builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1470421696.23 results: success (0) buildid: 20160805083232 builduid: bd4e1c93d5d8473d80442959eaf9071b revision: 940aa720c00e423769d315c858ec782b38a29626 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.233593) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.234197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.234534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.251068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.251730) ========= 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=4300f881736b422476174874000001bc-1470421695.433413-780139583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 11:28:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.5M=0s 2016-08-05 11:28:16 (51.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.370744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.371174) ========= 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=4300f881736b422476174874000001bc-1470421695.433413-780139583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:16.421430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 11:28:16.421830) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 940aa720c00e423769d315c858ec782b38a29626 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 940aa720c00e423769d315c858ec782b38a29626 --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=4300f881736b422476174874000001bc-1470421695.433413-780139583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 11:28:16,572 truncating revision to first 12 chars 2016-08-05 11:28:16,572 Setting DEBUG logging. 2016-08-05 11:28:16,572 attempt 1/10 2016-08-05 11:28:16,572 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/940aa720c00e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 11:28:17,545 unpacking tar archive at: mozilla-beta-940aa720c00e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.298333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-05 11:28:17.735661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:17.736378) ========= script_repo_revision: 940aa720c00e423769d315c858ec782b38a29626 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:17.737444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:17.737757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 11:28:17.748900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-05 11:28:17.749359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=4300f881736b422476174874000001bc-1470421695.433413-780139583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:28:17 INFO - MultiFileLogger online at 20160805 11:28:17 in /builds/slave/test 11:28:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:28:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:28:17 INFO - {'append_to_log': False, 11:28:17 INFO - 'base_work_dir': '/builds/slave/test', 11:28:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:28:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:28:17 INFO - 'branch': 'Mozilla-Beta', 11:28:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:28:17 INFO - 'config_files': ('talos/linux_config.py',), 11:28:17 INFO - 'default_actions': ('clobber', 11:28:17 INFO - 'read-buildbot-config', 11:28:17 INFO - 'download-and-extract', 11:28:17 INFO - 'populate-webroot', 11:28:17 INFO - 'create-virtualenv', 11:28:17 INFO - 'install', 11:28:17 INFO - 'run-tests'), 11:28:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:28:17 INFO - 'download_minidump_stackwalk': True, 11:28:17 INFO - 'download_symbols': 'ondemand', 11:28:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:28:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:28:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:28:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:28:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:28:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:28:17 INFO - 'installer_path': 'installer.exe', 11:28:17 INFO - 'log_level': 'info', 11:28:17 INFO - 'log_name': 'talos', 11:28:17 INFO - 'log_to_console': True, 11:28:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:28:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:28:17 INFO - 'opt_config_files': (), 11:28:17 INFO - 'pip_index': False, 11:28:17 INFO - 'sps_profile': False, 11:28:17 INFO - 'sps_profile_interval': 0, 11:28:17 INFO - 'suite': 'dromaeojs', 11:28:17 INFO - 'system_bits': '32', 11:28:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:28:17 INFO - 'title': 'talos-linux64-ix-045', 11:28:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:28:17 INFO - 'use_talos_json': True, 11:28:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:28:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:28:17 INFO - 'work_dir': 'build'} 11:28:17 INFO - ##### 11:28:17 INFO - ##### Running clobber step. 11:28:17 INFO - ##### 11:28:17 INFO - Running pre-action listener: _resource_record_pre_action 11:28:17 INFO - Running main action method: clobber 11:28:17 INFO - rmtree: /builds/slave/test/build 11:28:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:28:18 INFO - Running post-action listener: _resource_record_post_action 11:28:18 INFO - ##### 11:28:18 INFO - ##### Finished clobber step (success) 11:28:18 INFO - ##### 11:28:18 INFO - ##### 11:28:18 INFO - ##### Running read-buildbot-config step. 11:28:18 INFO - ##### 11:28:18 INFO - Running pre-action listener: _resource_record_pre_action 11:28:18 INFO - Running main action method: read_buildbot_config 11:28:18 INFO - Using buildbot properties: 11:28:18 INFO - { 11:28:18 INFO - "project": "", 11:28:18 INFO - "product": "firefox", 11:28:18 INFO - "script_repo_revision": "production", 11:28:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:28:18 INFO - "repository": "", 11:28:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:28:18 INFO - "buildid": "20160805083232", 11:28:18 INFO - "pgo_build": "True", 11:28:18 INFO - "basedir": "/builds/slave/test", 11:28:18 INFO - "buildnumber": 192, 11:28:18 INFO - "slavename": "talos-linux64-ix-045", 11:28:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:28:18 INFO - "platform": "ubuntu64_hw", 11:28:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:28:18 INFO - "branch": "mozilla-beta", 11:28:18 INFO - "repo_path": "releases/mozilla-beta", 11:28:18 INFO - "revision": "940aa720c00e423769d315c858ec782b38a29626", 11:28:18 INFO - "stage_platform": "linux64-pgo", 11:28:18 INFO - "builduid": "bd4e1c93d5d8473d80442959eaf9071b", 11:28:18 INFO - "slavebuilddir": "test" 11:28:18 INFO - } 11:28:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 11:28:18 INFO - Running post-action listener: _resource_record_post_action 11:28:18 INFO - ##### 11:28:18 INFO - ##### Finished read-buildbot-config step (success) 11:28:18 INFO - ##### 11:28:18 INFO - ##### 11:28:18 INFO - ##### Running download-and-extract step. 11:28:18 INFO - ##### 11:28:18 INFO - Running pre-action listener: _resource_record_pre_action 11:28:18 INFO - Running main action method: download_and_extract 11:28:18 INFO - mkdir: /builds/slave/test/build/tests 11:28:18 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')]} 11:28:18 INFO - https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:28:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:28:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:28:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:28:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:28:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:28:18 INFO - retry: Failed, sleeping 30 seconds before retrying 11:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 11:28:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:28:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:28:48 INFO - retry: Failed, sleeping 60 seconds before retrying 11:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 11:29:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:29:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:29:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json! 11:29:48 INFO - Caught exception: HTTP Error 404: Not Found 11:29:48 INFO - Caught exception: HTTP Error 404: Not Found 11:29:48 INFO - Caught exception: HTTP Error 404: Not Found 11:29:48 INFO - trying https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:29:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:29:49 INFO - Downloaded 1327 bytes. 11:29:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:29:49 INFO - Using the following test package requirements: 11:29:49 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:29:49 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:29:49 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:29:49 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'jsshell-linux-x86_64.zip'], 11:29:49 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:29:49 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:29:49 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:29:49 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:29:49 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:29:49 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:29:49 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:29:49 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:29: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')]} 11:29:49 INFO - https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:29:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:29:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:29:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:29:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:29:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:29:49 INFO - retry: Failed, sleeping 30 seconds before retrying 11:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 11:30:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:30:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:30:19 INFO - retry: Failed, sleeping 60 seconds before retrying 11:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 11:31:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:31:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 11:31:19 INFO - Caught exception: HTTP Error 404: Not Found 11:31:19 INFO - Caught exception: HTTP Error 404: Not Found 11:31:19 INFO - Caught exception: HTTP Error 404: Not Found 11:31:19 INFO - trying https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:31:20 INFO - Downloaded 21968359 bytes. 11:31:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:31:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:31:21 INFO - Return code: 0 11:31:21 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:31:21 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')]} 11:31:21 INFO - https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:31:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:31:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:31:21 INFO - retry: Failed, sleeping 30 seconds before retrying 11:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 11:31:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:31:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:31:51 INFO - retry: Failed, sleeping 60 seconds before retrying 11:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 11:32:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:32:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:32:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 11:32:51 INFO - Caught exception: HTTP Error 404: Not Found 11:32:51 INFO - Caught exception: HTTP Error 404: Not Found 11:32:51 INFO - Caught exception: HTTP Error 404: Not Found 11:32:51 INFO - trying https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:32:51 INFO - Downloading https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:32:52 INFO - Downloaded 21968359 bytes. 11:32:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:32:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:32:53 INFO - Return code: 0 11:32:53 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')]} 11:32:53 INFO - https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:32:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:32:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:32:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:32:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:32:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:32:53 INFO - retry: Failed, sleeping 30 seconds before retrying 11:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 11:33:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:33:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:33:23 INFO - retry: Failed, sleeping 60 seconds before retrying 11:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 11:34:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:34:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:34:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip! 11:34:23 INFO - Caught exception: HTTP Error 404: Not Found 11:34:23 INFO - Caught exception: HTTP Error 404: Not Found 11:34:23 INFO - Caught exception: HTTP Error 404: Not Found 11:34:23 INFO - trying https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:34:25 INFO - Downloaded 10833369 bytes. 11:34:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:34:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:34:25 INFO - Return code: 0 11:34:25 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')]} 11:34:25 INFO - https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:34:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:34:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:34:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:34:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:34:25 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:34:25 INFO - retry: Failed, sleeping 30 seconds before retrying 11:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 11:34:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:34:55 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:34:55 INFO - retry: Failed, sleeping 60 seconds before retrying 11:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 11:35:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:35:55 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:35:55 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2! 11:35:55 INFO - Caught exception: HTTP Error 404: Not Found 11:35:55 INFO - Caught exception: HTTP Error 404: Not Found 11:35:55 INFO - Caught exception: HTTP Error 404: Not Found 11:35:55 INFO - trying https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:35:57 INFO - Downloaded 55300868 bytes. 11:35:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:35:57 INFO - mkdir: /builds/slave/test/properties 11:35:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:35:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:35:57 INFO - Contents: 11:35:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:35:58 INFO - Running post-action listener: _resource_record_post_action 11:35:58 INFO - Running post-action listener: set_extra_try_arguments 11:35:58 INFO - ##### 11:35:58 INFO - ##### Finished download-and-extract step (success) 11:35:58 INFO - ##### 11:35:58 INFO - ##### 11:35:58 INFO - ##### Running populate-webroot step. 11:35:58 INFO - ##### 11:35:58 INFO - Running pre-action listener: _resource_record_pre_action 11:35:58 INFO - Running main action method: populate_webroot 11:35:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:35:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:35:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:35:58 INFO - '--tppagecycles', 11:35:58 INFO - '7'], 11:35:58 INFO - 'tests': ['tsvgm']}}, 11:35:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:35:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:35:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:35:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:35:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['damp', 'tps']}, 11:35:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'tests': ['damp', 'tps']}, 11:35:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['dromaeo_dom']}, 11:35:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:35:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['a11yr', 11:35:58 INFO - 'ts_paint', 11:35:58 INFO - 'tpaint', 11:35:58 INFO - 'sessionrestore', 11:35:58 INFO - 'sessionrestore_no_auto_restore', 11:35:58 INFO - 'tabpaint']}, 11:35:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:35:58 INFO - 'ts_paint', 11:35:58 INFO - 'tpaint', 11:35:58 INFO - 'sessionrestore', 11:35:58 INFO - 'sessionrestore_no_auto_restore', 11:35:58 INFO - 'tabpaint']}, 11:35:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:35:58 INFO - 'ts_paint', 11:35:58 INFO - 'tpaint', 11:35:58 INFO - 'sessionrestore', 11:35:58 INFO - 'sessionrestore_no_auto_restore', 11:35:58 INFO - 'tabpaint']}, 11:35:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:35:58 INFO - 'ts_paint', 11:35:58 INFO - 'tpaint', 11:35:58 INFO - 'sessionrestore', 11:35:58 INFO - 'sessionrestore_no_auto_restore', 11:35:58 INFO - 'tabpaint']}, 11:35:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['a11yr', 11:35:58 INFO - 'ts_paint', 11:35:58 INFO - 'tpaint', 11:35:58 INFO - 'sessionrestore', 11:35:58 INFO - 'sessionrestore_no_auto_restore', 11:35:58 INFO - 'tabpaint']}, 11:35:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['a11yr', 11:35:58 INFO - 'ts_paint', 11:35:58 INFO - 'tpaint', 11:35:58 INFO - 'sessionrestore', 11:35:58 INFO - 'sessionrestore_no_auto_restore', 11:35:58 INFO - 'tabpaint']}, 11:35:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['tsvgx', 11:35:58 INFO - 'tsvgr_opacity', 11:35:58 INFO - 'tart', 11:35:58 INFO - 'tscrollx', 11:35:58 INFO - 'cart']}, 11:35:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:35:58 INFO - 'tsvgr_opacity', 11:35:58 INFO - 'tart', 11:35:58 INFO - 'tscrollx', 11:35:58 INFO - 'cart']}, 11:35:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'talos_options': ['--disable-e10s'], 11:35:58 INFO - 'tests': ['tp5o']}, 11:35:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'tests': ['tp5o']}, 11:35:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'talos_options': ['--disable-e10s', 11:35:58 INFO - '--xperf_path', 11:35:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:58 INFO - 'tests': ['tp5n']}, 11:35:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:35:58 INFO - 'talos_options': ['--xperf_path', 11:35:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:58 INFO - 'tests': ['tp5n']}}, 11:35:58 INFO - 'talos.zip': {'path': '', 11:35:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:35:58 INFO - Running post-action listener: _resource_record_post_action 11:35:58 INFO - ##### 11:35:58 INFO - ##### Finished populate-webroot step (success) 11:35:58 INFO - ##### 11:35:58 INFO - ##### 11:35:58 INFO - ##### Running create-virtualenv step. 11:35:58 INFO - ##### 11:35:58 INFO - Running pre-action listener: _resource_record_pre_action 11:35:58 INFO - Running main action method: create_virtualenv 11:35:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:35:58 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 11:35:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:35:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:35:58 INFO - Using real prefix '/usr' 11:35:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:35:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:36:00 INFO - Installing pip.................done. 11:36:00 INFO - Return code: 0 11:36:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:36:00 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')]} 11:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:00 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')]} 11:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:00 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:00 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 11:36:00 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 11:36:00 INFO - Using env: {'DISPLAY': ':0', 11:36:00 INFO - 'HOME': '/home/cltbld', 11:36:00 INFO - 'LANG': 'en_US.UTF-8', 11:36:00 INFO - 'LANGUAGE': 'en_US:en', 11:36:00 INFO - 'LOGNAME': 'cltbld', 11:36:00 INFO - 'MAIL': '/var/mail/cltbld', 11:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:00 INFO - 'MOZ_NO_REMOTE': '1', 11:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:00 INFO - 'NO_EM_RESTART': '1', 11:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:00 INFO - 'PWD': '/builds/slave/test', 11:36:00 INFO - 'SHELL': '/bin/bash', 11:36:00 INFO - 'SHLVL': '1', 11:36:00 INFO - 'TERM': 'linux', 11:36:00 INFO - 'TMOUT': '86400', 11:36:00 INFO - 'USER': 'cltbld', 11:36:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:00 INFO - '_': '/tools/buildbot/bin/python'} 11:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:01 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 11:36:01 INFO - Cleaning up... 11:36:01 INFO - Return code: 0 11:36:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:01 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:01 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 11:36:01 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 11:36:01 INFO - Using env: {'DISPLAY': ':0', 11:36:01 INFO - 'HOME': '/home/cltbld', 11:36:01 INFO - 'LANG': 'en_US.UTF-8', 11:36:01 INFO - 'LANGUAGE': 'en_US:en', 11:36:01 INFO - 'LOGNAME': 'cltbld', 11:36:01 INFO - 'MAIL': '/var/mail/cltbld', 11:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:01 INFO - 'MOZ_NO_REMOTE': '1', 11:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:01 INFO - 'NO_EM_RESTART': '1', 11:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:01 INFO - 'PWD': '/builds/slave/test', 11:36:01 INFO - 'SHELL': '/bin/bash', 11:36:01 INFO - 'SHLVL': '1', 11:36:01 INFO - 'TERM': 'linux', 11:36:01 INFO - 'TMOUT': '86400', 11:36:01 INFO - 'USER': 'cltbld', 11:36:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:01 INFO - '_': '/tools/buildbot/bin/python'} 11:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:01 INFO - Downloading/unpacking psutil>=3.1.1 11:36:01 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 11:36:01 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 11:36:01 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 11:36:01 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 11:36:01 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 11:36:01 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 11:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:03 INFO - Installing collected packages: psutil 11:36:03 INFO - Running setup.py install for psutil 11:36:03 INFO - building 'psutil._psutil_linux' extension 11:36:03 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 11:36:03 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 11:36:03 INFO - building 'psutil._psutil_posix' extension 11:36:03 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 11:36:03 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 11:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:03 INFO - Successfully installed psutil 11:36:03 INFO - Cleaning up... 11:36:03 INFO - Return code: 0 11:36:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:36:03 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')]} 11:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:03 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')]} 11:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:03 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:03 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 11:36:03 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 11:36:03 INFO - Using env: {'DISPLAY': ':0', 11:36:03 INFO - 'HOME': '/home/cltbld', 11:36:03 INFO - 'LANG': 'en_US.UTF-8', 11:36:03 INFO - 'LANGUAGE': 'en_US:en', 11:36:03 INFO - 'LOGNAME': 'cltbld', 11:36:03 INFO - 'MAIL': '/var/mail/cltbld', 11:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:03 INFO - 'MOZ_NO_REMOTE': '1', 11:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:03 INFO - 'NO_EM_RESTART': '1', 11:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:03 INFO - 'PWD': '/builds/slave/test', 11:36:03 INFO - 'SHELL': '/bin/bash', 11:36:03 INFO - 'SHLVL': '1', 11:36:03 INFO - 'TERM': 'linux', 11:36:03 INFO - 'TMOUT': '86400', 11:36:03 INFO - 'USER': 'cltbld', 11:36:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:03 INFO - '_': '/tools/buildbot/bin/python'} 11:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:36:03 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 11:36:03 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 11:36:03 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 11:36:03 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 11:36:03 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 11:36:03 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 11:36:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:36:05 INFO - Installing collected packages: mozsystemmonitor 11:36:05 INFO - Running setup.py install for mozsystemmonitor 11:36:06 INFO - Successfully installed mozsystemmonitor 11:36:06 INFO - Cleaning up... 11:36:06 INFO - Return code: 0 11:36:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:36:06 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')]} 11:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:06 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')]} 11:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:06 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:06 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 11:36:06 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 11:36:06 INFO - Using env: {'DISPLAY': ':0', 11:36:06 INFO - 'HOME': '/home/cltbld', 11:36:06 INFO - 'LANG': 'en_US.UTF-8', 11:36:06 INFO - 'LANGUAGE': 'en_US:en', 11:36:06 INFO - 'LOGNAME': 'cltbld', 11:36:06 INFO - 'MAIL': '/var/mail/cltbld', 11:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:06 INFO - 'MOZ_NO_REMOTE': '1', 11:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:06 INFO - 'NO_EM_RESTART': '1', 11:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:06 INFO - 'PWD': '/builds/slave/test', 11:36:06 INFO - 'SHELL': '/bin/bash', 11:36:06 INFO - 'SHLVL': '1', 11:36:06 INFO - 'TERM': 'linux', 11:36:06 INFO - 'TMOUT': '86400', 11:36:06 INFO - 'USER': 'cltbld', 11:36:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:06 INFO - '_': '/tools/buildbot/bin/python'} 11:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:06 INFO - Downloading/unpacking jsonschema==2.5.1 11:36:06 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 11:36:06 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 11:36:06 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 11:36:06 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 11:36:06 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 11:36:06 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 11:36:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:36:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:36:08 INFO - warning: no files found matching '*.txt' 11:36:08 INFO - no previously-included directories found matching 'build' 11:36:08 INFO - no previously-included directories found matching 'dist' 11:36:08 INFO - no previously-included directories found matching '.git*' 11:36:08 INFO - Installing collected packages: jsonschema, functools32 11:36:08 INFO - Running setup.py install for functools32 11:36:08 INFO - warning: no files found matching '*.txt' 11:36:08 INFO - no previously-included directories found matching 'build' 11:36:08 INFO - no previously-included directories found matching 'dist' 11:36:08 INFO - no previously-included directories found matching '.git*' 11:36:08 INFO - Successfully installed jsonschema functools32 11:36:08 INFO - Cleaning up... 11:36:08 INFO - Return code: 0 11:36:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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', '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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:36: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 blobuploader==1.2.4 11:36:08 INFO - Using env: {'DISPLAY': ':0', 11:36:08 INFO - 'HOME': '/home/cltbld', 11:36:08 INFO - 'LANG': 'en_US.UTF-8', 11:36:08 INFO - 'LANGUAGE': 'en_US:en', 11:36:08 INFO - 'LOGNAME': 'cltbld', 11:36:08 INFO - 'MAIL': '/var/mail/cltbld', 11:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:08 INFO - 'MOZ_NO_REMOTE': '1', 11:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:08 INFO - 'NO_EM_RESTART': '1', 11:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:08 INFO - 'PWD': '/builds/slave/test', 11:36:08 INFO - 'SHELL': '/bin/bash', 11:36:08 INFO - 'SHLVL': '1', 11:36:08 INFO - 'TERM': 'linux', 11:36:08 INFO - 'TMOUT': '86400', 11:36:08 INFO - 'USER': 'cltbld', 11:36:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:08 INFO - '_': '/tools/buildbot/bin/python'} 11:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36: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 11:36:11 INFO - Downloading docopt-0.6.1.tar.gz 11:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:11 INFO - Running setup.py install for blobuploader 11:36:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:11 INFO - Running setup.py install for requests 11:36:11 INFO - Running setup.py install for docopt 11:36:11 INFO - Successfully installed blobuploader requests docopt 11:36:11 INFO - Cleaning up... 11:36:12 INFO - Return code: 0 11:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:12 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')]} 11:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:12 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')]} 11:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:12 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:12 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 11:36:12 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 11:36:12 INFO - Using env: {'DISPLAY': ':0', 11:36:12 INFO - 'HOME': '/home/cltbld', 11:36:12 INFO - 'LANG': 'en_US.UTF-8', 11:36:12 INFO - 'LANGUAGE': 'en_US:en', 11:36:12 INFO - 'LOGNAME': 'cltbld', 11:36:12 INFO - 'MAIL': '/var/mail/cltbld', 11:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:12 INFO - 'MOZ_NO_REMOTE': '1', 11:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:12 INFO - 'NO_EM_RESTART': '1', 11:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:12 INFO - 'PWD': '/builds/slave/test', 11:36:12 INFO - 'SHELL': '/bin/bash', 11:36:12 INFO - 'SHLVL': '1', 11:36:12 INFO - 'TERM': 'linux', 11:36:12 INFO - 'TMOUT': '86400', 11:36:12 INFO - 'USER': 'cltbld', 11:36:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:12 INFO - '_': '/tools/buildbot/bin/python'} 11:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:12 INFO - Running setup.py (path:/tmp/pip-daaQBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:12 INFO - Running setup.py (path:/tmp/pip-G8_9W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:12 INFO - Running setup.py (path:/tmp/pip-W6i9J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:12 INFO - Running setup.py (path:/tmp/pip-2n01YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:12 INFO - Running setup.py (path:/tmp/pip-8zMtLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:12 INFO - Running setup.py (path:/tmp/pip-buC_EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:12 INFO - Running setup.py (path:/tmp/pip-bN6EDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:12 INFO - Running setup.py (path:/tmp/pip-CsYbAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:12 INFO - Running setup.py (path:/tmp/pip-3eV7vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:12 INFO - Running setup.py (path:/tmp/pip-d23m0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:12 INFO - Running setup.py (path:/tmp/pip-_AOnjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:13 INFO - Running setup.py (path:/tmp/pip-ccqKqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:13 INFO - Running setup.py (path:/tmp/pip-vqG_hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:13 INFO - Running setup.py (path:/tmp/pip-0UmlrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:13 INFO - Running setup.py (path:/tmp/pip-KOIZHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:13 INFO - Running setup.py (path:/tmp/pip-wehEoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:13 INFO - Running setup.py (path:/tmp/pip-dZjBGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:13 INFO - Running setup.py install for manifestparser 11:36:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:13 INFO - Running setup.py install for mozcrash 11:36:13 INFO - Running setup.py install for mozdebug 11:36:13 INFO - Running setup.py install for mozdevice 11:36:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:36:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:13 INFO - Running setup.py install for mozfile 11:36:14 INFO - Running setup.py install for mozhttpd 11:36:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for mozinfo 11:36:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for mozInstall 11:36:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for mozleak 11:36:14 INFO - Running setup.py install for mozlog 11:36:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for moznetwork 11:36:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for mozprocess 11:36:14 INFO - Running setup.py install for mozprofile 11:36:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for mozrunner 11:36:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:14 INFO - Running setup.py install for mozscreenshot 11:36:15 INFO - Running setup.py install for moztest 11:36:15 INFO - Running setup.py install for mozversion 11:36:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:15 INFO - Cleaning up... 11:36:15 INFO - Return code: 0 11:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:15 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')]} 11:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:15 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')]} 11:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:15 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:15 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 11:36:15 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 11:36:15 INFO - Using env: {'DISPLAY': ':0', 11:36:15 INFO - 'HOME': '/home/cltbld', 11:36:15 INFO - 'LANG': 'en_US.UTF-8', 11:36:15 INFO - 'LANGUAGE': 'en_US:en', 11:36:15 INFO - 'LOGNAME': 'cltbld', 11:36:15 INFO - 'MAIL': '/var/mail/cltbld', 11:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:15 INFO - 'MOZ_NO_REMOTE': '1', 11:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:15 INFO - 'NO_EM_RESTART': '1', 11:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:15 INFO - 'PWD': '/builds/slave/test', 11:36:15 INFO - 'SHELL': '/bin/bash', 11:36:15 INFO - 'SHLVL': '1', 11:36:15 INFO - 'TERM': 'linux', 11:36:15 INFO - 'TMOUT': '86400', 11:36:15 INFO - 'USER': 'cltbld', 11:36:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:15 INFO - '_': '/tools/buildbot/bin/python'} 11:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:15 INFO - Running setup.py (path:/tmp/pip-P5Wuh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:15 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)) 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:15 INFO - Running setup.py (path:/tmp/pip-1dj5BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:15 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)) 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:15 INFO - Running setup.py (path:/tmp/pip-Q1r52F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:15 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)) 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:15 INFO - Running setup.py (path:/tmp/pip-EzJAzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:15 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)) 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:15 INFO - Running setup.py (path:/tmp/pip-uPKjXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:15 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)) 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:15 INFO - Running setup.py (path:/tmp/pip-nUkHSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:15 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)) 11:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:15 INFO - Running setup.py (path:/tmp/pip-fTD850-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:16 INFO - Running setup.py (path:/tmp/pip-5IK6Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:16 INFO - Running setup.py (path:/tmp/pip-P4M4Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:16 INFO - Running setup.py (path:/tmp/pip-MFtQ1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:16 INFO - Running setup.py (path:/tmp/pip-F0KEhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:16 INFO - Running setup.py (path:/tmp/pip-SbfInS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:16 INFO - Running setup.py (path:/tmp/pip-0jMw_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:16 INFO - Running setup.py (path:/tmp/pip-cBIH6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:16 INFO - Running setup.py (path:/tmp/pip-ExKBMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:16 INFO - Running setup.py (path:/tmp/pip-_EiTU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:16 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)) 11:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:16 INFO - Running setup.py (path:/tmp/pip-jKE78k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:16 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)) 11:36:16 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)) 11:36:16 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)) 11:36:16 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)) 11:36:16 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)) 11:36:16 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)) 11:36:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:16 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 11:36:16 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 11:36:16 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 11:36:16 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 11:36:16 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 11:36:16 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 11:36:18 INFO - Downloading blessings-1.6.tar.gz 11:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:18 INFO - Installing collected packages: blessings 11:36:18 INFO - Running setup.py install for blessings 11:36:18 INFO - Successfully installed blessings 11:36:18 INFO - Cleaning up... 11:36:18 INFO - Return code: 0 11:36:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:19 INFO - Reading from file tmpfile_stdout 11:36:19 INFO - Current package versions: 11:36:19 INFO - argparse == 1.2.1 11:36:19 INFO - blessings == 1.6 11:36:19 INFO - blobuploader == 1.2.4 11:36:19 INFO - docopt == 0.6.1 11:36:19 INFO - functools32 == 3.2.3-2 11:36:19 INFO - jsonschema == 2.5.1 11:36:19 INFO - manifestparser == 1.1 11:36:19 INFO - mozInstall == 1.12 11:36:19 INFO - mozcrash == 0.17 11:36:19 INFO - mozdebug == 0.1 11:36:19 INFO - mozdevice == 0.48 11:36:19 INFO - mozfile == 1.2 11:36:19 INFO - mozhttpd == 0.7 11:36:19 INFO - mozinfo == 0.9 11:36:19 INFO - mozleak == 0.1 11:36:19 INFO - mozlog == 3.2 11:36:19 INFO - moznetwork == 0.27 11:36:19 INFO - mozprocess == 0.23 11:36:19 INFO - mozprofile == 0.28 11:36:19 INFO - mozrunner == 6.12 11:36:19 INFO - mozscreenshot == 0.1 11:36:19 INFO - mozsystemmonitor == 0.3 11:36:19 INFO - moztest == 0.7 11:36:19 INFO - mozversion == 1.4 11:36:19 INFO - psutil == 3.1.1 11:36:19 INFO - requests == 1.2.3 11:36:19 INFO - wsgiref == 0.1.2 11:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:19 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')]} 11:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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')]} 11:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:19 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 11:36:19 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 11:36:19 INFO - Using env: {'DISPLAY': ':0', 11:36:19 INFO - 'HOME': '/home/cltbld', 11:36:19 INFO - 'LANG': 'en_US.UTF-8', 11:36:19 INFO - 'LANGUAGE': 'en_US:en', 11:36:19 INFO - 'LOGNAME': 'cltbld', 11:36:19 INFO - 'MAIL': '/var/mail/cltbld', 11:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:19 INFO - 'MOZ_NO_REMOTE': '1', 11:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:19 INFO - 'NO_EM_RESTART': '1', 11:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:19 INFO - 'PWD': '/builds/slave/test', 11:36:19 INFO - 'SHELL': '/bin/bash', 11:36:19 INFO - 'SHLVL': '1', 11:36:19 INFO - 'TERM': 'linux', 11:36:19 INFO - 'TMOUT': '86400', 11:36:19 INFO - 'USER': 'cltbld', 11:36:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:19 INFO - '_': '/tools/buildbot/bin/python'} 11:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 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)) 11:36:19 INFO - Cleaning up... 11:36:19 INFO - Return code: 0 11:36:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:19 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')]} 11:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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')]} 11:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:19 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 11:36:19 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 11:36:19 INFO - Using env: {'DISPLAY': ':0', 11:36:19 INFO - 'HOME': '/home/cltbld', 11:36:19 INFO - 'LANG': 'en_US.UTF-8', 11:36:19 INFO - 'LANGUAGE': 'en_US:en', 11:36:19 INFO - 'LOGNAME': 'cltbld', 11:36:19 INFO - 'MAIL': '/var/mail/cltbld', 11:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:19 INFO - 'MOZ_NO_REMOTE': '1', 11:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:19 INFO - 'NO_EM_RESTART': '1', 11:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:19 INFO - 'PWD': '/builds/slave/test', 11:36:19 INFO - 'SHELL': '/bin/bash', 11:36:19 INFO - 'SHLVL': '1', 11:36:19 INFO - 'TERM': 'linux', 11:36:19 INFO - 'TMOUT': '86400', 11:36:19 INFO - 'USER': 'cltbld', 11:36:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:19 INFO - '_': '/tools/buildbot/bin/python'} 11:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:19 INFO - Cleaning up... 11:36:19 INFO - Return code: 0 11:36:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:36:19 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')]} 11:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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')]} 11:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:19 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 0x7fa439e03f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, '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': '4300f881736b422476174874000001bc-1470421695.433413-780139583', '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 11:36:19 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 11:36:19 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 11:36:19 INFO - Using env: {'DISPLAY': ':0', 11:36:19 INFO - 'HOME': '/home/cltbld', 11:36:19 INFO - 'LANG': 'en_US.UTF-8', 11:36:19 INFO - 'LANGUAGE': 'en_US:en', 11:36:19 INFO - 'LOGNAME': 'cltbld', 11:36:19 INFO - 'MAIL': '/var/mail/cltbld', 11:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:19 INFO - 'MOZ_NO_REMOTE': '1', 11:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:19 INFO - 'NO_EM_RESTART': '1', 11:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:19 INFO - 'PWD': '/builds/slave/test', 11:36:19 INFO - 'SHELL': '/bin/bash', 11:36:19 INFO - 'SHLVL': '1', 11:36:19 INFO - 'TERM': 'linux', 11:36:19 INFO - 'TMOUT': '86400', 11:36:19 INFO - 'USER': 'cltbld', 11:36:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:19 INFO - '_': '/tools/buildbot/bin/python'} 11:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:19 INFO - Downloading/unpacking flake8 11:36:19 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 11:36:19 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 11:36:19 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 11:36:19 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 11:36:19 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 11:36:19 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 11:36:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:36:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:36:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 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 11:36:21 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 11:36:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 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 11:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:36:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:22 INFO - no previously-included directories found matching 'docs/_build' 11:36:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:36:22 INFO - Running setup.py install for pep8 11:36:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:22 INFO - no previously-included directories found matching 'docs/_build' 11:36:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:36:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:36:22 INFO - Cleaning up... 11:36:22 INFO - Return code: 0 11:36:22 INFO - Running post-action listener: _resource_record_post_action 11:36:22 INFO - Running post-action listener: _start_resource_monitoring 11:36:22 INFO - Starting resource monitoring. 11:36:22 INFO - ##### 11:36:22 INFO - ##### Finished create-virtualenv step (success) 11:36:22 INFO - ##### 11:36:22 INFO - ##### 11:36:22 INFO - ##### Running install step. 11:36:22 INFO - ##### 11:36:22 INFO - Running pre-action listener: _resource_record_pre_action 11:36:22 INFO - Running main action method: install 11:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:22 INFO - Reading from file tmpfile_stdout 11:36:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:23 INFO - Reading from file tmpfile_stdout 11:36:23 INFO - Output received: 11:36:23 INFO - Usage: mozinstall [options] installer 11:36:23 INFO - Options: 11:36:23 INFO - -h, --help show this help message and exit 11:36:23 INFO - -d DEST, --destination=DEST 11:36:23 INFO - Directory to install application into. [default: 11:36:23 INFO - "/builds/slave/test"] 11:36:23 INFO - --app=APP Application being installed. [default: firefox] 11:36:23 INFO - mkdir: /builds/slave/test/build/application 11:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:36:36 INFO - Reading from file tmpfile_stdout 11:36:36 INFO - Output received: 11:36:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:36:36 INFO - Running post-action listener: _resource_record_post_action 11:36:36 INFO - ##### 11:36:36 INFO - ##### Finished install step (success) 11:36:36 INFO - ##### 11:36:36 INFO - ##### 11:36:36 INFO - ##### Running run-tests step. 11:36:36 INFO - ##### 11:36:36 INFO - Running pre-action listener: _resource_record_pre_action 11:36:36 INFO - Running main action method: run_tests 11:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:36:36 INFO - Python 2.7.3 11:36:36 INFO - Return code: 0 11:36:36 INFO - grabbing minidump binary from tooltool 11:36:36 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')]} 11:36:36 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 0x135d1c0>, '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 0x135e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:36:36 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 11:36:36 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 11:36:36 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 11:36:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:36:36 INFO - Return code: 0 11:36:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:36:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:36:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:36:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:36:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:36:37 INFO - Return code: 0 11:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 11:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 11:36:37 INFO - Using env: {'DISPLAY': ':0', 11:36:37 INFO - 'HOME': '/home/cltbld', 11:36:37 INFO - 'LANG': 'en_US.UTF-8', 11:36:37 INFO - 'LANGUAGE': 'en_US:en', 11:36:37 INFO - 'LOGNAME': 'cltbld', 11:36:37 INFO - 'MAIL': '/var/mail/cltbld', 11:36:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:37 INFO - 'MOZ_NO_REMOTE': '1', 11:36:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:37 INFO - 'NO_EM_RESTART': '1', 11:36:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:37 INFO - 'PWD': '/builds/slave/test', 11:36:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:37 INFO - 'SHELL': '/bin/bash', 11:36:37 INFO - 'SHLVL': '1', 11:36:37 INFO - 'TERM': 'linux', 11:36:37 INFO - 'TMOUT': '86400', 11:36:37 INFO - 'USER': 'cltbld', 11:36:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470421695.433413-780139583', 11:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:37 INFO - '_': '/tools/buildbot/bin/python'} 11:36:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 11:36:37 INFO - mozversion application_buildid: 20160805083232 11:36:37 INFO - mozversion application_changeset: 940aa720c00e423769d315c858ec782b38a29626 11:36:37 INFO - mozversion application_display_name: Firefox 11:36:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:37 INFO - mozversion application_name: Firefox 11:36:37 INFO - mozversion application_remotingname: firefox 11:36:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:36:37 INFO - mozversion application_vendor: Mozilla 11:36:37 INFO - mozversion application_version: 49.0 11:36:37 INFO - mozversion platform_buildid: 20160805083232 11:36:37 INFO - mozversion platform_changeset: 940aa720c00e423769d315c858ec782b38a29626 11:36:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:36:37 INFO - mozversion platform_version: 49.0 11:36:37 INFO - using testdate: 1470422197 11:36:37 INFO - actual date: 1470422197 11:36:37 INFO - starting webserver on 'localhost:35188' 11:36:37 INFO - SUITE-START | Running 2 tests 11:36:37 INFO - TEST-START | dromaeo_css 11:36:37 INFO - operating with platform_type : linux_ 11:36:37 INFO - Initialising browser for dromaeo_css test... 11:36:37 INFO - TEST-INFO | started process 8573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm1V9gm/profile http://localhost:35188/getInfo.html) 11:36:41 INFO - PROCESS | 8573 | __metrics Screen width/height:1600/1200 11:36:41 INFO - PROCESS | 8573 | colorDepth:24 11:36:41 INFO - PROCESS | 8573 | Browser inner width/height: 1024/697 11:36:41 INFO - PROCESS | 8573 | __metrics 11:36:43 INFO - PROCESS | 8573 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:36:43 ERROR - PROCESS | 8573 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:36:43 INFO - TEST-INFO | 8573: exit 0 11:36:43 INFO - Browser initialized. 11:36:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:36:43 INFO - TEST-INFO | started process 8665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm1V9gm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:55 INFO - PROCESS | 8665 | RSS: Main: 144252928 11:36:55 INFO - PROCESS | 8665 | 11:37:46 INFO - PROCESS | 8665 | 1470422266948 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] 11:39:55 INFO - PROCESS | 8665 | Cycle 1(1): loaded http://localhost:35188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35188/tests/dromaeo/cssquery-ext.html) 11:39:56 INFO - PROCESS | 8665 | RSS: Main: 244523008 11:39:56 INFO - PROCESS | 8665 | 11:42:58 INFO - PROCESS | 8665 | Cycle 1(1): loaded http://localhost:35188/tests/dromaeo/cssquery-ext.html (next: http://localhost:35188/tests/dromaeo/cssquery-jquery.html) 11:42:58 INFO - PROCESS | 8665 | RSS: Main: 224870400 11:42:58 INFO - PROCESS | 8665 | 11:46:00 INFO - PROCESS | 8665 | Cycle 1(1): loaded http://localhost:35188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35188/tests/dromaeo/cssquery-mootools.html) 11:46:01 INFO - PROCESS | 8665 | RSS: Main: 227131392 11:46:01 INFO - PROCESS | 8665 | 11:49:03 INFO - PROCESS | 8665 | Cycle 1(1): loaded http://localhost:35188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35188/tests/dromaeo/cssquery-prototype.html) 11:49:03 INFO - PROCESS | 8665 | RSS: Main: 216014848 11:49:03 INFO - PROCESS | 8665 | 11:52:06 INFO - PROCESS | 8665 | Cycle 1(1): loaded http://localhost:35188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35188/tests/dromaeo/cssquery-yui.html) 11:52:06 INFO - PROCESS | 8665 | RSS: Main: 216276992 11:52:06 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | Cycle 1(1): loaded http://localhost:35188/tests/dromaeo/cssquery-yui.html (next: http://localhost:35188/tests/dromaeo/cssquery-dojo.html) 11:55:09 INFO - PROCESS | 8665 | RSS: Main: 258154496 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | __start_tp_report 11:55:09 INFO - PROCESS | 8665 | _x_x_mozilla_page_load 11:55:09 INFO - PROCESS | 8665 | _x_x_mozilla_page_load_details 11:55:09 INFO - PROCESS | 8665 | |i|pagename|runs| 11:55:09 INFO - PROCESS | 8665 | |0;dojo.html;3404.0298514923247;3408.0798184490204;3425.09235052711;3448.982755086224;3455.4816777483375;5571.609987300891;5621;5661.60368774186;5670.631408958415;5678.602497825149;5613.747381367848;5686.601937864351;5687.488126068653;5688;5698.544116470683;4970.130227210242;5032.2703208035;5154.690718556889;5158.3552055993005;5203.2975548301065;5102.36220472441;5158;5160.664556803796;5161.767720452589;5165.793368265284;5041.294218809369;5076.263941728447;5093.465186155456;5110.105731496992;5153.123968925292;5183.870403239912;5198.480151984809;5203.375594928595;5215.504527069922;5242.108841496935;5001.274815151819;5020.221865610836;5078.46676099008;5111.616628752859;5142.640015198937;5487.396386397493;5499.120140777496;5503.422140675251;5517.200005999108;5543.279373681436;6067;6067.24159480065;6072.51419886408;6075.270967483886;6082.847928801771;5995.310539287994;6035.879282414371;6079.787207447718;6104.877902441926;6106.511479081662;5696.544276457874;5736.569757268222;5745.195672605797;5747.0230060889335;5754.021816291241;6000.579959402888;6220.315765265817;6229.781957631461;6230.345813689588;6232.844178895473;5836.095405212199;5857.648541087463;5864.794732184353;5940.049592065336;5967.9701601491715;6043.576949613484;6046.486048685823;6081.3614570470345;6081.878362432726;6084.908726369108;5850.385709500526;5894.764209431661;5948.881022379528;5963.940360596339;5967.254093238345;5921.7631294747725;6000.8799824004145;6003.8198854034445;6005.069214271707;6042.395760423922;4618.815247390134;4619.122366750374;4626;4626.676132670681;4650.465196502378;4084.8570300039355;4090.9386359204636;4109.630133288018;4149.585041495826;4158.106007208465;5693.3168019837885;5711.628744131618;5716.857078573069;5725.713714314267;5740.6268592541355;5984;6059.424354686298;6060.121282414026;6064.878702426015;6080.2399700037495;5570.220169176318;5659.236003139606;5705.828825135252;5707.629004114802;5710.400407957105;5241.50205730455;5278.340207474066;5280.7359632019015;5281.656692314988;5301.0723123453245;6327.17746692927;6336.112944187817;6337.714802833883;6347.016212487072;6351.460125889351;5822.737976791139;5935.7032148391545;5961.612495187799;5979.133025711334;6079.878402432015;6212.565120441706;6225.159603453657;6252.562320637694;6264.780732674334;6272.780452684134;5909.202257695156;5916.319623243382;5916.940830591639;5923.348431672426;5949.702514874326;5928.762849485972;5934.881302374015;5952.107183922446;6012.188354572077;6021.066734656135;5821.883562328814;5891.440313170242;5909.497692696169;5940.851478713067;5957.314908785545;5865.794697185578;5872.383399742966;5874.735636896436;5880.441358070976;5896.410358964241;5727.599068065196;5766.250387449605;5778.075507918881;5805.767769289181;5808.186853840381;5971.044632858721;6003.339632640494;6004.219451471281;6012.368701286302;6013.849653758691;5842.824715258549;5848.766049358148;5853.1220316952795;5853.619514731528;5855.03391940325 11:55:09 INFO - PROCESS | 8665 | |1;ext.html;599.0714392691327;644.1079105438967;654.1398061549063;654.5320096131268;667.9198496180453;33575.16062098449;35713.64286357139;46670.29994550085;47359.763201183945;47519.28721069178;48176.75911620437;48688.51311486893;48728.756356218255;48792.75603621986;48801;8389.454685445457;9113.270938324935;9258.074192580756;9273;9275.211607013413;10989.890101099007;11301.717457063556;11306.943465282662;11307.095432365391;11308.09535237183;11053.778924421507;11155.442227888614;11162.107031437465;11186.552537898475;11188.496517656726;11160.553577856876;11211.990920817125;11217.831732524019;11226.04578610819;11227.326360418401;10943.56225750969;11010.229283950126;11019.063379612742;11022.834657480144;11026.944865275702;44703.55296447059;44752.55247447517;44818.55181448209;45169.54830451719;45259.32111018337;3884.0678237223146;3924.6860251179837;3935.330993731073;4003.899902502461;4006.7996600169877;34349.6565034349;34686;35159.648403515894;35229.647703522896;35381.46927796085;4701.929471057937;4765.1660959331975;4800.231962885957;4808.062427826575;4905.583025442842;352882;355245;355276;356051;356765;37998.620013800064;65052;65438;65490;65667;39267.803660982085;41142.79428602838;41193.176136477705;41237.38143927843;41237.58762412338;17206.655866882844;17466.476005719847;17531.56171095733;17537.736933946002;17594.64810703779;12638.620841374774;13084.869151308365;13123.60629181126;13356.866431335757;13371;9125.817483650422;9237.491937943478;9298.116678915492;9305.53472326381;9320.440773553473;3492.336456073338;3495.9300813984087;3539.150603855108;3553.236054248349;3629.6551827576336;1101.498818037791;1122.337820685783;1141.303804679145;1197.7724232395817;1213.9635810925686;33533.32933341368;34322.313553729284;34495.4825677615;34541.82729086339;34690;1166.4517676691942;1199.1186477938709;1228.0666693313146;1271.262667652759;1299.9220046797222;17962.730559041625;18054.277828886698;18220;18293.81706182948;18352.26590936374;571843;572064;572626;572764;573539;65779.34220657732;66075.66962165158;66092.33907660958;66351.33648663548;66589;1400.7828786538103;1425.4298280687808;1456.3737592835182;1520.6350475885708;1528.1213302351193;30985.098799805906;34322;34404.827975860964;34691.826540867136;35239.27257562374;54469;55154.72422638022;55155;55226;55238.447615524936;338207;338551;339638;339706;340349;27067.59398609062;30076.699233007388;30832;31127.221819454695;31141;51236.23145652893;52152;52722;53524.464755351946;56586;44236.557634424535;44426;44953;45484;45616.771916140206;43379.349309759746;44223.33664994963;44348;45208.54791452044;45519;44201.33697994597;44577.80323215323;45246.77376613096;45334.546654533035;45690.54309456863;38009.61990380061;38932.6106738929;39268.80365598268;39604.405933910435;39916.40125398179;29605;29764.255893602833;29810;30387.69612303937;30618.693813061585 11:55:09 INFO - PROCESS | 8665 | |2;jquery.html;387.1231660289444;398.81853756540767;408.3874188716925;410.3557414858671;416.5272415808057;13967.44130234792;18928.24287028519;20519.179232830687;20560.38318850435;22008.44978875525;18938;19864.602707945833;19917.90041049793;20588.794112058877;20917.895410522928;5271.472852714717;5445;5459.972700136514;5461.972690136544;5465.043617366965;5395.0558652235895;5417.945820541803;5434.619576629618;5436.401995780461;5437.32033495813;5440.211169380437;5529.142982837647;5956.225690660208;5960.731767070471;5965.970170149143;5682.431756824326;5819.447152520525;5884.323302820188;5896.999999999978;5936.465718085371;5052.545270925634;5202.03762303975;5214.0875346814155;5221.190715439113;5227.059129356714;13735.725285494234;13805.309734513234;18140.365087221882;24461.143859964995;24468.877655611785;2482.7144878338863;2503.849769013865;2767.8892844286206;2836.4043550854344;2898.840563768992;10358.585656573729;10433.217508686803;10746.731331716692;10747.140228781756;12659.36703164838;1839.7884243311923;1979.445755188535;2001.4996250937265;2036.216056818121;2125.798049185325;60460;62908;74037.25962740357;81066.5946670263;81931;9193.95403022994;9936;10000;10499.632512862167;10543.420111893765;14063.296835158406;14071.437142514389;14089.295535223198;14162.787558186636;14178.078424902349;8282.254597086292;8487.702930397407;8645.654173833102;8702.434341767765;8770.254528365032;8761.167689069529;8872.822543549093;8899.510526921082;9048.140426659456;9052.366334356664;4244.72409293395;4312.094460163338;4343;4363.06194168249;4424.093060922503;2068.214078650103;2070.223666125203;2075.3773867839586;2075.533005073846;2082.687596860483;836.7657056024323;1018.9032041956002;1070.4478506165935;1110.3005106782675;1182.0720734223594;19833.206671733256;20011;20082;20233.89883050605;20368.388948331572;1026.4068294382728;1078.396098185019;1098.9340639561651;1115.8828323026128;1123.1856903744883;11075.5569777208;11432.314061156358;11439.199256052163;11488.425578721031;11556.88443115575;489418;490021;493504;494944;498231.0530684085;93919.53040234892;95305;95617;96477;97253;1055.6199768083638;1071.132382769959;1075.5052675769234;1076.6716151573846;1081.8269076947809;17691.115444227995;17809.910950445683;17934.820651793314;17973.19120639548;18106.54733631617;38318.42522362111;39299.60700393074;39476.40785388164;40789.796051019555;40886.79556602317;55918;56052;56542.71728641495;57096.71451642715;57391;8861.512616806138;8978.86531702012;9056.275497960016;9079.818403632022;9113.863292050492;9767.609295628095;13421.932890335876;13467.259300738553;13577.86422135766;13911.304434778018;8525.701600443954;8607.311415086904;11610.593629222936;11778.941105294418;12118.697032573904;11727.706807329543;11765.176437649283;11809.468573914022;12076.698082547655;12130.393480326125;12067.09496787762;12122.27266364021;12306;12468.563600273947;12548.165605159009;8940.86588701183;9042.63829446841;9061.546922653974;9116.316276279173;9142.085791420805;11670.649880503599;11930.582429614922;12334.074944379028;12474.750504989668;12678.556250531186 11:55:09 INFO - PROCESS | 8665 | |3;mootools.html;1422.6087825847885;1547.582152818739;1583.3587397104172;1791.435697755207;1918.4820098573387;8577.270931970783;9420.85868711969;9712;9714.417134971907;10015.098641122298;9585.52072396381;9793.951030244856;9811.75470613235;9816.165625921805;9819.803603927918;2408.9999999999955;2436.8903399347073;2439.890204940782;2440.707115146185;2441.389652586853;2422.9823474140817;2425.054228850741;2464.051340234014;2467.4324905271797;2468.259522143359;2430.793382562484;2438.756124387565;2453.8036957043396;2454.8158888083376;2457.8525288482747;2432.2824766693866;2433.2335314375914;2435.07467162478;2456.7297597264287;2456.9631455528183;2354.505553833697;2361.988190059056;2364.2552595932398;2365.5741966446035;2384.8211384146257;8555.700550480766;9256.629734810667;9630.133288004114;9693.951530242373;9700.320977531575;5377.946220537823;5560.221568980346;5564.749586268627;5567.331920169565;5570.415106413809;3593.1017245688577;3618.8009659468717;3623.202895363016;3726.1988672435555;3734.9813250933844;1178.7112157521376;1221.9511219551207;1245.5080243303935;1252.2987127208792;1262.696952731347;14079.225642589654;14209;14231.07498012626;14277.500287489991;14329.713405731827;4982.950170498249;5034.6727462715535;5096.592272618256;5130.640855140105;5163.122269214243;11878.881211187778;11909.285442873455;11936.701582460508;11942.044636429066;11944.283342999448;5862.824115276549;5880.147378630075;5888.587798854039;5889.204957330706;5902.822915312548;5054.646174767805;5066.569341606005;5159.638825282194;5379.273798037293;5381.112116500812;4110.547839737626;4157.958420415817;4192.748435093904;4221.894452638709;4223.366495025771;1262.8484581850237;1289.8323217981601;1289.8903593194495;1304.6412236634812;1312.2716892124963;1069.390447444949;1073.5383784972537;1074.548689550375;1074.7044562745307;1083.47992963378;6441.259255185713;6714.764983225564;6719.160104986877;6783.084283621746;6794.286599907037;447.81415712479605;455.49667617283086;460.56476629585393;462.0182113009854;470.2123942396472;4543.363929049936;4672.159011377917;4703;4712.52874712526;4730.290456431494;11933;12394.566190183301;12398.13213075076;12465.813012804816;12513.624591262276;11616.361100139404;12135.543734751885;12149.392530373447;12447.315397653036;12529.74940501185;9033.322500812465;9132.543372831331;9173.40372875761;9175.862362064574;9184.357095003286;6578.111954886029;6727.831804204934;6755.392014718699;6790.5925644461495;6943.895841562482;11293.491792869505;11432;11460.255083419552;11500.137489688139;11601.071914247008;10988.890111098786;11417.486213120263;11454.713632159262;11546.480408381474;11683.357415342238;8165.4284200107795;8403.243708066304;8564.785880353042;8576.399652024298;8581.914180858112;9344.486053267136;9629.374090684363;9651.324407291422;9653.951730241304;9664.130228279488;8318.45930014547;8623.051464338792;8660.913390866011;8753.518556479456;8832.867506987272;8447.746567602982;8578.056413794602;8586.270167035622;8603.655853765778;8729.345299102466;7833.686652533835;8015.278624923785;8017.5590342529385;8031.196880311922;8051.597420129087;5726.713664316851;5760.596758226884;5853.502452291603;5910.970445147746;5950.821475355746;5726.341470730919;5764.884702306014;5826.242588463472;5850.005499065084;5878.177055212359 11:55:09 INFO - PROCESS | 8665 | |4;prototype.html;335.678143897322;338.14955387201184;344.49359441620817;345.3266131044464;348.90753950203185;5323.281357016802;5450.863728406782;5475.808346707866;5526.972365138174;5544.722763861806;5433.179884738617;5434.619576629638;5436.130219164925;5446.319210098738;5468.72656367181;4257.765822879748;4275.87172384829;4285.292926667096;4293.420388247593;4295.377170310303;4066.451029111062;4125.814338354766;4225.176090662307;4268.103698223377;4291.763952982585;4205.684573656973;4211.22092412903;4211.91576168478;4222.619964203221;4224.408582798411;4213.7893105344765;4213.936790948138;4219.409282700409;4233.661307095425;4258.616724494779;3627.546556680415;3755.1738617504107;3757.9812100939594;3760.191558814868;3762.739482273442;5241.947580524222;5254.6847189168775;5271.551918086967;5272.420033796279;5282.81510147143;4807.759612019385;4848.200046992242;4879.39007624047;4883.243097319921;4890.462049174588;5411.512963833274;5691.715414229313;5699.088145896637;5713.714314284311;5715.457031581993;4057.2494088593407;4092.529359123679;4097;4107.322291821846;4107.336528705879;5962.25471816023;6019.428154325332;6025.312912384583;6027.649216805449;6035.124906888476;4098.159877225162;4122;4203.621674049289;4208.705390622627;4218.49378074633;4226.535081141072;4227.767472789026;4246.554111818215;4247.492140290153;4262.3180291153885;4825.131476334223;4862.343583616237;4881.804727810848;4882.194437917775;4895.681780684244;5544.473275038946;5779.537636989115;5787;5803.361630220672;5807.5063619591965;1382.377929931535;1429.9142051476945;1462.232328027794;1463.6121427821636;1466.098349515062;900.3157600223877;902.7541992050927;903.3270213690711;907.2651152566442;924.611663101499;4794.4486384065585;4900.211422830713;4912.9508704913205;4993.550580447777;5012.323336349619;5307.920381194285;5309.814156504503;5331.653442526223;5345.305110335709;5349.304590403222;4833.4441539223435;4998.5751211146735;5009.5491405773655;5019.171836646912;5079.771410286546;2774.8890044398;2794.6925838157786;2813.338865366637;2831.9858400707863;2836.248394175545;5387.542058925035;5395.946040539623;5410.321890664147;5484.643498172606;5501.312335958005;5264.368275806928;5286.418493965661;5569.972150139223;6085.148079268906;6085.6348619083;6229;6252.718627661766;6268.905966410507;6276.529260305404;6279.8116056517465;5808.82573522795;5959.970200148971;6039.607425517327;6050.606710563799;6056.454919057306;5838.737256823538;5845.41545845429;5859.736311866061;5861.238039054895;5908.615939963888;6187.597806142587;6195.411435913581;6199.938000619936;6201.565890387629;6238.469730072995;4092.447519584818;4155.3766934958785;4174.269502836931;4203.414899836517;4217;5699.857503562444;5862.794802181903;5873.148393483007;5895.94104058954;5938.762449501972;5694.971525142348;5783.768649253982;5793.217915581343;5815.9709201453725;5825.543614096476;5783.190353350618;5794.913076303943;5819.592628515963;5822.446867547576;5823.505002074871;5560.304961879765;5672.2058911751565;5691.893999220315;5693.174489699053;5704.971475142764;5748.511376533042;5801.1878337032;5807.477327040587;5835.336928975222;5850.327212370632;5449.482299181572;5671.829845104653;5699.287589051369;5734.569907257056;5755.079187330007 11:55:09 INFO - PROCESS | 8665 | |5;yui.html;771.9112302085258;782.6673663692933;821.6220538552266;829.4774292195916;887.4098724348308;14538.055026423288;15740.370385184608;15795.84204157958;15824.208789560518;15833.999999999985;14665.560033198994;14731.410743570272;14733.778993315109;16505.504834854943;17117.486475405727;895.7536677413698;896.2605850173617;905.2712566384058;905.9728208153766;906.4017748286133;889.3996552327186;891.8929728432597;892.5537231384308;892.7500299916002;893.0712059458189;929.9721008369726;931.3806318797991;931.753085432361;934.1685899549407;935.8268720286769;927.1794461901233;929.0198840223561;930.16285343191;930.6882194464795;930.8324501589711;684.6782012454139;684.9931500685029;685.5509641185032;686.3445409633838;687.0381465947663;16645.167741612993;16685.082320472367;16696.081715505643;16733.24700388473;16747.413840515524;14284.715144975313;15032;15120.092794432368;15190.544283671508;15342.079475231521;12386.5664701735;12484.188527745759;12605.11764176508;12621.93689031549;12762.425690843935;3970.3250447424007;3998.52017757868;4029.4157347184496;4093.0585965227865;4105.281575724236;55484.72257638686;65244;66624.6668766658;67816;75398;12399.814002789966;12454.190477618926;12459.626211213677;12488.438020289108;12719.872801272053;22416.439589010406;22442.32673019812;22454.775452245594;22571.322860314216;22578.54842903133;6981.720731170798;9081.81836363269;9286.628534858664;9341.439513629068;9761.951190244145;5142.485751424828;5239.764210610531;5280.973595132076;5325.840224793263;5421.349438067378;3673.2102597941034;3835;3861.4400911868183;3863.5943225961432;3865.7487263327794;653.3009679642831;656.1732217406008;665.1153965226334;668.2615709640874;671.7941295374814;754.5812074298817;805.7099444200084;811.217175425717;815.0283272040506;832.4381042796089;10248;10344.793104137874;10355.948220259;10367.688969330931;10420.947895260626;712.771912987839;731.119001603067;733.977980660581;799.5242830515833;811.5009269299338;4724.692894961817;4905.920697446628;4962.280469331927;4964.826231081895;4976.054549635558;101034;114036.42981785038;114440;118265.40867295781;118313;93475;97741;98988;99502.5024874871;99902.50048749709;82230.17769822344;82952.17047829565;83599;83607.5819620898;84204.57897710595;9262.629494820132;9313.438804328864;9353.11145441182;9595.328327017321;9665.226781857575;51388.48611513837;52032;52467;53325.46674533205;54098;71023;75714.62142689251;76092.61953690196;78670;80234.19765802268;12603.49586016549;12928.095033347576;12942.741145177231;12949.870501294867;13215.669608259486;14475.059121157092;14800.703985920007;15101.697966040398;15375.692486150438;15591.76612350793;13029.934850325688;13201.339933003119;13208.603741887759;13237.933810330887;13300.135491193041;13981.790273146114;14319.355628996513;14327;14334.21161836109;14377.353019113956;13139.671508212372;13194.208347499181;13543.729125417634;13654.180749155083;13719;10666.946665266934;10719.196060295353;10944;11032.338059716443;11133.721656958316;10908.727281818017;11054.723631909266;11126.833097503382;11174;11246.156538259827 11:55:09 INFO - PROCESS | 8665 | __end_tp_report 11:55:09 INFO - PROCESS | 8665 | __start_cc_report 11:55:09 INFO - PROCESS | 8665 | _x_x_mozilla_cycle_collect,827 11:55:09 INFO - PROCESS | 8665 | __end_cc_report 11:55:09 INFO - PROCESS | 8665 | __startTimestamp1470423309446__endTimestamp 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | ------- Summary: start ------- 11:55:09 INFO - PROCESS | 8665 | Number of tests: 6 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | [#0] dojo.html Cycles:165 Average:5609.86 Median:5836.10 stddev:617.39 (10.6%) stddev-sans-first:594.54 11:55:09 INFO - PROCESS | 8665 | Values: 3404.0 3408.1 3425.1 3449.0 3455.5 5571.6 5621.0 5661.6 5670.6 5678.6 5613.7 5686.6 5687.5 5688.0 5698.5 4970.1 5032.3 5154.7 5158.4 5203.3 5102.4 5158.0 5160.7 5161.8 5165.8 5041.3 5076.3 5093.5 5110.1 5153.1 5183.9 5198.5 5203.4 5215.5 5242.1 5001.3 5020.2 5078.5 5111.6 5142.6 5487.4 5499.1 5503.4 5517.2 5543.3 6067.0 6067.2 6072.5 6075.3 6082.8 5995.3 6035.9 6079.8 6104.9 6106.5 5696.5 5736.6 5745.2 5747.0 5754.0 6000.6 6220.3 6229.8 6230.3 6232.8 5836.1 5857.6 5864.8 5940.0 5968.0 6043.6 6046.5 6081.4 6081.9 6084.9 5850.4 5894.8 5948.9 5963.9 5967.3 5921.8 6000.9 6003.8 6005.1 6042.4 4618.8 4619.1 4626.0 4626.7 4650.5 4084.9 4090.9 4109.6 4149.6 4158.1 5693.3 5711.6 5716.9 5725.7 5740.6 5984.0 6059.4 6060.1 6064.9 6080.2 5570.2 5659.2 5705.8 5707.6 5710.4 5241.5 5278.3 5280.7 5281.7 5301.1 6327.2 6336.1 6337.7 6347.0 6351.5 5822.7 5935.7 5961.6 5979.1 6079.9 6212.6 6225.2 6252.6 6264.8 6272.8 5909.2 5916.3 5916.9 5923.3 5949.7 5928.8 5934.9 5952.1 6012.2 6021.1 5821.9 5891.4 5909.5 5940.9 5957.3 5865.8 5872.4 5874.7 5880.4 5896.4 5727.6 5766.3 5778.1 5805.8 5808.2 5971.0 6003.3 6004.2 6012.4 6013.8 5842.8 5848.8 5853.1 5853.6 5855.0 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | [#1] ext.html Cycles:180 Average:59540.60 Median:19671.65 stddev:115527.87 (587.3%) stddev-sans-first:115767.20 11:55:09 INFO - PROCESS | 8665 | Values: 599.1 644.1 654.1 654.5 667.9 33575.2 35713.6 46670.3 47359.8 47519.3 48176.8 48688.5 48728.8 48792.8 48801.0 8389.5 9113.3 9258.1 9273.0 9275.2 10989.9 11301.7 11306.9 11307.1 11308.1 11053.8 11155.4 11162.1 11186.6 11188.5 11160.6 11212.0 11217.8 11226.0 11227.3 10943.6 11010.2 11019.1 11022.8 11026.9 44703.6 44752.6 44818.6 45169.5 45259.3 3884.1 3924.7 3935.3 4003.9 4006.8 34349.7 34686.0 35159.6 35229.6 35381.5 4701.9 4765.2 4800.2 4808.1 4905.6 352882.0 355245.0 355276.0 356051.0 356765.0 37998.6 65052.0 65438.0 65490.0 65667.0 39267.8 41142.8 41193.2 41237.4 41237.6 17206.7 17466.5 17531.6 17537.7 17594.6 12638.6 13084.9 13123.6 13356.9 13371.0 9125.8 9237.5 9298.1 9305.5 9320.4 3492.3 3495.9 3539.2 3553.2 3629.7 1101.5 1122.3 1141.3 1197.8 1214.0 33533.3 34322.3 34495.5 34541.8 34690.0 1166.5 1199.1 1228.1 1271.3 1299.9 17962.7 18054.3 18220.0 18293.8 18352.3 571843.0 572064.0 572626.0 572764.0 573539.0 65779.3 66075.7 66092.3 66351.3 66589.0 1400.8 1425.4 1456.4 1520.6 1528.1 30985.1 34322.0 34404.8 34691.8 35239.3 54469.0 55154.7 55155.0 55226.0 55238.4 338207.0 338551.0 339638.0 339706.0 340349.0 27067.6 30076.7 30832.0 31127.2 31141.0 51236.2 52152.0 52722.0 53524.5 56586.0 44236.6 44426.0 44953.0 45484.0 45616.8 43379.3 44223.3 44348.0 45208.5 45519.0 44201.3 44577.8 45246.8 45334.5 45690.5 38009.6 38932.6 39268.8 39604.4 39916.4 29605.0 29764.3 29810.0 30387.7 30618.7 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | [#2] jquery.html Cycles:180 Average:28827.82 Median:2635.87 stddev:81235.73 (3081.9%) stddev-sans-first:81435.55 11:55:09 INFO - PROCESS | 8665 | Values: 387.1 398.8 408.4 410.4 416.5 13967.4 18928.2 20519.2 20560.4 22008.4 18938.0 19864.6 19917.9 20588.8 20917.9 5271.5 5445.0 5460.0 5462.0 5465.0 5395.1 5417.9 5434.6 5436.4 5437.3 5440.2 5529.1 5956.2 5960.7 5966.0 5682.4 5819.4 5884.3 5897.0 5936.5 5052.5 5202.0 5214.1 5221.2 5227.1 13735.7 13805.3 18140.4 24461.1 24468.9 2482.7 2503.8 2767.9 2836.4 2898.8 10358.6 10433.2 10746.7 10747.1 12659.4 1839.8 1979.4 2001.5 2036.2 2125.8 60460.0 62908.0 74037.3 81066.6 81931.0 9194.0 9936.0 10000.0 10499.6 10543.4 14063.3 14071.4 14089.3 14162.8 14178.1 8282.3 8487.7 8645.7 8702.4 8770.3 8761.2 8872.8 8899.5 9048.1 9052.4 4244.7 4312.1 4343.0 4363.1 4424.1 2068.2 2070.2 2075.4 2075.5 2082.7 836.8 1018.9 1070.4 1110.3 1182.1 19833.2 20011.0 20082.0 20233.9 20368.4 1026.4 1078.4 1098.9 1115.9 1123.2 11075.6 11432.3 11439.2 11488.4 11556.9 489418.0 490021.0 493504.0 494944.0 498231.1 93919.5 95305.0 95617.0 96477.0 97253.0 1055.6 1071.1 1075.5 1076.7 1081.8 17691.1 17809.9 17934.8 17973.2 18106.5 38318.4 39299.6 39476.4 40789.8 40886.8 55918.0 56052.0 56542.7 57096.7 57391.0 8861.5 8978.9 9056.3 9079.8 9113.9 9767.6 13421.9 13467.3 13577.9 13911.3 8525.7 8607.3 11610.6 11778.9 12118.7 11727.7 11765.2 11809.5 12076.7 12130.4 12067.1 12122.3 12306.0 12468.6 12548.2 8940.9 9042.6 9061.5 9116.3 9142.1 11670.6 11930.6 12334.1 12474.8 12678.6 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | [#3] mootools.html Cycles:180 Average:6436.93 Median:2567.09 stddev:3789.95 (147.6%) stddev-sans-first:3781.85 11:55:09 INFO - PROCESS | 8665 | Values: 1422.6 1547.6 1583.4 1791.4 1918.5 8577.3 9420.9 9712.0 9714.4 10015.1 9585.5 9794.0 9811.8 9816.2 9819.8 2409.0 2436.9 2439.9 2440.7 2441.4 2423.0 2425.1 2464.1 2467.4 2468.3 2430.8 2438.8 2453.8 2454.8 2457.9 2432.3 2433.2 2435.1 2456.7 2457.0 2354.5 2362.0 2364.3 2365.6 2384.8 8555.7 9256.6 9630.1 9694.0 9700.3 5377.9 5560.2 5564.7 5567.3 5570.4 3593.1 3618.8 3623.2 3726.2 3735.0 1178.7 1222.0 1245.5 1252.3 1262.7 14079.2 14209.0 14231.1 14277.5 14329.7 4983.0 5034.7 5096.6 5130.6 5163.1 11878.9 11909.3 11936.7 11942.0 11944.3 5862.8 5880.1 5888.6 5889.2 5902.8 5054.6 5066.6 5159.6 5379.3 5381.1 4110.5 4158.0 4192.7 4221.9 4223.4 1262.8 1289.8 1289.9 1304.6 1312.3 1069.4 1073.5 1074.5 1074.7 1083.5 6441.3 6714.8 6719.2 6783.1 6794.3 447.8 455.5 460.6 462.0 470.2 4543.4 4672.2 4703.0 4712.5 4730.3 11933.0 12394.6 12398.1 12465.8 12513.6 11616.4 12135.5 12149.4 12447.3 12529.7 9033.3 9132.5 9173.4 9175.9 9184.4 6578.1 6727.8 6755.4 6790.6 6943.9 11293.5 11432.0 11460.3 11500.1 11601.1 10988.9 11417.5 11454.7 11546.5 11683.4 8165.4 8403.2 8564.8 8576.4 8581.9 9344.5 9629.4 9651.3 9654.0 9664.1 8318.5 8623.1 8660.9 8753.5 8832.9 8447.7 8578.1 8586.3 8603.7 8729.3 7833.7 8015.3 8017.6 8031.2 8051.6 5726.7 5760.6 5853.5 5911.0 5950.8 5726.3 5764.9 5826.2 5850.0 5878.2 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | [#4] prototype.html Cycles:180 Average:4760.06 Median:5338.48 stddev:1421.72 (26.6%) stddev-sans-first:1386.38 11:55:09 INFO - PROCESS | 8665 | Values: 335.7 338.1 344.5 345.3 348.9 5323.3 5450.9 5475.8 5527.0 5544.7 5433.2 5434.6 5436.1 5446.3 5468.7 4257.8 4275.9 4285.3 4293.4 4295.4 4066.5 4125.8 4225.2 4268.1 4291.8 4205.7 4211.2 4211.9 4222.6 4224.4 4213.8 4213.9 4219.4 4233.7 4258.6 3627.5 3755.2 3758.0 3760.2 3762.7 5241.9 5254.7 5271.6 5272.4 5282.8 4807.8 4848.2 4879.4 4883.2 4890.5 5411.5 5691.7 5699.1 5713.7 5715.5 4057.2 4092.5 4097.0 4107.3 4107.3 5962.3 6019.4 6025.3 6027.6 6035.1 4098.2 4122.0 4203.6 4208.7 4218.5 4226.5 4227.8 4246.6 4247.5 4262.3 4825.1 4862.3 4881.8 4882.2 4895.7 5544.5 5779.5 5787.0 5803.4 5807.5 1382.4 1429.9 1462.2 1463.6 1466.1 900.3 902.8 903.3 907.3 924.6 4794.4 4900.2 4913.0 4993.6 5012.3 5307.9 5309.8 5331.7 5345.3 5349.3 4833.4 4998.6 5009.5 5019.2 5079.8 2774.9 2794.7 2813.3 2832.0 2836.2 5387.5 5395.9 5410.3 5484.6 5501.3 5264.4 5286.4 5570.0 6085.1 6085.6 6229.0 6252.7 6268.9 6276.5 6279.8 5808.8 5960.0 6039.6 6050.6 6056.5 5838.7 5845.4 5859.7 5861.2 5908.6 6187.6 6195.4 6199.9 6201.6 6238.5 4092.4 4155.4 4174.3 4203.4 4217.0 5699.9 5862.8 5873.1 5895.9 5938.8 5695.0 5783.8 5793.2 5816.0 5825.5 5783.2 5794.9 5819.6 5822.4 5823.5 5560.3 5672.2 5691.9 5693.2 5705.0 5748.5 5801.2 5807.5 5835.3 5850.3 5449.5 5671.8 5699.3 5734.6 5755.1 11:55:09 INFO - PROCESS | 8665 | 11:55:09 INFO - PROCESS | 8665 | [#5] yui.html Cycles:180 Average:20693.43 Median:4815.31 stddev:29127.70 (604.9%) stddev-sans-first:29171.00 11:55:09 INFO - PROCESS | 8665 | Values: 771.9 782.7 821.6 829.5 887.4 14538.1 15740.4 15795.8 15824.2 15834.0 14665.6 14731.4 14733.8 16505.5 17117.5 895.8 896.3 905.3 906.0 906.4 889.4 891.9 892.6 892.8 893.1 930.0 931.4 931.8 934.2 935.8 927.2 929.0 930.2 930.7 930.8 684.7 685.0 685.6 686.3 687.0 16645.2 16685.1 16696.1 16733.2 16747.4 14284.7 15032.0 15120.1 15190.5 15342.1 12386.6 12484.2 12605.1 12621.9 12762.4 3970.3 3998.5 4029.4 4093.1 4105.3 55484.7 65244.0 66624.7 67816.0 75398.0 12399.8 12454.2 12459.6 12488.4 12719.9 22416.4 22442.3 22454.8 22571.3 22578.5 6981.7 9081.8 9286.6 9341.4 9762.0 5142.5 5239.8 5281.0 5325.8 5421.3 3673.2 3835.0 3861.4 3863.6 3865.7 653.3 656.2 665.1 668.3 671.8 754.6 805.7 811.2 815.0 832.4 10248.0 10344.8 10355.9 10367.7 10420.9 712.8 731.1 734.0 799.5 811.5 4724.7 4905.9 4962.3 4964.8 4976.1 101034.0 114036.4 114440.0 118265.4 118313.0 93475.0 97741.0 98988.0 99502.5 99902.5 82230.2 82952.2 83599.0 83607.6 84204.6 9262.6 9313.4 9353.1 9595.3 9665.2 51388.5 52032.0 52467.0 53325.5 54098.0 71023.0 75714.6 76092.6 78670.0 80234.2 12603.5 12928.1 12942.7 12949.9 13215.7 14475.1 14800.7 15101.7 15375.7 15591.8 13029.9 13201.3 13208.6 13237.9 13300.1 13981.8 14319.4 14327.0 14334.2 14377.4 13139.7 13194.2 13543.7 13654.2 13719.0 10666.9 10719.2 10944.0 11032.3 11133.7 10908.7 11054.7 11126.8 11174.0 11246.2 11:55:09 INFO - PROCESS | 8665 | -------- Summary: end -------- 11:55:09 INFO - PROCESS | 8665 | 11:55:10 INFO - TEST-INFO | 8665: exit 0 11:55:10 INFO - TEST-OK | dromaeo_css | took 1112322ms 11:55:10 INFO - TEST-START | kraken 11:55:10 INFO - operating with platform_type : linux_ 11:55:10 INFO - Initialising browser for kraken test... 11:55:10 INFO - TEST-INFO | started process 8855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuj6Dr/profile http://localhost:35188/getInfo.html) 11:55:14 INFO - PROCESS | 8855 | __metrics Screen width/height:1600/1200 11:55:14 INFO - PROCESS | 8855 | colorDepth:24 11:55:14 INFO - PROCESS | 8855 | Browser inner width/height: 1024/697 11:55:14 INFO - PROCESS | 8855 | __metrics 11:55:15 INFO - PROCESS | 8855 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:55:15 ERROR - PROCESS | 8855 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:55:16 INFO - TEST-INFO | 8855: exit 0 11:55:16 INFO - Browser initialized. 11:55:16 INFO - Running cycle 1/1 for kraken test... 11:55:16 INFO - TEST-INFO | started process 8945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOuj6Dr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:27 INFO - PROCESS | 8945 | RSS: Main: 140353536 11:55:27 INFO - PROCESS | 8945 | 11:55:30 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35188/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:31 INFO - PROCESS | 8945 | RSS: Main: 192057344 11:55:31 INFO - PROCESS | 8945 | 11:55:33 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35188/tests/kraken/driver.html?testName=audio-dft) 11:55:34 INFO - PROCESS | 8945 | RSS: Main: 189427712 11:55:34 INFO - PROCESS | 8945 | 11:55:37 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35188/tests/kraken/driver.html?testName=audio-fft) 11:55:37 INFO - PROCESS | 8945 | RSS: Main: 276267008 11:55:37 INFO - PROCESS | 8945 | 11:55:39 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35188/tests/kraken/driver.html?testName=audio-oscillator) 11:55:40 INFO - PROCESS | 8945 | RSS: Main: 184946688 11:55:40 INFO - PROCESS | 8945 | 11:55:42 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:55:43 INFO - PROCESS | 8945 | RSS: Main: 185155584 11:55:43 INFO - PROCESS | 8945 | 11:55:46 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35188/tests/kraken/driver.html?testName=imaging-darkroom) 11:55:46 INFO - PROCESS | 8945 | RSS: Main: 220532736 11:55:46 INFO - PROCESS | 8945 | 11:55:50 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35188/tests/kraken/driver.html?testName=imaging-desaturate) 11:55:50 INFO - PROCESS | 8945 | RSS: Main: 220274688 11:55:50 INFO - PROCESS | 8945 | 11:55:53 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35188/tests/kraken/driver.html?testName=json-parse-financial) 11:55:53 INFO - PROCESS | 8945 | RSS: Main: 218673152 11:55:53 INFO - PROCESS | 8945 | 11:55:55 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:55:56 INFO - PROCESS | 8945 | RSS: Main: 197984256 11:55:56 INFO - PROCESS | 8945 | 11:55:57 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:55:58 INFO - PROCESS | 8945 | RSS: Main: 200728576 11:55:58 INFO - PROCESS | 8945 | 11:56:00 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:01 INFO - PROCESS | 8945 | RSS: Main: 207613952 11:56:01 INFO - PROCESS | 8945 | 11:56:03 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:04 INFO - PROCESS | 8945 | RSS: Main: 211890176 11:56:04 INFO - PROCESS | 8945 | 11:56:06 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:07 INFO - PROCESS | 8945 | RSS: Main: 212684800 11:56:07 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | Cycle 1(1): loaded http://localhost:35188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35188/tests/kraken/driver.html?testName=ai-astar) 11:56:09 INFO - PROCESS | 8945 | RSS: Main: 254779392 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | __start_tp_report 11:56:09 INFO - PROCESS | 8945 | _x_x_mozilla_page_load 11:56:09 INFO - PROCESS | 8945 | _x_x_mozilla_page_load_details 11:56:09 INFO - PROCESS | 8945 | |i|pagename|runs| 11:56:09 INFO - PROCESS | 8945 | |0;ai-astar;111;104;110;109;110;110;110;112;109;110 11:56:09 INFO - PROCESS | 8945 | |1;audio-beat-detection;154;129;125;172;124;125;155;124;157;123 11:56:09 INFO - PROCESS | 8945 | |2;audio-dft;160;161;160;161;160;160;162;163;160;162 11:56:09 INFO - PROCESS | 8945 | |3;audio-fft;76;76;75;109;75;75;77;73;97;75 11:56:09 INFO - PROCESS | 8945 | |4;audio-oscillator;84;84;117;84;84;85;110;84;84;126 11:56:09 INFO - PROCESS | 8945 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;116;116 11:56:09 INFO - PROCESS | 8945 | |6;imaging-darkroom;145;145;146;146;146;146;146;145;146;145 11:56:09 INFO - PROCESS | 8945 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;94 11:56:09 INFO - PROCESS | 8945 | |8;json-parse-financial;50;54;49;51;51;54;52;52;50;50 11:56:09 INFO - PROCESS | 8945 | |9;json-stringify-tinderbox;61;63;61;61;61;60;61;61;61;61 11:56:09 INFO - PROCESS | 8945 | |10;stanford-crypto-aes;77;77;76;76;77;77;82;82;111;77 11:56:09 INFO - PROCESS | 8945 | |11;stanford-crypto-ccm;123;121;119;127;118;114;115;120;144;120 11:56:09 INFO - PROCESS | 8945 | |12;stanford-crypto-pbkdf2;156;154;161;157;161;161;160;156;156;158 11:56:09 INFO - PROCESS | 8945 | |13;stanford-crypto-sha256-iterative;64;61;69;64;61;61;61;62;60;63 11:56:09 INFO - PROCESS | 8945 | __end_tp_report 11:56:09 INFO - PROCESS | 8945 | __start_cc_report 11:56:09 INFO - PROCESS | 8945 | _x_x_mozilla_cycle_collect,1576 11:56:09 INFO - PROCESS | 8945 | __end_cc_report 11:56:09 INFO - PROCESS | 8945 | __startTimestamp1470423369274__endTimestamp 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | ------- Summary: start ------- 11:56:09 INFO - PROCESS | 8945 | Number of tests: 14 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.12 (1.9%) stddev-sans-first:2.18 11:56:09 INFO - PROCESS | 8945 | Values: 111.0 104.0 110.0 109.0 110.0 110.0 110.0 112.0 109.0 110.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:141.50 stddev:18.53 (13.1%) stddev-sans-first:18.82 11:56:09 INFO - PROCESS | 8945 | Values: 154.0 129.0 125.0 172.0 124.0 125.0 155.0 124.0 157.0 123.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:56:09 INFO - PROCESS | 8945 | Values: 160.0 161.0 160.0 161.0 160.0 160.0 162.0 163.0 160.0 162.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.08 (16.0%) stddev-sans-first:12.69 11:56:09 INFO - PROCESS | 8945 | Values: 76.0 76.0 75.0 109.0 75.0 75.0 77.0 73.0 97.0 75.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:16.63 (19.8%) stddev-sans-first:17.23 11:56:09 INFO - PROCESS | 8945 | Values: 84.0 84.0 117.0 84.0 84.0 85.0 110.0 84.0 84.0 126.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:56:09 INFO - PROCESS | 8945 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:56:09 INFO - PROCESS | 8945 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:56:09 INFO - PROCESS | 8945 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:1.70 (3.3%) stddev-sans-first:1.74 11:56:09 INFO - PROCESS | 8945 | Values: 50.0 54.0 49.0 51.0 51.0 54.0 52.0 52.0 50.0 50.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 11:56:09 INFO - PROCESS | 8945 | Values: 61.0 63.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:77.00 stddev:10.71 (13.9%) stddev-sans-first:11.25 11:56:09 INFO - PROCESS | 8945 | Values: 77.0 77.0 76.0 76.0 77.0 77.0 82.0 82.0 111.0 77.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:120.50 stddev:8.54 (7.1%) stddev-sans-first:9.06 11:56:09 INFO - PROCESS | 8945 | Values: 123.0 121.0 119.0 127.0 118.0 114.0 115.0 120.0 144.0 120.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:159.00 stddev:2.58 (1.6%) stddev-sans-first:2.64 11:56:09 INFO - PROCESS | 8945 | Values: 156.0 154.0 161.0 157.0 161.0 161.0 160.0 156.0 156.0 158.0 11:56:09 INFO - PROCESS | 8945 | 11:56:09 INFO - PROCESS | 8945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:2.63 (4.2%) stddev-sans-first:2.74 11:56:09 INFO - PROCESS | 8945 | Values: 64.0 61.0 69.0 64.0 61.0 61.0 61.0 62.0 60.0 63.0 11:56:09 INFO - PROCESS | 8945 | -------- Summary: end -------- 11:56:09 INFO - PROCESS | 8945 | 11:56:10 INFO - TEST-INFO | 8945: exit 0 11:56:10 INFO - TEST-OK | kraken | took 60107ms 11:56:10 INFO - SUITE-END | took 1172s 11:56:10 INFO - Completed test suite (00:19:32) 11:56:10 INFO - javascript benchmark 11:56:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3404.0298514923247, 3408.0798184490204, 3425.09235052711, 3448.982755086224, 3455.4816777483375, 5571.609987300891, 5621.0, 5661.60368774186, 5670.631408958415, 5678.602497825149, 5613.747381367848, 5686.601937864351, 5687.488126068653, 5688.0, 5698.544116470683, 4970.130227210242, 5032.2703208035, 5154.690718556889, 5158.3552055993005, 5203.2975548301065, 5102.36220472441, 5158.0, 5160.664556803796, 5161.767720452589, 5165.793368265284, 5041.294218809369, 5076.263941728447, 5093.465186155456, 5110.105731496992, 5153.123968925292, 5183.870403239912, 5198.480151984809, 5203.375594928595, 5215.504527069922, 5242.108841496935, 5001.274815151819, 5020.221865610836, 5078.46676099008, 5111.616628752859, 5142.640015198937, 5487.396386397493, 5499.120140777496, 5503.422140675251, 5517.200005999108, 5543.279373681436, 6067.0, 6067.24159480065, 6072.51419886408, 6075.270967483886, 6082.847928801771, 5995.310539287994, 6035.879282414371, 6079.787207447718, 6104.877902441926, 6106.511479081662, 5696.544276457874, 5736.569757268222, 5745.195672605797, 5747.0230060889335, 5754.021816291241, 6000.579959402888, 6220.315765265817, 6229.781957631461, 6230.345813689588, 6232.844178895473, 5836.095405212199, 5857.648541087463, 5864.794732184353, 5940.049592065336, 5967.9701601491715, 6043.576949613484, 6046.486048685823, 6081.3614570470345, 6081.878362432726, 6084.908726369108, 5850.385709500526, 5894.764209431661, 5948.881022379528, 5963.940360596339, 5967.254093238345, 5921.7631294747725, 6000.8799824004145, 6003.8198854034445, 6005.069214271707, 6042.395760423922, 4618.815247390134, 4619.122366750374, 4626.0, 4626.676132670681, 4650.465196502378, 4084.8570300039355, 4090.9386359204636, 4109.630133288018, 4149.585041495826, 4158.106007208465, 5693.3168019837885, 5711.628744131618, 5716.857078573069, 5725.713714314267, 5740.6268592541355, 5984.0, 6059.424354686298, 6060.121282414026, 6064.878702426015, 6080.2399700037495, 5570.220169176318, 5659.236003139606, 5705.828825135252, 5707.629004114802, 5710.400407957105, 5241.50205730455, 5278.340207474066, 5280.7359632019015, 5281.656692314988, 5301.0723123453245, 6327.17746692927, 6336.112944187817, 6337.714802833883, 6347.016212487072, 6351.460125889351, 5822.737976791139, 5935.7032148391545, 5961.612495187799, 5979.133025711334, 6079.878402432015, 6212.565120441706, 6225.159603453657, 6252.562320637694, 6264.780732674334, 6272.780452684134, 5909.202257695156, 5916.319623243382, 5916.940830591639, 5923.348431672426, 5949.702514874326, 5928.762849485972, 5934.881302374015, 5952.107183922446, 6012.188354572077, 6021.066734656135, 5821.883562328814, 5891.440313170242, 5909.497692696169, 5940.851478713067, 5957.314908785545, 5865.794697185578, 5872.383399742966, 5874.735636896436, 5880.441358070976, 5896.410358964241, 5727.599068065196, 5766.250387449605, 5778.075507918881, 5805.767769289181, 5808.186853840381, 5971.044632858721, 6003.339632640494, 6004.219451471281, 6012.368701286302, 6013.849653758691, 5842.824715258549, 5848.766049358148, 5853.1220316952795, 5853.619514731528, 5855.03391940325], "value": 5570.197531511068, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.0714392691327, 644.1079105438967, 654.1398061549063, 654.5320096131268, 667.9198496180453, 33575.16062098449, 35713.64286357139, 46670.29994550085, 47359.763201183945, 47519.28721069178, 48176.75911620437, 48688.51311486893, 48728.756356218255, 48792.75603621986, 48801.0, 8389.454685445457, 9113.270938324935, 9258.074192580756, 9273.0, 9275.211607013413, 10989.890101099007, 11301.717457063556, 11306.943465282662, 11307.095432365391, 11308.09535237183, 11053.778924421507, 11155.442227888614, 11162.107031437465, 11186.552537898475, 11188.496517656726, 11160.553577856876, 11211.990920817125, 11217.831732524019, 11226.04578610819, 11227.326360418401, 10943.56225750969, 11010.229283950126, 11019.063379612742, 11022.834657480144, 11026.944865275702, 44703.55296447059, 44752.55247447517, 44818.55181448209, 45169.54830451719, 45259.32111018337, 3884.0678237223146, 3924.6860251179837, 3935.330993731073, 4003.899902502461, 4006.7996600169877, 34349.6565034349, 34686.0, 35159.648403515894, 35229.647703522896, 35381.46927796085, 4701.929471057937, 4765.1660959331975, 4800.231962885957, 4808.062427826575, 4905.583025442842, 352882.0, 355245.0, 355276.0, 356051.0, 356765.0, 37998.620013800064, 65052.0, 65438.0, 65490.0, 65667.0, 39267.803660982085, 41142.79428602838, 41193.176136477705, 41237.38143927843, 41237.58762412338, 17206.655866882844, 17466.476005719847, 17531.56171095733, 17537.736933946002, 17594.64810703779, 12638.620841374774, 13084.869151308365, 13123.60629181126, 13356.866431335757, 13371.0, 9125.817483650422, 9237.491937943478, 9298.116678915492, 9305.53472326381, 9320.440773553473, 3492.336456073338, 3495.9300813984087, 3539.150603855108, 3553.236054248349, 3629.6551827576336, 1101.498818037791, 1122.337820685783, 1141.303804679145, 1197.7724232395817, 1213.9635810925686, 33533.32933341368, 34322.313553729284, 34495.4825677615, 34541.82729086339, 34690.0, 1166.4517676691942, 1199.1186477938709, 1228.0666693313146, 1271.262667652759, 1299.9220046797222, 17962.730559041625, 18054.277828886698, 18220.0, 18293.81706182948, 18352.26590936374, 571843.0, 572064.0, 572626.0, 572764.0, 573539.0, 65779.34220657732, 66075.66962165158, 66092.33907660958, 66351.33648663548, 66589.0, 1400.7828786538103, 1425.4298280687808, 1456.3737592835182, 1520.6350475885708, 1528.1213302351193, 30985.098799805906, 34322.0, 34404.827975860964, 34691.826540867136, 35239.27257562374, 54469.0, 55154.72422638022, 55155.0, 55226.0, 55238.447615524936, 338207.0, 338551.0, 339638.0, 339706.0, 340349.0, 27067.59398609062, 30076.699233007388, 30832.0, 31127.221819454695, 31141.0, 51236.23145652893, 52152.0, 52722.0, 53524.464755351946, 56586.0, 44236.557634424535, 44426.0, 44953.0, 45484.0, 45616.771916140206, 43379.349309759746, 44223.33664994963, 44348.0, 45208.54791452044, 45519.0, 44201.33697994597, 44577.80323215323, 45246.77376613096, 45334.546654533035, 45690.54309456863, 38009.61990380061, 38932.6106738929, 39268.80365598268, 39604.405933910435, 39916.40125398179, 29605.0, 29764.255893602833, 29810.0, 30387.69612303937, 30618.693813061585], "value": 20577.40853160923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.1231660289444, 398.81853756540767, 408.3874188716925, 410.3557414858671, 416.5272415808057, 13967.44130234792, 18928.24287028519, 20519.179232830687, 20560.38318850435, 22008.44978875525, 18938.0, 19864.602707945833, 19917.90041049793, 20588.794112058877, 20917.895410522928, 5271.472852714717, 5445.0, 5459.972700136514, 5461.972690136544, 5465.043617366965, 5395.0558652235895, 5417.945820541803, 5434.619576629618, 5436.401995780461, 5437.32033495813, 5440.211169380437, 5529.142982837647, 5956.225690660208, 5960.731767070471, 5965.970170149143, 5682.431756824326, 5819.447152520525, 5884.323302820188, 5896.999999999978, 5936.465718085371, 5052.545270925634, 5202.03762303975, 5214.0875346814155, 5221.190715439113, 5227.059129356714, 13735.725285494234, 13805.309734513234, 18140.365087221882, 24461.143859964995, 24468.877655611785, 2482.7144878338863, 2503.849769013865, 2767.8892844286206, 2836.4043550854344, 2898.840563768992, 10358.585656573729, 10433.217508686803, 10746.731331716692, 10747.140228781756, 12659.36703164838, 1839.7884243311923, 1979.445755188535, 2001.4996250937265, 2036.216056818121, 2125.798049185325, 60460.0, 62908.0, 74037.25962740357, 81066.5946670263, 81931.0, 9193.95403022994, 9936.0, 10000.0, 10499.632512862167, 10543.420111893765, 14063.296835158406, 14071.437142514389, 14089.295535223198, 14162.787558186636, 14178.078424902349, 8282.254597086292, 8487.702930397407, 8645.654173833102, 8702.434341767765, 8770.254528365032, 8761.167689069529, 8872.822543549093, 8899.510526921082, 9048.140426659456, 9052.366334356664, 4244.72409293395, 4312.094460163338, 4343.0, 4363.06194168249, 4424.093060922503, 2068.214078650103, 2070.223666125203, 2075.3773867839586, 2075.533005073846, 2082.687596860483, 836.7657056024323, 1018.9032041956002, 1070.4478506165935, 1110.3005106782675, 1182.0720734223594, 19833.206671733256, 20011.0, 20082.0, 20233.89883050605, 20368.388948331572, 1026.4068294382728, 1078.396098185019, 1098.9340639561651, 1115.8828323026128, 1123.1856903744883, 11075.5569777208, 11432.314061156358, 11439.199256052163, 11488.425578721031, 11556.88443115575, 489418.0, 490021.0, 493504.0, 494944.0, 498231.0530684085, 93919.53040234892, 95305.0, 95617.0, 96477.0, 97253.0, 1055.6199768083638, 1071.132382769959, 1075.5052675769234, 1076.6716151573846, 1081.8269076947809, 17691.115444227995, 17809.910950445683, 17934.820651793314, 17973.19120639548, 18106.54733631617, 38318.42522362111, 39299.60700393074, 39476.40785388164, 40789.796051019555, 40886.79556602317, 55918.0, 56052.0, 56542.71728641495, 57096.71451642715, 57391.0, 8861.512616806138, 8978.86531702012, 9056.275497960016, 9079.818403632022, 9113.863292050492, 9767.609295628095, 13421.932890335876, 13467.259300738553, 13577.86422135766, 13911.304434778018, 8525.701600443954, 8607.311415086904, 11610.593629222936, 11778.941105294418, 12118.697032573904, 11727.706807329543, 11765.176437649283, 11809.468573914022, 12076.698082547655, 12130.393480326125, 12067.09496787762, 12122.27266364021, 12306.0, 12468.563600273947, 12548.165605159009, 8940.86588701183, 9042.63829446841, 9061.546922653974, 9116.316276279173, 9142.085791420805, 11670.649880503599, 11930.582429614922, 12334.074944379028, 12474.750504989668, 12678.556250531186], "value": 9274.207866828616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.6087825847885, 1547.582152818739, 1583.3587397104172, 1791.435697755207, 1918.4820098573387, 8577.270931970783, 9420.85868711969, 9712.0, 9714.417134971907, 10015.098641122298, 9585.52072396381, 9793.951030244856, 9811.75470613235, 9816.165625921805, 9819.803603927918, 2408.9999999999955, 2436.8903399347073, 2439.890204940782, 2440.707115146185, 2441.389652586853, 2422.9823474140817, 2425.054228850741, 2464.051340234014, 2467.4324905271797, 2468.259522143359, 2430.793382562484, 2438.756124387565, 2453.8036957043396, 2454.8158888083376, 2457.8525288482747, 2432.2824766693866, 2433.2335314375914, 2435.07467162478, 2456.7297597264287, 2456.9631455528183, 2354.505553833697, 2361.988190059056, 2364.2552595932398, 2365.5741966446035, 2384.8211384146257, 8555.700550480766, 9256.629734810667, 9630.133288004114, 9693.951530242373, 9700.320977531575, 5377.946220537823, 5560.221568980346, 5564.749586268627, 5567.331920169565, 5570.415106413809, 3593.1017245688577, 3618.8009659468717, 3623.202895363016, 3726.1988672435555, 3734.9813250933844, 1178.7112157521376, 1221.9511219551207, 1245.5080243303935, 1252.2987127208792, 1262.696952731347, 14079.225642589654, 14209.0, 14231.07498012626, 14277.500287489991, 14329.713405731827, 4982.950170498249, 5034.6727462715535, 5096.592272618256, 5130.640855140105, 5163.122269214243, 11878.881211187778, 11909.285442873455, 11936.701582460508, 11942.044636429066, 11944.283342999448, 5862.824115276549, 5880.147378630075, 5888.587798854039, 5889.204957330706, 5902.822915312548, 5054.646174767805, 5066.569341606005, 5159.638825282194, 5379.273798037293, 5381.112116500812, 4110.547839737626, 4157.958420415817, 4192.748435093904, 4221.894452638709, 4223.366495025771, 1262.8484581850237, 1289.8323217981601, 1289.8903593194495, 1304.6412236634812, 1312.2716892124963, 1069.390447444949, 1073.5383784972537, 1074.548689550375, 1074.7044562745307, 1083.47992963378, 6441.259255185713, 6714.764983225564, 6719.160104986877, 6783.084283621746, 6794.286599907037, 447.81415712479605, 455.49667617283086, 460.56476629585393, 462.0182113009854, 470.2123942396472, 4543.363929049936, 4672.159011377917, 4703.0, 4712.52874712526, 4730.290456431494, 11933.0, 12394.566190183301, 12398.13213075076, 12465.813012804816, 12513.624591262276, 11616.361100139404, 12135.543734751885, 12149.392530373447, 12447.315397653036, 12529.74940501185, 9033.322500812465, 9132.543372831331, 9173.40372875761, 9175.862362064574, 9184.357095003286, 6578.111954886029, 6727.831804204934, 6755.392014718699, 6790.5925644461495, 6943.895841562482, 11293.491792869505, 11432.0, 11460.255083419552, 11500.137489688139, 11601.071914247008, 10988.890111098786, 11417.486213120263, 11454.713632159262, 11546.480408381474, 11683.357415342238, 8165.4284200107795, 8403.243708066304, 8564.785880353042, 8576.399652024298, 8581.914180858112, 9344.486053267136, 9629.374090684363, 9651.324407291422, 9653.951730241304, 9664.130228279488, 8318.45930014547, 8623.051464338792, 8660.913390866011, 8753.518556479456, 8832.867506987272, 8447.746567602982, 8578.056413794602, 8586.270167035622, 8603.655853765778, 8729.345299102466, 7833.686652533835, 8015.278624923785, 8017.5590342529385, 8031.196880311922, 8051.597420129087, 5726.713664316851, 5760.596758226884, 5853.502452291603, 5910.970445147746, 5950.821475355746, 5726.341470730919, 5764.884702306014, 5826.242588463472, 5850.005499065084, 5878.177055212359], "value": 4986.489209975392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.678143897322, 338.14955387201184, 344.49359441620817, 345.3266131044464, 348.90753950203185, 5323.281357016802, 5450.863728406782, 5475.808346707866, 5526.972365138174, 5544.722763861806, 5433.179884738617, 5434.619576629638, 5436.130219164925, 5446.319210098738, 5468.72656367181, 4257.765822879748, 4275.87172384829, 4285.292926667096, 4293.420388247593, 4295.377170310303, 4066.451029111062, 4125.814338354766, 4225.176090662307, 4268.103698223377, 4291.763952982585, 4205.684573656973, 4211.22092412903, 4211.91576168478, 4222.619964203221, 4224.408582798411, 4213.7893105344765, 4213.936790948138, 4219.409282700409, 4233.661307095425, 4258.616724494779, 3627.546556680415, 3755.1738617504107, 3757.9812100939594, 3760.191558814868, 3762.739482273442, 5241.947580524222, 5254.6847189168775, 5271.551918086967, 5272.420033796279, 5282.81510147143, 4807.759612019385, 4848.200046992242, 4879.39007624047, 4883.243097319921, 4890.462049174588, 5411.512963833274, 5691.715414229313, 5699.088145896637, 5713.714314284311, 5715.457031581993, 4057.2494088593407, 4092.529359123679, 4097.0, 4107.322291821846, 4107.336528705879, 5962.25471816023, 6019.428154325332, 6025.312912384583, 6027.649216805449, 6035.124906888476, 4098.159877225162, 4122.0, 4203.621674049289, 4208.705390622627, 4218.49378074633, 4226.535081141072, 4227.767472789026, 4246.554111818215, 4247.492140290153, 4262.3180291153885, 4825.131476334223, 4862.343583616237, 4881.804727810848, 4882.194437917775, 4895.681780684244, 5544.473275038946, 5779.537636989115, 5787.0, 5803.361630220672, 5807.5063619591965, 1382.377929931535, 1429.9142051476945, 1462.232328027794, 1463.6121427821636, 1466.098349515062, 900.3157600223877, 902.7541992050927, 903.3270213690711, 907.2651152566442, 924.611663101499, 4794.4486384065585, 4900.211422830713, 4912.9508704913205, 4993.550580447777, 5012.323336349619, 5307.920381194285, 5309.814156504503, 5331.653442526223, 5345.305110335709, 5349.304590403222, 4833.4441539223435, 4998.5751211146735, 5009.5491405773655, 5019.171836646912, 5079.771410286546, 2774.8890044398, 2794.6925838157786, 2813.338865366637, 2831.9858400707863, 2836.248394175545, 5387.542058925035, 5395.946040539623, 5410.321890664147, 5484.643498172606, 5501.312335958005, 5264.368275806928, 5286.418493965661, 5569.972150139223, 6085.148079268906, 6085.6348619083, 6229.0, 6252.718627661766, 6268.905966410507, 6276.529260305404, 6279.8116056517465, 5808.82573522795, 5959.970200148971, 6039.607425517327, 6050.606710563799, 6056.454919057306, 5838.737256823538, 5845.41545845429, 5859.736311866061, 5861.238039054895, 5908.615939963888, 6187.597806142587, 6195.411435913581, 6199.938000619936, 6201.565890387629, 6238.469730072995, 4092.447519584818, 4155.3766934958785, 4174.269502836931, 4203.414899836517, 4217.0, 5699.857503562444, 5862.794802181903, 5873.148393483007, 5895.94104058954, 5938.762449501972, 5694.971525142348, 5783.768649253982, 5793.217915581343, 5815.9709201453725, 5825.543614096476, 5783.190353350618, 5794.913076303943, 5819.592628515963, 5822.446867547576, 5823.505002074871, 5560.304961879765, 5672.2058911751565, 5691.893999220315, 5693.174489699053, 5704.971475142764, 5748.511376533042, 5801.1878337032, 5807.477327040587, 5835.336928975222, 5850.327212370632, 5449.482299181572, 5671.829845104653, 5699.287589051369, 5734.569907257056, 5755.079187330007], "value": 4304.321039246257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.9112302085258, 782.6673663692933, 821.6220538552266, 829.4774292195916, 887.4098724348308, 14538.055026423288, 15740.370385184608, 15795.84204157958, 15824.208789560518, 15833.999999999985, 14665.560033198994, 14731.410743570272, 14733.778993315109, 16505.504834854943, 17117.486475405727, 895.7536677413698, 896.2605850173617, 905.2712566384058, 905.9728208153766, 906.4017748286133, 889.3996552327186, 891.8929728432597, 892.5537231384308, 892.7500299916002, 893.0712059458189, 929.9721008369726, 931.3806318797991, 931.753085432361, 934.1685899549407, 935.8268720286769, 927.1794461901233, 929.0198840223561, 930.16285343191, 930.6882194464795, 930.8324501589711, 684.6782012454139, 684.9931500685029, 685.5509641185032, 686.3445409633838, 687.0381465947663, 16645.167741612993, 16685.082320472367, 16696.081715505643, 16733.24700388473, 16747.413840515524, 14284.715144975313, 15032.0, 15120.092794432368, 15190.544283671508, 15342.079475231521, 12386.5664701735, 12484.188527745759, 12605.11764176508, 12621.93689031549, 12762.425690843935, 3970.3250447424007, 3998.52017757868, 4029.4157347184496, 4093.0585965227865, 4105.281575724236, 55484.72257638686, 65244.0, 66624.6668766658, 67816.0, 75398.0, 12399.814002789966, 12454.190477618926, 12459.626211213677, 12488.438020289108, 12719.872801272053, 22416.439589010406, 22442.32673019812, 22454.775452245594, 22571.322860314216, 22578.54842903133, 6981.720731170798, 9081.81836363269, 9286.628534858664, 9341.439513629068, 9761.951190244145, 5142.485751424828, 5239.764210610531, 5280.973595132076, 5325.840224793263, 5421.349438067378, 3673.2102597941034, 3835.0, 3861.4400911868183, 3863.5943225961432, 3865.7487263327794, 653.3009679642831, 656.1732217406008, 665.1153965226334, 668.2615709640874, 671.7941295374814, 754.5812074298817, 805.7099444200084, 811.217175425717, 815.0283272040506, 832.4381042796089, 10248.0, 10344.793104137874, 10355.948220259, 10367.688969330931, 10420.947895260626, 712.771912987839, 731.119001603067, 733.977980660581, 799.5242830515833, 811.5009269299338, 4724.692894961817, 4905.920697446628, 4962.280469331927, 4964.826231081895, 4976.054549635558, 101034.0, 114036.42981785038, 114440.0, 118265.40867295781, 118313.0, 93475.0, 97741.0, 98988.0, 99502.5024874871, 99902.50048749709, 82230.17769822344, 82952.17047829565, 83599.0, 83607.5819620898, 84204.57897710595, 9262.629494820132, 9313.438804328864, 9353.11145441182, 9595.328327017321, 9665.226781857575, 51388.48611513837, 52032.0, 52467.0, 53325.46674533205, 54098.0, 71023.0, 75714.62142689251, 76092.61953690196, 78670.0, 80234.19765802268, 12603.49586016549, 12928.095033347576, 12942.741145177231, 12949.870501294867, 13215.669608259486, 14475.059121157092, 14800.703985920007, 15101.697966040398, 15375.692486150438, 15591.76612350793, 13029.934850325688, 13201.339933003119, 13208.603741887759, 13237.933810330887, 13300.135491193041, 13981.790273146114, 14319.355628996513, 14327.0, 14334.21161836109, 14377.353019113956, 13139.671508212372, 13194.208347499181, 13543.729125417634, 13654.180749155083, 13719.0, 10666.946665266934, 10719.196060295353, 10944.0, 11032.338059716443, 11133.721656958316, 10908.727281818017, 11054.723631909266, 11126.833097503382, 11174.0, 11246.156538259827], "value": 7862.371386731918, "unit": "score"}], "name": "dromaeo_css", "value": 7509.98189751164, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 109.0, 110.0, 110.0, 110.0, 112.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 125.0, 172.0, 124.0, 125.0, 155.0, 124.0, 157.0, 123.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 163.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 109.0, 75.0, 75.0, 77.0, 73.0, 97.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 84.0, 85.0, 110.0, 84.0, 84.0, 126.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 54.0, 49.0, 51.0, 51.0, 54.0, 52.0, 52.0, 50.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 77.0, 77.0, 82.0, 82.0, 111.0, 77.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 119.0, 127.0, 118.0, 114.0, 115.0, 120.0, 144.0, 120.0], "value": 122.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 161.0, 157.0, 161.0, 161.0, 160.0, 156.0, 156.0, 158.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 69.0, 64.0, 61.0, 61.0, 61.0, 62.0, 60.0, 63.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1477.4999999999998, "alertThreshold": 2.0}]} 11:56:10 INFO - Return code: 0 11:56:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:56:10 ERROR - # TBPL SUCCESS # 11:56:10 INFO - Running post-action listener: _resource_record_post_action 11:56:10 INFO - ##### 11:56:10 INFO - ##### Finished run-tests step (success) 11:56:10 INFO - ##### 11:56:10 INFO - Running post-run listener: _resource_record_post_run 11:56:10 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 733184; Write bytes: 286318592; Read time: 120; Write time: 209288 11:56:10 INFO - TinderboxPrint: CPU usage
13.1% 11:56:10 INFO - TinderboxPrint: I/O read bytes / time
733,184 / 120 11:56:10 INFO - TinderboxPrint: I/O write bytes / time
286,318,592 / 209,288 11:56:10 INFO - TinderboxPrint: CPU idle
8,238.4 (86.9%) 11:56:10 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 11:56:10 INFO - TinderboxPrint: Swap in / out
0 / 0 11:56:10 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70094848; Read time: 0; Write time: 80308 11:56:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 733184; Write bytes: 215609344; Read time: 120; Write time: 128980 11:56:11 INFO - Running post-run listener: _upload_blobber_files 11:56:11 INFO - Blob upload gear active. 11:56:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:11 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 11:56:11 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:56:11 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:56:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:12 INFO - (blobuploader) - INFO - Done attempting. 11:56:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:56:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:15 INFO - (blobuploader) - INFO - Done attempting. 11:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:56:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:16 INFO - (blobuploader) - INFO - Done attempting. 11:56:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:16 INFO - Return code: 0 11:56:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f782a9748aec9464b14f888124c3332572897e5904f71bbe1c73e944af1ce8c716077421e98bd8daea80aeb265fb136faf7ef197ff3a49b661a13bd3a8ede308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7149a691e2f158e5f8ee2a8dd4d9ebeeca67204b39265bd469c389fc7f79cee6a045d6330151ceaa3c591874e5d5189e9743eb908513226e83bce3e31f0a0401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac73851bfedac962874b9b055284cea04713701c6754528e95a34aa5abce1214b665a834e806d710303ac6be00c6bc311105315bd2b4197184f6d9a348e36955"} 11:56:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:16 INFO - Contents: 11:56:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f782a9748aec9464b14f888124c3332572897e5904f71bbe1c73e944af1ce8c716077421e98bd8daea80aeb265fb136faf7ef197ff3a49b661a13bd3a8ede308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7149a691e2f158e5f8ee2a8dd4d9ebeeca67204b39265bd469c389fc7f79cee6a045d6330151ceaa3c591874e5d5189e9743eb908513226e83bce3e31f0a0401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac73851bfedac962874b9b055284cea04713701c6754528e95a34aa5abce1214b665a834e806d710303ac6be00c6bc311105315bd2b4197184f6d9a348e36955"} 11:56:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:16 INFO - Copying logs to upload dir... 11:56:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.983593 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-05 11:56:16.744467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:56:16.748408) ========= 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=4300f881736b422476174874000001bc-1470421695.433413-780139583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f782a9748aec9464b14f888124c3332572897e5904f71bbe1c73e944af1ce8c716077421e98bd8daea80aeb265fb136faf7ef197ff3a49b661a13bd3a8ede308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7149a691e2f158e5f8ee2a8dd4d9ebeeca67204b39265bd469c389fc7f79cee6a045d6330151ceaa3c591874e5d5189e9743eb908513226e83bce3e31f0a0401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac73851bfedac962874b9b055284cea04713701c6754528e95a34aa5abce1214b665a834e806d710303ac6be00c6bc311105315bd2b4197184f6d9a348e36955"} build_url:https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/ajn996ApRP6sJkIbvxvBpQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f782a9748aec9464b14f888124c3332572897e5904f71bbe1c73e944af1ce8c716077421e98bd8daea80aeb265fb136faf7ef197ff3a49b661a13bd3a8ede308", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7149a691e2f158e5f8ee2a8dd4d9ebeeca67204b39265bd469c389fc7f79cee6a045d6330151ceaa3c591874e5d5189e9743eb908513226e83bce3e31f0a0401", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac73851bfedac962874b9b055284cea04713701c6754528e95a34aa5abce1214b665a834e806d710303ac6be00c6bc311105315bd2b4197184f6d9a348e36955"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:56:16.774601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:56:16.774947) ========= 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=4300f881736b422476174874000001bc-1470421695.433413-780139583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:56:16.861019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:56:16.861371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:56:16.861720) ========= ========= Total master_lag: 0.17 =========