builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1476355870.09 results: success (0) buildid: 20161013004623 builduid: 12b13e63f52747398c24a104b8459ede revision: 0c76efc924acd4b16e64aaaa07fe21462d0f7cfa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.088820) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.089282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.089553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.104347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.104682) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 03:51:10-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-10-13 03:51:10 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115935 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.234269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.234579) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017884 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.284732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:10.285076) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0c76efc924acd4b16e64aaaa07fe21462d0f7cfa --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 0c76efc924acd4b16e64aaaa07fe21462d0f7cfa --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=7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 03:51:10,670 truncating revision to first 12 chars 2016-10-13 03:51:10,670 Setting DEBUG logging. 2016-10-13 03:51:10,670 attempt 1/10 2016-10-13 03:51:10,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0c76efc924ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 03:51:10,976 unpacking tar archive at: mozilla-beta-0c76efc924ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:11.008192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:11.008508) ========= script_repo_revision: 0c76efc924acd4b16e64aaaa07fe21462d0f7cfa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:11.008921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:11.009178) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 03:51:11.017252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-13 03:51:11.017535) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:51:11 INFO - MultiFileLogger online at 20161013 03:51:11 in /builds/slave/test 03:51:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:51:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:11 INFO - {'append_to_log': False, 03:51:11 INFO - 'base_work_dir': '/builds/slave/test', 03:51:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:51:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:11 INFO - 'branch': 'Mozilla-Beta', 03:51:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:11 INFO - 'config_files': ('talos/linux_config.py',), 03:51:11 INFO - 'default_actions': ('clobber', 03:51:11 INFO - 'read-buildbot-config', 03:51:11 INFO - 'download-and-extract', 03:51:11 INFO - 'populate-webroot', 03:51:11 INFO - 'create-virtualenv', 03:51:11 INFO - 'install', 03:51:11 INFO - 'run-tests'), 03:51:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:11 INFO - 'download_minidump_stackwalk': True, 03:51:11 INFO - 'download_symbols': 'ondemand', 03:51:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:11 INFO - 'installer_path': 'installer.exe', 03:51:11 INFO - 'log_level': 'info', 03:51:11 INFO - 'log_name': 'talos', 03:51:11 INFO - 'log_to_console': True, 03:51:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:51:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:51:11 INFO - 'opt_config_files': (), 03:51:11 INFO - 'pip_index': False, 03:51:11 INFO - 'sps_profile': False, 03:51:11 INFO - 'sps_profile_interval': 0, 03:51:11 INFO - 'suite': 'dromaeojs-e10s', 03:51:11 INFO - 'system_bits': '32', 03:51:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:11 INFO - 'title': 'talos-linux64-ix-005', 03:51:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:11 INFO - 'use_talos_json': True, 03:51:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:11 INFO - 'work_dir': 'build'} 03:51:11 INFO - [mozharness: 2016-10-13 10:51:11.498072Z] Running clobber step. 03:51:11 INFO - Running pre-action listener: _resource_record_pre_action 03:51:11 INFO - Running main action method: clobber 03:51:11 INFO - rmtree: /builds/slave/test/build 03:51:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:11 INFO - Running post-action listener: _resource_record_post_action 03:51:11 INFO - [mozharness: 2016-10-13 10:51:11.953359Z] Finished clobber step (success) 03:51:11 INFO - [mozharness: 2016-10-13 10:51:11.953461Z] Running read-buildbot-config step. 03:51:11 INFO - Running pre-action listener: _resource_record_pre_action 03:51:11 INFO - Running main action method: read_buildbot_config 03:51:11 INFO - Using buildbot properties: 03:51:11 INFO - { 03:51:11 INFO - "project": "", 03:51:11 INFO - "product": "firefox", 03:51:11 INFO - "script_repo_revision": "production", 03:51:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:51:11 INFO - "repository": "", 03:51:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 03:51:11 INFO - "buildid": "20161013004623", 03:51:11 INFO - "pgo_build": "True", 03:51:11 INFO - "basedir": "/builds/slave/test", 03:51:11 INFO - "buildnumber": 152, 03:51:11 INFO - "slavename": "talos-linux64-ix-005", 03:51:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:51:11 INFO - "platform": "ubuntu64_hw", 03:51:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:51:11 INFO - "branch": "mozilla-beta", 03:51:11 INFO - "repo_path": "releases/mozilla-beta", 03:51:11 INFO - "revision": "0c76efc924acd4b16e64aaaa07fe21462d0f7cfa", 03:51:11 INFO - "stage_platform": "linux64-pgo", 03:51:11 INFO - "builduid": "12b13e63f52747398c24a104b8459ede", 03:51:11 INFO - "slavebuilddir": "test" 03:51:11 INFO - } 03:51:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 03:51:11 INFO - Running post-action listener: _resource_record_post_action 03:51:11 INFO - [mozharness: 2016-10-13 10:51:11.955934Z] Finished read-buildbot-config step (success) 03:51:11 INFO - [mozharness: 2016-10-13 10:51:11.956024Z] Running download-and-extract step. 03:51:11 INFO - Running pre-action listener: _resource_record_pre_action 03:51:11 INFO - Running main action method: download_and_extract 03:51:11 INFO - mkdir: /builds/slave/test/build/tests 03:51:11 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')]} 03:51:11 INFO - https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:51:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:51:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:51:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:51:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:51:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:51:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:51:11 INFO - retry: Failed, sleeping 30 seconds before retrying 03:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:51:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:51:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:51:42 INFO - retry: Failed, sleeping 60 seconds before retrying 03:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:52:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:52:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:52:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 03:52:42 INFO - Caught exception: HTTP Error 404: Not Found 03:52:42 INFO - Caught exception: HTTP Error 404: Not Found 03:52:42 INFO - Caught exception: HTTP Error 404: Not Found 03:52:42 INFO - trying https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:52:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:52:42 INFO - Downloaded 1327 bytes. 03:52:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:52:42 INFO - Using the following test package requirements: 03:52:42 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 03:52:42 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:52:42 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 03:52:42 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'jsshell-linux-x86_64.zip'], 03:52:42 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:52:42 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 03:52:42 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 03:52:42 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 03:52:42 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:52:42 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:52:42 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:52:42 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:52:42 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')]} 03:52:42 INFO - https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:52:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:52:42 INFO - retry: Failed, sleeping 30 seconds before retrying 03:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:53:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:53:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:53:12 INFO - retry: Failed, sleeping 60 seconds before retrying 03:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:54:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:54:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 03:54:12 INFO - Caught exception: HTTP Error 404: Not Found 03:54:12 INFO - Caught exception: HTTP Error 404: Not Found 03:54:12 INFO - Caught exception: HTTP Error 404: Not Found 03:54:12 INFO - trying https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:12 INFO - Downloading https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:54:13 INFO - Downloaded 21774055 bytes. 03:54:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:54:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:54:14 INFO - Return code: 0 03:54:14 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:54:14 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')]} 03:54:14 INFO - https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:54:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:54:14 INFO - retry: Failed, sleeping 30 seconds before retrying 03:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:54:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:54:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:54:44 INFO - retry: Failed, sleeping 60 seconds before retrying 03:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:55:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:55:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:55:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 03:55:44 INFO - Caught exception: HTTP Error 404: Not Found 03:55:44 INFO - Caught exception: HTTP Error 404: Not Found 03:55:44 INFO - Caught exception: HTTP Error 404: Not Found 03:55:44 INFO - trying https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:55:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:55:45 INFO - Downloaded 21774055 bytes. 03:55:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:55:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:55:47 INFO - Return code: 0 03:55:47 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')]} 03:55:47 INFO - https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:55:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:55:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:55:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:55:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:55:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:55:47 INFO - retry: Failed, sleeping 30 seconds before retrying 03:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:56:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:56:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:56:17 INFO - retry: Failed, sleeping 60 seconds before retrying 03:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:57:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:57:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:57:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 03:57:17 INFO - Caught exception: HTTP Error 404: Not Found 03:57:17 INFO - Caught exception: HTTP Error 404: Not Found 03:57:17 INFO - Caught exception: HTTP Error 404: Not Found 03:57:17 INFO - trying https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:57:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:57:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:57:17 INFO - Downloaded 14413740 bytes. 03:57:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:57:18 INFO - Return code: 0 03:57: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')]} 03:57:18 INFO - https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:57:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:57:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:57:18 INFO - retry: Failed, sleeping 30 seconds before retrying 03:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:57:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:57:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:57:48 INFO - retry: Failed, sleeping 60 seconds before retrying 03:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:58:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:58:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:58:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 03:58:48 INFO - Caught exception: HTTP Error 404: Not Found 03:58:48 INFO - Caught exception: HTTP Error 404: Not Found 03:58:48 INFO - Caught exception: HTTP Error 404: Not Found 03:58:48 INFO - trying https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:58:48 INFO - Downloading https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:58:49 INFO - Downloaded 56810820 bytes. 03:58:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:58:49 INFO - mkdir: /builds/slave/test/properties 03:58:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:49 INFO - Contents: 03:58:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:58:50 INFO - Running post-action listener: _resource_record_post_action 03:58:50 INFO - Running post-action listener: set_extra_try_arguments 03:58:50 INFO - [mozharness: 2016-10-13 10:58:50.381725Z] Finished download-and-extract step (success) 03:58:50 INFO - [mozharness: 2016-10-13 10:58:50.381960Z] Running populate-webroot step. 03:58:50 INFO - Running pre-action listener: _resource_record_pre_action 03:58:50 INFO - Running main action method: populate_webroot 03:58:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:50 INFO - '--tppagecycles', 03:58:50 INFO - '7'], 03:58:50 INFO - 'tests': ['tsvgm']}}, 03:58:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['damp', 'tps']}, 03:58:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'tests': ['damp', 'tps']}, 03:58:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['dromaeo_dom']}, 03:58:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['basic_compositor_video']}, 03:58:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['a11yr', 03:58:50 INFO - 'ts_paint', 03:58:50 INFO - 'tpaint', 03:58:50 INFO - 'sessionrestore', 03:58:50 INFO - 'sessionrestore_no_auto_restore', 03:58:50 INFO - 'tabpaint']}, 03:58:50 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:50 INFO - 'ts_paint', 03:58:50 INFO - 'tpaint', 03:58:50 INFO - 'sessionrestore', 03:58:50 INFO - 'sessionrestore_no_auto_restore', 03:58:50 INFO - 'tabpaint']}, 03:58:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:50 INFO - 'ts_paint', 03:58:50 INFO - 'tpaint', 03:58:50 INFO - 'sessionrestore', 03:58:50 INFO - 'sessionrestore_no_auto_restore', 03:58:50 INFO - 'tabpaint']}, 03:58:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:50 INFO - 'ts_paint', 03:58:50 INFO - 'tpaint', 03:58:50 INFO - 'sessionrestore', 03:58:50 INFO - 'sessionrestore_no_auto_restore', 03:58:50 INFO - 'tabpaint']}, 03:58:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['a11yr', 03:58:50 INFO - 'ts_paint', 03:58:50 INFO - 'tpaint', 03:58:50 INFO - 'sessionrestore', 03:58:50 INFO - 'sessionrestore_no_auto_restore', 03:58:50 INFO - 'tabpaint']}, 03:58:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['a11yr', 03:58:50 INFO - 'ts_paint', 03:58:50 INFO - 'tpaint', 03:58:50 INFO - 'sessionrestore', 03:58:50 INFO - 'sessionrestore_no_auto_restore', 03:58:50 INFO - 'tabpaint']}, 03:58:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['tsvgx', 03:58:50 INFO - 'tsvgr_opacity', 03:58:50 INFO - 'tart', 03:58:50 INFO - 'tscrollx', 03:58:50 INFO - 'cart']}, 03:58:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:50 INFO - 'tsvgr_opacity', 03:58:50 INFO - 'tart', 03:58:50 INFO - 'tscrollx', 03:58:50 INFO - 'cart']}, 03:58:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'talos_options': ['--disable-e10s'], 03:58:50 INFO - 'tests': ['tp5o']}, 03:58:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'tests': ['tp5o']}, 03:58:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'talos_options': ['--disable-e10s', 03:58:50 INFO - '--xperf_path', 03:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:50 INFO - 'tests': ['tp5n']}, 03:58:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:50 INFO - 'talos_options': ['--xperf_path', 03:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:50 INFO - 'tests': ['tp5n']}}, 03:58:50 INFO - 'talos.zip': {'path': '', 03:58:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:50 INFO - Running post-action listener: _resource_record_post_action 03:58:50 INFO - [mozharness: 2016-10-13 10:58:50.399949Z] Finished populate-webroot step (success) 03:58:50 INFO - [mozharness: 2016-10-13 10:58:50.400039Z] Running create-virtualenv step. 03:58:50 INFO - Running pre-action listener: _resource_record_pre_action 03:58:50 INFO - Running main action method: create_virtualenv 03:58:50 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:50 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 03:58:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:50 INFO - Using real prefix '/usr' 03:58:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:52 INFO - Installing pip.................done. 03:58:52 INFO - Return code: 0 03:58:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:58:52 INFO - Using env: {'DISPLAY': ':0', 03:58:52 INFO - 'HOME': '/home/cltbld', 03:58:52 INFO - 'LANG': 'en_US.UTF-8', 03:58:52 INFO - 'LANGUAGE': 'en_US:en', 03:58:52 INFO - 'LOGNAME': 'cltbld', 03:58:52 INFO - 'MAIL': '/var/mail/cltbld', 03:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:52 INFO - 'MOZ_NO_REMOTE': '1', 03:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:52 INFO - 'NO_EM_RESTART': '1', 03:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:52 INFO - 'PWD': '/builds/slave/test', 03:58:52 INFO - 'SHELL': '/bin/bash', 03:58:52 INFO - 'SHLVL': '1', 03:58:52 INFO - 'TERM': 'linux', 03:58:52 INFO - 'TMOUT': '86400', 03:58:52 INFO - 'USER': 'cltbld', 03:58:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:52 INFO - '_': '/tools/buildbot/bin/python'} 03:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:53 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 03:58:53 INFO - Cleaning up... 03:58:53 INFO - Return code: 0 03:58:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58: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')]} 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58: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')]} 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:53 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:58:53 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 03:58:53 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 03:58:53 INFO - Using env: {'DISPLAY': ':0', 03:58:53 INFO - 'HOME': '/home/cltbld', 03:58:53 INFO - 'LANG': 'en_US.UTF-8', 03:58:53 INFO - 'LANGUAGE': 'en_US:en', 03:58:53 INFO - 'LOGNAME': 'cltbld', 03:58:53 INFO - 'MAIL': '/var/mail/cltbld', 03:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:53 INFO - 'MOZ_NO_REMOTE': '1', 03:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:53 INFO - 'NO_EM_RESTART': '1', 03:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:53 INFO - 'PWD': '/builds/slave/test', 03:58:53 INFO - 'SHELL': '/bin/bash', 03:58:53 INFO - 'SHLVL': '1', 03:58:53 INFO - 'TERM': 'linux', 03:58:53 INFO - 'TMOUT': '86400', 03:58:53 INFO - 'USER': 'cltbld', 03:58:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:53 INFO - '_': '/tools/buildbot/bin/python'} 03:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:53 INFO - Downloading/unpacking psutil>=3.1.1 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:55 INFO - Installing collected packages: psutil 03:58:55 INFO - Running setup.py install for psutil 03:58:55 INFO - building 'psutil._psutil_linux' extension 03:58:55 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 03:58:55 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 03:58:55 INFO - building 'psutil._psutil_posix' extension 03:58:55 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 03:58:55 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 03:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:55 INFO - Successfully installed psutil 03:58:55 INFO - Cleaning up... 03:58:55 INFO - Return code: 0 03:58:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:58:55 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')]} 03:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:55 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')]} 03:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:55 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:58:55 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 03:58:55 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 03:58:55 INFO - Using env: {'DISPLAY': ':0', 03:58:55 INFO - 'HOME': '/home/cltbld', 03:58:55 INFO - 'LANG': 'en_US.UTF-8', 03:58:55 INFO - 'LANGUAGE': 'en_US:en', 03:58:55 INFO - 'LOGNAME': 'cltbld', 03:58:55 INFO - 'MAIL': '/var/mail/cltbld', 03:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:55 INFO - 'MOZ_NO_REMOTE': '1', 03:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:55 INFO - 'NO_EM_RESTART': '1', 03:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:55 INFO - 'PWD': '/builds/slave/test', 03:58:55 INFO - 'SHELL': '/bin/bash', 03:58:55 INFO - 'SHLVL': '1', 03:58:55 INFO - 'TERM': 'linux', 03:58:55 INFO - 'TMOUT': '86400', 03:58:55 INFO - 'USER': 'cltbld', 03:58:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:55 INFO - '_': '/tools/buildbot/bin/python'} 03:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:58:58 INFO - Installing collected packages: mozsystemmonitor 03:58:58 INFO - Running setup.py install for mozsystemmonitor 03:58:58 INFO - Successfully installed mozsystemmonitor 03:58:58 INFO - Cleaning up... 03:58:58 INFO - Return code: 0 03:58:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:58:58 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')]} 03:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 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')]} 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:58:58 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 03:58:58 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 03:58:58 INFO - Using env: {'DISPLAY': ':0', 03:58:58 INFO - 'HOME': '/home/cltbld', 03:58:58 INFO - 'LANG': 'en_US.UTF-8', 03:58:58 INFO - 'LANGUAGE': 'en_US:en', 03:58:58 INFO - 'LOGNAME': 'cltbld', 03:58:58 INFO - 'MAIL': '/var/mail/cltbld', 03:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:58 INFO - 'MOZ_NO_REMOTE': '1', 03:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:58 INFO - 'NO_EM_RESTART': '1', 03:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:58 INFO - 'PWD': '/builds/slave/test', 03:58:58 INFO - 'SHELL': '/bin/bash', 03:58:58 INFO - 'SHLVL': '1', 03:58:58 INFO - 'TERM': 'linux', 03:58:58 INFO - 'TMOUT': '86400', 03:58:58 INFO - 'USER': 'cltbld', 03:58:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:58 INFO - '_': '/tools/buildbot/bin/python'} 03:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:58:58 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 03:58:58 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 03:58:58 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 03:58:58 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 03:58:58 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 03:58:58 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 03:59:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:00 INFO - warning: no files found matching '*.txt' 03:59:00 INFO - no previously-included directories found matching 'build' 03:59:00 INFO - no previously-included directories found matching 'dist' 03:59:00 INFO - no previously-included directories found matching '.git*' 03:59:00 INFO - Installing collected packages: jsonschema, functools32 03:59:00 INFO - Running setup.py install for functools32 03:59:00 INFO - warning: no files found matching '*.txt' 03:59:00 INFO - no previously-included directories found matching 'build' 03:59:00 INFO - no previously-included directories found matching 'dist' 03:59:00 INFO - no previously-included directories found matching '.git*' 03:59:00 INFO - Successfully installed jsonschema functools32 03:59:00 INFO - Cleaning up... 03:59:00 INFO - Return code: 0 03:59:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:59: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 functools32==3.2.3-2 03:59:00 INFO - Using env: {'DISPLAY': ':0', 03:59:00 INFO - 'HOME': '/home/cltbld', 03:59:00 INFO - 'LANG': 'en_US.UTF-8', 03:59:00 INFO - 'LANGUAGE': 'en_US:en', 03:59:00 INFO - 'LOGNAME': 'cltbld', 03:59:00 INFO - 'MAIL': '/var/mail/cltbld', 03:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:00 INFO - 'MOZ_NO_REMOTE': '1', 03:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:00 INFO - 'NO_EM_RESTART': '1', 03:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:00 INFO - 'PWD': '/builds/slave/test', 03:59:00 INFO - 'SHELL': '/bin/bash', 03:59:00 INFO - 'SHLVL': '1', 03:59:00 INFO - 'TERM': 'linux', 03:59:00 INFO - 'TMOUT': '86400', 03:59:00 INFO - 'USER': 'cltbld', 03:59:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:00 INFO - '_': '/tools/buildbot/bin/python'} 03:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:59:01 INFO - Cleaning up... 03:59:01 INFO - Return code: 0 03:59:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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', '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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59: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 blobuploader==1.2.4 03:59:01 INFO - Using env: {'DISPLAY': ':0', 03:59:01 INFO - 'HOME': '/home/cltbld', 03:59:01 INFO - 'LANG': 'en_US.UTF-8', 03:59:01 INFO - 'LANGUAGE': 'en_US:en', 03:59:01 INFO - 'LOGNAME': 'cltbld', 03:59:01 INFO - 'MAIL': '/var/mail/cltbld', 03:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:01 INFO - 'MOZ_NO_REMOTE': '1', 03:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:01 INFO - 'NO_EM_RESTART': '1', 03:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:01 INFO - 'PWD': '/builds/slave/test', 03:59:01 INFO - 'SHELL': '/bin/bash', 03:59:01 INFO - 'SHLVL': '1', 03:59:01 INFO - 'TERM': 'linux', 03:59:01 INFO - 'TMOUT': '86400', 03:59:01 INFO - 'USER': 'cltbld', 03:59:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:01 INFO - '_': '/tools/buildbot/bin/python'} 03:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59: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 03:59:04 INFO - Downloading docopt-0.6.1.tar.gz 03:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:04 INFO - Running setup.py install for blobuploader 03:59:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:04 INFO - Running setup.py install for requests 03:59:04 INFO - Running setup.py install for docopt 03:59:04 INFO - Successfully installed blobuploader requests docopt 03:59:04 INFO - Cleaning up... 03:59:04 INFO - Return code: 0 03:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:04 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:59:04 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 03:59:04 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 03:59:04 INFO - Using env: {'DISPLAY': ':0', 03:59:04 INFO - 'HOME': '/home/cltbld', 03:59:04 INFO - 'LANG': 'en_US.UTF-8', 03:59:04 INFO - 'LANGUAGE': 'en_US:en', 03:59:04 INFO - 'LOGNAME': 'cltbld', 03:59:04 INFO - 'MAIL': '/var/mail/cltbld', 03:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:04 INFO - 'MOZ_NO_REMOTE': '1', 03:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:04 INFO - 'NO_EM_RESTART': '1', 03:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:04 INFO - 'PWD': '/builds/slave/test', 03:59:04 INFO - 'SHELL': '/bin/bash', 03:59:04 INFO - 'SHLVL': '1', 03:59:04 INFO - 'TERM': 'linux', 03:59:04 INFO - 'TMOUT': '86400', 03:59:04 INFO - 'USER': 'cltbld', 03:59:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:04 INFO - '_': '/tools/buildbot/bin/python'} 03:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:05 INFO - Running setup.py (path:/tmp/pip-ErL6nE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:05 INFO - Running setup.py (path:/tmp/pip-khpCY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:05 INFO - Running setup.py (path:/tmp/pip-tNfkdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:05 INFO - Running setup.py (path:/tmp/pip-AvJ20X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:05 INFO - Running setup.py (path:/tmp/pip-Dry3EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:05 INFO - Running setup.py (path:/tmp/pip-9E1WSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:05 INFO - Running setup.py (path:/tmp/pip-ps4BNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:05 INFO - Running setup.py (path:/tmp/pip-bw94pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:05 INFO - Running setup.py (path:/tmp/pip-61ihhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:05 INFO - Running setup.py (path:/tmp/pip-w4ogez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:05 INFO - Running setup.py (path:/tmp/pip-JAe6fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:05 INFO - Running setup.py (path:/tmp/pip-7yBRFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:05 INFO - Running setup.py (path:/tmp/pip-mP54B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:05 INFO - Running setup.py (path:/tmp/pip-pfMj2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:06 INFO - Running setup.py (path:/tmp/pip-NLlP4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:06 INFO - Running setup.py (path:/tmp/pip-jpJLXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:06 INFO - Running setup.py (path:/tmp/pip-frlXul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:06 INFO - Running setup.py install for manifestparser 03:59:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:06 INFO - Running setup.py install for mozcrash 03:59:06 INFO - Running setup.py install for mozdebug 03:59:06 INFO - Running setup.py install for mozdevice 03:59:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:06 INFO - Running setup.py install for mozfile 03:59:06 INFO - Running setup.py install for mozhttpd 03:59:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:06 INFO - Running setup.py install for mozinfo 03:59:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:06 INFO - Running setup.py install for mozInstall 03:59:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Running setup.py install for mozleak 03:59:07 INFO - Running setup.py install for mozlog 03:59:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Running setup.py install for moznetwork 03:59:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Running setup.py install for mozprocess 03:59:07 INFO - Running setup.py install for mozprofile 03:59:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Running setup.py install for mozrunner 03:59:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:07 INFO - Running setup.py install for mozscreenshot 03:59:07 INFO - Running setup.py install for moztest 03:59:07 INFO - Running setup.py install for mozversion 03:59:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:08 INFO - Cleaning up... 03:59:08 INFO - Return code: 0 03:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:08 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:59:08 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 03:59:08 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 03:59:08 INFO - Using env: {'DISPLAY': ':0', 03:59:08 INFO - 'HOME': '/home/cltbld', 03:59:08 INFO - 'LANG': 'en_US.UTF-8', 03:59:08 INFO - 'LANGUAGE': 'en_US:en', 03:59:08 INFO - 'LOGNAME': 'cltbld', 03:59:08 INFO - 'MAIL': '/var/mail/cltbld', 03:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:08 INFO - 'MOZ_NO_REMOTE': '1', 03:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:08 INFO - 'NO_EM_RESTART': '1', 03:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:08 INFO - 'PWD': '/builds/slave/test', 03:59:08 INFO - 'SHELL': '/bin/bash', 03:59:08 INFO - 'SHLVL': '1', 03:59:08 INFO - 'TERM': 'linux', 03:59:08 INFO - 'TMOUT': '86400', 03:59:08 INFO - 'USER': 'cltbld', 03:59:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:08 INFO - '_': '/tools/buildbot/bin/python'} 03:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:08 INFO - Running setup.py (path:/tmp/pip-UqZNRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:08 INFO - Running setup.py (path:/tmp/pip-jXJiFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:08 INFO - Running setup.py (path:/tmp/pip-PZ5jNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:08 INFO - Running setup.py (path:/tmp/pip-mIv_7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:08 INFO - Running setup.py (path:/tmp/pip-_EkHAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:08 INFO - Running setup.py (path:/tmp/pip-6oSUVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:08 INFO - Running setup.py (path:/tmp/pip-s0ohAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:08 INFO - Running setup.py (path:/tmp/pip-7UJ6et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:08 INFO - Running setup.py (path:/tmp/pip-0_xGpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:08 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:08 INFO - Running setup.py (path:/tmp/pip-RbO8xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:08 INFO - Running setup.py (path:/tmp/pip-lFU_K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:09 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)) 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:09 INFO - Running setup.py (path:/tmp/pip-Vxqs4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:09 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)) 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:09 INFO - Running setup.py (path:/tmp/pip-XqSTz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:09 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)) 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:09 INFO - Running setup.py (path:/tmp/pip-Lq_xKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:09 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)) 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:09 INFO - Running setup.py (path:/tmp/pip-j_KUG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:09 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)) 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:09 INFO - Running setup.py (path:/tmp/pip-Cu49ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:09 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)) 03:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:09 INFO - Running setup.py (path:/tmp/pip-L6ycUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:09 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)) 03:59:09 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)) 03:59:09 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)) 03:59:09 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)) 03:59:09 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)) 03:59:09 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)) 03:59:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:09 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 03:59:09 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 03:59:09 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 03:59:09 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 03:59:09 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 03:59:09 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 03:59:11 INFO - Downloading blessings-1.6.tar.gz 03:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:11 INFO - Installing collected packages: blessings 03:59:11 INFO - Running setup.py install for blessings 03:59:11 INFO - Successfully installed blessings 03:59:11 INFO - Cleaning up... 03:59:11 INFO - Return code: 0 03:59:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:11 INFO - Reading from file tmpfile_stdout 03:59:11 INFO - Current package versions: 03:59:11 INFO - argparse == 1.2.1 03:59:11 INFO - blessings == 1.6 03:59:11 INFO - blobuploader == 1.2.4 03:59:11 INFO - docopt == 0.6.1 03:59:11 INFO - functools32 == 3.2.3-2 03:59:11 INFO - jsonschema == 2.5.1 03:59:11 INFO - manifestparser == 1.1 03:59:11 INFO - mozInstall == 1.12 03:59:11 INFO - mozcrash == 0.17 03:59:11 INFO - mozdebug == 0.1 03:59:11 INFO - mozdevice == 0.48 03:59:11 INFO - mozfile == 1.2 03:59:11 INFO - mozhttpd == 0.7 03:59:11 INFO - mozinfo == 0.9 03:59:11 INFO - mozleak == 0.1 03:59:11 INFO - mozlog == 3.3 03:59:11 INFO - moznetwork == 0.27 03:59:11 INFO - mozprocess == 0.23 03:59:11 INFO - mozprofile == 0.28 03:59:11 INFO - mozrunner == 6.12 03:59:11 INFO - mozscreenshot == 0.1 03:59:11 INFO - mozsystemmonitor == 0.3 03:59:11 INFO - moztest == 0.7 03:59:11 INFO - mozversion == 1.4 03:59:11 INFO - psutil == 3.1.1 03:59:11 INFO - requests == 1.2.3 03:59:11 INFO - wsgiref == 0.1.2 03:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:11 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')]} 03:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 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')]} 03:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:59:11 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 03:59:11 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 03:59:11 INFO - Using env: {'DISPLAY': ':0', 03:59:11 INFO - 'HOME': '/home/cltbld', 03:59:11 INFO - 'LANG': 'en_US.UTF-8', 03:59:11 INFO - 'LANGUAGE': 'en_US:en', 03:59:11 INFO - 'LOGNAME': 'cltbld', 03:59:11 INFO - 'MAIL': '/var/mail/cltbld', 03:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:11 INFO - 'MOZ_NO_REMOTE': '1', 03:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:11 INFO - 'NO_EM_RESTART': '1', 03:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:11 INFO - 'PWD': '/builds/slave/test', 03:59:11 INFO - 'SHELL': '/bin/bash', 03:59:11 INFO - 'SHLVL': '1', 03:59:11 INFO - 'TERM': 'linux', 03:59:11 INFO - 'TMOUT': '86400', 03:59:11 INFO - 'USER': 'cltbld', 03:59:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:11 INFO - '_': '/tools/buildbot/bin/python'} 03:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 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)) 03:59:12 INFO - Cleaning up... 03:59:12 INFO - Return code: 0 03:59:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:12 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 0x1358030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1587400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', '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 03:59:12 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 03:59:12 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 03:59:12 INFO - Using env: {'DISPLAY': ':0', 03:59:12 INFO - 'HOME': '/home/cltbld', 03:59:12 INFO - 'LANG': 'en_US.UTF-8', 03:59:12 INFO - 'LANGUAGE': 'en_US:en', 03:59:12 INFO - 'LOGNAME': 'cltbld', 03:59:12 INFO - 'MAIL': '/var/mail/cltbld', 03:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:12 INFO - 'MOZ_NO_REMOTE': '1', 03:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:12 INFO - 'NO_EM_RESTART': '1', 03:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:12 INFO - 'PWD': '/builds/slave/test', 03:59:12 INFO - 'SHELL': '/bin/bash', 03:59:12 INFO - 'SHLVL': '1', 03:59:12 INFO - 'TERM': 'linux', 03:59:12 INFO - 'TMOUT': '86400', 03:59:12 INFO - 'USER': 'cltbld', 03:59:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:12 INFO - '_': '/tools/buildbot/bin/python'} 03:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:59:12 INFO - Cleaning up... 03:59:12 INFO - Return code: 0 03:59:12 INFO - Running post-action listener: _resource_record_post_action 03:59:12 INFO - Running post-action listener: _start_resource_monitoring 03:59:12 INFO - Starting resource monitoring. 03:59:12 INFO - [mozharness: 2016-10-13 10:59:12.316082Z] Finished create-virtualenv step (success) 03:59:12 INFO - [mozharness: 2016-10-13 10:59:12.316518Z] Running install step. 03:59:12 INFO - Running pre-action listener: _resource_record_pre_action 03:59:12 INFO - Running main action method: install 03:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:12 INFO - Reading from file tmpfile_stdout 03:59:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:12 INFO - Reading from file tmpfile_stdout 03:59:12 INFO - Output received: 03:59:12 INFO - Usage: mozinstall [options] installer 03:59:12 INFO - Options: 03:59:12 INFO - -h, --help show this help message and exit 03:59:12 INFO - -d DEST, --destination=DEST 03:59:12 INFO - Directory to install application into. [default: 03:59:12 INFO - "/builds/slave/test"] 03:59:12 INFO - --app=APP Application being installed. [default: firefox] 03:59:12 INFO - mkdir: /builds/slave/test/build/application 03:59:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:59:26 INFO - Reading from file tmpfile_stdout 03:59:26 INFO - Output received: 03:59:26 INFO - /builds/slave/test/build/application/firefox/firefox 03:59:26 INFO - Running post-action listener: _resource_record_post_action 03:59:26 INFO - [mozharness: 2016-10-13 10:59:26.653229Z] Finished install step (success) 03:59:26 INFO - [mozharness: 2016-10-13 10:59:26.653508Z] Running run-tests step. 03:59:26 INFO - Running pre-action listener: _resource_record_pre_action 03:59:26 INFO - Running main action method: run_tests 03:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:26 INFO - Python 2.7.3 03:59:26 INFO - Return code: 0 03:59:26 INFO - grabbing minidump binary from tooltool 03:59:26 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')]} 03:59:26 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 0x1616570>, '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 0x1617470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:26 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 03:59:26 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 03:59:26 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 03:59:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:26 INFO - Return code: 0 03:59:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:59:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:59:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:59:26 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:59:26 INFO - Using env: {'DISPLAY': ':0', 03:59:26 INFO - 'HOME': '/home/cltbld', 03:59:26 INFO - 'LANG': 'en_US.UTF-8', 03:59:26 INFO - 'LANGUAGE': 'en_US:en', 03:59:26 INFO - 'LOGNAME': 'cltbld', 03:59:26 INFO - 'MAIL': '/var/mail/cltbld', 03:59:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:26 INFO - 'MOZ_NO_REMOTE': '1', 03:59:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:26 INFO - 'NO_EM_RESTART': '1', 03:59:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:26 INFO - 'PWD': '/builds/slave/test', 03:59:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:26 INFO - 'SHELL': '/bin/bash', 03:59:26 INFO - 'SHLVL': '1', 03:59:26 INFO - 'TERM': 'linux', 03:59:26 INFO - 'TMOUT': '86400', 03:59:26 INFO - 'USER': 'cltbld', 03:59:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422', 03:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:26 INFO - '_': '/tools/buildbot/bin/python'} 03:59:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:59:26 INFO - mozversion application_buildid: 20161013004623 03:59:26 INFO - mozversion application_changeset: 0c76efc924acd4b16e64aaaa07fe21462d0f7cfa 03:59:26 INFO - mozversion application_display_name: Firefox 03:59:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:26 INFO - mozversion application_name: Firefox 03:59:26 INFO - mozversion application_remotingname: firefox 03:59:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:59:26 INFO - mozversion application_vendor: Mozilla 03:59:26 INFO - mozversion application_version: 50.0 03:59:26 INFO - mozversion platform_buildid: 20161013004623 03:59:26 INFO - mozversion platform_changeset: 0c76efc924acd4b16e64aaaa07fe21462d0f7cfa 03:59:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:59:26 INFO - mozversion platform_version: 50.0 03:59:26 INFO - using testdate: 1476356366 03:59:26 INFO - actual date: 1476356366 03:59:26 INFO - starting webserver on 'localhost:33767' 03:59:26 INFO - SUITE-START | Running 2 tests 03:59:26 INFO - TEST-START | dromaeo_css 03:59:26 INFO - operating with platform_type : linux_ 03:59:26 INFO - Initialising browser for dromaeo_css test... 03:59:26 INFO - TEST-INFO | started process 30247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR54VJP/profile http://localhost:33767/getInfo.html) 03:59:31 INFO - PROCESS | 30247 | __metrics Screen width/height:1600/1200 03:59:31 INFO - PROCESS | 30247 | colorDepth:24 03:59:31 INFO - PROCESS | 30247 | Browser inner width/height: 1024/697 03:59:31 INFO - PROCESS | 30247 | __metrics 03:59:31 ERROR - PROCESS | 30247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:59:32 INFO - TEST-INFO | 30247: exit 0 03:59:32 INFO - Browser initialized. 03:59:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:32 INFO - TEST-INFO | started process 30370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR54VJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:44 INFO - PROCESS | 30370 | RSS: Main: 150581248 03:59:44 INFO - PROCESS | 30370 | 04:00:33 INFO - PROCESS | 30370 | 1476356433925 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] 04:02:42 INFO - PROCESS | 30370 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33767/tests/dromaeo/cssquery-ext.html) 04:02:43 INFO - PROCESS | 30370 | RSS: Main: 158736384 04:02:43 INFO - PROCESS | 30370 | 04:05:45 INFO - PROCESS | 30370 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-ext.html (next: http://localhost:33767/tests/dromaeo/cssquery-jquery.html) 04:05:46 INFO - PROCESS | 30370 | RSS: Main: 155697152 04:05:46 INFO - PROCESS | 30370 | 04:08:47 INFO - PROCESS | 30370 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33767/tests/dromaeo/cssquery-mootools.html) 04:08:48 INFO - PROCESS | 30370 | RSS: Main: 154939392 04:08:48 INFO - PROCESS | 30370 | 04:11:50 INFO - PROCESS | 30370 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33767/tests/dromaeo/cssquery-prototype.html) 04:11:50 INFO - PROCESS | 30370 | RSS: Main: 156602368 04:11:50 INFO - PROCESS | 30370 | 04:14:53 INFO - PROCESS | 30370 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33767/tests/dromaeo/cssquery-yui.html) 04:14:53 INFO - PROCESS | 30370 | RSS: Main: 157786112 04:14:53 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | Cycle 1(1): loaded http://localhost:33767/tests/dromaeo/cssquery-yui.html (next: http://localhost:33767/tests/dromaeo/cssquery-dojo.html) 04:17:56 INFO - PROCESS | 30370 | RSS: Main: 157986816 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | __start_tp_report 04:17:56 INFO - PROCESS | 30370 | _x_x_mozilla_page_load 04:17:56 INFO - PROCESS | 30370 | _x_x_mozilla_page_load_details 04:17:56 INFO - PROCESS | 30370 | |i|pagename|runs| 04:17:56 INFO - PROCESS | 30370 | |0;dojo.html;3283.7537184711146;3287.556179915711;3327.0850516108076;3345.9163520911975;3354.614219364774;5793.681347525884;5837.416258374161;5865.178874957509;5867.735951882165;5876.001079816426;5781.19063331134;5804.042333015047;5830.212921255629;5840.269966254218;5862.2965244170755;5267.367915850104;5303;5318.282031925679;5380.811671591495;5431.456854314576;5352.357717073937;5353.9196912046355;5374.543163831059;5390.649607775482;5405.162199859028;5238.5023422774775;5242.18746094356;5354.598405119612;5362.51737343639;5385.703786291752;5298.682079075268;5351.812686555952;5361.651492652965;5366.838994830161;5395.487428694268;5267.130923397634;5322.068637988336;5350.732463376816;5367.651102678314;5373.543248823855;5597.468240517144;5648.3222013358245;5805.651660900359;5829.329627092896;5893.911591326134;6104.2980057293535;6197.6901154942525;6215.968920155416;6218.471429928416;6230;6219.906701399437;6251.468625166866;6255.24937007562;6255.906161407583;6261.906071408933;5587.441255874462;5726.513246374022;5802.216700745387;5824.388439213864;5834.854128646775;6249.6562689051625;6384.32964538726;6389.584676995981;6394.072859435356;6397.680115994275;6095.146679464879;6112.572119951561;6119.265688117365;6121.112438696364;6135.877282454326;6074.331823499411;6140.723667434976;6173.444390004921;6174.783882564178;6235.968820155961;6190;6206.286277078104;6222.066689996536;6229.781957631461;6235.469985051322;6185.8144255672405;6186.10301506279;6190.350013248544;6221.440070393686;6221.564490485713;4680.765961701902;4732.1718699227495;4762.571368576775;4764.880877978078;4781.306710527024;4200.810963506649;4246.532881383046;4254.042840360956;4277.57224277576;4278;5960.225170727777;6030.6080104793045;6037.969810150921;6042.577019608673;6045.106021628964;5995.280566332068;6126.295476020226;6304.401081897304;6347.492200623939;6347.777827776005;5898.174255604219;5988.700564971734;5990.940090599125;6001.639901605918;6031.09533569968;5334.11987022137;5338.386085600128;5338.893222135535;5367.597430192751;5370.409254981949;6321.146645202839;6411.2627047889155;6469.999999999905;6496.350364963466;6514.674266286666;6295.811125666238;6307.842303942254;6324.2410910691015;6324.936750632435;6350.618962862243;6528.934710653023;6540.50946179029;6589;6598.8350291243105;6602.570832895846;5892.793752218652;6072.939270607238;6100.176476175659;6237;6241.563090583615;6286.74853005893;6303;6305.211848518935;6307.873842523216;6319.431251187415;6159.9836027055035;6168.25980882297;6170.660613666291;6175.135481032748;6182.072689096672;5944.078667806497;5986.610870293417;6030.6080104793045;6153.446189842935;6159.260888693386;6036.849078773066;6045.153678484928;6090.3605121461605;6092.512598992159;6120.785772497941;6158.661273629993;6163.075538669056;6171.1668924694595;6203.937960620336;6217.782377616762;5826.213461182686;5833.79581714638;5948.672822994777;6024.367441418588;6034.607750496204 04:17:56 INFO - PROCESS | 30370 | |1;ext.html;597.1311741416237;629.7512482569385;644.9290578036415;653.8136631060149;704.6611438267295;41991;45443.31835022477;45465;45763.54236457639;45804.54195458045;46328.76835615826;46472;46512;46709.7664511677;46936.765316173456;8992.32557558184;9144.679936202234;9147;9152.039035901234;9165;9172.816543669123;9208.67769628063;9236.584353704066;9268.953655231715;9298.16316531512;9296.163345298923;9323.72028839136;9345.532723363838;9358.204552613002;9378.5310734463;9222.35443518954;9240.953795231015;9263.86104208434;9269;9270.860937085949;9237.584308706057;9264.11990860867;9294.07059294072;9297.209737172348;9317.627294908196;44811.551884481065;44830.77584612089;44920;45126.323105153446;45137.645870623935;3728.384816505273;3740.4950331705145;3814.8283327250065;3816.484774555427;3856.9421458678144;34748.30503389918;35112.82443587791;35341.46987795185;35359.64640353615;35767.4634880477;4604.746738929358;4611.823984883833;4645.88385290367;4672.649551283667;4719.952800471986;384323;392601;393120;581350;582293;65863.67068164724;66946.330536694;66962.66518667375;67004.66497667578;67079.66460167668;39372.40941385881;40017.39973900394;40427.1914561713;41651.37522937158;71674.2832571678;17849.28602855897;17981.370652027115;18038.729419058724;18069.367572134914;18096;13726.107802992774;13832.93083534596;13859.376328065262;13874.306284685725;13880.375383107583;20048.799512004985;20279.695804562944;20404.183832646824;20419.59160816805;20553.38339849807;7546.584937828362;7648.08223013242;7649.464537482323;7701.652210863076;7705.8844117338285;1006.4665727164614;1085.066842515436;1108.6430526357517;1162.8895254950767;1227.0735594626;32857.3428531428;34111.65888341134;34287.31425371479;34354.31291374158;34555.30889382248;1120.9383483908464;1137.7383201863618;1139.139949338261;1148.311013391958;1244.5438836561245;17845.46463606068;17929.462116136536;18007.909960450113;18038.458846234633;18111;652779;656917;657251;661805;664052;65123.67438162779;65493.34506654968;65789.67105164539;65841;65868.67065664641;1431.9714004042887;1442.8412874583787;1445.985540144585;1454.2219912347055;1484.4062375050066;31884.303956708016;33403;33499.665003349655;33747.66252337445;34029.14927126742;57463.71268143632;58172;58291.91956563;58342.4165758337;58684.706576466844;498200;502987;503746;505031;508236;31528.211794705316;31682;31695.683043170196;31855.36289274248;32346.676533234368;47817.52182478131;50273;51963.83900928793;52430.21354679759;53358.733206333716;43470.78264608657;46651.53348466472;46705.53294467012;47091;47231;44104.87100586984;45481.317780233985;45687.314690280335;46351.53648463472;46800.531994679615;39167.2166556673;43771.78114109409;43973.56026439695;44160.77919610382;45526.08947821091;38466.80766596149;38816.417753734284;39311;41577.792111040464;42078;30114;30468.84765576158;31004.379912401175;31212.219694507818;31304.21739456532 04:17:56 INFO - PROCESS | 30370 | |2;jquery.html;411.5103027397395;415.20281060364096;425.9595338442848;430.76523294804326;441.59814568742433;19179.32872349468;19919.203231870724;20648.793512064876;20666.276680316172;20912.68630970533;19859.801401985977;20177.192912283528;20259.797402025975;20666.48333791656;20698.37904862853;5873.7356818943035;6041.154238406604;6042.939570604303;6049.30433000204;6072.119542666311;5929.495992840613;5935.851603709899;5982.401759824004;5987.850303742398;5998.820035398945;5910.202122713443;5916;5922.407759224065;5940.138679891413;5947.167396564484;5896.675682837442;5902.940970590282;5932.88134237315;5949.524038076944;5958.374370691102;5252.763625636855;5356.758945847446;5356.812511562077;5358.678479291216;5366.275552800361;21718.891405542872;22335.888320558457;24242.7575724244;25150.11974580881;25260.621090683653;2351.3651314145254;2396.4727759892794;2496.6879140107485;2551.4897020595768;2815.0991682661556;10962.123030157569;11005.449727513593;11196.776064478747;11244.437778111062;12868.485260589565;2001.796227921368;2055.8149766521083;2082.7188329575615;2086.5722526881955;2138.219549864288;84864.72702909462;85018.57490712508;86051;86977.56511217466;88162;11622.6513204604;11624.26829695021;11714.765704685859;11749.4712737927;12086.637400877988;16428.589285267964;16435.26041328143;16446.588835279214;16452.095134767704;16493.6701265974;8422.28410585095;8574.056853746082;8591.312694984386;8603.354748393895;8725.91274087251;8132.512049277062;8228.136045715233;8273.710420135387;8386.119457457002;8456.450330728607;4862.562369386772;4910.631702622318;5021.59827213822;5051.949480505222;5185.507376799198;2090.7386576677914;2114.6827975803753;2151.0750377337895;2154.6337122688865;2197.2090047582856;971.2472833554052;1048.1667074675652;1080.8594882665204;1081.5498559594866;1088.4829705889797;18703.532411689543;20489;20799.584008319747;20809.58380832375;20942;1034.6844212515105;1036.7045392063226;1074.3500182389698;1104.1442881766534;1107.245170051846;9545.761355966017;11260.718482037852;11528.711782205512;11653.242539234923;11666.358350290646;464448;466067;474255;476020;476967;91846.54076729708;92785.53607231921;94914;95192;103954.4802275999;1067.791780602775;1092.7650555130685;1105.3975583307117;1106.468894930438;1110.1285490889613;18632.720509192644;18692.252309907995;19167.233310667416;19219.615607688047;19231.992683750967;43537.78231108824;43807.34288985604;44013.779931100136;44651.33023004723;45530.77234613806;53358.4664153369;53462.73268633632;56466;56808.715956419954;57895.71052144881;9189.356745027784;9327.673531426368;9347.532623368941;9369.390989585656;9426.81146377055;11212.719682007688;13878.306084695523;14117;14259.572212833631;14630.707385852436;12740.490380384681;12975.286359249954;12987.935060324638;13013;13224.074314798256;11851.170418070997;12488.188267762567;12891.355432228163;12962.675933101747;12976.480940762263;12711.42798574085;12937.417816198105;12987.870121299044;13203.735925281248;13356.664333566565;9076.455412675261;9265.490398028172;9298.163165315154;9346.392484488486;9492.572834222614;12336;12377.443015064164;12597.433115510008;12833.614991550268;12906.935465322613 04:17:56 INFO - PROCESS | 30370 | |3;mootools.html;1529;1546.3350759173554;1731.9567010824728;1805.7381679656457;1838.5863180784324;9322.953385233073;9837.65568205113;10027.197824174067;10052.44711540864;10168.44073575953;10172.491375431237;10286.074253317218;10326.741831454217;10347.741306467342;10348.12040976516;2551.7958563314983;2585.5604547227017;2592.4167062410997;2594.4811037792424;2594.558924982748;2491.2401717476164;2535.833516582374;2538.441542860577;2541;2542.148380292604;2494.5759220932487;2521.2436269119285;2559.4497183105627;2571.819972601919;2571.9228423147338;2460.1143588308105;2469.148143890364;2484.0188125690343;2492.327071690633;2497.1759319424727;2481.528509583173;2486.2416962826333;2487.4154573675173;2489.3403248139257;2518.597024476075;10038.64864729731;10094.89905100947;10107.494625268708;10116.03897629724;10134.13859821916;5873.177755114288;6007.609505382136;6009.06859436788;6010.519158467312;6034.5172386209;3635.672789448936;3669.082729317671;3724.776513409177;3728.5898551159353;3807.3717836556934;1171.584087648881;1254.7239607286383;1262.4571434283255;1263.7219811641423;1281.3849352310942;12441.440135193847;13051.738965220642;13088.47646094155;13438.529651462151;13831.100978436369;4852.684575502581;4992.875178120504;5022.84931452057;5082.898342033139;5170.45710200431;10865.83701244482;10927.453627318602;10970.835437468444;10992.450377481095;11034.613788517363;5870.354261031283;5900.970495147582;5918.348981612019;5921.792737254175;5970.373110823388;4871.244957031666;5271.42014378418;5346.358436987586;5409.891802163935;5482.80810171642;4264.061906380653;4268.466441694788;4393.780310984502;4406.691531592758;4413;1237.2020047069589;1242.1180961517423;1244.085597086141;1244.6141696074246;1254.8431446069242;1076.9407682577532;1107.5846557540922;1113.3598181045932;1114.6154576671036;1115.0132133062298;6715.46276297895;6773.187217533928;6799;6871;7026.227115017344;475.6028716022091;485.1291930983822;488.1579275749375;488.54321209669075;489.652346833752;4504.864854054384;4527.298268768346;4568.817247310137;4625.884352891205;4689.882752931204;11580.247283926517;11920.403979801149;12236.265824050586;12315.93842030784;12327.630171094881;12283.754324913452;12285.57000504978;12305.44625491855;12321.568745093879;12399.194052386567;9109.954450227706;9261.583228754722;9280.211182049601;9319.673811416567;9324.25405967521;6416.871662566629;6768.323167683192;6788.151481064867;6847.417969472452;6863.588184708933;10750.892491074988;10824;11220.66338009861;11235.66293011211;11240.7751844961;10977;11063.50214240345;11230.157738169506;11240.831387529357;11289.887101129212;7953.204679532232;8561.957190214009;8680.392372533863;8856.867146992672;9032.683856065007;9625.51872406391;9685.934547199662;9740.464274464972;9755.707328780149;9801.068898454636;8610.61252243638;8685.913140868763;8719.782005449915;8769.210771030637;8932.86600701003;8459.450135741157;8478.23695867375;8539.274161696325;8632.78418039554;8650.653973840976;7501.362384197404;7638.427117966064;7641.312281894656;7658.425618078778;7667.156612772702;5835.260274383094;5871.588988770745;5909.85225369352;5966.642001479925;6041.818745437644;5559.27729395176;5691.658500489983;5792.391798861059;5844.94155058444;5920.319163296276 04:17:56 INFO - PROCESS | 30370 | |4;prototype.html;343.9587249530057;350.83686085970027;353.08022601124077;354.46298857231284;356.248316053128;5564.248826408434;5637.492625663689;5764.193012978187;5798.884022319557;5802.825915222545;5656.78379148483;5657.23627310313;5658.603897727161;5669.206311116447;5671.63134396265;4475.753833539154;4487.551244875503;4488.775561221943;4490.820367185317;4500.909981800362;4417.756383216291;4420.40324556184;4441.578050085237;4486.057927835159;4499.572540608637;4436.534163912791;4441.489228738688;4443.355713421552;4444.97777511112;4462.3306504024495;4442.822287108512;4461.1969845427975;4467.257769469909;4477.194105061088;4482.618977386926;3713.220223753015;3791.0332865119494;3962.187751510933;3973.3443981742976;3982.4623675803687;5482.5613950884235;5495.505404513613;5499.085484693119;5504.4495550444635;5515.669059856422;5059.16523773577;5059.418166910816;5069.340985671839;5073.086844368012;5073.543381095682;5714.371419143891;5889.676067816268;5954.55340849438;5956.910646340309;5963.5527335450015;4262.722923009995;4266.616004559604;4267.082577245876;4277.123189746126;4283.314669652872;6227.100734275999;6232.376762323776;6243.313235544087;6249.656268905208;6258.906116408258;4241.681873859473;4283.271843786564;4292.377605247284;4331.198728235287;4361.542038085955;4393.450818647669;4423;4426.889327766831;4428.3800267962515;4446.799894004777;5033.270175824485;5047.798088076436;5062.7215503146945;5063.696178229318;5074.16276314404;5710.200571919934;5888.676122813286;5987.520998320124;6015.887060893749;6026.457618814327;1499.6400863792612;1531.9846801532065;1536.377767004365;1537.630968567558;1539.191924239783;949.7293271417751;975.6389836178491;982.4891056650645;992.8163289791412;992.8709267795285;5140.665856719302;5153.252778347119;5166.509181627739;5169.560587350042;5189.818356357585;5410.133503941134;5423.484768946943;5439.918401223906;5456.61803673747;5469.890602187934;5053.5957123430035;5079.619028572872;5125;5157.478543829579;5186.377634683862;2893.218830915641;2903.274181454636;2906.3170155013554;2931.5456104303867;2935;5576.414476479992;5576.479285507399;5583.134614134816;5613.663180209201;5615.775368985276;5333.0167163853575;5346.235742205063;5484.972575137099;5524.403530340734;5547.944520554743;5528.396764938123;5562.554995600342;5567.2762540870235;5583.74873130702;5620.662760234399;5396.83809485716;5410.404855465817;5448.809291674773;5461.344638643388;5778.16216648592;6155.784547540815;6166.722497487714;6176.722047507783;6179.28938172116;6185.195924529962;6488.578242414228;6501.732162228509;6505.642189679613;6506.275836903319;6521.07628249658;4400.207962566768;4518.706284091523;4527.343535187313;4537.795799188978;4544.113897789899;6066.272047354346;6193.194884664965;6217.844553886008;6245.000799871998;6245.6252624842655;6060.999935010674;6094.664793436404;6096.268447786117;6101.816945491642;6116.26604807426;5940.5940594059475;6086.391360863879;6104.847378815565;6115.113308570321;6123.755049797958;5985.521158307238;6016.570554783906;6033.637981720935;6035.5473339500595;6056.66688332146;6129.724162412791;6130.295016073209;6136.6011209271255;6140.662263575367;6146.692665366624;5805.187273781758;5989.52083833301;6009.519238460825;6012.428819262338;6033.728482218223 04:17:56 INFO - PROCESS | 30370 | |5;yui.html;796.2793671727086;804.3068054062884;830.5722552885265;837.6816809612346;844.2898296468336;14768.483103091394;15448.922755386235;15456.381744730226;15461.226938653064;15540.456084037061;15041;15112.622184445367;15118.773218401733;15119.092854428742;15139.848601513982;716.9103862017248;861.4874149880842;871.7820544863785;877.9253763430116;889.022075716713;870.4255191573562;879.1823604048233;879.3141349747208;880.053942012336;881.1144799476517;922.229938001766;922.5894476957757;923.6213152607432;924.653255029364;925.5742358515091;914.593006112277;918.8529835226332;921.2952091649893;921.9631214751402;922.1562270522464;673.0308355967392;673.9831504212434;675.9357861003197;677.515576362898;678.5826716569275;14799.334029968677;14911.328990195467;14924.2537873107;14957.102573845495;14969.476068337664;16729.414470493597;17060.317587296493;17400.30398784047;17472.563185920328;17617;13494.39275232607;13645.795313070312;13675.726485470334;13778.586642400744;13845.16928984264;4037.6971727120585;4095.9385609215888;4160.729552579072;4217.768022758747;4260.510041345254;87227;87439.56280218558;88432.55783721105;90764;90895.09104908933;13202.405891734896;13299.534516291884;13301.135426197266;13371.866281337063;13435.992300577496;25060.373490662878;25238.369040774127;25309.493810124062;25469;25616.615750763754;9040.276777857756;9334.299927505464;9343.065693430603;9376.8593471098;9492.525373731423;4966.354373931365;5058.595312375001;5097.439281679087;5133;5178.741062946838;3854.113553882623;3911.8239679214503;3946.210757848442;3950.3876899080688;3997.520297564311;646.2503495944682;649.1885143570537;658.7924803686823;662.1755913887145;678.5860625018735;820.798904268458;830.9418340716092;852.6845067325129;860.0066922704286;868.2619773192736;9900.702978910644;10497.685069447929;10605.151587873106;10840.241183117263;10969.586690927983;658.0574934441622;749.7076140305285;801.9117897031322;815.1278132398277;878.7715194049593;5122.846314610568;5248.291480650139;5378.623496355296;5521.806736764194;5536.003519366473;102488.48755756173;118315.40842295733;120749;122375;124028.37985810013;100569.49715251524;103485.48257258665;104979;106123;108132.45933770438;93318;93664;94508;94924.52537737406;97099;10068.14420774213;10074.647387341407;10075.899241007495;10097;10213.591456341961;52277.7386113067;52870.735646321526;53577.464225357246;53980;54203.72898135484;45190.32214516851;45350.77324613356;79569.60215198887;80940;82345.17654823375;12635.74728505443;12770.425330859947;12958.870411295766;12996.155249908727;13106.148100373444;14533;14667.266636668337;14839.703205936037;14993.77509337339;15805.683886322438;13650.522231721841;14043.227622480454;14051.718965620836;14198.716025679636;14442;12445.875541244472;12716.554920577735;12731.80902286448;13042.673933151747;13288.601341959757;13192.604221873358;13227;13496.32518374097;13533.526326578523;13679.86320136786;10517.211209159497;10552.947235263775;10728.678139655824;10804.506427118158;10964.616238431936;11371.20401571882;11877.22798018126;11897.226680265756;11935.641930742091;11965.880341196476 04:17:56 INFO - PROCESS | 30370 | __end_tp_report 04:17:56 INFO - PROCESS | 30370 | __start_cc_report 04:17:56 INFO - PROCESS | 30370 | _x_x_mozilla_cycle_collect,369 04:17:56 INFO - PROCESS | 30370 | __end_cc_report 04:17:56 INFO - PROCESS | 30370 | __startTimestamp1476357476376__endTimestamp 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | ------- Summary: start ------- 04:17:56 INFO - PROCESS | 30370 | Number of tests: 6 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | [#0] dojo.html Cycles:165 Average:5802.06 Median:6036.85 stddev:667.06 (11.0%) stddev-sans-first:639.18 04:17:56 INFO - PROCESS | 30370 | Values: 3283.8 3287.6 3327.1 3345.9 3354.6 5793.7 5837.4 5865.2 5867.7 5876.0 5781.2 5804.0 5830.2 5840.3 5862.3 5267.4 5303.0 5318.3 5380.8 5431.5 5352.4 5353.9 5374.5 5390.6 5405.2 5238.5 5242.2 5354.6 5362.5 5385.7 5298.7 5351.8 5361.7 5366.8 5395.5 5267.1 5322.1 5350.7 5367.7 5373.5 5597.5 5648.3 5805.7 5829.3 5893.9 6104.3 6197.7 6216.0 6218.5 6230.0 6219.9 6251.5 6255.2 6255.9 6261.9 5587.4 5726.5 5802.2 5824.4 5834.9 6249.7 6384.3 6389.6 6394.1 6397.7 6095.1 6112.6 6119.3 6121.1 6135.9 6074.3 6140.7 6173.4 6174.8 6236.0 6190.0 6206.3 6222.1 6229.8 6235.5 6185.8 6186.1 6190.4 6221.4 6221.6 4680.8 4732.2 4762.6 4764.9 4781.3 4200.8 4246.5 4254.0 4277.6 4278.0 5960.2 6030.6 6038.0 6042.6 6045.1 5995.3 6126.3 6304.4 6347.5 6347.8 5898.2 5988.7 5990.9 6001.6 6031.1 5334.1 5338.4 5338.9 5367.6 5370.4 6321.1 6411.3 6470.0 6496.4 6514.7 6295.8 6307.8 6324.2 6324.9 6350.6 6528.9 6540.5 6589.0 6598.8 6602.6 5892.8 6072.9 6100.2 6237.0 6241.6 6286.7 6303.0 6305.2 6307.9 6319.4 6160.0 6168.3 6170.7 6175.1 6182.1 5944.1 5986.6 6030.6 6153.4 6159.3 6036.8 6045.2 6090.4 6092.5 6120.8 6158.7 6163.1 6171.2 6203.9 6217.8 5826.2 5833.8 5948.7 6024.4 6034.6 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | [#1] ext.html Cycles:180 Average:70310.56 Median:45473.16 stddev:147074.09 (323.4%) stddev-sans-first:147393.53 04:17:56 INFO - PROCESS | 30370 | Values: 597.1 629.8 644.9 653.8 704.7 41991.0 45443.3 45465.0 45763.5 45804.5 46328.8 46472.0 46512.0 46709.8 46936.8 8992.3 9144.7 9147.0 9152.0 9165.0 9172.8 9208.7 9236.6 9269.0 9298.2 9296.2 9323.7 9345.5 9358.2 9378.5 9222.4 9241.0 9263.9 9269.0 9270.9 9237.6 9264.1 9294.1 9297.2 9317.6 44811.6 44830.8 44920.0 45126.3 45137.6 3728.4 3740.5 3814.8 3816.5 3856.9 34748.3 35112.8 35341.5 35359.6 35767.5 4604.7 4611.8 4645.9 4672.6 4720.0 384323.0 392601.0 393120.0 581350.0 582293.0 65863.7 66946.3 66962.7 67004.7 67079.7 39372.4 40017.4 40427.2 41651.4 71674.3 17849.3 17981.4 18038.7 18069.4 18096.0 13726.1 13832.9 13859.4 13874.3 13880.4 20048.8 20279.7 20404.2 20419.6 20553.4 7546.6 7648.1 7649.5 7701.7 7705.9 1006.5 1085.1 1108.6 1162.9 1227.1 32857.3 34111.7 34287.3 34354.3 34555.3 1120.9 1137.7 1139.1 1148.3 1244.5 17845.5 17929.5 18007.9 18038.5 18111.0 652779.0 656917.0 657251.0 661805.0 664052.0 65123.7 65493.3 65789.7 65841.0 65868.7 1432.0 1442.8 1446.0 1454.2 1484.4 31884.3 33403.0 33499.7 33747.7 34029.1 57463.7 58172.0 58291.9 58342.4 58684.7 498200.0 502987.0 503746.0 505031.0 508236.0 31528.2 31682.0 31695.7 31855.4 32346.7 47817.5 50273.0 51963.8 52430.2 53358.7 43470.8 46651.5 46705.5 47091.0 47231.0 44104.9 45481.3 45687.3 46351.5 46800.5 39167.2 43771.8 43973.6 44160.8 45526.1 38466.8 38816.4 39311.0 41577.8 42078.0 30114.0 30468.8 31004.4 31212.2 31304.2 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | [#2] jquery.html Cycles:180 Average:29245.83 Median:12343.63 stddev:77941.42 (631.4%) stddev-sans-first:78129.99 04:17:56 INFO - PROCESS | 30370 | Values: 411.5 415.2 426.0 430.8 441.6 19179.3 19919.2 20648.8 20666.3 20912.7 19859.8 20177.2 20259.8 20666.5 20698.4 5873.7 6041.2 6042.9 6049.3 6072.1 5929.5 5935.9 5982.4 5987.9 5998.8 5910.2 5916.0 5922.4 5940.1 5947.2 5896.7 5902.9 5932.9 5949.5 5958.4 5252.8 5356.8 5356.8 5358.7 5366.3 21718.9 22335.9 24242.8 25150.1 25260.6 2351.4 2396.5 2496.7 2551.5 2815.1 10962.1 11005.4 11196.8 11244.4 12868.5 2001.8 2055.8 2082.7 2086.6 2138.2 84864.7 85018.6 86051.0 86977.6 88162.0 11622.7 11624.3 11714.8 11749.5 12086.6 16428.6 16435.3 16446.6 16452.1 16493.7 8422.3 8574.1 8591.3 8603.4 8725.9 8132.5 8228.1 8273.7 8386.1 8456.5 4862.6 4910.6 5021.6 5051.9 5185.5 2090.7 2114.7 2151.1 2154.6 2197.2 971.2 1048.2 1080.9 1081.5 1088.5 18703.5 20489.0 20799.6 20809.6 20942.0 1034.7 1036.7 1074.4 1104.1 1107.2 9545.8 11260.7 11528.7 11653.2 11666.4 464448.0 466067.0 474255.0 476020.0 476967.0 91846.5 92785.5 94914.0 95192.0 103954.5 1067.8 1092.8 1105.4 1106.5 1110.1 18632.7 18692.3 19167.2 19219.6 19232.0 43537.8 43807.3 44013.8 44651.3 45530.8 53358.5 53462.7 56466.0 56808.7 57895.7 9189.4 9327.7 9347.5 9369.4 9426.8 11212.7 13878.3 14117.0 14259.6 14630.7 12740.5 12975.3 12987.9 13013.0 13224.1 11851.2 12488.2 12891.4 12962.7 12976.5 12711.4 12937.4 12987.9 13203.7 13356.7 9076.5 9265.5 9298.2 9346.4 9492.6 12336.0 12377.4 12597.4 12833.6 12906.9 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | [#3] mootools.html Cycles:180 Average:6445.64 Median:3726.68 stddev:3692.85 (99.1%) stddev-sans-first:3684.72 04:17:56 INFO - PROCESS | 30370 | Values: 1529.0 1546.3 1732.0 1805.7 1838.6 9323.0 9837.7 10027.2 10052.4 10168.4 10172.5 10286.1 10326.7 10347.7 10348.1 2551.8 2585.6 2592.4 2594.5 2594.6 2491.2 2535.8 2538.4 2541.0 2542.1 2494.6 2521.2 2559.4 2571.8 2571.9 2460.1 2469.1 2484.0 2492.3 2497.2 2481.5 2486.2 2487.4 2489.3 2518.6 10038.6 10094.9 10107.5 10116.0 10134.1 5873.2 6007.6 6009.1 6010.5 6034.5 3635.7 3669.1 3724.8 3728.6 3807.4 1171.6 1254.7 1262.5 1263.7 1281.4 12441.4 13051.7 13088.5 13438.5 13831.1 4852.7 4992.9 5022.8 5082.9 5170.5 10865.8 10927.5 10970.8 10992.5 11034.6 5870.4 5901.0 5918.3 5921.8 5970.4 4871.2 5271.4 5346.4 5409.9 5482.8 4264.1 4268.5 4393.8 4406.7 4413.0 1237.2 1242.1 1244.1 1244.6 1254.8 1076.9 1107.6 1113.4 1114.6 1115.0 6715.5 6773.2 6799.0 6871.0 7026.2 475.6 485.1 488.2 488.5 489.7 4504.9 4527.3 4568.8 4625.9 4689.9 11580.2 11920.4 12236.3 12315.9 12327.6 12283.8 12285.6 12305.4 12321.6 12399.2 9110.0 9261.6 9280.2 9319.7 9324.3 6416.9 6768.3 6788.2 6847.4 6863.6 10750.9 10824.0 11220.7 11235.7 11240.8 10977.0 11063.5 11230.2 11240.8 11289.9 7953.2 8562.0 8680.4 8856.9 9032.7 9625.5 9685.9 9740.5 9755.7 9801.1 8610.6 8685.9 8719.8 8769.2 8932.9 8459.5 8478.2 8539.3 8632.8 8650.7 7501.4 7638.4 7641.3 7658.4 7667.2 5835.3 5871.6 5909.9 5966.6 6041.8 5559.3 5691.7 5792.4 5844.9 5920.3 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | [#4] prototype.html Cycles:180 Average:4919.03 Median:5476.23 stddev:1442.63 (26.3%) stddev-sans-first:1405.21 04:17:56 INFO - PROCESS | 30370 | Values: 344.0 350.8 353.1 354.5 356.2 5564.2 5637.5 5764.2 5798.9 5802.8 5656.8 5657.2 5658.6 5669.2 5671.6 4475.8 4487.6 4488.8 4490.8 4500.9 4417.8 4420.4 4441.6 4486.1 4499.6 4436.5 4441.5 4443.4 4445.0 4462.3 4442.8 4461.2 4467.3 4477.2 4482.6 3713.2 3791.0 3962.2 3973.3 3982.5 5482.6 5495.5 5499.1 5504.4 5515.7 5059.2 5059.4 5069.3 5073.1 5073.5 5714.4 5889.7 5954.6 5956.9 5963.6 4262.7 4266.6 4267.1 4277.1 4283.3 6227.1 6232.4 6243.3 6249.7 6258.9 4241.7 4283.3 4292.4 4331.2 4361.5 4393.5 4423.0 4426.9 4428.4 4446.8 5033.3 5047.8 5062.7 5063.7 5074.2 5710.2 5888.7 5987.5 6015.9 6026.5 1499.6 1532.0 1536.4 1537.6 1539.2 949.7 975.6 982.5 992.8 992.9 5140.7 5153.3 5166.5 5169.6 5189.8 5410.1 5423.5 5439.9 5456.6 5469.9 5053.6 5079.6 5125.0 5157.5 5186.4 2893.2 2903.3 2906.3 2931.5 2935.0 5576.4 5576.5 5583.1 5613.7 5615.8 5333.0 5346.2 5485.0 5524.4 5547.9 5528.4 5562.6 5567.3 5583.7 5620.7 5396.8 5410.4 5448.8 5461.3 5778.2 6155.8 6166.7 6176.7 6179.3 6185.2 6488.6 6501.7 6505.6 6506.3 6521.1 4400.2 4518.7 4527.3 4537.8 4544.1 6066.3 6193.2 6217.8 6245.0 6245.6 6061.0 6094.7 6096.3 6101.8 6116.3 5940.6 6086.4 6104.8 6115.1 6123.8 5985.5 6016.6 6033.6 6035.5 6056.7 6129.7 6130.3 6136.6 6140.7 6146.7 5805.2 5989.5 6009.5 6012.4 6033.7 04:17:56 INFO - PROCESS | 30370 | 04:17:56 INFO - PROCESS | 30370 | [#5] yui.html Cycles:180 Average:21875.73 Median:3929.02 stddev:31570.36 (803.5%) stddev-sans-first:31619.25 04:17:56 INFO - PROCESS | 30370 | Values: 796.3 804.3 830.6 837.7 844.3 14768.5 15448.9 15456.4 15461.2 15540.5 15041.0 15112.6 15118.8 15119.1 15139.8 716.9 861.5 871.8 877.9 889.0 870.4 879.2 879.3 880.1 881.1 922.2 922.6 923.6 924.7 925.6 914.6 918.9 921.3 922.0 922.2 673.0 674.0 675.9 677.5 678.6 14799.3 14911.3 14924.3 14957.1 14969.5 16729.4 17060.3 17400.3 17472.6 17617.0 13494.4 13645.8 13675.7 13778.6 13845.2 4037.7 4095.9 4160.7 4217.8 4260.5 87227.0 87439.6 88432.6 90764.0 90895.1 13202.4 13299.5 13301.1 13371.9 13436.0 25060.4 25238.4 25309.5 25469.0 25616.6 9040.3 9334.3 9343.1 9376.9 9492.5 4966.4 5058.6 5097.4 5133.0 5178.7 3854.1 3911.8 3946.2 3950.4 3997.5 646.3 649.2 658.8 662.2 678.6 820.8 830.9 852.7 860.0 868.3 9900.7 10497.7 10605.2 10840.2 10969.6 658.1 749.7 801.9 815.1 878.8 5122.8 5248.3 5378.6 5521.8 5536.0 102488.5 118315.4 120749.0 122375.0 124028.4 100569.5 103485.5 104979.0 106123.0 108132.5 93318.0 93664.0 94508.0 94924.5 97099.0 10068.1 10074.6 10075.9 10097.0 10213.6 52277.7 52870.7 53577.5 53980.0 54203.7 45190.3 45350.8 79569.6 80940.0 82345.2 12635.7 12770.4 12958.9 12996.2 13106.1 14533.0 14667.3 14839.7 14993.8 15805.7 13650.5 14043.2 14051.7 14198.7 14442.0 12445.9 12716.6 12731.8 13042.7 13288.6 13192.6 13227.0 13496.3 13533.5 13679.9 10517.2 10552.9 10728.7 10804.5 10964.6 11371.2 11877.2 11897.2 11935.6 11965.9 04:17:56 INFO - PROCESS | 30370 | -------- Summary: end -------- 04:17:56 INFO - PROCESS | 30370 | 04:17:57 INFO - TEST-INFO | 30370: exit 0 04:17:57 INFO - TEST-OK | dromaeo_css | took 1110209ms 04:17:57 INFO - TEST-START | kraken 04:17:57 INFO - operating with platform_type : linux_ 04:17:57 INFO - Initialising browser for kraken test... 04:17:57 INFO - TEST-INFO | started process 30613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5jCY2/profile http://localhost:33767/getInfo.html) 04:18:01 INFO - PROCESS | 30613 | __metrics Screen width/height:1600/1200 04:18:01 INFO - PROCESS | 30613 | colorDepth:24 04:18:01 INFO - PROCESS | 30613 | Browser inner width/height: 1024/697 04:18:01 INFO - PROCESS | 30613 | __metrics 04:18:01 ERROR - PROCESS | 30613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:18:02 INFO - TEST-INFO | 30613: exit 0 04:18:02 INFO - Browser initialized. 04:18:02 INFO - Running cycle 1/1 for kraken test... 04:18:02 INFO - TEST-INFO | started process 30737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5jCY2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:14 INFO - PROCESS | 30737 | RSS: Main: 150265856 04:18:14 INFO - PROCESS | 30737 | 04:18:16 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:17 INFO - PROCESS | 30737 | RSS: Main: 156979200 04:18:17 INFO - PROCESS | 30737 | 04:18:20 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-dft) 04:18:20 INFO - PROCESS | 30737 | RSS: Main: 155521024 04:18:20 INFO - PROCESS | 30737 | 04:18:23 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-fft) 04:18:24 INFO - PROCESS | 30737 | RSS: Main: 156618752 04:18:24 INFO - PROCESS | 30737 | 04:18:26 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33767/tests/kraken/driver.html?testName=audio-oscillator) 04:18:27 INFO - PROCESS | 30737 | RSS: Main: 155676672 04:18:27 INFO - PROCESS | 30737 | 04:18:29 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:29 INFO - PROCESS | 30737 | RSS: Main: 155930624 04:18:29 INFO - PROCESS | 30737 | 04:18:33 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33767/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:33 INFO - PROCESS | 30737 | RSS: Main: 155770880 04:18:33 INFO - PROCESS | 30737 | 04:18:37 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33767/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:37 INFO - PROCESS | 30737 | RSS: Main: 156188672 04:18:37 INFO - PROCESS | 30737 | 04:18:40 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33767/tests/kraken/driver.html?testName=json-parse-financial) 04:18:41 INFO - PROCESS | 30737 | RSS: Main: 156413952 04:18:41 INFO - PROCESS | 30737 | 04:18:42 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:43 INFO - PROCESS | 30737 | RSS: Main: 155406336 04:18:43 INFO - PROCESS | 30737 | 04:18:45 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:45 INFO - PROCESS | 30737 | RSS: Main: 155295744 04:18:45 INFO - PROCESS | 30737 | 04:18:47 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:48 INFO - PROCESS | 30737 | RSS: Main: 156491776 04:18:48 INFO - PROCESS | 30737 | 04:18:50 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:51 INFO - PROCESS | 30737 | RSS: Main: 156196864 04:18:51 INFO - PROCESS | 30737 | 04:18:54 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:54 INFO - PROCESS | 30737 | RSS: Main: 156409856 04:18:54 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | Cycle 1(1): loaded http://localhost:33767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33767/tests/kraken/driver.html?testName=ai-astar) 04:18:56 INFO - PROCESS | 30737 | RSS: Main: 158240768 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | __start_tp_report 04:18:56 INFO - PROCESS | 30737 | _x_x_mozilla_page_load 04:18:56 INFO - PROCESS | 30737 | _x_x_mozilla_page_load_details 04:18:56 INFO - PROCESS | 30737 | |i|pagename|runs| 04:18:56 INFO - PROCESS | 30737 | |0;ai-astar;109;110;103;110;109;109;110;110;111;108 04:18:56 INFO - PROCESS | 30737 | |1;audio-beat-detection;150;114;147;169;117;143;147;118;169;119 04:18:56 INFO - PROCESS | 30737 | |2;audio-dft;162;164;165;164;162;162;160;162;164;162 04:18:56 INFO - PROCESS | 30737 | |3;audio-fft;75;76;75;177;76;76;74;76;180;76 04:18:56 INFO - PROCESS | 30737 | |4;audio-oscillator;85;84;159;83;82;83;137;83;84;147 04:18:56 INFO - PROCESS | 30737 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;117;117 04:18:56 INFO - PROCESS | 30737 | |6;imaging-darkroom;146;147;146;148;147;147;147;146;146;146 04:18:56 INFO - PROCESS | 30737 | |7;imaging-desaturate;96;95;95;96;95;96;97;95;94;96 04:18:56 INFO - PROCESS | 30737 | |8;json-parse-financial;52;51;54;51;52;52;55;55;53;51 04:18:56 INFO - PROCESS | 30737 | |9;json-stringify-tinderbox;63;64;61;62;62;61;60;60;65;62 04:18:56 INFO - PROCESS | 30737 | |10;stanford-crypto-aes;83;74;73;72;74;79;78;73;79;72 04:18:56 INFO - PROCESS | 30737 | |11;stanford-crypto-ccm;126;126;124;124;119;135;126;124;165;117 04:18:56 INFO - PROCESS | 30737 | |12;stanford-crypto-pbkdf2;150;151;147;152;151;149;150;153;152;151 04:18:56 INFO - PROCESS | 30737 | |13;stanford-crypto-sha256-iterative;66;61;64;61;63;60;59;59;59;59 04:18:56 INFO - PROCESS | 30737 | __end_tp_report 04:18:56 INFO - PROCESS | 30737 | __start_cc_report 04:18:56 INFO - PROCESS | 30737 | _x_x_mozilla_cycle_collect,874 04:18:56 INFO - PROCESS | 30737 | __end_cc_report 04:18:56 INFO - PROCESS | 30737 | __startTimestamp1476357536680__endTimestamp 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | ------- Summary: start ------- 04:18:56 INFO - PROCESS | 30737 | Number of tests: 14 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.23 (2.0%) stddev-sans-first:2.37 04:18:56 INFO - PROCESS | 30737 | Values: 109.0 110.0 103.0 110.0 109.0 109.0 110.0 110.0 111.0 108.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:147.00 stddev:21.12 (14.4%) stddev-sans-first:22.04 04:18:56 INFO - PROCESS | 30737 | Values: 150.0 114.0 147.0 169.0 117.0 143.0 147.0 118.0 169.0 119.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 04:18:56 INFO - PROCESS | 30737 | Values: 162.0 164.0 165.0 164.0 162.0 162.0 160.0 162.0 164.0 162.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:43.44 (57.2%) stddev-sans-first:45.40 04:18:56 INFO - PROCESS | 30737 | Values: 75.0 76.0 75.0 177.0 76.0 76.0 74.0 76.0 180.0 76.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:83.00 stddev:31.47 (37.9%) stddev-sans-first:32.72 04:18:56 INFO - PROCESS | 30737 | Values: 85.0 84.0 159.0 83.0 82.0 83.0 137.0 83.0 84.0 147.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:18:56 INFO - PROCESS | 30737 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:18:56 INFO - PROCESS | 30737 | Values: 146.0 147.0 146.0 148.0 147.0 147.0 147.0 146.0 146.0 146.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 04:18:56 INFO - PROCESS | 30737 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 97.0 95.0 94.0 96.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:1.58 (3.0%) stddev-sans-first:1.66 04:18:56 INFO - PROCESS | 30737 | Values: 52.0 51.0 54.0 51.0 52.0 52.0 55.0 55.0 53.0 51.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.63 (2.6%) stddev-sans-first:1.69 04:18:56 INFO - PROCESS | 30737 | Values: 63.0 64.0 61.0 62.0 62.0 61.0 60.0 60.0 65.0 62.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:3.77 (5.0%) stddev-sans-first:2.93 04:18:56 INFO - PROCESS | 30737 | Values: 83.0 74.0 73.0 72.0 74.0 79.0 78.0 73.0 79.0 72.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:126.00 stddev:13.65 (10.8%) stddev-sans-first:14.44 04:18:56 INFO - PROCESS | 30737 | Values: 126.0 126.0 124.0 124.0 119.0 135.0 126.0 124.0 165.0 117.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:151.00 stddev:1.71 (1.1%) stddev-sans-first:1.80 04:18:56 INFO - PROCESS | 30737 | Values: 150.0 151.0 147.0 152.0 151.0 149.0 150.0 153.0 152.0 151.0 04:18:56 INFO - PROCESS | 30737 | 04:18:56 INFO - PROCESS | 30737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:2.47 (4.0%) stddev-sans-first:1.88 04:18:56 INFO - PROCESS | 30737 | Values: 66.0 61.0 64.0 61.0 63.0 60.0 59.0 59.0 59.0 59.0 04:18:56 INFO - PROCESS | 30737 | -------- Summary: end -------- 04:18:56 INFO - PROCESS | 30737 | 04:18:57 INFO - TEST-INFO | 30737: exit 0 04:18:57 INFO - TEST-OK | kraken | took 60440ms 04:18:57 INFO - SUITE-END | took 1170s 04:18:57 INFO - Completed test suite (00:19:30) 04:18:57 INFO - javascript benchmark 04:18:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7771.63564311365, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.7537184711146, 3287.556179915711, 3327.0850516108076, 3345.9163520911975, 3354.614219364774, 5793.681347525884, 5837.416258374161, 5865.178874957509, 5867.735951882165, 5876.001079816426, 5781.19063331134, 5804.042333015047, 5830.212921255629, 5840.269966254218, 5862.2965244170755, 5267.367915850104, 5303.0, 5318.282031925679, 5380.811671591495, 5431.456854314576, 5352.357717073937, 5353.9196912046355, 5374.543163831059, 5390.649607775482, 5405.162199859028, 5238.5023422774775, 5242.18746094356, 5354.598405119612, 5362.51737343639, 5385.703786291752, 5298.682079075268, 5351.812686555952, 5361.651492652965, 5366.838994830161, 5395.487428694268, 5267.130923397634, 5322.068637988336, 5350.732463376816, 5367.651102678314, 5373.543248823855, 5597.468240517144, 5648.3222013358245, 5805.651660900359, 5829.329627092896, 5893.911591326134, 6104.2980057293535, 6197.6901154942525, 6215.968920155416, 6218.471429928416, 6230.0, 6219.906701399437, 6251.468625166866, 6255.24937007562, 6255.906161407583, 6261.906071408933, 5587.441255874462, 5726.513246374022, 5802.216700745387, 5824.388439213864, 5834.854128646775, 6249.6562689051625, 6384.32964538726, 6389.584676995981, 6394.072859435356, 6397.680115994275, 6095.146679464879, 6112.572119951561, 6119.265688117365, 6121.112438696364, 6135.877282454326, 6074.331823499411, 6140.723667434976, 6173.444390004921, 6174.783882564178, 6235.968820155961, 6190.0, 6206.286277078104, 6222.066689996536, 6229.781957631461, 6235.469985051322, 6185.8144255672405, 6186.10301506279, 6190.350013248544, 6221.440070393686, 6221.564490485713, 4680.765961701902, 4732.1718699227495, 4762.571368576775, 4764.880877978078, 4781.306710527024, 4200.810963506649, 4246.532881383046, 4254.042840360956, 4277.57224277576, 4278.0, 5960.225170727777, 6030.6080104793045, 6037.969810150921, 6042.577019608673, 6045.106021628964, 5995.280566332068, 6126.295476020226, 6304.401081897304, 6347.492200623939, 6347.777827776005, 5898.174255604219, 5988.700564971734, 5990.940090599125, 6001.639901605918, 6031.09533569968, 5334.11987022137, 5338.386085600128, 5338.893222135535, 5367.597430192751, 5370.409254981949, 6321.146645202839, 6411.2627047889155, 6469.999999999905, 6496.350364963466, 6514.674266286666, 6295.811125666238, 6307.842303942254, 6324.2410910691015, 6324.936750632435, 6350.618962862243, 6528.934710653023, 6540.50946179029, 6589.0, 6598.8350291243105, 6602.570832895846, 5892.793752218652, 6072.939270607238, 6100.176476175659, 6237.0, 6241.563090583615, 6286.74853005893, 6303.0, 6305.211848518935, 6307.873842523216, 6319.431251187415, 6159.9836027055035, 6168.25980882297, 6170.660613666291, 6175.135481032748, 6182.072689096672, 5944.078667806497, 5986.610870293417, 6030.6080104793045, 6153.446189842935, 6159.260888693386, 6036.849078773066, 6045.153678484928, 6090.3605121461605, 6092.512598992159, 6120.785772497941, 6158.661273629993, 6163.075538669056, 6171.1668924694595, 6203.937960620336, 6217.782377616762, 5826.213461182686, 5833.79581714638, 5948.672822994777, 6024.367441418588, 6034.607750496204], "value": 5756.0725650110935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1311741416237, 629.7512482569385, 644.9290578036415, 653.8136631060149, 704.6611438267295, 41991.0, 45443.31835022477, 45465.0, 45763.54236457639, 45804.54195458045, 46328.76835615826, 46472.0, 46512.0, 46709.7664511677, 46936.765316173456, 8992.32557558184, 9144.679936202234, 9147.0, 9152.039035901234, 9165.0, 9172.816543669123, 9208.67769628063, 9236.584353704066, 9268.953655231715, 9298.16316531512, 9296.163345298923, 9323.72028839136, 9345.532723363838, 9358.204552613002, 9378.5310734463, 9222.35443518954, 9240.953795231015, 9263.86104208434, 9269.0, 9270.860937085949, 9237.584308706057, 9264.11990860867, 9294.07059294072, 9297.209737172348, 9317.627294908196, 44811.551884481065, 44830.77584612089, 44920.0, 45126.323105153446, 45137.645870623935, 3728.384816505273, 3740.4950331705145, 3814.8283327250065, 3816.484774555427, 3856.9421458678144, 34748.30503389918, 35112.82443587791, 35341.46987795185, 35359.64640353615, 35767.4634880477, 4604.746738929358, 4611.823984883833, 4645.88385290367, 4672.649551283667, 4719.952800471986, 384323.0, 392601.0, 393120.0, 581350.0, 582293.0, 65863.67068164724, 66946.330536694, 66962.66518667375, 67004.66497667578, 67079.66460167668, 39372.40941385881, 40017.39973900394, 40427.1914561713, 41651.37522937158, 71674.2832571678, 17849.28602855897, 17981.370652027115, 18038.729419058724, 18069.367572134914, 18096.0, 13726.107802992774, 13832.93083534596, 13859.376328065262, 13874.306284685725, 13880.375383107583, 20048.799512004985, 20279.695804562944, 20404.183832646824, 20419.59160816805, 20553.38339849807, 7546.584937828362, 7648.08223013242, 7649.464537482323, 7701.652210863076, 7705.8844117338285, 1006.4665727164614, 1085.066842515436, 1108.6430526357517, 1162.8895254950767, 1227.0735594626, 32857.3428531428, 34111.65888341134, 34287.31425371479, 34354.31291374158, 34555.30889382248, 1120.9383483908464, 1137.7383201863618, 1139.139949338261, 1148.311013391958, 1244.5438836561245, 17845.46463606068, 17929.462116136536, 18007.909960450113, 18038.458846234633, 18111.0, 652779.0, 656917.0, 657251.0, 661805.0, 664052.0, 65123.67438162779, 65493.34506654968, 65789.67105164539, 65841.0, 65868.67065664641, 1431.9714004042887, 1442.8412874583787, 1445.985540144585, 1454.2219912347055, 1484.4062375050066, 31884.303956708016, 33403.0, 33499.665003349655, 33747.66252337445, 34029.14927126742, 57463.71268143632, 58172.0, 58291.91956563, 58342.4165758337, 58684.706576466844, 498200.0, 502987.0, 503746.0, 505031.0, 508236.0, 31528.211794705316, 31682.0, 31695.683043170196, 31855.36289274248, 32346.676533234368, 47817.52182478131, 50273.0, 51963.83900928793, 52430.21354679759, 53358.733206333716, 43470.78264608657, 46651.53348466472, 46705.53294467012, 47091.0, 47231.0, 44104.87100586984, 45481.317780233985, 45687.314690280335, 46351.53648463472, 46800.531994679615, 39167.2166556673, 43771.78114109409, 43973.56026439695, 44160.77919610382, 45526.08947821091, 38466.80766596149, 38816.417753734284, 39311.0, 41577.792111040464, 42078.0, 30114.0, 30468.84765576158, 31004.379912401175, 31212.219694507818, 31304.21739456532], "value": 21697.23226195054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.5103027397395, 415.20281060364096, 425.9595338442848, 430.76523294804326, 441.59814568742433, 19179.32872349468, 19919.203231870724, 20648.793512064876, 20666.276680316172, 20912.68630970533, 19859.801401985977, 20177.192912283528, 20259.797402025975, 20666.48333791656, 20698.37904862853, 5873.7356818943035, 6041.154238406604, 6042.939570604303, 6049.30433000204, 6072.119542666311, 5929.495992840613, 5935.851603709899, 5982.401759824004, 5987.850303742398, 5998.820035398945, 5910.202122713443, 5916.0, 5922.407759224065, 5940.138679891413, 5947.167396564484, 5896.675682837442, 5902.940970590282, 5932.88134237315, 5949.524038076944, 5958.374370691102, 5252.763625636855, 5356.758945847446, 5356.812511562077, 5358.678479291216, 5366.275552800361, 21718.891405542872, 22335.888320558457, 24242.7575724244, 25150.11974580881, 25260.621090683653, 2351.3651314145254, 2396.4727759892794, 2496.6879140107485, 2551.4897020595768, 2815.0991682661556, 10962.123030157569, 11005.449727513593, 11196.776064478747, 11244.437778111062, 12868.485260589565, 2001.796227921368, 2055.8149766521083, 2082.7188329575615, 2086.5722526881955, 2138.219549864288, 84864.72702909462, 85018.57490712508, 86051.0, 86977.56511217466, 88162.0, 11622.6513204604, 11624.26829695021, 11714.765704685859, 11749.4712737927, 12086.637400877988, 16428.589285267964, 16435.26041328143, 16446.588835279214, 16452.095134767704, 16493.6701265974, 8422.28410585095, 8574.056853746082, 8591.312694984386, 8603.354748393895, 8725.91274087251, 8132.512049277062, 8228.136045715233, 8273.710420135387, 8386.119457457002, 8456.450330728607, 4862.562369386772, 4910.631702622318, 5021.59827213822, 5051.949480505222, 5185.507376799198, 2090.7386576677914, 2114.6827975803753, 2151.0750377337895, 2154.6337122688865, 2197.2090047582856, 971.2472833554052, 1048.1667074675652, 1080.8594882665204, 1081.5498559594866, 1088.4829705889797, 18703.532411689543, 20489.0, 20799.584008319747, 20809.58380832375, 20942.0, 1034.6844212515105, 1036.7045392063226, 1074.3500182389698, 1104.1442881766534, 1107.245170051846, 9545.761355966017, 11260.718482037852, 11528.711782205512, 11653.242539234923, 11666.358350290646, 464448.0, 466067.0, 474255.0, 476020.0, 476967.0, 91846.54076729708, 92785.53607231921, 94914.0, 95192.0, 103954.4802275999, 1067.791780602775, 1092.7650555130685, 1105.3975583307117, 1106.468894930438, 1110.1285490889613, 18632.720509192644, 18692.252309907995, 19167.233310667416, 19219.615607688047, 19231.992683750967, 43537.78231108824, 43807.34288985604, 44013.779931100136, 44651.33023004723, 45530.77234613806, 53358.4664153369, 53462.73268633632, 56466.0, 56808.715956419954, 57895.71052144881, 9189.356745027784, 9327.673531426368, 9347.532623368941, 9369.390989585656, 9426.81146377055, 11212.719682007688, 13878.306084695523, 14117.0, 14259.572212833631, 14630.707385852436, 12740.490380384681, 12975.286359249954, 12987.935060324638, 13013.0, 13224.074314798256, 11851.170418070997, 12488.188267762567, 12891.355432228163, 12962.675933101747, 12976.480940762263, 12711.42798574085, 12937.417816198105, 12987.870121299044, 13203.735925281248, 13356.664333566565, 9076.455412675261, 9265.490398028172, 9298.163165315154, 9346.392484488486, 9492.572834222614, 12336.0, 12377.443015064164, 12597.433115510008, 12833.614991550268, 12906.935465322613], "value": 9752.259416408173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1529.0, 1546.3350759173554, 1731.9567010824728, 1805.7381679656457, 1838.5863180784324, 9322.953385233073, 9837.65568205113, 10027.197824174067, 10052.44711540864, 10168.44073575953, 10172.491375431237, 10286.074253317218, 10326.741831454217, 10347.741306467342, 10348.12040976516, 2551.7958563314983, 2585.5604547227017, 2592.4167062410997, 2594.4811037792424, 2594.558924982748, 2491.2401717476164, 2535.833516582374, 2538.441542860577, 2541.0, 2542.148380292604, 2494.5759220932487, 2521.2436269119285, 2559.4497183105627, 2571.819972601919, 2571.9228423147338, 2460.1143588308105, 2469.148143890364, 2484.0188125690343, 2492.327071690633, 2497.1759319424727, 2481.528509583173, 2486.2416962826333, 2487.4154573675173, 2489.3403248139257, 2518.597024476075, 10038.64864729731, 10094.89905100947, 10107.494625268708, 10116.03897629724, 10134.13859821916, 5873.177755114288, 6007.609505382136, 6009.06859436788, 6010.519158467312, 6034.5172386209, 3635.672789448936, 3669.082729317671, 3724.776513409177, 3728.5898551159353, 3807.3717836556934, 1171.584087648881, 1254.7239607286383, 1262.4571434283255, 1263.7219811641423, 1281.3849352310942, 12441.440135193847, 13051.738965220642, 13088.47646094155, 13438.529651462151, 13831.100978436369, 4852.684575502581, 4992.875178120504, 5022.84931452057, 5082.898342033139, 5170.45710200431, 10865.83701244482, 10927.453627318602, 10970.835437468444, 10992.450377481095, 11034.613788517363, 5870.354261031283, 5900.970495147582, 5918.348981612019, 5921.792737254175, 5970.373110823388, 4871.244957031666, 5271.42014378418, 5346.358436987586, 5409.891802163935, 5482.80810171642, 4264.061906380653, 4268.466441694788, 4393.780310984502, 4406.691531592758, 4413.0, 1237.2020047069589, 1242.1180961517423, 1244.085597086141, 1244.6141696074246, 1254.8431446069242, 1076.9407682577532, 1107.5846557540922, 1113.3598181045932, 1114.6154576671036, 1115.0132133062298, 6715.46276297895, 6773.187217533928, 6799.0, 6871.0, 7026.227115017344, 475.6028716022091, 485.1291930983822, 488.1579275749375, 488.54321209669075, 489.652346833752, 4504.864854054384, 4527.298268768346, 4568.817247310137, 4625.884352891205, 4689.882752931204, 11580.247283926517, 11920.403979801149, 12236.265824050586, 12315.93842030784, 12327.630171094881, 12283.754324913452, 12285.57000504978, 12305.44625491855, 12321.568745093879, 12399.194052386567, 9109.954450227706, 9261.583228754722, 9280.211182049601, 9319.673811416567, 9324.25405967521, 6416.871662566629, 6768.323167683192, 6788.151481064867, 6847.417969472452, 6863.588184708933, 10750.892491074988, 10824.0, 11220.66338009861, 11235.66293011211, 11240.7751844961, 10977.0, 11063.50214240345, 11230.157738169506, 11240.831387529357, 11289.887101129212, 7953.204679532232, 8561.957190214009, 8680.392372533863, 8856.867146992672, 9032.683856065007, 9625.51872406391, 9685.934547199662, 9740.464274464972, 9755.707328780149, 9801.068898454636, 8610.61252243638, 8685.913140868763, 8719.782005449915, 8769.210771030637, 8932.86600701003, 8459.450135741157, 8478.23695867375, 8539.274161696325, 8632.78418039554, 8650.653973840976, 7501.362384197404, 7638.427117966064, 7641.312281894656, 7658.425618078778, 7667.156612772702, 5835.260274383094, 5871.588988770745, 5909.85225369352, 5966.642001479925, 6041.818745437644, 5559.27729395176, 5691.658500489983, 5792.391798861059, 5844.94155058444, 5920.319163296276], "value": 5037.862335420139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9587249530057, 350.83686085970027, 353.08022601124077, 354.46298857231284, 356.248316053128, 5564.248826408434, 5637.492625663689, 5764.193012978187, 5798.884022319557, 5802.825915222545, 5656.78379148483, 5657.23627310313, 5658.603897727161, 5669.206311116447, 5671.63134396265, 4475.753833539154, 4487.551244875503, 4488.775561221943, 4490.820367185317, 4500.909981800362, 4417.756383216291, 4420.40324556184, 4441.578050085237, 4486.057927835159, 4499.572540608637, 4436.534163912791, 4441.489228738688, 4443.355713421552, 4444.97777511112, 4462.3306504024495, 4442.822287108512, 4461.1969845427975, 4467.257769469909, 4477.194105061088, 4482.618977386926, 3713.220223753015, 3791.0332865119494, 3962.187751510933, 3973.3443981742976, 3982.4623675803687, 5482.5613950884235, 5495.505404513613, 5499.085484693119, 5504.4495550444635, 5515.669059856422, 5059.16523773577, 5059.418166910816, 5069.340985671839, 5073.086844368012, 5073.543381095682, 5714.371419143891, 5889.676067816268, 5954.55340849438, 5956.910646340309, 5963.5527335450015, 4262.722923009995, 4266.616004559604, 4267.082577245876, 4277.123189746126, 4283.314669652872, 6227.100734275999, 6232.376762323776, 6243.313235544087, 6249.656268905208, 6258.906116408258, 4241.681873859473, 4283.271843786564, 4292.377605247284, 4331.198728235287, 4361.542038085955, 4393.450818647669, 4423.0, 4426.889327766831, 4428.3800267962515, 4446.799894004777, 5033.270175824485, 5047.798088076436, 5062.7215503146945, 5063.696178229318, 5074.16276314404, 5710.200571919934, 5888.676122813286, 5987.520998320124, 6015.887060893749, 6026.457618814327, 1499.6400863792612, 1531.9846801532065, 1536.377767004365, 1537.630968567558, 1539.191924239783, 949.7293271417751, 975.6389836178491, 982.4891056650645, 992.8163289791412, 992.8709267795285, 5140.665856719302, 5153.252778347119, 5166.509181627739, 5169.560587350042, 5189.818356357585, 5410.133503941134, 5423.484768946943, 5439.918401223906, 5456.61803673747, 5469.890602187934, 5053.5957123430035, 5079.619028572872, 5125.0, 5157.478543829579, 5186.377634683862, 2893.218830915641, 2903.274181454636, 2906.3170155013554, 2931.5456104303867, 2935.0, 5576.414476479992, 5576.479285507399, 5583.134614134816, 5613.663180209201, 5615.775368985276, 5333.0167163853575, 5346.235742205063, 5484.972575137099, 5524.403530340734, 5547.944520554743, 5528.396764938123, 5562.554995600342, 5567.2762540870235, 5583.74873130702, 5620.662760234399, 5396.83809485716, 5410.404855465817, 5448.809291674773, 5461.344638643388, 5778.16216648592, 6155.784547540815, 6166.722497487714, 6176.722047507783, 6179.28938172116, 6185.195924529962, 6488.578242414228, 6501.732162228509, 6505.642189679613, 6506.275836903319, 6521.07628249658, 4400.207962566768, 4518.706284091523, 4527.343535187313, 4537.795799188978, 4544.113897789899, 6066.272047354346, 6193.194884664965, 6217.844553886008, 6245.000799871998, 6245.6252624842655, 6060.999935010674, 6094.664793436404, 6096.268447786117, 6101.816945491642, 6116.26604807426, 5940.5940594059475, 6086.391360863879, 6104.847378815565, 6115.113308570321, 6123.755049797958, 5985.521158307238, 6016.570554783906, 6033.637981720935, 6035.5473339500595, 6056.66688332146, 6129.724162412791, 6130.295016073209, 6136.6011209271255, 6140.662263575367, 6146.692665366624, 5805.187273781758, 5989.52083833301, 6009.519238460825, 6012.428819262338, 6033.728482218223], "value": 4458.906725338625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.2793671727086, 804.3068054062884, 830.5722552885265, 837.6816809612346, 844.2898296468336, 14768.483103091394, 15448.922755386235, 15456.381744730226, 15461.226938653064, 15540.456084037061, 15041.0, 15112.622184445367, 15118.773218401733, 15119.092854428742, 15139.848601513982, 716.9103862017248, 861.4874149880842, 871.7820544863785, 877.9253763430116, 889.022075716713, 870.4255191573562, 879.1823604048233, 879.3141349747208, 880.053942012336, 881.1144799476517, 922.229938001766, 922.5894476957757, 923.6213152607432, 924.653255029364, 925.5742358515091, 914.593006112277, 918.8529835226332, 921.2952091649893, 921.9631214751402, 922.1562270522464, 673.0308355967392, 673.9831504212434, 675.9357861003197, 677.515576362898, 678.5826716569275, 14799.334029968677, 14911.328990195467, 14924.2537873107, 14957.102573845495, 14969.476068337664, 16729.414470493597, 17060.317587296493, 17400.30398784047, 17472.563185920328, 17617.0, 13494.39275232607, 13645.795313070312, 13675.726485470334, 13778.586642400744, 13845.16928984264, 4037.6971727120585, 4095.9385609215888, 4160.729552579072, 4217.768022758747, 4260.510041345254, 87227.0, 87439.56280218558, 88432.55783721105, 90764.0, 90895.09104908933, 13202.405891734896, 13299.534516291884, 13301.135426197266, 13371.866281337063, 13435.992300577496, 25060.373490662878, 25238.369040774127, 25309.493810124062, 25469.0, 25616.615750763754, 9040.276777857756, 9334.299927505464, 9343.065693430603, 9376.8593471098, 9492.525373731423, 4966.354373931365, 5058.595312375001, 5097.439281679087, 5133.0, 5178.741062946838, 3854.113553882623, 3911.8239679214503, 3946.210757848442, 3950.3876899080688, 3997.520297564311, 646.2503495944682, 649.1885143570537, 658.7924803686823, 662.1755913887145, 678.5860625018735, 820.798904268458, 830.9418340716092, 852.6845067325129, 860.0066922704286, 868.2619773192736, 9900.702978910644, 10497.685069447929, 10605.151587873106, 10840.241183117263, 10969.586690927983, 658.0574934441622, 749.7076140305285, 801.9117897031322, 815.1278132398277, 878.7715194049593, 5122.846314610568, 5248.291480650139, 5378.623496355296, 5521.806736764194, 5536.003519366473, 102488.48755756173, 118315.40842295733, 120749.0, 122375.0, 124028.37985810013, 100569.49715251524, 103485.48257258665, 104979.0, 106123.0, 108132.45933770438, 93318.0, 93664.0, 94508.0, 94924.52537737406, 97099.0, 10068.14420774213, 10074.647387341407, 10075.899241007495, 10097.0, 10213.591456341961, 52277.7386113067, 52870.735646321526, 53577.464225357246, 53980.0, 54203.72898135484, 45190.32214516851, 45350.77324613356, 79569.60215198887, 80940.0, 82345.17654823375, 12635.74728505443, 12770.425330859947, 12958.870411295766, 12996.155249908727, 13106.148100373444, 14533.0, 14667.266636668337, 14839.703205936037, 14993.77509337339, 15805.683886322438, 13650.522231721841, 14043.227622480454, 14051.718965620836, 14198.716025679636, 14442.0, 12445.875541244472, 12716.554920577735, 12731.80902286448, 13042.673933151747, 13288.601341959757, 13192.604221873358, 13227.0, 13496.32518374097, 13533.526326578523, 13679.86320136786, 10517.211209159497, 10552.947235263775, 10728.678139655824, 10804.506427118158, 10964.616238431936, 11371.20401571882, 11877.22798018126, 11897.226680265756, 11935.641930742091, 11965.880341196476], "value": 8052.334843522328, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 103.0, 110.0, 109.0, 109.0, 110.0, 110.0, 111.0, 108.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 114.0, 147.0, 169.0, 117.0, 143.0, 147.0, 118.0, 169.0, 119.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 164.0, 162.0, 162.0, 160.0, 162.0, 164.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 177.0, 76.0, 76.0, 74.0, 76.0, 180.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 159.0, 83.0, 82.0, 83.0, 137.0, 83.0, 84.0, 147.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0, 94.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 54.0, 51.0, 52.0, 52.0, 55.0, 55.0, 53.0, 51.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 61.0, 62.0, 62.0, 61.0, 60.0, 60.0, 65.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 74.0, 73.0, 72.0, 74.0, 79.0, 78.0, 73.0, 79.0, 72.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 124.0, 124.0, 119.0, 135.0, 126.0, 124.0, 165.0, 117.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 147.0, 152.0, 151.0, 149.0, 150.0, 153.0, 152.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 61.0, 64.0, 61.0, 63.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 61.1, "unit": "score"}]}]} 04:18:57 INFO - Return code: 0 04:18:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:18:57 ERROR - # TBPL SUCCESS # 04:18:57 INFO - Running post-action listener: _resource_record_post_action 04:18:57 INFO - [mozharness: 2016-10-13 11:18:57.967002Z] Finished run-tests step (success) 04:18:57 INFO - Running post-run listener: _resource_record_post_run 04:18:58 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290676736; Read time: 16; Write time: 161076 04:18:58 INFO - TinderboxPrint: CPU usage
13.2% 04:18:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:18:58 INFO - TinderboxPrint: I/O write bytes / time
290,676,736 / 161,076 04:18:58 INFO - TinderboxPrint: CPU idle
8,206.0 (86.8%) 04:18:58 INFO - TinderboxPrint: CPU user
1,196.1 (12.6%) 04:18:58 INFO - TinderboxPrint: Swap in / out
0 / 0 04:18:58 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71327744; Read time: 0; Write time: 57616 04:18:58 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 219348992; Read time: 0; Write time: 103460 04:18:58 INFO - Running post-run listener: _upload_blobber_files 04:18:58 INFO - Blob upload gear active. 04:18:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:18:58 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 04:18:58 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'] 04:18:58 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 04:18:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:18:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:59 INFO - (blobuploader) - INFO - Done attempting. 04:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:01 INFO - (blobuploader) - INFO - Done attempting. 04:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:04 INFO - (blobuploader) - INFO - Done attempting. 04:19:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:04 INFO - Return code: 0 04:19:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c46cb310232080709c6b56954cb5540650f6ea74e75da5a68c6a0eba4c05196fdd4468e4183145534aeca393633a901ed5a173a8c03590f4e18785934a0858ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06c35be658a76b777885afc3a4bdf7d3a258b0f07a6b440695c3738210dff930ea139cd27e2da2989fc73921fbc0456e7073143975d75cd7d2654d83f64c115", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab4f6df6eb7dc44e01e52066f943802369aa3c20a6176f608ba18ab1d289c750e7a567f61208712f9c73f87b54994348f1bdb68dd230832cfa6afc284deb6433"} 04:19:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:04 INFO - Contents: 04:19:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c46cb310232080709c6b56954cb5540650f6ea74e75da5a68c6a0eba4c05196fdd4468e4183145534aeca393633a901ed5a173a8c03590f4e18785934a0858ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06c35be658a76b777885afc3a4bdf7d3a258b0f07a6b440695c3738210dff930ea139cd27e2da2989fc73921fbc0456e7073143975d75cd7d2654d83f64c115", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab4f6df6eb7dc44e01e52066f943802369aa3c20a6176f608ba18ab1d289c750e7a567f61208712f9c73f87b54994348f1bdb68dd230832cfa6afc284deb6433"} 04:19:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:04 INFO - Copying logs to upload dir... 04:19:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.150343 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-13 04:19:04.192917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:19:04.200165) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c46cb310232080709c6b56954cb5540650f6ea74e75da5a68c6a0eba4c05196fdd4468e4183145534aeca393633a901ed5a173a8c03590f4e18785934a0858ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06c35be658a76b777885afc3a4bdf7d3a258b0f07a6b440695c3738210dff930ea139cd27e2da2989fc73921fbc0456e7073143975d75cd7d2654d83f64c115", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab4f6df6eb7dc44e01e52066f943802369aa3c20a6176f608ba18ab1d289c750e7a567f61208712f9c73f87b54994348f1bdb68dd230832cfa6afc284deb6433"} build_url:https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/GGJc7MOYQayeV4WupYg7Uw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c46cb310232080709c6b56954cb5540650f6ea74e75da5a68c6a0eba4c05196fdd4468e4183145534aeca393633a901ed5a173a8c03590f4e18785934a0858ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06c35be658a76b777885afc3a4bdf7d3a258b0f07a6b440695c3738210dff930ea139cd27e2da2989fc73921fbc0456e7073143975d75cd7d2654d83f64c115", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab4f6df6eb7dc44e01e52066f943802369aa3c20a6176f608ba18ab1d289c750e7a567f61208712f9c73f87b54994348f1bdb68dd230832cfa6afc284deb6433"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:19:04.228560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:19:04.228991) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476355869.706287-1951477422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:19:04.311137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:19:04.311546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:19:04.311934) ========= ========= Total master_lag: 0.18 =========