builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1466786734.27 results: success (0) buildid: 20160624091358 builduid: ac83a0bab5d34eddbebd248436c7ccb9 revision: d69c52dd4f67d859e037f6b061b47cc3a272dc25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.272535) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.273070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.273365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.285087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.285344) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 09:45:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-24 09:45:35 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.407999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.408400) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018754 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:34.458315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 09:45:34.458664) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d69c52dd4f67d859e037f6b061b47cc3a272dc25 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d69c52dd4f67d859e037f6b061b47cc3a272dc25 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 09:45:35,785 truncating revision to first 12 chars 2016-06-24 09:45:35,785 Setting DEBUG logging. 2016-06-24 09:45:35,785 attempt 1/10 2016-06-24 09:45:35,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d69c52dd4f67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 09:45:37,106 unpacking tar archive at: fx-team-d69c52dd4f67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 09:45:36.089431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:36.089976) ========= script_repo_revision: d69c52dd4f67d859e037f6b061b47cc3a272dc25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:36.090881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:36.091472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 09:45:36.102604) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-24 09:45:36.103285) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:45:37 INFO - MultiFileLogger online at 20160624 09:45:37 in /builds/slave/test 09:45:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:45:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:37 INFO - {'append_to_log': False, 09:45:37 INFO - 'base_work_dir': '/builds/slave/test', 09:45:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:45:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:37 INFO - 'branch': 'Fx-Team-Non-PGO', 09:45:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:37 INFO - 'config_files': ('talos/linux_config.py',), 09:45:37 INFO - 'default_actions': ('clobber', 09:45:37 INFO - 'read-buildbot-config', 09:45:37 INFO - 'download-and-extract', 09:45:37 INFO - 'populate-webroot', 09:45:37 INFO - 'create-virtualenv', 09:45:37 INFO - 'install', 09:45:37 INFO - 'run-tests'), 09:45:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:37 INFO - 'download_minidump_stackwalk': True, 09:45:37 INFO - 'download_symbols': 'ondemand', 09:45:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:37 INFO - 'installer_path': 'installer.exe', 09:45:37 INFO - 'log_level': 'info', 09:45:37 INFO - 'log_name': 'talos', 09:45:37 INFO - 'log_to_console': True, 09:45:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:45:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:45:37 INFO - 'opt_config_files': (), 09:45:37 INFO - 'pip_index': False, 09:45:37 INFO - 'sps_profile': False, 09:45:37 INFO - 'sps_profile_interval': 0, 09:45:37 INFO - 'suite': 'dromaeojs', 09:45:37 INFO - 'system_bits': '32', 09:45:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:37 INFO - 'title': 'talos-linux64-ix-056', 09:45:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:37 INFO - 'use_talos_json': True, 09:45:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:37 INFO - 'work_dir': 'build'} 09:45:37 INFO - ##### 09:45:37 INFO - ##### Running clobber step. 09:45:37 INFO - ##### 09:45:37 INFO - Running pre-action listener: _resource_record_pre_action 09:45:37 INFO - Running main action method: clobber 09:45:37 INFO - rmtree: /builds/slave/test/build 09:45:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:38 INFO - Running post-action listener: _resource_record_post_action 09:45:38 INFO - ##### 09:45:38 INFO - ##### Finished clobber step (success) 09:45:38 INFO - ##### 09:45:38 INFO - ##### 09:45:38 INFO - ##### Running read-buildbot-config step. 09:45:38 INFO - ##### 09:45:38 INFO - Running pre-action listener: _resource_record_pre_action 09:45:38 INFO - Running main action method: read_buildbot_config 09:45:38 INFO - Using buildbot properties: 09:45:38 INFO - { 09:45:38 INFO - "project": "", 09:45:38 INFO - "product": "firefox", 09:45:38 INFO - "script_repo_revision": "production", 09:45:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:45:38 INFO - "repository": "", 09:45:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:45:38 INFO - "buildid": "20160624091358", 09:45:38 INFO - "pgo_build": "False", 09:45:38 INFO - "basedir": "/builds/slave/test", 09:45:38 INFO - "buildnumber": 1883, 09:45:38 INFO - "slavename": "talos-linux64-ix-056", 09:45:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:45:38 INFO - "platform": "ubuntu64_hw", 09:45:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:45:38 INFO - "branch": "fx-team", 09:45:38 INFO - "repo_path": "integration/fx-team", 09:45:38 INFO - "revision": "d69c52dd4f67d859e037f6b061b47cc3a272dc25", 09:45:38 INFO - "stage_platform": "linux64", 09:45:38 INFO - "builduid": "ac83a0bab5d34eddbebd248436c7ccb9", 09:45:38 INFO - "slavebuilddir": "test" 09:45:38 INFO - } 09:45:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:45:38 INFO - Running post-action listener: _resource_record_post_action 09:45:38 INFO - ##### 09:45:38 INFO - ##### Finished read-buildbot-config step (success) 09:45:38 INFO - ##### 09:45:38 INFO - ##### 09:45:38 INFO - ##### Running download-and-extract step. 09:45:38 INFO - ##### 09:45:38 INFO - Running pre-action listener: _resource_record_pre_action 09:45:38 INFO - Running main action method: download_and_extract 09:45:38 INFO - mkdir: /builds/slave/test/build/tests 09:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:38 INFO - https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:45:38 INFO - Downloaded 1361 bytes. 09:45:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:45:38 INFO - Using the following test package requirements: 09:45:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:45:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'jsshell-linux-x86_64.zip'], 09:45:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:45:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:45:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:38 INFO - https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:39 INFO - Downloaded 22710890 bytes. 09:45:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:45:40 INFO - Return code: 0 09:45:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:40 INFO - https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:45:42 INFO - Downloaded 22710890 bytes. 09:45:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:45:43 INFO - Return code: 0 09:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:43 INFO - https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:45:44 INFO - Downloaded 14405518 bytes. 09:45:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:45:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:45:44 INFO - Return code: 0 09:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:44 INFO - https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:45:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:45:46 INFO - Downloaded 56264758 bytes. 09:45:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:46 INFO - mkdir: /builds/slave/test/properties 09:45:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:46 INFO - Contents: 09:45:46 INFO - build_url:https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:45:46 INFO - Running post-action listener: _resource_record_post_action 09:45:46 INFO - Running post-action listener: set_extra_try_arguments 09:45:46 INFO - ##### 09:45:46 INFO - ##### Finished download-and-extract step (success) 09:45:46 INFO - ##### 09:45:46 INFO - ##### 09:45:46 INFO - ##### Running populate-webroot step. 09:45:46 INFO - ##### 09:45:46 INFO - Running pre-action listener: _resource_record_pre_action 09:45:46 INFO - Running main action method: populate_webroot 09:45:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:46 INFO - '--tppagecycles', 09:45:46 INFO - '7'], 09:45:46 INFO - 'tests': ['tsvgm']}}, 09:45:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['damp', 'tps']}, 09:45:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'tests': ['damp', 'tps']}, 09:45:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['dromaeo_dom']}, 09:45:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['basic_compositor_video']}, 09:45:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['a11yr', 09:45:46 INFO - 'ts_paint', 09:45:46 INFO - 'tpaint', 09:45:46 INFO - 'sessionrestore', 09:45:46 INFO - 'sessionrestore_no_auto_restore', 09:45:46 INFO - 'tabpaint']}, 09:45:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:46 INFO - 'ts_paint', 09:45:46 INFO - 'tpaint', 09:45:46 INFO - 'sessionrestore', 09:45:46 INFO - 'sessionrestore_no_auto_restore', 09:45:46 INFO - 'tabpaint']}, 09:45:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:46 INFO - 'ts_paint', 09:45:46 INFO - 'tpaint', 09:45:46 INFO - 'sessionrestore', 09:45:46 INFO - 'sessionrestore_no_auto_restore', 09:45:46 INFO - 'tabpaint']}, 09:45:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:46 INFO - 'ts_paint', 09:45:46 INFO - 'tpaint', 09:45:46 INFO - 'sessionrestore', 09:45:46 INFO - 'sessionrestore_no_auto_restore', 09:45:46 INFO - 'tabpaint']}, 09:45:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['a11yr', 09:45:46 INFO - 'ts_paint', 09:45:46 INFO - 'tpaint', 09:45:46 INFO - 'sessionrestore', 09:45:46 INFO - 'sessionrestore_no_auto_restore', 09:45:46 INFO - 'tabpaint']}, 09:45:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['a11yr', 09:45:46 INFO - 'ts_paint', 09:45:46 INFO - 'tpaint', 09:45:46 INFO - 'sessionrestore', 09:45:46 INFO - 'sessionrestore_no_auto_restore', 09:45:46 INFO - 'tabpaint']}, 09:45:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['tsvgx', 09:45:46 INFO - 'tsvgr_opacity', 09:45:46 INFO - 'tart', 09:45:46 INFO - 'tscrollx', 09:45:46 INFO - 'cart']}, 09:45:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:46 INFO - 'tsvgr_opacity', 09:45:46 INFO - 'tart', 09:45:46 INFO - 'tscrollx', 09:45:46 INFO - 'cart']}, 09:45:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'talos_options': ['--disable-e10s'], 09:45:46 INFO - 'tests': ['tp5o']}, 09:45:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'tests': ['tp5o']}, 09:45:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'talos_options': ['--disable-e10s', 09:45:46 INFO - '--xperf_path', 09:45:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:46 INFO - 'tests': ['tp5n']}, 09:45:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:46 INFO - 'talos_options': ['--xperf_path', 09:45:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:46 INFO - 'tests': ['tp5n']}}, 09:45:46 INFO - 'talos.zip': {'path': '', 09:45:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:46 INFO - Running post-action listener: _resource_record_post_action 09:45:46 INFO - ##### 09:45:46 INFO - ##### Finished populate-webroot step (success) 09:45:46 INFO - ##### 09:45:46 INFO - ##### 09:45:46 INFO - ##### Running create-virtualenv step. 09:45:46 INFO - ##### 09:45:46 INFO - Running pre-action listener: _resource_record_pre_action 09:45:46 INFO - Running main action method: create_virtualenv 09:45:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:45:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:47 INFO - Using real prefix '/usr' 09:45:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:49 INFO - Installing pip.................done. 09:45:49 INFO - Return code: 0 09:45:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:49 INFO - Using env: {'DISPLAY': ':0', 09:45:49 INFO - 'HOME': '/home/cltbld', 09:45:49 INFO - 'LANG': 'en_US.UTF-8', 09:45:49 INFO - 'LANGUAGE': 'en_US:en', 09:45:49 INFO - 'LOGNAME': 'cltbld', 09:45:49 INFO - 'MAIL': '/var/mail/cltbld', 09:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:49 INFO - 'MOZ_NO_REMOTE': '1', 09:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:49 INFO - 'NO_EM_RESTART': '1', 09:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:49 INFO - 'PWD': '/builds/slave/test', 09:45:49 INFO - 'SHELL': '/bin/bash', 09:45:49 INFO - 'SHLVL': '1', 09:45:49 INFO - 'TERM': 'linux', 09:45:49 INFO - 'TMOUT': '86400', 09:45:49 INFO - 'USER': 'cltbld', 09:45:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:49 INFO - '_': '/tools/buildbot/bin/python'} 09:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:45:49 INFO - Cleaning up... 09:45:49 INFO - Return code: 0 09:45:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:49 INFO - Using env: {'DISPLAY': ':0', 09:45:49 INFO - 'HOME': '/home/cltbld', 09:45:49 INFO - 'LANG': 'en_US.UTF-8', 09:45:49 INFO - 'LANGUAGE': 'en_US:en', 09:45:49 INFO - 'LOGNAME': 'cltbld', 09:45:49 INFO - 'MAIL': '/var/mail/cltbld', 09:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:49 INFO - 'MOZ_NO_REMOTE': '1', 09:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:49 INFO - 'NO_EM_RESTART': '1', 09:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:49 INFO - 'PWD': '/builds/slave/test', 09:45:49 INFO - 'SHELL': '/bin/bash', 09:45:49 INFO - 'SHLVL': '1', 09:45:49 INFO - 'TERM': 'linux', 09:45:49 INFO - 'TMOUT': '86400', 09:45:49 INFO - 'USER': 'cltbld', 09:45:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:49 INFO - '_': '/tools/buildbot/bin/python'} 09:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:50 INFO - Downloading/unpacking psutil>=3.1.1 09:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:52 INFO - Installing collected packages: psutil 09:45:52 INFO - Running setup.py install for psutil 09:45:52 INFO - building 'psutil._psutil_linux' extension 09:45:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:45:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:45:52 INFO - building 'psutil._psutil_posix' extension 09:45:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:45:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:45:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:52 INFO - Successfully installed psutil 09:45:52 INFO - Cleaning up... 09:45:52 INFO - Return code: 0 09:45:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:45:52 INFO - Using env: {'DISPLAY': ':0', 09:45:52 INFO - 'HOME': '/home/cltbld', 09:45:52 INFO - 'LANG': 'en_US.UTF-8', 09:45:52 INFO - 'LANGUAGE': 'en_US:en', 09:45:52 INFO - 'LOGNAME': 'cltbld', 09:45:52 INFO - 'MAIL': '/var/mail/cltbld', 09:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:52 INFO - 'MOZ_NO_REMOTE': '1', 09:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:52 INFO - 'NO_EM_RESTART': '1', 09:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:52 INFO - 'PWD': '/builds/slave/test', 09:45:52 INFO - 'SHELL': '/bin/bash', 09:45:52 INFO - 'SHLVL': '1', 09:45:52 INFO - 'TERM': 'linux', 09:45:52 INFO - 'TMOUT': '86400', 09:45:52 INFO - 'USER': 'cltbld', 09:45:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:52 INFO - '_': '/tools/buildbot/bin/python'} 09:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:54 INFO - Installing collected packages: mozsystemmonitor 09:45:54 INFO - Running setup.py install for mozsystemmonitor 09:45:54 INFO - Successfully installed mozsystemmonitor 09:45:54 INFO - Cleaning up... 09:45:54 INFO - Return code: 0 09:45:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:45:54 INFO - Using env: {'DISPLAY': ':0', 09:45:54 INFO - 'HOME': '/home/cltbld', 09:45:54 INFO - 'LANG': 'en_US.UTF-8', 09:45:54 INFO - 'LANGUAGE': 'en_US:en', 09:45:54 INFO - 'LOGNAME': 'cltbld', 09:45:54 INFO - 'MAIL': '/var/mail/cltbld', 09:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:54 INFO - 'MOZ_NO_REMOTE': '1', 09:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:54 INFO - 'NO_EM_RESTART': '1', 09:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:54 INFO - 'PWD': '/builds/slave/test', 09:45:54 INFO - 'SHELL': '/bin/bash', 09:45:54 INFO - 'SHLVL': '1', 09:45:54 INFO - 'TERM': 'linux', 09:45:54 INFO - 'TMOUT': '86400', 09:45:54 INFO - 'USER': 'cltbld', 09:45:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:54 INFO - '_': '/tools/buildbot/bin/python'} 09:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:55 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:57 INFO - warning: no files found matching '*.txt' 09:45:57 INFO - no previously-included directories found matching 'build' 09:45:57 INFO - no previously-included directories found matching 'dist' 09:45:57 INFO - no previously-included directories found matching '.git*' 09:45:57 INFO - Installing collected packages: jsonschema, functools32 09:45:57 INFO - Running setup.py install for functools32 09:45:57 INFO - warning: no files found matching '*.txt' 09:45:57 INFO - no previously-included directories found matching 'build' 09:45:57 INFO - no previously-included directories found matching 'dist' 09:45:57 INFO - no previously-included directories found matching '.git*' 09:45:57 INFO - Successfully installed jsonschema functools32 09:45:57 INFO - Cleaning up... 09:45:57 INFO - Return code: 0 09:45:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:57 INFO - Using env: {'DISPLAY': ':0', 09:45:57 INFO - 'HOME': '/home/cltbld', 09:45:57 INFO - 'LANG': 'en_US.UTF-8', 09:45:57 INFO - 'LANGUAGE': 'en_US:en', 09:45:57 INFO - 'LOGNAME': 'cltbld', 09:45:57 INFO - 'MAIL': '/var/mail/cltbld', 09:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:57 INFO - 'MOZ_NO_REMOTE': '1', 09:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:57 INFO - 'NO_EM_RESTART': '1', 09:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:57 INFO - 'PWD': '/builds/slave/test', 09:45:57 INFO - 'SHELL': '/bin/bash', 09:45:57 INFO - 'SHLVL': '1', 09:45:57 INFO - 'TERM': 'linux', 09:45:57 INFO - 'TMOUT': '86400', 09:45:57 INFO - 'USER': 'cltbld', 09:45:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:57 INFO - '_': '/tools/buildbot/bin/python'} 09:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:00 INFO - Downloading docopt-0.6.1.tar.gz 09:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:00 INFO - Running setup.py install for blobuploader 09:46:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:00 INFO - Running setup.py install for requests 09:46:00 INFO - Running setup.py install for docopt 09:46:00 INFO - Successfully installed blobuploader requests docopt 09:46:00 INFO - Cleaning up... 09:46:01 INFO - Return code: 0 09:46:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:01 INFO - Using env: {'DISPLAY': ':0', 09:46:01 INFO - 'HOME': '/home/cltbld', 09:46:01 INFO - 'LANG': 'en_US.UTF-8', 09:46:01 INFO - 'LANGUAGE': 'en_US:en', 09:46:01 INFO - 'LOGNAME': 'cltbld', 09:46:01 INFO - 'MAIL': '/var/mail/cltbld', 09:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:01 INFO - 'MOZ_NO_REMOTE': '1', 09:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:01 INFO - 'NO_EM_RESTART': '1', 09:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:01 INFO - 'PWD': '/builds/slave/test', 09:46:01 INFO - 'SHELL': '/bin/bash', 09:46:01 INFO - 'SHLVL': '1', 09:46:01 INFO - 'TERM': 'linux', 09:46:01 INFO - 'TMOUT': '86400', 09:46:01 INFO - 'USER': 'cltbld', 09:46:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:01 INFO - '_': '/tools/buildbot/bin/python'} 09:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:01 INFO - Running setup.py (path:/tmp/pip-qiul5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:01 INFO - Running setup.py (path:/tmp/pip-onHGt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:01 INFO - Running setup.py (path:/tmp/pip-UE0SPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:01 INFO - Running setup.py (path:/tmp/pip-nCZIWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:01 INFO - Running setup.py (path:/tmp/pip-akElTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:01 INFO - Running setup.py (path:/tmp/pip-uUYMJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:01 INFO - Running setup.py (path:/tmp/pip-FRWLVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:01 INFO - Running setup.py (path:/tmp/pip-SBx5CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:01 INFO - Running setup.py (path:/tmp/pip-xyoUqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:01 INFO - Running setup.py (path:/tmp/pip-Iqq6cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:01 INFO - Running setup.py (path:/tmp/pip-p8zswP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:02 INFO - Running setup.py (path:/tmp/pip-yHKzuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:02 INFO - Running setup.py (path:/tmp/pip-MhZV7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:02 INFO - Running setup.py (path:/tmp/pip-70N4dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:02 INFO - Running setup.py (path:/tmp/pip-oI0WY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:02 INFO - Running setup.py (path:/tmp/pip-JL0eVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:02 INFO - Running setup.py (path:/tmp/pip-7Mq4sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:02 INFO - Running setup.py install for manifestparser 09:46:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:02 INFO - Running setup.py install for mozcrash 09:46:02 INFO - Running setup.py install for mozdebug 09:46:02 INFO - Running setup.py install for mozdevice 09:46:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:02 INFO - Running setup.py install for mozfile 09:46:03 INFO - Running setup.py install for mozhttpd 09:46:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for mozinfo 09:46:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for mozInstall 09:46:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for mozleak 09:46:03 INFO - Running setup.py install for mozlog 09:46:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for moznetwork 09:46:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for mozprocess 09:46:03 INFO - Running setup.py install for mozprofile 09:46:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for mozrunner 09:46:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:03 INFO - Running setup.py install for mozscreenshot 09:46:04 INFO - Running setup.py install for moztest 09:46:04 INFO - Running setup.py install for mozversion 09:46:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:04 INFO - Cleaning up... 09:46:04 INFO - Return code: 0 09:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:04 INFO - Using env: {'DISPLAY': ':0', 09:46:04 INFO - 'HOME': '/home/cltbld', 09:46:04 INFO - 'LANG': 'en_US.UTF-8', 09:46:04 INFO - 'LANGUAGE': 'en_US:en', 09:46:04 INFO - 'LOGNAME': 'cltbld', 09:46:04 INFO - 'MAIL': '/var/mail/cltbld', 09:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:04 INFO - 'MOZ_NO_REMOTE': '1', 09:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:04 INFO - 'NO_EM_RESTART': '1', 09:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:04 INFO - 'PWD': '/builds/slave/test', 09:46:04 INFO - 'SHELL': '/bin/bash', 09:46:04 INFO - 'SHLVL': '1', 09:46:04 INFO - 'TERM': 'linux', 09:46:04 INFO - 'TMOUT': '86400', 09:46:04 INFO - 'USER': 'cltbld', 09:46:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:04 INFO - '_': '/tools/buildbot/bin/python'} 09:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:04 INFO - Running setup.py (path:/tmp/pip-B9Vhcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:04 INFO - Running setup.py (path:/tmp/pip-s7iz2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:04 INFO - Running setup.py (path:/tmp/pip-WAoKwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:04 INFO - Running setup.py (path:/tmp/pip-admxE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:04 INFO - Running setup.py (path:/tmp/pip-uR9K5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:04 INFO - Running setup.py (path:/tmp/pip-4tcorY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:04 INFO - Running setup.py (path:/tmp/pip-XIl7c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:05 INFO - Running setup.py (path:/tmp/pip-B7RYn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:05 INFO - Running setup.py (path:/tmp/pip-gxiypS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:05 INFO - Running setup.py (path:/tmp/pip-JqYevT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:05 INFO - Running setup.py (path:/tmp/pip-jFjVZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:05 INFO - Running setup.py (path:/tmp/pip-cKGOVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:05 INFO - Running setup.py (path:/tmp/pip-eVXDRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:05 INFO - Running setup.py (path:/tmp/pip-_D0Rqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:05 INFO - Running setup.py (path:/tmp/pip-FnTiqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:05 INFO - Running setup.py (path:/tmp/pip-ufICaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:05 INFO - Running setup.py (path:/tmp/pip-LGWZ0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:07 INFO - Downloading blessings-1.6.tar.gz 09:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:07 INFO - Installing collected packages: blessings 09:46:07 INFO - Running setup.py install for blessings 09:46:07 INFO - Successfully installed blessings 09:46:07 INFO - Cleaning up... 09:46:07 INFO - Return code: 0 09:46:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:08 INFO - Reading from file tmpfile_stdout 09:46:08 INFO - Current package versions: 09:46:08 INFO - argparse == 1.2.1 09:46:08 INFO - blessings == 1.6 09:46:08 INFO - blobuploader == 1.2.4 09:46:08 INFO - docopt == 0.6.1 09:46:08 INFO - functools32 == 3.2.3-2 09:46:08 INFO - jsonschema == 2.5.1 09:46:08 INFO - manifestparser == 1.1 09:46:08 INFO - mozInstall == 1.12 09:46:08 INFO - mozcrash == 0.17 09:46:08 INFO - mozdebug == 0.1 09:46:08 INFO - mozdevice == 0.48 09:46:08 INFO - mozfile == 1.2 09:46:08 INFO - mozhttpd == 0.7 09:46:08 INFO - mozinfo == 0.9 09:46:08 INFO - mozleak == 0.1 09:46:08 INFO - mozlog == 3.2 09:46:08 INFO - moznetwork == 0.27 09:46:08 INFO - mozprocess == 0.22 09:46:08 INFO - mozprofile == 0.28 09:46:08 INFO - mozrunner == 6.11 09:46:08 INFO - mozscreenshot == 0.1 09:46:08 INFO - mozsystemmonitor == 0.3 09:46:08 INFO - moztest == 0.7 09:46:08 INFO - mozversion == 1.4 09:46:08 INFO - psutil == 3.1.1 09:46:08 INFO - requests == 1.2.3 09:46:08 INFO - wsgiref == 0.1.2 09:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:08 INFO - Using env: {'DISPLAY': ':0', 09:46:08 INFO - 'HOME': '/home/cltbld', 09:46:08 INFO - 'LANG': 'en_US.UTF-8', 09:46:08 INFO - 'LANGUAGE': 'en_US:en', 09:46:08 INFO - 'LOGNAME': 'cltbld', 09:46:08 INFO - 'MAIL': '/var/mail/cltbld', 09:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:08 INFO - 'MOZ_NO_REMOTE': '1', 09:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:08 INFO - 'NO_EM_RESTART': '1', 09:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:08 INFO - 'PWD': '/builds/slave/test', 09:46:08 INFO - 'SHELL': '/bin/bash', 09:46:08 INFO - 'SHLVL': '1', 09:46:08 INFO - 'TERM': 'linux', 09:46:08 INFO - 'TMOUT': '86400', 09:46:08 INFO - 'USER': 'cltbld', 09:46:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:08 INFO - '_': '/tools/buildbot/bin/python'} 09:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:46:08 INFO - Cleaning up... 09:46:08 INFO - Return code: 0 09:46:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:46:08 INFO - Using env: {'DISPLAY': ':0', 09:46:08 INFO - 'HOME': '/home/cltbld', 09:46:08 INFO - 'LANG': 'en_US.UTF-8', 09:46:08 INFO - 'LANGUAGE': 'en_US:en', 09:46:08 INFO - 'LOGNAME': 'cltbld', 09:46:08 INFO - 'MAIL': '/var/mail/cltbld', 09:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:08 INFO - 'MOZ_NO_REMOTE': '1', 09:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:08 INFO - 'NO_EM_RESTART': '1', 09:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:08 INFO - 'PWD': '/builds/slave/test', 09:46:08 INFO - 'SHELL': '/bin/bash', 09:46:08 INFO - 'SHLVL': '1', 09:46:08 INFO - 'TERM': 'linux', 09:46:08 INFO - 'TMOUT': '86400', 09:46:08 INFO - 'USER': 'cltbld', 09:46:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:08 INFO - '_': '/tools/buildbot/bin/python'} 09:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:46:08 INFO - Cleaning up... 09:46:08 INFO - Return code: 0 09:46:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4e28c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:46:08 INFO - Using env: {'DISPLAY': ':0', 09:46:08 INFO - 'HOME': '/home/cltbld', 09:46:08 INFO - 'LANG': 'en_US.UTF-8', 09:46:08 INFO - 'LANGUAGE': 'en_US:en', 09:46:08 INFO - 'LOGNAME': 'cltbld', 09:46:08 INFO - 'MAIL': '/var/mail/cltbld', 09:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:08 INFO - 'MOZ_NO_REMOTE': '1', 09:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:08 INFO - 'NO_EM_RESTART': '1', 09:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:08 INFO - 'PWD': '/builds/slave/test', 09:46:08 INFO - 'SHELL': '/bin/bash', 09:46:08 INFO - 'SHLVL': '1', 09:46:08 INFO - 'TERM': 'linux', 09:46:08 INFO - 'TMOUT': '86400', 09:46:08 INFO - 'USER': 'cltbld', 09:46:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:08 INFO - '_': '/tools/buildbot/bin/python'} 09:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:08 INFO - Downloading/unpacking flake8 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:46:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:46:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:46:11 INFO - no previously-included directories found matching 'docs/_build' 09:46:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:46:11 INFO - Running setup.py install for pep8 09:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:46:11 INFO - no previously-included directories found matching 'docs/_build' 09:46:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:46:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:46:11 INFO - Cleaning up... 09:46:11 INFO - Return code: 0 09:46:11 INFO - Running post-action listener: _resource_record_post_action 09:46:11 INFO - Running post-action listener: _start_resource_monitoring 09:46:11 INFO - Starting resource monitoring. 09:46:11 INFO - ##### 09:46:11 INFO - ##### Finished create-virtualenv step (success) 09:46:11 INFO - ##### 09:46:11 INFO - ##### 09:46:11 INFO - ##### Running install step. 09:46:11 INFO - ##### 09:46:11 INFO - Running pre-action listener: _resource_record_pre_action 09:46:11 INFO - Running main action method: install 09:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:11 INFO - Reading from file tmpfile_stdout 09:46:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:46:11 INFO - Reading from file tmpfile_stdout 09:46:11 INFO - Output received: 09:46:11 INFO - Usage: mozinstall [options] installer 09:46:11 INFO - Options: 09:46:11 INFO - -h, --help show this help message and exit 09:46:11 INFO - -d DEST, --destination=DEST 09:46:11 INFO - Directory to install application into. [default: 09:46:11 INFO - "/builds/slave/test"] 09:46:11 INFO - --app=APP Application being installed. [default: firefox] 09:46:11 INFO - mkdir: /builds/slave/test/build/application 09:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:46:28 INFO - Reading from file tmpfile_stdout 09:46:28 INFO - Output received: 09:46:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:46:28 INFO - Running post-action listener: _resource_record_post_action 09:46:28 INFO - ##### 09:46:28 INFO - ##### Finished install step (success) 09:46:28 INFO - ##### 09:46:28 INFO - ##### 09:46:28 INFO - ##### Running run-tests step. 09:46:28 INFO - ##### 09:46:28 INFO - Running pre-action listener: _resource_record_pre_action 09:46:28 INFO - Running main action method: run_tests 09:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:28 INFO - Python 2.7.3 09:46:28 INFO - Return code: 0 09:46:28 INFO - grabbing minidump binary from tooltool 09:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ea2e0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21565d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:46:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:46:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:46:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:28 INFO - Return code: 0 09:46:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:46:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:46:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:46:29 INFO - Return code: 0 09:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:46:29 INFO - Using env: {'DISPLAY': ':0', 09:46:29 INFO - 'HOME': '/home/cltbld', 09:46:29 INFO - 'LANG': 'en_US.UTF-8', 09:46:29 INFO - 'LANGUAGE': 'en_US:en', 09:46:29 INFO - 'LOGNAME': 'cltbld', 09:46:29 INFO - 'MAIL': '/var/mail/cltbld', 09:46:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:29 INFO - 'MOZ_NO_REMOTE': '1', 09:46:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:29 INFO - 'NO_EM_RESTART': '1', 09:46:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:29 INFO - 'PWD': '/builds/slave/test', 09:46:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:29 INFO - 'SHELL': '/bin/bash', 09:46:29 INFO - 'SHLVL': '1', 09:46:29 INFO - 'TERM': 'linux', 09:46:29 INFO - 'TMOUT': '86400', 09:46:29 INFO - 'USER': 'cltbld', 09:46:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325', 09:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:29 INFO - '_': '/tools/buildbot/bin/python'} 09:46:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:46:29 INFO - mozversion application_buildid: 20160624091358 09:46:29 INFO - mozversion application_changeset: d69c52dd4f67d859e037f6b061b47cc3a272dc25 09:46:29 INFO - mozversion application_display_name: Nightly 09:46:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:29 INFO - mozversion application_name: Firefox 09:46:29 INFO - mozversion application_remotingname: firefox 09:46:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:46:29 INFO - mozversion application_vendor: Mozilla 09:46:29 INFO - mozversion application_version: 50.0a1 09:46:29 INFO - mozversion platform_buildid: 20160624091358 09:46:29 INFO - mozversion platform_changeset: d69c52dd4f67d859e037f6b061b47cc3a272dc25 09:46:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:46:29 INFO - mozversion platform_version: 50.0a1 09:46:29 INFO - using testdate: 1466786789 09:46:29 INFO - actual date: 1466786789 09:46:29 INFO - starting webserver on 'localhost:38401' 09:46:29 INFO - SUITE-START | Running 2 tests 09:46:29 INFO - TEST-START | dromaeo_css 09:46:29 INFO - operating with platform_type : linux_ 09:46:29 INFO - Initialising browser for dromaeo_css test... 09:46:29 INFO - TEST-INFO | started process 7045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKSl3v/profile http://localhost:38401/getInfo.html) 09:46:33 INFO - PROCESS | 7045 | __metrics Screen width/height:1600/1200 09:46:33 INFO - PROCESS | 7045 | colorDepth:24 09:46:33 INFO - PROCESS | 7045 | Browser inner width/height: 1024/697 09:46:33 INFO - PROCESS | 7045 | __metrics 09:46:34 INFO - PROCESS | 7045 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:35 INFO - TEST-INFO | 7045: exit 0 09:46:35 INFO - Browser initialized. 09:46:35 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:35 INFO - TEST-INFO | started process 7127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKSl3v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:48 INFO - PROCESS | 7127 | RSS: Main: 175685632 09:46:48 INFO - PROCESS | 7127 | 09:47:38 INFO - PROCESS | 7127 | 1466786858850 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:49:51 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:38401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38401/tests/dromaeo/cssquery-ext.html) 09:49:52 INFO - PROCESS | 7127 | RSS: Main: 253624320 09:49:52 INFO - PROCESS | 7127 | 09:52:55 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:38401/tests/dromaeo/cssquery-ext.html (next: http://localhost:38401/tests/dromaeo/cssquery-jquery.html) 09:52:56 INFO - PROCESS | 7127 | RSS: Main: 252243968 09:52:56 INFO - PROCESS | 7127 | 09:55:58 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:38401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38401/tests/dromaeo/cssquery-mootools.html) 09:55:58 INFO - PROCESS | 7127 | RSS: Main: 264024064 09:55:58 INFO - PROCESS | 7127 | 09:59:01 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:38401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38401/tests/dromaeo/cssquery-prototype.html) 09:59:01 INFO - PROCESS | 7127 | RSS: Main: 250626048 09:59:01 INFO - PROCESS | 7127 | 10:02:04 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:38401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38401/tests/dromaeo/cssquery-yui.html) 10:02:05 INFO - PROCESS | 7127 | RSS: Main: 238559232 10:02:05 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | Cycle 1(1): loaded http://localhost:38401/tests/dromaeo/cssquery-yui.html (next: http://localhost:38401/tests/dromaeo/cssquery-dojo.html) 10:05:08 INFO - PROCESS | 7127 | RSS: Main: 325029888 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | __start_tp_report 10:05:08 INFO - PROCESS | 7127 | _x_x_mozilla_page_load 10:05:08 INFO - PROCESS | 7127 | _x_x_mozilla_page_load_details 10:05:08 INFO - PROCESS | 7127 | |i|pagename|runs| 10:05:08 INFO - PROCESS | 7127 | |0;dojo.html;2643.5109504741636;2644.9074282400115;2682.289193363758;2685.8657067146646;2688.905888293909;4622.214223581991;4706.764661766911;4716.85849424517;4763.14263432582;4828.493008234133;4734.053189362124;4742;4748.4301883774;4761.2143996240575;4763;4177.415161877339;4325.87022389328;4425.911481770363;4449.777511124431;4564.269716845305;4433.756143412111;4494.101179764044;4498.685092043558;4505.43682039745;4536.773161341936;4309.913801723948;4369.956300437018;4430.977845110754;4501.144782491317;4503.166914120865;4365.934510982338;4401.207782599131;4426.977865110686;4463.821447142111;4487.618552423048;4432.867013989586;4449.310356894686;4452.131834292314;4466.240739074366;4489.281714925629;4691.835785747517;4736.786844592001;4753.619710423158;4806.303086052538;4817.566419022305;5196.0647083524955;5206.479352064801;5211.557017653504;5214.139666954948;5214.921776173361;5142.61430392722;5176.559992400613;5179.507946745053;5189.55888749453;5193.221016847466;4596.6092882105395;4718.764061796896;4780.832670856504;4785.904281914342;4846.200376937836;5257.921131183035;5281.339832520935;5299.4700529946695;5301.045811753845;5310.389305229948;4814.903701925942;5054.393472783216;5067.08792417361;5067.163917953497;5067.923981140286;4992.301077849104;5068.138416469209;5116.130257856174;5139.12634852076;5140.768665410065;5044.899102018013;5053.444121146671;5056.26684130799;5057.393112826484;5077.644564880423;4895.730734809548;4993.50064993505;5018.723970181602;5045.747712614355;5062.392512898476;4402.669799765031;4423.668224883147;4443.422355093881;4480.551944805494;4482.484514280899;3854.2291541691775;3855.3060449118866;3864.8260828262796;3889.4360317753767;3895.2209558088493;4242.745435273831;4273.273543497613;4399.934000989988;4441.888952776142;4449.844255451044;5092.9236061459105;5137.33214682089;5149.665271757323;5150.665206761549;5169.870753231124;4336.718113322687;4349.28236840924;4364.018095928454;4374.540673229329;4387.868363949086;4501.3248012797685;4591.104734576726;4595.793189306489;4622.329762184464;4640.23436133041;4798.832040878552;4802.27965805132;4823.5658790709;4846.975765121081;4866.829660961849;5165.276861239505;5166.922496162636;5167.6641018333685;5170.922436163385;5199.922001170061;4672.088942656285;4780.259059845729;4803.447603525499;4813.95186048135;4824.324594556695;5116.8720781979255;5141.768620412166;5142.1772516397195;5149.9742501287255;5198.194279886624;5184.040952423814;5195.870103247449;5197.870053248699;5210.817621383233;5253.185756207794;4830.4444988826735;4875.488073752205;4942.20924652054;4961.578265847444;5059.721715305694;4980.8754781130765;4984.775685094107;5002.099622068063;5014.874628134326;5053.191489361684;4918.508149185053;4927.876803079808;4933.777979990838;5010.448850626501;5020.071286811952;4884.438289596742;5021.748912554284;5047.2681461187185;5080.466551012239;5084.41529224144;4942.233953737176;4948.356713627206;4974.825881094144;4979.502049794992;5018.347614810197 10:05:08 INFO - PROCESS | 7127 | |1;ext.html;536.70513364051;575.4044563876388;581.0441823200838;588.3322429043035;593.2317648645005;29089;29367.412651746978;39357.40963885544;40304.19391612166;40400.39399409004;42299.57700422995;42595.57404425955;42607.36088958668;42645.7867710661;42648.36027459583;7794.025746781666;7924.247196516321;7925.9603701981405;7936.325412339958;7945.404094692893;7588.506747061451;10153.644622438216;10326.896731032668;10446.791064178711;10850.945745271263;10481.73795655111;10563.366198028105;10574;10575.524101415454;10576.78846423071;7642.5796581188015;10194.23543234253;10424.478776061205;10511.421871797049;10526.473676316153;9895.65365212214;10280.383177009404;10288.639897603623;10289.176865850714;10293.845592316122;39649.20701585952;40071;40086.599134008575;40102.19795604071;40121.59878401208;3094.5048792193143;3104.6895310469;3370.898873033813;3652.6712595866234;3720.720945929039;29973.550396744067;30191.396172076435;30256.54615180774;30895.382092358253;31075;3635.2296520693;3641.578350397009;3690.335739566877;3713.442983552489;3748.5314335708035;261071;262432.6878365615;262826;263039;263988;31788.20529486735;33388.3322333552;54285.72857135768;55428;55576.72211638916;33404.832975834965;33777.49333759995;33819.15452113717;33861.661383386345;33868;12506.562270320495;12704.42830072649;12748.936255318664;12750;12766.425510852034;9497.43015419077;11251.099912007183;11319.547218111184;11497.942510287396;11610.6516804496;7891.802704932423;7895.171007044178;7933.127355990837;7978.321842643324;8029;3013.3973205359016;3077.07687693691;3092.304231547884;3094.1491089950446;3096.504559270506;781.4373650971291;857.9871301930476;876.4960147914975;952.9142377186087;976.1312431935582;27329;27368.905243790425;27450.5882411764;28071.43857122887;28531.429371412454;958.1999030809213;993.7913038261902;1049.2550289294534;1076.784643071389;1087.1194332590626;14564.708705826037;14730.705385892223;15026.849731502763;15135.864810139283;15254.708182016744;379488;379515;382228;383615;384013;51059.489405106215;51477.48522514727;51478.74260628673;51509;51510;1065.973350666224;1159.3913195572222;1176.5999560149419;1205.5057426455112;1205.7769312677183;27976;29056;29218.415631687672;29405;29774.70225297806;43269;43381.3492797602;44011.11977760363;44057;44071.77964110287;308424;311049;311164;311428;311553;33046;37246.255074898894;38743.80628096954;38865.61134388733;41942.370864436445;41714;41852.79073604734;42487.3626895603;42570.57429425666;43485.3477197836;35734.46398303976;36628.45057324089;37310.440343395414;37404;37623.43564846584;36308.27383452369;36528.634713653584;36534.63465365419;36769.448458272615;37266.62733372632;35867.82066089653;36040.819795900854;36197.27605447929;36467.26495512794;37672.05819854526;33126.00621981345;33973.83013084919;34476.31047378988;34691.826540867136;34732.65267347395;24788.752112479367;25262.368440789127;25472.872635636704;25761.098361557255;25806.870965645052 10:05:08 INFO - PROCESS | 7127 | |2;jquery.html;363.4294158171671;365.23665539023455;367.4103064581346;367.557093702089;385.7531180044772;15773.60565985851;16969;17348.479545613653;17352.21915013826;17394.043327616975;15521.68956620867;16481;16851.57871053224;16902.408415705453;17326.393576224833;4815.5906747926465;5053.140966035783;5083.923741143886;5088.745562721849;5098.26075219093;3648.4709717091005;4946.084974279752;5505.779768809243;5926.851828704273;5950.821475355746;5862.32583252925;5916.319623243339;5983.850403739898;5984.790532331369;5985.042393217086;5607.831765047055;5810.215620891167;5816.185733997223;5822.214001109838;5824.30108386992;3290.52287418323;4832.178529649933;5109.770060347293;5147.6654017488745;5196.558292545138;20042.599148017103;20649.5870082599;20775.37673869786;20816.47958801027;20910.163593456244;1853.0827240515896;1885.1328388941104;1907.4754442528415;1921.490804936693;1962.3328068456792;12553.874461255453;12995.675108122277;13033.739325213442;13387.933060334733;13391.598252052454;1694.1783235130952;1723.112597012527;1757.6572568349177;1783.3223375117502;1814.1836173721879;65000.67499662519;66882.3311766881;67116.66441667761;67209.32790672079;67448;9478.668246611336;9719.757006074904;9814.509274536245;10506.369617822955;10549.736256593493;13016.739665206644;13079.803802942963;13152.539661112007;13160.14459060158;13182;7179.353858152791;7369.152547457111;7450.329470347695;7525.8118547036765;7534.171241163468;7001.964990175016;7064.1876184238445;7161.427085833121;7207.13514378278;7209.134903811576;5900.64596124234;6020.127081573235;6115.4801841843055;6172.925868926487;6228.4705800007505;1626.463267121847;1681.8563376903578;1758.859291256722;1769.1066011664284;1777.3601503459004;861.8405594964952;873.7553485024204;886.8980067292215;919.4804935211585;933.780561568031;15711.450099246471;16779.244933977756;17548.210330535156;18025.369112081014;18035.819641803413;860.2300940658201;864.0495454999576;881.828043531518;891.3359547137425;913.36064754672;9350.859737103949;9627.759306017406;10318.122959548373;10347.43089130105;10353.482325883826;415103;421127;439111;440294;441626;80638.5968070156;84265;84721.57639211764;84807.5759621198;85422.14577854142;921.6221349246777;924.7179610218948;926.9536523173814;948.1324588002038;950.5769932380025;15762.645797727222;15796.36814527452;15987.280572374038;16147.596310091873;16490.093044882167;39318.2136357277;39652.80173599113;39775.60224397719;39997.60002399939;40383.192336152526;49313.26030109623;49498.25752613786;52980;53917;55282.72358638181;7617.581033043236;7715.305622494003;7739.496932699357;7849.411294152847;7864.21357864209;11542.826857596974;11658;11823.881761182622;11832.11259155584;12339.259644421363;9946.950265248917;9994.650187243411;10089.243306751876;10429.26995110335;10433.686989390331;10369.377837329785;10434.68695939123;10440.530176142243;10510.421926794099;10742.19433542503;10468.842967355344;10661.134301497052;10704.197185211297;10753.247272690836;10789.62236321725;7736.149023607286;7771.950786643957;7817.5309481431295;7838.255365740246;7888.290053895177;7841.451098423056;9668.661596844076;10082.747931301776;10256.28206025601;10356.223283253636 10:05:08 INFO - PROCESS | 7127 | |3;mootools.html;1276.9553065642704;1395.1350162899;1421.1402101728454;1509.3886975774808;1725.6203635200259;7414.184439711634;7778.766637000892;7791.493552919056;7800.804979875499;7989.400794940374;7450.0687414073245;7692.230776922319;7868.685252589904;7872.724454644089;7877.487963282382;2207.867527948324;2259.5029093599383;2259.9661005084854;2261.7851304126166;2263.287064574662;2263.241813992306;2284.189112864934;2300.804431623314;2304.0323064312943;2306.873121978299;2236.586231547169;2249.7300323961067;2277.943051423711;2282.4522114692436;2283.086765293879;2162.0703097667997;2178.194068194762;2193.8903054847356;2198.2525941179997;2200.2959053103014;2145.7210562626915;2146.5384942237492;2148.140743702516;2149.408912549046;2151.526664133888;7561.810954726121;7805.41459390548;7914.485558438683;7973.282404583558;7983.081945576275;4692.694974826625;4812.831550895702;4822.565969062766;4824.324594556765;4826.7827947742435;2788.63747712796;2956.1131660501765;2991.7457016153653;3008.939821203586;3016.245938515371;910.5765818894246;919.0011724499187;931.4271722890373;933.0529512544772;938.666773295484;10763.085137763299;10939.671809845717;10949.905009499065;10981.835272470918;10989.725256868562;4221.810018549173;4338.457692788402;4404.251277282806;4411.051623900877;4470.105978804252;9261.907380926239;9317.208037316768;9326.860097098548;9336.439813611205;9345.48599827016;4712.034033023222;4742.19382704941;4805.423349198119;4805.471398146201;4805.879853003703;3608.9097772555897;3812.5996770338716;4243.2998555238655;4268.807903644343;4325.589069038437;3798.1074447504816;3849.57654657993;3871.2451072041245;3901.96098039016;3909.706771992112;1212.7877621416394;1212.902967762577;1219.1039585904352;1225.5710501324643;1236.1841184818156;786.3394748411362;786.4219798448136;799.5043073294478;799.8520273749375;867.9001914779755;5104.259882317043;5257.5005374489365;5269.683818970874;5292.690475952794;5314.97342513285;865.7532603208056;867.1848462445281;894.2086253665423;948.2224575847877;986.2504496582649;3467.01190160803;3581.068922080226;3586.55168103987;3599.586047604507;3631.763935344194;9501.429914205031;9735.659251926148;9911.801763964824;9912.653057142965;9916.305858589829;9566.66516671913;9736.269779766404;9845.409275443353;9872.901270987342;9876.160526355197;7446.180920098785;7460.813479662943;7545.962270188724;7547.584882831387;7550.509216900884;5045;5130.820421285237;5149.073166830007;5226.189940559219;5311.601629877852;8795.296376290009;9072.818543628959;9177.449353038839;9341.626334946526;9409.29430292717;9261.259099272176;9438.38650487716;9439.386439881386;9445.52772361393;9610.375325603813;5822;6359.07793369968;6536.509761767791;6543.083968244355;6678.332166783477;7663.88504172449;7689.538627682133;7722.459427839997;7726.961365193138;7749.341305988829;6501.414872661483;6695.665216739046;6708.664566771739;6752.864942701217;6825.761098361533;6579.901301480386;6590.736370545316;6612.636305003271;6683.799486015428;6707.228668703162;6169.290531588746;6198.163247961467;6239.0953311768635;6267.435930766253;6314.305426403183;4556.225441674989;4576.839810606612;4579.793909274024;4640.93038604428;4644.442666879996;4492.73043617384;4536.6824322297125;4536.841210557614;4539.5006549280215;4541.886452838706 10:05:08 INFO - PROCESS | 7127 | |4;prototype.html;287.45814140345453;290.67734814356066;300.17002986741664;304.7820808122192;312.5078002146618;4642.651801114921;4809.158397280479;4827.324174615556;4827.755093881345;4858.5627293543575;4640.886187315045;4791.808327666889;4806.591439727618;4814.253790662444;4823.204171311738;3834.5398552173638;3838.696781930847;3839.289731399686;3846.076941534033;3855.749376290532;3652.707783377337;3676.74262801604;3865.903352416184;3867.57456679765;3873.4383514390397;3816.484774555427;3819.2552452271816;3830.195658911632;3844.692424606025;3853.113783829721;3812.4281357796276;3826.8660596879113;3833.3291673956946;3850.8267127979307;3870.53553573573;3422.57217847769;3423.5720534933134;3426.7601267911255;3439.7764145330475;3450.6549345065546;4579.381783459224;4720.12677654635;4751.904961900777;4755.738434386108;4777.996620709655;4357.891052723676;4365.279728844768;4386.210482113218;4392.494863090754;4394.143142087294;5054.873628159288;5067.0879241736475;5072;5084.186530155194;5112.798492354294;3603.4774957631257;3674.5590529136675;3699.6300369962787;3709.4250391189407;3716.3310604091253;5251.212318152269;5270.49930256625;5281.287026251445;5281.524662780368;5288.810017745976;3785.9432108518395;3814.1799513104816;3814.294355544233;3818.4654148419245;3829.7893615851394;3750.1937083527173;3842.269968705937;3867.806609669505;3873.767573945572;3877.1276462795645;4251.681123915657;4321.481422229353;4326.956730432656;4330.242207613718;4341.435613370241;4992.900141997213;5013.373328333958;5059.266406371055;5106.617003724661;5108.438071812097;1257.5535684831937;1271.8855303022588;1306.203216038216;1319.1886989501388;1325.2512330533218;854.197054768528;855.9700410485603;874.152072489684;877.9648814047495;883.5891310540501;3949.5063117110362;3967.960320396759;3980.2238563480423;4003.399490076512;4008.318585840356;4637.655080026754;4639.396878405786;4649.418822647169;4655.766221951186;4661.482799288414;4000.819963101609;4022.396640503889;4023.786917195531;4030.2745505809235;4043.2924238258774;2289.1644549739226;2460.6678098456837;2509.7866681332293;2522.092046863128;2530.5445019896597;4359.433273674402;4391.209582275157;4403.515613282536;4423.8009289581405;4425.5574442556135;4645.883852903637;4708.411448568861;4725.787339569728;4763.237881938873;4765.451973023078;4327.100842435576;4402.327115696015;4582.427196600425;4977.60179185657;4994.70031798086;5279.762410691451;5281.577473802164;5306.4794222743885;5307.593487725833;5310.707911064928;5178.844634660966;5181.430042695376;5228.3987341454695;5232.607554433509;5262.97368513155;4696.436427628706;4976.104301225814;4978.800847966186;4979.3526841510375;4995.925061124013;3760.266747984226;3760.849566017438;3763.5295588051495;3782.905427364338;3795.449659799369;5047.268146118866;5283.550898173698;5309.761060752198;5321.2816269804625;5323.494268044529;4968.503149685002;5106.872328191825;5114.900296436284;5122.385313762373;5124.5131712487255;5064.569511591556;5072.416672082758;5097.566706829961;5098.515641014098;5103.18349064148;4776.259679749644;5043.36957880265;5054.1696649876185;5055.443901170795;5060.165072762953;5157.587393008625;5173.094708426086;5176.058977883294;5190.169572868323;5199.220116982483;4982.377202849644;5019.498050194951;5073.467285935071;5078.162103252922;5079.517445842639 10:05:08 INFO - PROCESS | 7127 | |5;yui.html;689.2693744630689;722.8626560953421;731.6159016516328;739.0724640576076;756.1870988687161;12745.426455809487;13509.594712158627;13557.322133893304;13559.932200338984;13564.389602467889;13045.08684392093;13193.076484646079;13285.269310187936;13286.667833304173;13296.933515332434;613.5398451161628;756.5611945071872;758.8140905478166;775.5966897213445;784.3607459920175;775.0699161006786;779.8596252674516;781.8983532140813;783.0134031120772;783.1307248953685;831.0359982420393;836.3351135847016;836.6946064686376;837.1753822484878;837.2632083766308;643.6685107169787;656.3174298729316;658.2890478283442;663.3167837127767;828.5153185386556;590.0971513584223;598.5421152818097;604.3442864492032;605.2494906316181;605.4550904186268;13015;13067.803982940264;13073.803892941614;13078.542251021263;13087;12025.458854351575;12064.577739779066;12666.303353315563;12681.858632723099;12807.103502754811;11731.53073877044;12100.939495302555;12427.627171184879;12479.438425270793;12717.554885579053;4142.8763769279585;4151.169766046773;4151.3150330195485;4158.428661782793;4283.0363168287195;61558.92205389713;62430.68784656093;62768.68615656938;62846.685766570874;62989.68505157491;9909.75225619351;10523.10553602937;10634.361938283573;10653;10954.835677464844;17668.204930778145;17683.823161768476;18440.446786596425;18634.347797827282;18664.253429862925;6728.125343705287;6751;6799.864002719918;6841.692123854438;6847.897281540781;3759.3984962405884;3796.7911764853197;3829.272438236726;3849.2301539692176;3963.504561929759;2778.19432364612;2876.4103358811394;2879.5248783950833;2886.523723585627;2890.2485353807742;491.14540699183163;497.34847349971653;500.61952915784263;506.845412149298;507.6801614982537;432.51990290777843;452.88451444882;465.2277219815091;524.5226843572331;544.4664229055547;7186.245444228385;7409.147947985943;7513.910482979937;7523.172451030382;7639.770806875803;379.7322887364401;430.3781036402369;476.6710969431081;501.86198795330847;515.6927189574411;3521.4717792331357;3692.9815350923072;3714.981425092857;3808.7714737115307;3831.50190475242;91217;96403.51798240964;99292;100043.49978250063;100081.49959250157;50663.49336506661;64233.678831605546;82033.58983205046;86222.56888715517;86693.56653216694;70864.64567677128;72770.63614681999;74343.25656743471;74362.25637743661;74372.25627743654;6754.966225168842;7015.298470153148;7126.251743566851;7185.748498802517;7199.06412166415;44285.33571996358;44613.55386446094;44865.87835304013;45456.772716136205;46483.30275045945;55399.723001386345;63289;64980;65831;66548.66725666341;9543.52282385864;9605.18355939725;9612.395351743096;11133.88866111361;11411.25826821254;12837.358132093172;13154.34228288601;13245.337733113112;13884.028118031641;13905.930470347988;11948.76102477963;12353.444095015566;12373.13388062827;12432.254064756144;12493.500259989498;11958.521659133537;12019.21875078117;12709.110362274552;12733.236005839679;12979;11891.405429728651;12161.087918406332;12357.691057723629;13011.154274972096;13025.674358141123;9893.752656183653;10469.842952355873;10561.531168876072;10722.410267435365;10742.785144297226;9186.356955013085;9984.301098923297;10023.198144148304;10061.496925153859;10073 10:05:08 INFO - PROCESS | 7127 | __end_tp_report 10:05:08 INFO - PROCESS | 7127 | __start_cc_report 10:05:08 INFO - PROCESS | 7127 | _x_x_mozilla_cycle_collect,1062 10:05:08 INFO - PROCESS | 7127 | __end_cc_report 10:05:08 INFO - PROCESS | 7127 | __startTimestamp1466787908640__endTimestamp 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | ------- Summary: start ------- 10:05:08 INFO - PROCESS | 7127 | Number of tests: 6 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | [#0] dojo.html Cycles:165 Average:4742.37 Median:4828.49 stddev:497.17 (10.3%) stddev-sans-first:470.64 10:05:08 INFO - PROCESS | 7127 | Values: 2643.5 2644.9 2682.3 2685.9 2688.9 4622.2 4706.8 4716.9 4763.1 4828.5 4734.1 4742.0 4748.4 4761.2 4763.0 4177.4 4325.9 4425.9 4449.8 4564.3 4433.8 4494.1 4498.7 4505.4 4536.8 4309.9 4370.0 4431.0 4501.1 4503.2 4365.9 4401.2 4427.0 4463.8 4487.6 4432.9 4449.3 4452.1 4466.2 4489.3 4691.8 4736.8 4753.6 4806.3 4817.6 5196.1 5206.5 5211.6 5214.1 5214.9 5142.6 5176.6 5179.5 5189.6 5193.2 4596.6 4718.8 4780.8 4785.9 4846.2 5257.9 5281.3 5299.5 5301.0 5310.4 4814.9 5054.4 5067.1 5067.2 5067.9 4992.3 5068.1 5116.1 5139.1 5140.8 5044.9 5053.4 5056.3 5057.4 5077.6 4895.7 4993.5 5018.7 5045.7 5062.4 4402.7 4423.7 4443.4 4480.6 4482.5 3854.2 3855.3 3864.8 3889.4 3895.2 4242.7 4273.3 4399.9 4441.9 4449.8 5092.9 5137.3 5149.7 5150.7 5169.9 4336.7 4349.3 4364.0 4374.5 4387.9 4501.3 4591.1 4595.8 4622.3 4640.2 4798.8 4802.3 4823.6 4847.0 4866.8 5165.3 5166.9 5167.7 5170.9 5199.9 4672.1 4780.3 4803.4 4814.0 4824.3 5116.9 5141.8 5142.2 5150.0 5198.2 5184.0 5195.9 5197.9 5210.8 5253.2 4830.4 4875.5 4942.2 4961.6 5059.7 4980.9 4984.8 5002.1 5014.9 5053.2 4918.5 4927.9 4933.8 5010.4 5020.1 4884.4 5021.7 5047.3 5080.5 5084.4 4942.2 4948.4 4974.8 4979.5 5018.3 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | [#1] ext.html Cycles:180 Average:47074.03 Median:34712.24 stddev:84714.37 (244.0%) stddev-sans-first:84879.95 10:05:08 INFO - PROCESS | 7127 | Values: 536.7 575.4 581.0 588.3 593.2 29089.0 29367.4 39357.4 40304.2 40400.4 42299.6 42595.6 42607.4 42645.8 42648.4 7794.0 7924.2 7926.0 7936.3 7945.4 7588.5 10153.6 10326.9 10446.8 10850.9 10481.7 10563.4 10574.0 10575.5 10576.8 7642.6 10194.2 10424.5 10511.4 10526.5 9895.7 10280.4 10288.6 10289.2 10293.8 39649.2 40071.0 40086.6 40102.2 40121.6 3094.5 3104.7 3370.9 3652.7 3720.7 29973.6 30191.4 30256.5 30895.4 31075.0 3635.2 3641.6 3690.3 3713.4 3748.5 261071.0 262432.7 262826.0 263039.0 263988.0 31788.2 33388.3 54285.7 55428.0 55576.7 33404.8 33777.5 33819.2 33861.7 33868.0 12506.6 12704.4 12748.9 12750.0 12766.4 9497.4 11251.1 11319.5 11497.9 11610.7 7891.8 7895.2 7933.1 7978.3 8029.0 3013.4 3077.1 3092.3 3094.1 3096.5 781.4 858.0 876.5 952.9 976.1 27329.0 27368.9 27450.6 28071.4 28531.4 958.2 993.8 1049.3 1076.8 1087.1 14564.7 14730.7 15026.8 15135.9 15254.7 379488.0 379515.0 382228.0 383615.0 384013.0 51059.5 51477.5 51478.7 51509.0 51510.0 1066.0 1159.4 1176.6 1205.5 1205.8 27976.0 29056.0 29218.4 29405.0 29774.7 43269.0 43381.3 44011.1 44057.0 44071.8 308424.0 311049.0 311164.0 311428.0 311553.0 33046.0 37246.3 38743.8 38865.6 41942.4 41714.0 41852.8 42487.4 42570.6 43485.3 35734.5 36628.5 37310.4 37404.0 37623.4 36308.3 36528.6 36534.6 36769.4 37266.6 35867.8 36040.8 36197.3 36467.3 37672.1 33126.0 33973.8 34476.3 34691.8 34732.7 24788.8 25262.4 25472.9 25761.1 25806.9 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | [#2] jquery.html Cycles:180 Average:25889.39 Median:439702.50 stddev:71112.63 (16.2%) stddev-sans-first:71286.29 10:05:08 INFO - PROCESS | 7127 | Values: 363.4 365.2 367.4 367.6 385.8 15773.6 16969.0 17348.5 17352.2 17394.0 15521.7 16481.0 16851.6 16902.4 17326.4 4815.6 5053.1 5083.9 5088.7 5098.3 3648.5 4946.1 5505.8 5926.9 5950.8 5862.3 5916.3 5983.9 5984.8 5985.0 5607.8 5810.2 5816.2 5822.2 5824.3 3290.5 4832.2 5109.8 5147.7 5196.6 20042.6 20649.6 20775.4 20816.5 20910.2 1853.1 1885.1 1907.5 1921.5 1962.3 12553.9 12995.7 13033.7 13387.9 13391.6 1694.2 1723.1 1757.7 1783.3 1814.2 65000.7 66882.3 67116.7 67209.3 67448.0 9478.7 9719.8 9814.5 10506.4 10549.7 13016.7 13079.8 13152.5 13160.1 13182.0 7179.4 7369.2 7450.3 7525.8 7534.2 7002.0 7064.2 7161.4 7207.1 7209.1 5900.6 6020.1 6115.5 6172.9 6228.5 1626.5 1681.9 1758.9 1769.1 1777.4 861.8 873.8 886.9 919.5 933.8 15711.5 16779.2 17548.2 18025.4 18035.8 860.2 864.0 881.8 891.3 913.4 9350.9 9627.8 10318.1 10347.4 10353.5 415103.0 421127.0 439111.0 440294.0 441626.0 80638.6 84265.0 84721.6 84807.6 85422.1 921.6 924.7 927.0 948.1 950.6 15762.6 15796.4 15987.3 16147.6 16490.1 39318.2 39652.8 39775.6 39997.6 40383.2 49313.3 49498.3 52980.0 53917.0 55282.7 7617.6 7715.3 7739.5 7849.4 7864.2 11542.8 11658.0 11823.9 11832.1 12339.3 9947.0 9994.7 10089.2 10429.3 10433.7 10369.4 10434.7 10440.5 10510.4 10742.2 10468.8 10661.1 10704.2 10753.2 10789.6 7736.1 7772.0 7817.5 7838.3 7888.3 7841.5 9668.7 10082.7 10256.3 10356.2 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | [#3] mootools.html Cycles:180 Average:5204.37 Median:5263.59 stddev:2927.95 (55.6%) stddev-sans-first:2921.29 10:05:08 INFO - PROCESS | 7127 | Values: 1277.0 1395.1 1421.1 1509.4 1725.6 7414.2 7778.8 7791.5 7800.8 7989.4 7450.1 7692.2 7868.7 7872.7 7877.5 2207.9 2259.5 2260.0 2261.8 2263.3 2263.2 2284.2 2300.8 2304.0 2306.9 2236.6 2249.7 2277.9 2282.5 2283.1 2162.1 2178.2 2193.9 2198.3 2200.3 2145.7 2146.5 2148.1 2149.4 2151.5 7561.8 7805.4 7914.5 7973.3 7983.1 4692.7 4812.8 4822.6 4824.3 4826.8 2788.6 2956.1 2991.7 3008.9 3016.2 910.6 919.0 931.4 933.1 938.7 10763.1 10939.7 10949.9 10981.8 10989.7 4221.8 4338.5 4404.3 4411.1 4470.1 9261.9 9317.2 9326.9 9336.4 9345.5 4712.0 4742.2 4805.4 4805.5 4805.9 3608.9 3812.6 4243.3 4268.8 4325.6 3798.1 3849.6 3871.2 3902.0 3909.7 1212.8 1212.9 1219.1 1225.6 1236.2 786.3 786.4 799.5 799.9 867.9 5104.3 5257.5 5269.7 5292.7 5315.0 865.8 867.2 894.2 948.2 986.3 3467.0 3581.1 3586.6 3599.6 3631.8 9501.4 9735.7 9911.8 9912.7 9916.3 9566.7 9736.3 9845.4 9872.9 9876.2 7446.2 7460.8 7546.0 7547.6 7550.5 5045.0 5130.8 5149.1 5226.2 5311.6 8795.3 9072.8 9177.4 9341.6 9409.3 9261.3 9438.4 9439.4 9445.5 9610.4 5822.0 6359.1 6536.5 6543.1 6678.3 7663.9 7689.5 7722.5 7727.0 7749.3 6501.4 6695.7 6708.7 6752.9 6825.8 6579.9 6590.7 6612.6 6683.8 6707.2 6169.3 6198.2 6239.1 6267.4 6314.3 4556.2 4576.8 4579.8 4640.9 4644.4 4492.7 4536.7 4536.8 4539.5 4541.9 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | [#4] prototype.html Cycles:180 Average:4157.95 Median:4640.14 stddev:1204.92 (26.0%) stddev-sans-first:1172.76 10:05:08 INFO - PROCESS | 7127 | Values: 287.5 290.7 300.2 304.8 312.5 4642.7 4809.2 4827.3 4827.8 4858.6 4640.9 4791.8 4806.6 4814.3 4823.2 3834.5 3838.7 3839.3 3846.1 3855.7 3652.7 3676.7 3865.9 3867.6 3873.4 3816.5 3819.3 3830.2 3844.7 3853.1 3812.4 3826.9 3833.3 3850.8 3870.5 3422.6 3423.6 3426.8 3439.8 3450.7 4579.4 4720.1 4751.9 4755.7 4778.0 4357.9 4365.3 4386.2 4392.5 4394.1 5054.9 5067.1 5072.0 5084.2 5112.8 3603.5 3674.6 3699.6 3709.4 3716.3 5251.2 5270.5 5281.3 5281.5 5288.8 3785.9 3814.2 3814.3 3818.5 3829.8 3750.2 3842.3 3867.8 3873.8 3877.1 4251.7 4321.5 4327.0 4330.2 4341.4 4992.9 5013.4 5059.3 5106.6 5108.4 1257.6 1271.9 1306.2 1319.2 1325.3 854.2 856.0 874.2 878.0 883.6 3949.5 3968.0 3980.2 4003.4 4008.3 4637.7 4639.4 4649.4 4655.8 4661.5 4000.8 4022.4 4023.8 4030.3 4043.3 2289.2 2460.7 2509.8 2522.1 2530.5 4359.4 4391.2 4403.5 4423.8 4425.6 4645.9 4708.4 4725.8 4763.2 4765.5 4327.1 4402.3 4582.4 4977.6 4994.7 5279.8 5281.6 5306.5 5307.6 5310.7 5178.8 5181.4 5228.4 5232.6 5263.0 4696.4 4976.1 4978.8 4979.4 4995.9 3760.3 3760.8 3763.5 3782.9 3795.4 5047.3 5283.6 5309.8 5321.3 5323.5 4968.5 5106.9 5114.9 5122.4 5124.5 5064.6 5072.4 5097.6 5098.5 5103.2 4776.3 5043.4 5054.2 5055.4 5060.2 5157.6 5173.1 5176.1 5190.2 5199.2 4982.4 5019.5 5073.5 5078.2 5079.5 10:05:08 INFO - PROCESS | 7127 | 10:05:08 INFO - PROCESS | 7127 | [#5] yui.html Cycles:180 Average:17549.21 Median:22659.38 stddev:24715.30 (109.1%) stddev-sans-first:24752.21 10:05:08 INFO - PROCESS | 7127 | Values: 689.3 722.9 731.6 739.1 756.2 12745.4 13509.6 13557.3 13559.9 13564.4 13045.1 13193.1 13285.3 13286.7 13296.9 613.5 756.6 758.8 775.6 784.4 775.1 779.9 781.9 783.0 783.1 831.0 836.3 836.7 837.2 837.3 643.7 656.3 658.3 663.3 828.5 590.1 598.5 604.3 605.2 605.5 13015.0 13067.8 13073.8 13078.5 13087.0 12025.5 12064.6 12666.3 12681.9 12807.1 11731.5 12100.9 12427.6 12479.4 12717.6 4142.9 4151.2 4151.3 4158.4 4283.0 61558.9 62430.7 62768.7 62846.7 62989.7 9909.8 10523.1 10634.4 10653.0 10954.8 17668.2 17683.8 18440.4 18634.3 18664.3 6728.1 6751.0 6799.9 6841.7 6847.9 3759.4 3796.8 3829.3 3849.2 3963.5 2778.2 2876.4 2879.5 2886.5 2890.2 491.1 497.3 500.6 506.8 507.7 432.5 452.9 465.2 524.5 544.5 7186.2 7409.1 7513.9 7523.2 7639.8 379.7 430.4 476.7 501.9 515.7 3521.5 3693.0 3715.0 3808.8 3831.5 91217.0 96403.5 99292.0 100043.5 100081.5 50663.5 64233.7 82033.6 86222.6 86693.6 70864.6 72770.6 74343.3 74362.3 74372.3 6755.0 7015.3 7126.3 7185.7 7199.1 44285.3 44613.6 44865.9 45456.8 46483.3 55399.7 63289.0 64980.0 65831.0 66548.7 9543.5 9605.2 9612.4 11133.9 11411.3 12837.4 13154.3 13245.3 13884.0 13905.9 11948.8 12353.4 12373.1 12432.3 12493.5 11958.5 12019.2 12709.1 12733.2 12979.0 11891.4 12161.1 12357.7 13011.2 13025.7 9893.8 10469.8 10561.5 10722.4 10742.8 9186.4 9984.3 10023.2 10061.5 10073.0 10:05:08 INFO - PROCESS | 7127 | -------- Summary: end -------- 10:05:08 INFO - PROCESS | 7127 | 10:05:09 INFO - TEST-INFO | 7127: exit 0 10:05:09 INFO - TEST-OK | dromaeo_css | took 1120026ms 10:05:09 INFO - TEST-START | kraken 10:05:09 INFO - operating with platform_type : linux_ 10:05:09 INFO - Initialising browser for kraken test... 10:05:09 INFO - TEST-INFO | started process 7305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsM34G/profile http://localhost:38401/getInfo.html) 10:05:13 INFO - PROCESS | 7305 | __metrics Screen width/height:1600/1200 10:05:13 INFO - PROCESS | 7305 | colorDepth:24 10:05:13 INFO - PROCESS | 7305 | Browser inner width/height: 1024/697 10:05:13 INFO - PROCESS | 7305 | __metrics 10:05:14 INFO - PROCESS | 7305 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:15 INFO - TEST-INFO | 7305: exit 0 10:05:15 INFO - Browser initialized. 10:05:15 INFO - Running cycle 1/1 for kraken test... 10:05:15 INFO - TEST-INFO | started process 7385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsM34G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:28 INFO - PROCESS | 7385 | RSS: Main: 175591424 10:05:28 INFO - PROCESS | 7385 | 10:05:30 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38401/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:31 INFO - PROCESS | 7385 | RSS: Main: 233443328 10:05:31 INFO - PROCESS | 7385 | 10:05:34 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38401/tests/kraken/driver.html?testName=audio-dft) 10:05:35 INFO - PROCESS | 7385 | RSS: Main: 221376512 10:05:35 INFO - PROCESS | 7385 | 10:05:38 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38401/tests/kraken/driver.html?testName=audio-fft) 10:05:39 INFO - PROCESS | 7385 | RSS: Main: 288796672 10:05:39 INFO - PROCESS | 7385 | 10:05:41 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38401/tests/kraken/driver.html?testName=audio-oscillator) 10:05:41 INFO - PROCESS | 7385 | RSS: Main: 198926336 10:05:41 INFO - PROCESS | 7385 | 10:05:44 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:44 INFO - PROCESS | 7385 | RSS: Main: 203055104 10:05:44 INFO - PROCESS | 7385 | 10:05:47 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38401/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:48 INFO - PROCESS | 7385 | RSS: Main: 238178304 10:05:48 INFO - PROCESS | 7385 | 10:05:51 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38401/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:52 INFO - PROCESS | 7385 | RSS: Main: 234446848 10:05:52 INFO - PROCESS | 7385 | 10:05:55 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38401/tests/kraken/driver.html?testName=json-parse-financial) 10:05:56 INFO - PROCESS | 7385 | RSS: Main: 236929024 10:05:56 INFO - PROCESS | 7385 | 10:05:57 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:58 INFO - PROCESS | 7385 | RSS: Main: 221757440 10:05:58 INFO - PROCESS | 7385 | 10:06:00 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:00 INFO - PROCESS | 7385 | RSS: Main: 226459648 10:06:00 INFO - PROCESS | 7385 | 10:06:03 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:03 INFO - PROCESS | 7385 | RSS: Main: 235364352 10:06:03 INFO - PROCESS | 7385 | 10:06:06 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:07 INFO - PROCESS | 7385 | RSS: Main: 239443968 10:06:07 INFO - PROCESS | 7385 | 10:06:10 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:10 INFO - PROCESS | 7385 | RSS: Main: 239751168 10:06:10 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | Cycle 1(1): loaded http://localhost:38401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38401/tests/kraken/driver.html?testName=ai-astar) 10:06:12 INFO - PROCESS | 7385 | RSS: Main: 282247168 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | __start_tp_report 10:06:12 INFO - PROCESS | 7385 | _x_x_mozilla_page_load 10:06:12 INFO - PROCESS | 7385 | _x_x_mozilla_page_load_details 10:06:12 INFO - PROCESS | 7385 | |i|pagename|runs| 10:06:12 INFO - PROCESS | 7385 | |0;ai-astar;106;114;112;114;116;113;113;116;113;114 10:06:12 INFO - PROCESS | 7385 | |1;audio-beat-detection;174;131;133;189;141;132;165;141;210;131 10:06:12 INFO - PROCESS | 7385 | |2;audio-dft;163;163;163;164;162;165;165;163;164;164 10:06:12 INFO - PROCESS | 7385 | |3;audio-fft;77;76;77;102;76;77;76;77;99;77 10:06:12 INFO - PROCESS | 7385 | |4;audio-oscillator;89;87;117;88;89;87;124;86;87;129 10:06:12 INFO - PROCESS | 7385 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 10:06:12 INFO - PROCESS | 7385 | |6;imaging-darkroom;148;146;149;149;149;148;147;148;147;148 10:06:12 INFO - PROCESS | 7385 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;94 10:06:12 INFO - PROCESS | 7385 | |8;json-parse-financial;65;64;66;65;66;65;65;66;66;65 10:06:12 INFO - PROCESS | 7385 | |9;json-stringify-tinderbox;64;66;65;65;67;67;66;65;66;65 10:06:12 INFO - PROCESS | 7385 | |10;stanford-crypto-aes;84;84;84;82;82;82;83;84;95;82 10:06:12 INFO - PROCESS | 7385 | |11;stanford-crypto-ccm;132;136;131;149;130;142;138;132;138;144 10:06:12 INFO - PROCESS | 7385 | |12;stanford-crypto-pbkdf2;173;177;173;170;178;176;181;174;174;173 10:06:12 INFO - PROCESS | 7385 | |13;stanford-crypto-sha256-iterative;68;71;74;68;68;69;73;77;66;66 10:06:12 INFO - PROCESS | 7385 | __end_tp_report 10:06:12 INFO - PROCESS | 7385 | __start_cc_report 10:06:12 INFO - PROCESS | 7385 | _x_x_mozilla_cycle_collect,1910 10:06:12 INFO - PROCESS | 7385 | __end_cc_report 10:06:12 INFO - PROCESS | 7385 | __startTimestamp1466787972841__endTimestamp 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | ------- Summary: start ------- 10:06:12 INFO - PROCESS | 7385 | Number of tests: 14 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.81 (2.5%) stddev-sans-first:1.36 10:06:12 INFO - PROCESS | 7385 | Values: 106.0 114.0 112.0 114.0 116.0 113.0 113.0 116.0 113.0 114.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:153.00 stddev:28.28 (18.5%) stddev-sans-first:29.12 10:06:12 INFO - PROCESS | 7385 | Values: 174.0 131.0 133.0 189.0 141.0 132.0 165.0 141.0 210.0 131.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 10:06:12 INFO - PROCESS | 7385 | Values: 163.0 163.0 163.0 164.0 162.0 165.0 165.0 163.0 164.0 164.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#3] audio-fft Cycles:10 Average:81.40 Median:77.00 stddev:10.10 (13.1%) stddev-sans-first:10.59 10:06:12 INFO - PROCESS | 7385 | Values: 77.0 76.0 77.0 102.0 76.0 77.0 76.0 77.0 99.0 77.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:87.00 stddev:17.53 (20.2%) stddev-sans-first:18.27 10:06:12 INFO - PROCESS | 7385 | Values: 89.0 87.0 117.0 88.0 89.0 87.0 124.0 86.0 87.0 129.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:06:12 INFO - PROCESS | 7385 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 10:06:12 INFO - PROCESS | 7385 | Values: 148.0 146.0 149.0 149.0 149.0 148.0 147.0 148.0 147.0 148.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:06:12 INFO - PROCESS | 7385 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 94.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 10:06:12 INFO - PROCESS | 7385 | Values: 65.0 64.0 66.0 65.0 66.0 65.0 65.0 66.0 66.0 65.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 10:06:12 INFO - PROCESS | 7385 | Values: 64.0 66.0 65.0 65.0 67.0 67.0 66.0 65.0 66.0 65.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:3.91 (4.7%) stddev-sans-first:4.15 10:06:12 INFO - PROCESS | 7385 | Values: 84.0 84.0 84.0 82.0 82.0 82.0 83.0 84.0 95.0 82.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:138.00 stddev:6.29 (4.6%) stddev-sans-first:6.38 10:06:12 INFO - PROCESS | 7385 | Values: 132.0 136.0 131.0 149.0 130.0 142.0 138.0 132.0 138.0 144.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.00 stddev:3.14 (1.8%) stddev-sans-first:3.26 10:06:12 INFO - PROCESS | 7385 | Values: 173.0 177.0 173.0 170.0 178.0 176.0 181.0 174.0 174.0 173.0 10:06:12 INFO - PROCESS | 7385 | 10:06:12 INFO - PROCESS | 7385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:3.65 (5.2%) stddev-sans-first:3.80 10:06:12 INFO - PROCESS | 7385 | Values: 68.0 71.0 74.0 68.0 68.0 69.0 73.0 77.0 66.0 66.0 10:06:12 INFO - PROCESS | 7385 | -------- Summary: end -------- 10:06:12 INFO - PROCESS | 7385 | 10:06:13 INFO - TEST-INFO | 7385: exit 0 10:06:13 INFO - TEST-OK | kraken | took 64426ms 10:06:13 INFO - SUITE-END | took 1184s 10:06:13 INFO - Completed test suite (00:19:44) 10:06:14 INFO - javascript benchmark 10:06:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.5109504741636, 2644.9074282400115, 2682.289193363758, 2685.8657067146646, 2688.905888293909, 4622.214223581991, 4706.764661766911, 4716.85849424517, 4763.14263432582, 4828.493008234133, 4734.053189362124, 4742.0, 4748.4301883774, 4761.2143996240575, 4763.0, 4177.415161877339, 4325.87022389328, 4425.911481770363, 4449.777511124431, 4564.269716845305, 4433.756143412111, 4494.101179764044, 4498.685092043558, 4505.43682039745, 4536.773161341936, 4309.913801723948, 4369.956300437018, 4430.977845110754, 4501.144782491317, 4503.166914120865, 4365.934510982338, 4401.207782599131, 4426.977865110686, 4463.821447142111, 4487.618552423048, 4432.867013989586, 4449.310356894686, 4452.131834292314, 4466.240739074366, 4489.281714925629, 4691.835785747517, 4736.786844592001, 4753.619710423158, 4806.303086052538, 4817.566419022305, 5196.0647083524955, 5206.479352064801, 5211.557017653504, 5214.139666954948, 5214.921776173361, 5142.61430392722, 5176.559992400613, 5179.507946745053, 5189.55888749453, 5193.221016847466, 4596.6092882105395, 4718.764061796896, 4780.832670856504, 4785.904281914342, 4846.200376937836, 5257.921131183035, 5281.339832520935, 5299.4700529946695, 5301.045811753845, 5310.389305229948, 4814.903701925942, 5054.393472783216, 5067.08792417361, 5067.163917953497, 5067.923981140286, 4992.301077849104, 5068.138416469209, 5116.130257856174, 5139.12634852076, 5140.768665410065, 5044.899102018013, 5053.444121146671, 5056.26684130799, 5057.393112826484, 5077.644564880423, 4895.730734809548, 4993.50064993505, 5018.723970181602, 5045.747712614355, 5062.392512898476, 4402.669799765031, 4423.668224883147, 4443.422355093881, 4480.551944805494, 4482.484514280899, 3854.2291541691775, 3855.3060449118866, 3864.8260828262796, 3889.4360317753767, 3895.2209558088493, 4242.745435273831, 4273.273543497613, 4399.934000989988, 4441.888952776142, 4449.844255451044, 5092.9236061459105, 5137.33214682089, 5149.665271757323, 5150.665206761549, 5169.870753231124, 4336.718113322687, 4349.28236840924, 4364.018095928454, 4374.540673229329, 4387.868363949086, 4501.3248012797685, 4591.104734576726, 4595.793189306489, 4622.329762184464, 4640.23436133041, 4798.832040878552, 4802.27965805132, 4823.5658790709, 4846.975765121081, 4866.829660961849, 5165.276861239505, 5166.922496162636, 5167.6641018333685, 5170.922436163385, 5199.922001170061, 4672.088942656285, 4780.259059845729, 4803.447603525499, 4813.95186048135, 4824.324594556695, 5116.8720781979255, 5141.768620412166, 5142.1772516397195, 5149.9742501287255, 5198.194279886624, 5184.040952423814, 5195.870103247449, 5197.870053248699, 5210.817621383233, 5253.185756207794, 4830.4444988826735, 4875.488073752205, 4942.20924652054, 4961.578265847444, 5059.721715305694, 4980.8754781130765, 4984.775685094107, 5002.099622068063, 5014.874628134326, 5053.191489361684, 4918.508149185053, 4927.876803079808, 4933.777979990838, 5010.448850626501, 5020.071286811952, 4884.438289596742, 5021.748912554284, 5047.2681461187185, 5080.466551012239, 5084.41529224144, 4942.233953737176, 4948.356713627206, 4974.825881094144, 4979.502049794992, 5018.347614810197], "value": 4710.706174650452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.70513364051, 575.4044563876388, 581.0441823200838, 588.3322429043035, 593.2317648645005, 29089.0, 29367.412651746978, 39357.40963885544, 40304.19391612166, 40400.39399409004, 42299.57700422995, 42595.57404425955, 42607.36088958668, 42645.7867710661, 42648.36027459583, 7794.025746781666, 7924.247196516321, 7925.9603701981405, 7936.325412339958, 7945.404094692893, 7588.506747061451, 10153.644622438216, 10326.896731032668, 10446.791064178711, 10850.945745271263, 10481.73795655111, 10563.366198028105, 10574.0, 10575.524101415454, 10576.78846423071, 7642.5796581188015, 10194.23543234253, 10424.478776061205, 10511.421871797049, 10526.473676316153, 9895.65365212214, 10280.383177009404, 10288.639897603623, 10289.176865850714, 10293.845592316122, 39649.20701585952, 40071.0, 40086.599134008575, 40102.19795604071, 40121.59878401208, 3094.5048792193143, 3104.6895310469, 3370.898873033813, 3652.6712595866234, 3720.720945929039, 29973.550396744067, 30191.396172076435, 30256.54615180774, 30895.382092358253, 31075.0, 3635.2296520693, 3641.578350397009, 3690.335739566877, 3713.442983552489, 3748.5314335708035, 261071.0, 262432.6878365615, 262826.0, 263039.0, 263988.0, 31788.20529486735, 33388.3322333552, 54285.72857135768, 55428.0, 55576.72211638916, 33404.832975834965, 33777.49333759995, 33819.15452113717, 33861.661383386345, 33868.0, 12506.562270320495, 12704.42830072649, 12748.936255318664, 12750.0, 12766.425510852034, 9497.43015419077, 11251.099912007183, 11319.547218111184, 11497.942510287396, 11610.6516804496, 7891.802704932423, 7895.171007044178, 7933.127355990837, 7978.321842643324, 8029.0, 3013.3973205359016, 3077.07687693691, 3092.304231547884, 3094.1491089950446, 3096.504559270506, 781.4373650971291, 857.9871301930476, 876.4960147914975, 952.9142377186087, 976.1312431935582, 27329.0, 27368.905243790425, 27450.5882411764, 28071.43857122887, 28531.429371412454, 958.1999030809213, 993.7913038261902, 1049.2550289294534, 1076.784643071389, 1087.1194332590626, 14564.708705826037, 14730.705385892223, 15026.849731502763, 15135.864810139283, 15254.708182016744, 379488.0, 379515.0, 382228.0, 383615.0, 384013.0, 51059.489405106215, 51477.48522514727, 51478.74260628673, 51509.0, 51510.0, 1065.973350666224, 1159.3913195572222, 1176.5999560149419, 1205.5057426455112, 1205.7769312677183, 27976.0, 29056.0, 29218.415631687672, 29405.0, 29774.70225297806, 43269.0, 43381.3492797602, 44011.11977760363, 44057.0, 44071.77964110287, 308424.0, 311049.0, 311164.0, 311428.0, 311553.0, 33046.0, 37246.255074898894, 38743.80628096954, 38865.61134388733, 41942.370864436445, 41714.0, 41852.79073604734, 42487.3626895603, 42570.57429425666, 43485.3477197836, 35734.46398303976, 36628.45057324089, 37310.440343395414, 37404.0, 37623.43564846584, 36308.27383452369, 36528.634713653584, 36534.63465365419, 36769.448458272615, 37266.62733372632, 35867.82066089653, 36040.819795900854, 36197.27605447929, 36467.26495512794, 37672.05819854526, 33126.00621981345, 33973.83013084919, 34476.31047378988, 34691.826540867136, 34732.65267347395, 24788.752112479367, 25262.368440789127, 25472.872635636704, 25761.098361557255, 25806.870965645052], "value": 17296.349950174805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.4294158171671, 365.23665539023455, 367.4103064581346, 367.557093702089, 385.7531180044772, 15773.60565985851, 16969.0, 17348.479545613653, 17352.21915013826, 17394.043327616975, 15521.68956620867, 16481.0, 16851.57871053224, 16902.408415705453, 17326.393576224833, 4815.5906747926465, 5053.140966035783, 5083.923741143886, 5088.745562721849, 5098.26075219093, 3648.4709717091005, 4946.084974279752, 5505.779768809243, 5926.851828704273, 5950.821475355746, 5862.32583252925, 5916.319623243339, 5983.850403739898, 5984.790532331369, 5985.042393217086, 5607.831765047055, 5810.215620891167, 5816.185733997223, 5822.214001109838, 5824.30108386992, 3290.52287418323, 4832.178529649933, 5109.770060347293, 5147.6654017488745, 5196.558292545138, 20042.599148017103, 20649.5870082599, 20775.37673869786, 20816.47958801027, 20910.163593456244, 1853.0827240515896, 1885.1328388941104, 1907.4754442528415, 1921.490804936693, 1962.3328068456792, 12553.874461255453, 12995.675108122277, 13033.739325213442, 13387.933060334733, 13391.598252052454, 1694.1783235130952, 1723.112597012527, 1757.6572568349177, 1783.3223375117502, 1814.1836173721879, 65000.67499662519, 66882.3311766881, 67116.66441667761, 67209.32790672079, 67448.0, 9478.668246611336, 9719.757006074904, 9814.509274536245, 10506.369617822955, 10549.736256593493, 13016.739665206644, 13079.803802942963, 13152.539661112007, 13160.14459060158, 13182.0, 7179.353858152791, 7369.152547457111, 7450.329470347695, 7525.8118547036765, 7534.171241163468, 7001.964990175016, 7064.1876184238445, 7161.427085833121, 7207.13514378278, 7209.134903811576, 5900.64596124234, 6020.127081573235, 6115.4801841843055, 6172.925868926487, 6228.4705800007505, 1626.463267121847, 1681.8563376903578, 1758.859291256722, 1769.1066011664284, 1777.3601503459004, 861.8405594964952, 873.7553485024204, 886.8980067292215, 919.4804935211585, 933.780561568031, 15711.450099246471, 16779.244933977756, 17548.210330535156, 18025.369112081014, 18035.819641803413, 860.2300940658201, 864.0495454999576, 881.828043531518, 891.3359547137425, 913.36064754672, 9350.859737103949, 9627.759306017406, 10318.122959548373, 10347.43089130105, 10353.482325883826, 415103.0, 421127.0, 439111.0, 440294.0, 441626.0, 80638.5968070156, 84265.0, 84721.57639211764, 84807.5759621198, 85422.14577854142, 921.6221349246777, 924.7179610218948, 926.9536523173814, 948.1324588002038, 950.5769932380025, 15762.645797727222, 15796.36814527452, 15987.280572374038, 16147.596310091873, 16490.093044882167, 39318.2136357277, 39652.80173599113, 39775.60224397719, 39997.60002399939, 40383.192336152526, 49313.26030109623, 49498.25752613786, 52980.0, 53917.0, 55282.72358638181, 7617.581033043236, 7715.305622494003, 7739.496932699357, 7849.411294152847, 7864.21357864209, 11542.826857596974, 11658.0, 11823.881761182622, 11832.11259155584, 12339.259644421363, 9946.950265248917, 9994.650187243411, 10089.243306751876, 10429.26995110335, 10433.686989390331, 10369.377837329785, 10434.68695939123, 10440.530176142243, 10510.421926794099, 10742.19433542503, 10468.842967355344, 10661.134301497052, 10704.197185211297, 10753.247272690836, 10789.62236321725, 7736.149023607286, 7771.950786643957, 7817.5309481431295, 7838.255365740246, 7888.290053895177, 7841.451098423056, 9668.661596844076, 10082.747931301776, 10256.28206025601, 10356.223283253636], "value": 8452.86016196964, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.9553065642704, 1395.1350162899, 1421.1402101728454, 1509.3886975774808, 1725.6203635200259, 7414.184439711634, 7778.766637000892, 7791.493552919056, 7800.804979875499, 7989.400794940374, 7450.0687414073245, 7692.230776922319, 7868.685252589904, 7872.724454644089, 7877.487963282382, 2207.867527948324, 2259.5029093599383, 2259.9661005084854, 2261.7851304126166, 2263.287064574662, 2263.241813992306, 2284.189112864934, 2300.804431623314, 2304.0323064312943, 2306.873121978299, 2236.586231547169, 2249.7300323961067, 2277.943051423711, 2282.4522114692436, 2283.086765293879, 2162.0703097667997, 2178.194068194762, 2193.8903054847356, 2198.2525941179997, 2200.2959053103014, 2145.7210562626915, 2146.5384942237492, 2148.140743702516, 2149.408912549046, 2151.526664133888, 7561.810954726121, 7805.41459390548, 7914.485558438683, 7973.282404583558, 7983.081945576275, 4692.694974826625, 4812.831550895702, 4822.565969062766, 4824.324594556765, 4826.7827947742435, 2788.63747712796, 2956.1131660501765, 2991.7457016153653, 3008.939821203586, 3016.245938515371, 910.5765818894246, 919.0011724499187, 931.4271722890373, 933.0529512544772, 938.666773295484, 10763.085137763299, 10939.671809845717, 10949.905009499065, 10981.835272470918, 10989.725256868562, 4221.810018549173, 4338.457692788402, 4404.251277282806, 4411.051623900877, 4470.105978804252, 9261.907380926239, 9317.208037316768, 9326.860097098548, 9336.439813611205, 9345.48599827016, 4712.034033023222, 4742.19382704941, 4805.423349198119, 4805.471398146201, 4805.879853003703, 3608.9097772555897, 3812.5996770338716, 4243.2998555238655, 4268.807903644343, 4325.589069038437, 3798.1074447504816, 3849.57654657993, 3871.2451072041245, 3901.96098039016, 3909.706771992112, 1212.7877621416394, 1212.902967762577, 1219.1039585904352, 1225.5710501324643, 1236.1841184818156, 786.3394748411362, 786.4219798448136, 799.5043073294478, 799.8520273749375, 867.9001914779755, 5104.259882317043, 5257.5005374489365, 5269.683818970874, 5292.690475952794, 5314.97342513285, 865.7532603208056, 867.1848462445281, 894.2086253665423, 948.2224575847877, 986.2504496582649, 3467.01190160803, 3581.068922080226, 3586.55168103987, 3599.586047604507, 3631.763935344194, 9501.429914205031, 9735.659251926148, 9911.801763964824, 9912.653057142965, 9916.305858589829, 9566.66516671913, 9736.269779766404, 9845.409275443353, 9872.901270987342, 9876.160526355197, 7446.180920098785, 7460.813479662943, 7545.962270188724, 7547.584882831387, 7550.509216900884, 5045.0, 5130.820421285237, 5149.073166830007, 5226.189940559219, 5311.601629877852, 8795.296376290009, 9072.818543628959, 9177.449353038839, 9341.626334946526, 9409.29430292717, 9261.259099272176, 9438.38650487716, 9439.386439881386, 9445.52772361393, 9610.375325603813, 5822.0, 6359.07793369968, 6536.509761767791, 6543.083968244355, 6678.332166783477, 7663.88504172449, 7689.538627682133, 7722.459427839997, 7726.961365193138, 7749.341305988829, 6501.414872661483, 6695.665216739046, 6708.664566771739, 6752.864942701217, 6825.761098361533, 6579.901301480386, 6590.736370545316, 6612.636305003271, 6683.799486015428, 6707.228668703162, 6169.290531588746, 6198.163247961467, 6239.0953311768635, 6267.435930766253, 6314.305426403183, 4556.225441674989, 4576.839810606612, 4579.793909274024, 4640.93038604428, 4644.442666879996, 4492.73043617384, 4536.6824322297125, 4536.841210557614, 4539.5006549280215, 4541.886452838706], "value": 4192.582032170006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.45814140345453, 290.67734814356066, 300.17002986741664, 304.7820808122192, 312.5078002146618, 4642.651801114921, 4809.158397280479, 4827.324174615556, 4827.755093881345, 4858.5627293543575, 4640.886187315045, 4791.808327666889, 4806.591439727618, 4814.253790662444, 4823.204171311738, 3834.5398552173638, 3838.696781930847, 3839.289731399686, 3846.076941534033, 3855.749376290532, 3652.707783377337, 3676.74262801604, 3865.903352416184, 3867.57456679765, 3873.4383514390397, 3816.484774555427, 3819.2552452271816, 3830.195658911632, 3844.692424606025, 3853.113783829721, 3812.4281357796276, 3826.8660596879113, 3833.3291673956946, 3850.8267127979307, 3870.53553573573, 3422.57217847769, 3423.5720534933134, 3426.7601267911255, 3439.7764145330475, 3450.6549345065546, 4579.381783459224, 4720.12677654635, 4751.904961900777, 4755.738434386108, 4777.996620709655, 4357.891052723676, 4365.279728844768, 4386.210482113218, 4392.494863090754, 4394.143142087294, 5054.873628159288, 5067.0879241736475, 5072.0, 5084.186530155194, 5112.798492354294, 3603.4774957631257, 3674.5590529136675, 3699.6300369962787, 3709.4250391189407, 3716.3310604091253, 5251.212318152269, 5270.49930256625, 5281.287026251445, 5281.524662780368, 5288.810017745976, 3785.9432108518395, 3814.1799513104816, 3814.294355544233, 3818.4654148419245, 3829.7893615851394, 3750.1937083527173, 3842.269968705937, 3867.806609669505, 3873.767573945572, 3877.1276462795645, 4251.681123915657, 4321.481422229353, 4326.956730432656, 4330.242207613718, 4341.435613370241, 4992.900141997213, 5013.373328333958, 5059.266406371055, 5106.617003724661, 5108.438071812097, 1257.5535684831937, 1271.8855303022588, 1306.203216038216, 1319.1886989501388, 1325.2512330533218, 854.197054768528, 855.9700410485603, 874.152072489684, 877.9648814047495, 883.5891310540501, 3949.5063117110362, 3967.960320396759, 3980.2238563480423, 4003.399490076512, 4008.318585840356, 4637.655080026754, 4639.396878405786, 4649.418822647169, 4655.766221951186, 4661.482799288414, 4000.819963101609, 4022.396640503889, 4023.786917195531, 4030.2745505809235, 4043.2924238258774, 2289.1644549739226, 2460.6678098456837, 2509.7866681332293, 2522.092046863128, 2530.5445019896597, 4359.433273674402, 4391.209582275157, 4403.515613282536, 4423.8009289581405, 4425.5574442556135, 4645.883852903637, 4708.411448568861, 4725.787339569728, 4763.237881938873, 4765.451973023078, 4327.100842435576, 4402.327115696015, 4582.427196600425, 4977.60179185657, 4994.70031798086, 5279.762410691451, 5281.577473802164, 5306.4794222743885, 5307.593487725833, 5310.707911064928, 5178.844634660966, 5181.430042695376, 5228.3987341454695, 5232.607554433509, 5262.97368513155, 4696.436427628706, 4976.104301225814, 4978.800847966186, 4979.3526841510375, 4995.925061124013, 3760.266747984226, 3760.849566017438, 3763.5295588051495, 3782.905427364338, 3795.449659799369, 5047.268146118866, 5283.550898173698, 5309.761060752198, 5321.2816269804625, 5323.494268044529, 4968.503149685002, 5106.872328191825, 5114.900296436284, 5122.385313762373, 5124.5131712487255, 5064.569511591556, 5072.416672082758, 5097.566706829961, 5098.515641014098, 5103.18349064148, 4776.259679749644, 5043.36957880265, 5054.1696649876185, 5055.443901170795, 5060.165072762953, 5157.587393008625, 5173.094708426086, 5176.058977883294, 5190.169572868323, 5199.220116982483, 4982.377202849644, 5019.498050194951, 5073.467285935071, 5078.162103252922, 5079.517445842639], "value": 3777.1379359593625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.2693744630689, 722.8626560953421, 731.6159016516328, 739.0724640576076, 756.1870988687161, 12745.426455809487, 13509.594712158627, 13557.322133893304, 13559.932200338984, 13564.389602467889, 13045.08684392093, 13193.076484646079, 13285.269310187936, 13286.667833304173, 13296.933515332434, 613.5398451161628, 756.5611945071872, 758.8140905478166, 775.5966897213445, 784.3607459920175, 775.0699161006786, 779.8596252674516, 781.8983532140813, 783.0134031120772, 783.1307248953685, 831.0359982420393, 836.3351135847016, 836.6946064686376, 837.1753822484878, 837.2632083766308, 643.6685107169787, 656.3174298729316, 658.2890478283442, 663.3167837127767, 828.5153185386556, 590.0971513584223, 598.5421152818097, 604.3442864492032, 605.2494906316181, 605.4550904186268, 13015.0, 13067.803982940264, 13073.803892941614, 13078.542251021263, 13087.0, 12025.458854351575, 12064.577739779066, 12666.303353315563, 12681.858632723099, 12807.103502754811, 11731.53073877044, 12100.939495302555, 12427.627171184879, 12479.438425270793, 12717.554885579053, 4142.8763769279585, 4151.169766046773, 4151.3150330195485, 4158.428661782793, 4283.0363168287195, 61558.92205389713, 62430.68784656093, 62768.68615656938, 62846.685766570874, 62989.68505157491, 9909.75225619351, 10523.10553602937, 10634.361938283573, 10653.0, 10954.835677464844, 17668.204930778145, 17683.823161768476, 18440.446786596425, 18634.347797827282, 18664.253429862925, 6728.125343705287, 6751.0, 6799.864002719918, 6841.692123854438, 6847.897281540781, 3759.3984962405884, 3796.7911764853197, 3829.272438236726, 3849.2301539692176, 3963.504561929759, 2778.19432364612, 2876.4103358811394, 2879.5248783950833, 2886.523723585627, 2890.2485353807742, 491.14540699183163, 497.34847349971653, 500.61952915784263, 506.845412149298, 507.6801614982537, 432.51990290777843, 452.88451444882, 465.2277219815091, 524.5226843572331, 544.4664229055547, 7186.245444228385, 7409.147947985943, 7513.910482979937, 7523.172451030382, 7639.770806875803, 379.7322887364401, 430.3781036402369, 476.6710969431081, 501.86198795330847, 515.6927189574411, 3521.4717792331357, 3692.9815350923072, 3714.981425092857, 3808.7714737115307, 3831.50190475242, 91217.0, 96403.51798240964, 99292.0, 100043.49978250063, 100081.49959250157, 50663.49336506661, 64233.678831605546, 82033.58983205046, 86222.56888715517, 86693.56653216694, 70864.64567677128, 72770.63614681999, 74343.25656743471, 74362.25637743661, 74372.25627743654, 6754.966225168842, 7015.298470153148, 7126.251743566851, 7185.748498802517, 7199.06412166415, 44285.33571996358, 44613.55386446094, 44865.87835304013, 45456.772716136205, 46483.30275045945, 55399.723001386345, 63289.0, 64980.0, 65831.0, 66548.66725666341, 9543.52282385864, 9605.18355939725, 9612.395351743096, 11133.88866111361, 11411.25826821254, 12837.358132093172, 13154.34228288601, 13245.337733113112, 13884.028118031641, 13905.930470347988, 11948.76102477963, 12353.444095015566, 12373.13388062827, 12432.254064756144, 12493.500259989498, 11958.521659133537, 12019.21875078117, 12709.110362274552, 12733.236005839679, 12979.0, 11891.405429728651, 12161.087918406332, 12357.691057723629, 13011.154274972096, 13025.674358141123, 9893.752656183653, 10469.842952355873, 10561.531168876072, 10722.410267435365, 10742.785144297226, 9186.356955013085, 9984.301098923297, 10023.198144148304, 10061.496925153859, 10073.0], "value": 6490.6675714807125, "unit": "score"}], "name": "dromaeo_css", "value": 6431.878408716906, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 112.0, 114.0, 116.0, 113.0, 113.0, 116.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 131.0, 133.0, 189.0, 141.0, 132.0, 165.0, 141.0, 210.0, 131.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 162.0, 165.0, 165.0, 163.0, 164.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 102.0, 76.0, 77.0, 76.0, 77.0, 99.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 117.0, 88.0, 89.0, 87.0, 124.0, 86.0, 87.0, 129.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 149.0, 149.0, 149.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 67.0, 67.0, 66.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 82.0, 82.0, 82.0, 83.0, 84.0, 95.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 131.0, 149.0, 130.0, 142.0, 138.0, 132.0, 138.0, 144.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 173.0, 170.0, 178.0, 176.0, 181.0, 174.0, 174.0, 173.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 74.0, 68.0, 68.0, 69.0, 73.0, 77.0, 66.0, 66.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1568.4, "alertThreshold": 2.0}]} 10:06:14 INFO - Return code: 0 10:06:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:06:14 INFO - # TBPL SUCCESS # 10:06:14 INFO - Running post-action listener: _resource_record_post_action 10:06:14 INFO - ##### 10:06:14 INFO - ##### Finished run-tests step (success) 10:06:14 INFO - ##### 10:06:14 INFO - Running post-run listener: _resource_record_post_run 10:06:14 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544256000; Read time: 12; Write time: 551460 10:06:14 INFO - TinderboxPrint: CPU usage
13.2% 10:06:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:06:14 INFO - TinderboxPrint: I/O write bytes / time
544,256,000 / 551,460 10:06:14 INFO - TinderboxPrint: CPU idle
8,322.2 (86.8%) 10:06:14 INFO - TinderboxPrint: CPU user
1,220.3 (12.7%) 10:06:14 INFO - TinderboxPrint: Swap in / out
0 / 0 10:06:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246403072; Read time: 0; Write time: 327776 10:06:14 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297852928; Read time: 12; Write time: 223684 10:06:14 INFO - Running post-run listener: _upload_blobber_files 10:06:14 INFO - Blob upload gear active. 10:06:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:06:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:06:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:06:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:18 INFO - (blobuploader) - INFO - Done attempting. 10:06:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:19 INFO - (blobuploader) - INFO - Done attempting. 10:06:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:20 INFO - (blobuploader) - INFO - Done attempting. 10:06:20 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:20 INFO - Return code: 0 10:06:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05ea1acef497a93d83536c3c7908848a583b560cbdb61e00addd8e6f92b50e90b9bcabb48c679b2265cc83eff6846c9bb7899173abfbfea7698b05ba0504faab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec400d6e12eebe7cb70c142c8e7f1fdd466b784e28ad1c8ec8f1c215536f505dc45ab7c2395e5f8e0e5ccf48c4449d260f4836bbcd6c5f2f979063255ed0554c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d03a8b12576f3fadb34819d7967d326edb2ea178b00e53aa2db6800bc3a9953b7ba4df73119c93a7fc0822b5d8adf094c9821b50dfc9d4cb042330779b226ca6"} 10:06:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:20 INFO - Contents: 10:06:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05ea1acef497a93d83536c3c7908848a583b560cbdb61e00addd8e6f92b50e90b9bcabb48c679b2265cc83eff6846c9bb7899173abfbfea7698b05ba0504faab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec400d6e12eebe7cb70c142c8e7f1fdd466b784e28ad1c8ec8f1c215536f505dc45ab7c2395e5f8e0e5ccf48c4449d260f4836bbcd6c5f2f979063255ed0554c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d03a8b12576f3fadb34819d7967d326edb2ea178b00e53aa2db6800bc3a9953b7ba4df73119c93a7fc0822b5d8adf094c9821b50dfc9d4cb042330779b226ca6"} 10:06:20 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:20 INFO - Copying logs to upload dir... 10:06:20 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.974821 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-24 10:06:19.079905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:06:19.084104) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05ea1acef497a93d83536c3c7908848a583b560cbdb61e00addd8e6f92b50e90b9bcabb48c679b2265cc83eff6846c9bb7899173abfbfea7698b05ba0504faab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec400d6e12eebe7cb70c142c8e7f1fdd466b784e28ad1c8ec8f1c215536f505dc45ab7c2395e5f8e0e5ccf48c4449d260f4836bbcd6c5f2f979063255ed0554c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d03a8b12576f3fadb34819d7967d326edb2ea178b00e53aa2db6800bc3a9953b7ba4df73119c93a7fc0822b5d8adf094c9821b50dfc9d4cb042330779b226ca6"} build_url:https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/a56j5VJxTaG2gZiy0EESig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05ea1acef497a93d83536c3c7908848a583b560cbdb61e00addd8e6f92b50e90b9bcabb48c679b2265cc83eff6846c9bb7899173abfbfea7698b05ba0504faab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec400d6e12eebe7cb70c142c8e7f1fdd466b784e28ad1c8ec8f1c215536f505dc45ab7c2395e5f8e0e5ccf48c4449d260f4836bbcd6c5f2f979063255ed0554c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d03a8b12576f3fadb34819d7967d326edb2ea178b00e53aa2db6800bc3a9953b7ba4df73119c93a7fc0822b5d8adf094c9821b50dfc9d4cb042330779b226ca6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 10:06:19.113247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:06:19.113855) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1466786734.912392-1763931325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004730 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 10:06:19.197872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:06:19.198239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 10:06:19.198634) ========= ========= Total master_lag: 0.16 =========