builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1476139574.97 results: success (0) buildid: 20161010132824 builduid: 6e8b1014dcfe43768723ecbb1981f197 revision: 9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:14.970745) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:14.972938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:14.973266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:14.989261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:14.989549) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 15:46:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-10-10 15:46:17 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.164535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.164832) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.214269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.214579) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30 --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 9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 15:46:17,190 truncating revision to first 12 chars 2016-10-10 15:46:17,190 Setting DEBUG logging. 2016-10-10 15:46:17,190 attempt 1/10 2016-10-10 15:46:17,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9f5ef22fc76f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 15:46:17,504 unpacking tar archive at: mozilla-beta-9f5ef22fc76f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697461 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.925348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.925667) ========= script_repo_revision: 9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.926090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.926365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 15:46:15.939774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-10 15:46:15.940079) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:46:17 INFO - MultiFileLogger online at 20161010 15:46:17 in /builds/slave/test 15:46:17 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 15:46:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:46:18 INFO - {'append_to_log': False, 15:46:18 INFO - 'base_work_dir': '/builds/slave/test', 15:46:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:46:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:46:18 INFO - 'branch': 'Mozilla-Beta', 15:46:18 INFO - 'buildbot_json_path': 'buildprops.json', 15:46:18 INFO - 'config_files': ('talos/linux_config.py',), 15:46:18 INFO - 'default_actions': ('clobber', 15:46:18 INFO - 'read-buildbot-config', 15:46:18 INFO - 'download-and-extract', 15:46:18 INFO - 'populate-webroot', 15:46:18 INFO - 'create-virtualenv', 15:46:18 INFO - 'install', 15:46:18 INFO - 'run-tests'), 15:46:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:46:18 INFO - 'download_minidump_stackwalk': True, 15:46:18 INFO - 'download_symbols': 'ondemand', 15:46:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:46:18 INFO - 'tooltool.py': '/tools/tooltool.py', 15:46:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:46:18 INFO - '/tools/misc-python/virtualenv.py')}, 15:46:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:46:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:46:18 INFO - 'installer_path': 'installer.exe', 15:46:18 INFO - 'log_level': 'info', 15:46:18 INFO - 'log_name': 'talos', 15:46:18 INFO - 'log_to_console': True, 15:46:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:46:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:46:18 INFO - 'opt_config_files': (), 15:46:18 INFO - 'pip_index': False, 15:46:18 INFO - 'sps_profile': False, 15:46:18 INFO - 'sps_profile_interval': 0, 15:46:18 INFO - 'suite': 'dromaeojs-e10s', 15:46:18 INFO - 'system_bits': '32', 15:46:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:46:18 INFO - 'title': 'talos-linux64-ix-069', 15:46:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:46:18 INFO - 'use_talos_json': True, 15:46:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:46:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:46:18 INFO - 'work_dir': 'build'} 15:46:18 INFO - [mozharness: 2016-10-10 22:46:18.009482Z] Running clobber step. 15:46:18 INFO - Running pre-action listener: _resource_record_pre_action 15:46:18 INFO - Running main action method: clobber 15:46:18 INFO - rmtree: /builds/slave/test/build 15:46:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:46:18 INFO - Running post-action listener: _resource_record_post_action 15:46:18 INFO - [mozharness: 2016-10-10 22:46:18.467257Z] Finished clobber step (success) 15:46:18 INFO - [mozharness: 2016-10-10 22:46:18.467359Z] Running read-buildbot-config step. 15:46:18 INFO - Running pre-action listener: _resource_record_pre_action 15:46:18 INFO - Running main action method: read_buildbot_config 15:46:18 INFO - Using buildbot properties: 15:46:18 INFO - { 15:46:18 INFO - "project": "", 15:46:18 INFO - "product": "firefox", 15:46:18 INFO - "script_repo_revision": "production", 15:46:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:46:18 INFO - "repository": "", 15:46:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:46:18 INFO - "buildid": "20161010132824", 15:46:18 INFO - "pgo_build": "True", 15:46:18 INFO - "basedir": "/builds/slave/test", 15:46:18 INFO - "buildnumber": 147, 15:46:18 INFO - "slavename": "talos-linux64-ix-069", 15:46:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:46:18 INFO - "platform": "ubuntu64_hw", 15:46:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:46:18 INFO - "branch": "mozilla-beta", 15:46:18 INFO - "repo_path": "releases/mozilla-beta", 15:46:18 INFO - "revision": "9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30", 15:46:18 INFO - "stage_platform": "linux64-pgo", 15:46:18 INFO - "builduid": "6e8b1014dcfe43768723ecbb1981f197", 15:46:18 INFO - "slavebuilddir": "test" 15:46:18 INFO - } 15:46:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:46:18 INFO - Running post-action listener: _resource_record_post_action 15:46:18 INFO - [mozharness: 2016-10-10 22:46:18.469835Z] Finished read-buildbot-config step (success) 15:46:18 INFO - [mozharness: 2016-10-10 22:46:18.469925Z] Running download-and-extract step. 15:46:18 INFO - Running pre-action listener: _resource_record_pre_action 15:46:18 INFO - Running main action method: download_and_extract 15:46:18 INFO - mkdir: /builds/slave/test/build/tests 15:46: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')]} 15:46:18 INFO - https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:46:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:46:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:46:18 INFO - retry: Failed, sleeping 30 seconds before retrying 15:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:46:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:46:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:46:48 INFO - retry: Failed, sleeping 60 seconds before retrying 15:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:47:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:47:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:47:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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! 15:47:48 INFO - Caught exception: HTTP Error 404: Not Found 15:47:48 INFO - Caught exception: HTTP Error 404: Not Found 15:47:48 INFO - Caught exception: HTTP Error 404: Not Found 15:47:48 INFO - trying https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:47:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:47:49 INFO - Downloaded 1327 bytes. 15:47:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:47:49 INFO - Using the following test package requirements: 15:47:49 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:47:49 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:49 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:47:49 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'jsshell-linux-x86_64.zip'], 15:47:49 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:49 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:47:49 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:47:49 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:47:49 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:49 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:47:49 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:49 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:49 INFO - https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:47:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:47:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:47:49 INFO - retry: Failed, sleeping 30 seconds before retrying 15:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:48:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:48:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:48:19 INFO - retry: Failed, sleeping 60 seconds before retrying 15:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:49:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:49:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:49:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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! 15:49:19 INFO - Caught exception: HTTP Error 404: Not Found 15:49:19 INFO - Caught exception: HTTP Error 404: Not Found 15:49:19 INFO - Caught exception: HTTP Error 404: Not Found 15:49:19 INFO - trying https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:49:19 INFO - Downloading https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:49:20 INFO - Downloaded 21773377 bytes. 15:49:20 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'] 15:49:20 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 15:49:21 INFO - Return code: 0 15:49:21 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 15:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:21 INFO - https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:49:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:49:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:49:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:49:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:49:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:49:21 INFO - retry: Failed, sleeping 30 seconds before retrying 15:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:49:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:49:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:49:51 INFO - retry: Failed, sleeping 60 seconds before retrying 15:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:50:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:50:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:50:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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! 15:50:51 INFO - Caught exception: HTTP Error 404: Not Found 15:50:51 INFO - Caught exception: HTTP Error 404: Not Found 15:50:51 INFO - Caught exception: HTTP Error 404: Not Found 15:50:51 INFO - trying https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:50:51 INFO - Downloading https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:50:52 INFO - Downloaded 21773377 bytes. 15:50:52 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'] 15:50:52 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 15:50:53 INFO - Return code: 0 15:50: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')]} 15:50:53 INFO - https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:50:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:50:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:50:53 INFO - retry: Failed, sleeping 30 seconds before retrying 15:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:51:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:51:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:51:23 INFO - retry: Failed, sleeping 60 seconds before retrying 15:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:52:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:52:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:52:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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! 15:52:23 INFO - Caught exception: HTTP Error 404: Not Found 15:52:23 INFO - Caught exception: HTTP Error 404: Not Found 15:52:23 INFO - Caught exception: HTTP Error 404: Not Found 15:52:23 INFO - trying https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:52:23 INFO - Downloading https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:52:24 INFO - Downloaded 14413740 bytes. 15:52:24 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'] 15:52:24 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 15:52:24 INFO - Return code: 0 15:52:24 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')]} 15:52:24 INFO - https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:52:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:52:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:52:24 INFO - retry: Failed, sleeping 30 seconds before retrying 15:52:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:52:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:52:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:52:54 INFO - retry: Failed, sleeping 60 seconds before retrying 15:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:53:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:53:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:53:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RAWXIckmQgiv5Jreg6hiCg/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! 15:53:54 INFO - Caught exception: HTTP Error 404: Not Found 15:53:54 INFO - Caught exception: HTTP Error 404: Not Found 15:53:54 INFO - Caught exception: HTTP Error 404: Not Found 15:53:54 INFO - trying https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:53:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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 15:53:55 INFO - Downloaded 56813478 bytes. 15:53:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:53:55 INFO - mkdir: /builds/slave/test/properties 15:53:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:55 INFO - Contents: 15:53:55 INFO - build_url:https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:53:56 INFO - Running post-action listener: _resource_record_post_action 15:53:56 INFO - Running post-action listener: set_extra_try_arguments 15:53:56 INFO - [mozharness: 2016-10-10 22:53:56.574099Z] Finished download-and-extract step (success) 15:53:56 INFO - [mozharness: 2016-10-10 22:53:56.574331Z] Running populate-webroot step. 15:53:56 INFO - Running pre-action listener: _resource_record_pre_action 15:53:56 INFO - Running main action method: populate_webroot 15:53:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:56 INFO - '--tppagecycles', 15:53:56 INFO - '7'], 15:53:56 INFO - 'tests': ['tsvgm']}}, 15:53:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['damp', 'tps']}, 15:53:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'tests': ['damp', 'tps']}, 15:53:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['dromaeo_dom']}, 15:53:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['basic_compositor_video']}, 15:53:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:53:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['a11yr', 15:53:56 INFO - 'ts_paint', 15:53:56 INFO - 'tpaint', 15:53:56 INFO - 'sessionrestore', 15:53:56 INFO - 'sessionrestore_no_auto_restore', 15:53:56 INFO - 'tabpaint']}, 15:53:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:56 INFO - 'ts_paint', 15:53:56 INFO - 'tpaint', 15:53:56 INFO - 'sessionrestore', 15:53:56 INFO - 'sessionrestore_no_auto_restore', 15:53:56 INFO - 'tabpaint']}, 15:53:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:56 INFO - 'ts_paint', 15:53:56 INFO - 'tpaint', 15:53:56 INFO - 'sessionrestore', 15:53:56 INFO - 'sessionrestore_no_auto_restore', 15:53:56 INFO - 'tabpaint']}, 15:53:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:56 INFO - 'ts_paint', 15:53:56 INFO - 'tpaint', 15:53:56 INFO - 'sessionrestore', 15:53:56 INFO - 'sessionrestore_no_auto_restore', 15:53:56 INFO - 'tabpaint']}, 15:53:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['a11yr', 15:53:56 INFO - 'ts_paint', 15:53:56 INFO - 'tpaint', 15:53:56 INFO - 'sessionrestore', 15:53:56 INFO - 'sessionrestore_no_auto_restore', 15:53:56 INFO - 'tabpaint']}, 15:53:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['a11yr', 15:53:56 INFO - 'ts_paint', 15:53:56 INFO - 'tpaint', 15:53:56 INFO - 'sessionrestore', 15:53:56 INFO - 'sessionrestore_no_auto_restore', 15:53:56 INFO - 'tabpaint']}, 15:53:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['tsvgx', 15:53:56 INFO - 'tsvgr_opacity', 15:53:56 INFO - 'tart', 15:53:56 INFO - 'tscrollx', 15:53:56 INFO - 'cart']}, 15:53:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:56 INFO - 'tsvgr_opacity', 15:53:56 INFO - 'tart', 15:53:56 INFO - 'tscrollx', 15:53:56 INFO - 'cart']}, 15:53:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'talos_options': ['--disable-e10s'], 15:53:56 INFO - 'tests': ['tp5o']}, 15:53:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'tests': ['tp5o']}, 15:53:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'talos_options': ['--disable-e10s', 15:53:56 INFO - '--xperf_path', 15:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:56 INFO - 'tests': ['tp5n']}, 15:53:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:56 INFO - 'talos_options': ['--xperf_path', 15:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:56 INFO - 'tests': ['tp5n']}}, 15:53:56 INFO - 'talos.zip': {'path': '', 15:53:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:56 INFO - Running post-action listener: _resource_record_post_action 15:53:56 INFO - [mozharness: 2016-10-10 22:53:56.596715Z] Finished populate-webroot step (success) 15:53:56 INFO - [mozharness: 2016-10-10 22:53:56.596810Z] Running create-virtualenv step. 15:53:56 INFO - Running pre-action listener: _resource_record_pre_action 15:53:56 INFO - Running main action method: create_virtualenv 15:53:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:56 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 15:53:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:56 INFO - Using real prefix '/usr' 15:53:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:59 INFO - Installing pip.................done. 15:53:59 INFO - Return code: 0 15:53:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:59 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')]} 15:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:59 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')]} 15:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:59 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:53:59 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 15:53:59 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 15:53:59 INFO - Using env: {'DISPLAY': ':0', 15:53:59 INFO - 'HOME': '/home/cltbld', 15:53:59 INFO - 'LANG': 'en_US.UTF-8', 15:53:59 INFO - 'LANGUAGE': 'en_US:en', 15:53:59 INFO - 'LOGNAME': 'cltbld', 15:53:59 INFO - 'MAIL': '/var/mail/cltbld', 15:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:59 INFO - 'MOZ_NO_REMOTE': '1', 15:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:59 INFO - 'NO_EM_RESTART': '1', 15:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:59 INFO - 'PWD': '/builds/slave/test', 15:53:59 INFO - 'SHELL': '/bin/bash', 15:53:59 INFO - 'SHLVL': '1', 15:53:59 INFO - 'TERM': 'linux', 15:53:59 INFO - 'TMOUT': '86400', 15:53:59 INFO - 'USER': 'cltbld', 15:53:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:59 INFO - '_': '/tools/buildbot/bin/python'} 15:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:59 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 15:53:59 INFO - Cleaning up... 15:53:59 INFO - Return code: 0 15:53:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:59 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')]} 15:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:59 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')]} 15:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:59 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:53:59 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 15:53:59 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 15:53:59 INFO - Using env: {'DISPLAY': ':0', 15:53:59 INFO - 'HOME': '/home/cltbld', 15:53:59 INFO - 'LANG': 'en_US.UTF-8', 15:53:59 INFO - 'LANGUAGE': 'en_US:en', 15:53:59 INFO - 'LOGNAME': 'cltbld', 15:53:59 INFO - 'MAIL': '/var/mail/cltbld', 15:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:59 INFO - 'MOZ_NO_REMOTE': '1', 15:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:59 INFO - 'NO_EM_RESTART': '1', 15:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:59 INFO - 'PWD': '/builds/slave/test', 15:53:59 INFO - 'SHELL': '/bin/bash', 15:53:59 INFO - 'SHLVL': '1', 15:53:59 INFO - 'TERM': 'linux', 15:53:59 INFO - 'TMOUT': '86400', 15:53:59 INFO - 'USER': 'cltbld', 15:53:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:59 INFO - '_': '/tools/buildbot/bin/python'} 15:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:59 INFO - Downloading/unpacking psutil>=3.1.1 15:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:01 INFO - Installing collected packages: psutil 15:54:01 INFO - Running setup.py install for psutil 15:54:01 INFO - building 'psutil._psutil_linux' extension 15:54:01 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 15:54:01 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 15:54:01 INFO - building 'psutil._psutil_posix' extension 15:54:01 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 15:54:02 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 15:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:02 INFO - Successfully installed psutil 15:54:02 INFO - Cleaning up... 15:54:02 INFO - Return code: 0 15:54:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54:02 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')]} 15:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:02 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')]} 15:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:02 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:02 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 15:54:02 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 15:54:02 INFO - Using env: {'DISPLAY': ':0', 15:54:02 INFO - 'HOME': '/home/cltbld', 15:54:02 INFO - 'LANG': 'en_US.UTF-8', 15:54:02 INFO - 'LANGUAGE': 'en_US:en', 15:54:02 INFO - 'LOGNAME': 'cltbld', 15:54:02 INFO - 'MAIL': '/var/mail/cltbld', 15:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:02 INFO - 'MOZ_NO_REMOTE': '1', 15:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:02 INFO - 'NO_EM_RESTART': '1', 15:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:02 INFO - 'PWD': '/builds/slave/test', 15:54:02 INFO - 'SHELL': '/bin/bash', 15:54:02 INFO - 'SHLVL': '1', 15:54:02 INFO - 'TERM': 'linux', 15:54:02 INFO - 'TMOUT': '86400', 15:54:02 INFO - 'USER': 'cltbld', 15:54:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:02 INFO - '_': '/tools/buildbot/bin/python'} 15:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 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 15:54:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:04 INFO - Installing collected packages: mozsystemmonitor 15:54:04 INFO - Running setup.py install for mozsystemmonitor 15:54:04 INFO - Successfully installed mozsystemmonitor 15:54:04 INFO - Cleaning up... 15:54:04 INFO - Return code: 0 15:54:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:04 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:04 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 15:54:04 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 15:54:04 INFO - Using env: {'DISPLAY': ':0', 15:54:04 INFO - 'HOME': '/home/cltbld', 15:54:04 INFO - 'LANG': 'en_US.UTF-8', 15:54:04 INFO - 'LANGUAGE': 'en_US:en', 15:54:04 INFO - 'LOGNAME': 'cltbld', 15:54:04 INFO - 'MAIL': '/var/mail/cltbld', 15:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:04 INFO - 'MOZ_NO_REMOTE': '1', 15:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:04 INFO - 'NO_EM_RESTART': '1', 15:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:04 INFO - 'PWD': '/builds/slave/test', 15:54:04 INFO - 'SHELL': '/bin/bash', 15:54:04 INFO - 'SHLVL': '1', 15:54:04 INFO - 'TERM': 'linux', 15:54:04 INFO - 'TMOUT': '86400', 15:54:04 INFO - 'USER': 'cltbld', 15:54:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:04 INFO - '_': '/tools/buildbot/bin/python'} 15:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:04 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:04 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 15:54:04 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 15:54:04 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 15:54:04 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 15:54:04 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 15:54:04 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 15:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:06 INFO - warning: no files found matching '*.txt' 15:54:06 INFO - no previously-included directories found matching 'build' 15:54:06 INFO - no previously-included directories found matching 'dist' 15:54:06 INFO - no previously-included directories found matching '.git*' 15:54:06 INFO - Installing collected packages: jsonschema, functools32 15:54:06 INFO - Running setup.py install for functools32 15:54:07 INFO - warning: no files found matching '*.txt' 15:54:07 INFO - no previously-included directories found matching 'build' 15:54:07 INFO - no previously-included directories found matching 'dist' 15:54:07 INFO - no previously-included directories found matching '.git*' 15:54:07 INFO - Successfully installed jsonschema functools32 15:54:07 INFO - Cleaning up... 15:54:07 INFO - Return code: 0 15:54:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:54:07 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')]} 15:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:07 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')]} 15:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:07 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:07 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 15:54:07 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 15:54:07 INFO - Using env: {'DISPLAY': ':0', 15:54:07 INFO - 'HOME': '/home/cltbld', 15:54:07 INFO - 'LANG': 'en_US.UTF-8', 15:54:07 INFO - 'LANGUAGE': 'en_US:en', 15:54:07 INFO - 'LOGNAME': 'cltbld', 15:54:07 INFO - 'MAIL': '/var/mail/cltbld', 15:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:07 INFO - 'MOZ_NO_REMOTE': '1', 15:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:07 INFO - 'NO_EM_RESTART': '1', 15:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:07 INFO - 'PWD': '/builds/slave/test', 15:54:07 INFO - 'SHELL': '/bin/bash', 15:54:07 INFO - 'SHLVL': '1', 15:54:07 INFO - 'TERM': 'linux', 15:54:07 INFO - 'TMOUT': '86400', 15:54:07 INFO - 'USER': 'cltbld', 15:54:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:07 INFO - '_': '/tools/buildbot/bin/python'} 15:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:54:07 INFO - Cleaning up... 15:54:07 INFO - Return code: 0 15:54:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54:07 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')]} 15:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:07 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')]} 15:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:07 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:07 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 15:54:07 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 15:54:07 INFO - Using env: {'DISPLAY': ':0', 15:54:07 INFO - 'HOME': '/home/cltbld', 15:54:07 INFO - 'LANG': 'en_US.UTF-8', 15:54:07 INFO - 'LANGUAGE': 'en_US:en', 15:54:07 INFO - 'LOGNAME': 'cltbld', 15:54:07 INFO - 'MAIL': '/var/mail/cltbld', 15:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:07 INFO - 'MOZ_NO_REMOTE': '1', 15:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:07 INFO - 'NO_EM_RESTART': '1', 15:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:07 INFO - 'PWD': '/builds/slave/test', 15:54:07 INFO - 'SHELL': '/bin/bash', 15:54:07 INFO - 'SHLVL': '1', 15:54:07 INFO - 'TERM': 'linux', 15:54:07 INFO - 'TMOUT': '86400', 15:54:07 INFO - 'USER': 'cltbld', 15:54:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:07 INFO - '_': '/tools/buildbot/bin/python'} 15:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:07 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 15:54:07 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 15:54:07 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 15:54:07 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 15:54:07 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 15:54:07 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 15:54:09 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:10 INFO - Downloading docopt-0.6.1.tar.gz 15:54:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:10 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:10 INFO - Running setup.py install for blobuploader 15:54:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:10 INFO - Running setup.py install for requests 15:54:10 INFO - Running setup.py install for docopt 15:54:10 INFO - Successfully installed blobuploader requests docopt 15:54:11 INFO - Cleaning up... 15:54:11 INFO - Return code: 0 15:54:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:11 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:11 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 15:54:11 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 15:54:11 INFO - Using env: {'DISPLAY': ':0', 15:54:11 INFO - 'HOME': '/home/cltbld', 15:54:11 INFO - 'LANG': 'en_US.UTF-8', 15:54:11 INFO - 'LANGUAGE': 'en_US:en', 15:54:11 INFO - 'LOGNAME': 'cltbld', 15:54:11 INFO - 'MAIL': '/var/mail/cltbld', 15:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:11 INFO - 'MOZ_NO_REMOTE': '1', 15:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:11 INFO - 'NO_EM_RESTART': '1', 15:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:11 INFO - 'PWD': '/builds/slave/test', 15:54:11 INFO - 'SHELL': '/bin/bash', 15:54:11 INFO - 'SHLVL': '1', 15:54:11 INFO - 'TERM': 'linux', 15:54:11 INFO - 'TMOUT': '86400', 15:54:11 INFO - 'USER': 'cltbld', 15:54:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:11 INFO - '_': '/tools/buildbot/bin/python'} 15:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:11 INFO - Running setup.py (path:/tmp/pip-xE77K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:11 INFO - Running setup.py (path:/tmp/pip-IYYSKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:11 INFO - Running setup.py (path:/tmp/pip-SbWTHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:11 INFO - Running setup.py (path:/tmp/pip-H4750r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:11 INFO - Running setup.py (path:/tmp/pip-Wt3Mi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:11 INFO - Running setup.py (path:/tmp/pip-IJWkYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:11 INFO - Running setup.py (path:/tmp/pip-29UBH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:11 INFO - Running setup.py (path:/tmp/pip-n5xUKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:11 INFO - Running setup.py (path:/tmp/pip-gafVhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:11 INFO - Running setup.py (path:/tmp/pip-cLhqXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:11 INFO - Running setup.py (path:/tmp/pip-_9t5FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:12 INFO - Running setup.py (path:/tmp/pip-0K3otv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:12 INFO - Running setup.py (path:/tmp/pip-hkKhML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:12 INFO - Running setup.py (path:/tmp/pip-620MFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:12 INFO - Running setup.py (path:/tmp/pip-feWqAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:12 INFO - Running setup.py (path:/tmp/pip-aX1Ffx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:12 INFO - Running setup.py (path:/tmp/pip-dYGu1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:12 INFO - Running setup.py install for manifestparser 15:54:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:12 INFO - Running setup.py install for mozcrash 15:54:12 INFO - Running setup.py install for mozdebug 15:54:12 INFO - Running setup.py install for mozdevice 15:54:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:12 INFO - Running setup.py install for mozfile 15:54:13 INFO - Running setup.py install for mozhttpd 15:54:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for mozinfo 15:54:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for mozInstall 15:54:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for mozleak 15:54:13 INFO - Running setup.py install for mozlog 15:54:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for moznetwork 15:54:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for mozprocess 15:54:13 INFO - Running setup.py install for mozprofile 15:54:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for mozrunner 15:54:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:13 INFO - Running setup.py install for mozscreenshot 15:54:14 INFO - Running setup.py install for moztest 15:54:14 INFO - Running setup.py install for mozversion 15:54:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:14 INFO - Cleaning up... 15:54:14 INFO - Return code: 0 15:54:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:14 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:14 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 15:54:14 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 15:54:14 INFO - Using env: {'DISPLAY': ':0', 15:54:14 INFO - 'HOME': '/home/cltbld', 15:54:14 INFO - 'LANG': 'en_US.UTF-8', 15:54:14 INFO - 'LANGUAGE': 'en_US:en', 15:54:14 INFO - 'LOGNAME': 'cltbld', 15:54:14 INFO - 'MAIL': '/var/mail/cltbld', 15:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:14 INFO - 'MOZ_NO_REMOTE': '1', 15:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:14 INFO - 'NO_EM_RESTART': '1', 15:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:14 INFO - 'PWD': '/builds/slave/test', 15:54:14 INFO - 'SHELL': '/bin/bash', 15:54:14 INFO - 'SHLVL': '1', 15:54:14 INFO - 'TERM': 'linux', 15:54:14 INFO - 'TMOUT': '86400', 15:54:14 INFO - 'USER': 'cltbld', 15:54:14 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:14 INFO - '_': '/tools/buildbot/bin/python'} 15:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:14 INFO - Running setup.py (path:/tmp/pip-qwLOwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:14 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)) 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:14 INFO - Running setup.py (path:/tmp/pip-FAio0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:14 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)) 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:14 INFO - Running setup.py (path:/tmp/pip-j14eD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:14 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)) 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:14 INFO - Running setup.py (path:/tmp/pip-mhfYcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:14 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)) 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:14 INFO - Running setup.py (path:/tmp/pip-iNJcUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:14 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)) 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:14 INFO - Running setup.py (path:/tmp/pip-RbDPJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:14 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)) 15:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:14 INFO - Running setup.py (path:/tmp/pip-LnDz0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:15 INFO - Running setup.py (path:/tmp/pip-guM8ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:15 INFO - Running setup.py (path:/tmp/pip-ud9xFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:15 INFO - Running setup.py (path:/tmp/pip-tIBNZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:15 INFO - Running setup.py (path:/tmp/pip-3huW8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:15 INFO - Running setup.py (path:/tmp/pip-wniXZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:15 INFO - Running setup.py (path:/tmp/pip-Y5DdGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:15 INFO - Running setup.py (path:/tmp/pip-iZT9tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:15 INFO - Running setup.py (path:/tmp/pip-3dUYwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:15 INFO - Running setup.py (path:/tmp/pip-BPFdsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:15 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)) 15:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:15 INFO - Running setup.py (path:/tmp/pip-LXxYSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:15 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)) 15:54:15 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)) 15:54:15 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)) 15:54:15 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)) 15:54:15 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)) 15:54:15 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)) 15:54:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:15 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 15:54:15 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 15:54:15 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 15:54:15 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 15:54:15 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 15:54:15 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 15:54:17 INFO - Downloading blessings-1.6.tar.gz 15:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:17 INFO - Installing collected packages: blessings 15:54:17 INFO - Running setup.py install for blessings 15:54:18 INFO - Successfully installed blessings 15:54:18 INFO - Cleaning up... 15:54:18 INFO - Return code: 0 15:54:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:18 INFO - Reading from file tmpfile_stdout 15:54:18 INFO - Current package versions: 15:54:18 INFO - argparse == 1.2.1 15:54:18 INFO - blessings == 1.6 15:54:18 INFO - blobuploader == 1.2.4 15:54:18 INFO - docopt == 0.6.1 15:54:18 INFO - functools32 == 3.2.3-2 15:54:18 INFO - jsonschema == 2.5.1 15:54:18 INFO - manifestparser == 1.1 15:54:18 INFO - mozInstall == 1.12 15:54:18 INFO - mozcrash == 0.17 15:54:18 INFO - mozdebug == 0.1 15:54:18 INFO - mozdevice == 0.48 15:54:18 INFO - mozfile == 1.2 15:54:18 INFO - mozhttpd == 0.7 15:54:18 INFO - mozinfo == 0.9 15:54:18 INFO - mozleak == 0.1 15:54:18 INFO - mozlog == 3.3 15:54:18 INFO - moznetwork == 0.27 15:54:18 INFO - mozprocess == 0.23 15:54:18 INFO - mozprofile == 0.28 15:54:18 INFO - mozrunner == 6.12 15:54:18 INFO - mozscreenshot == 0.1 15:54:18 INFO - mozsystemmonitor == 0.3 15:54:18 INFO - moztest == 0.7 15:54:18 INFO - mozversion == 1.4 15:54:18 INFO - psutil == 3.1.1 15:54:18 INFO - requests == 1.2.3 15:54:18 INFO - wsgiref == 0.1.2 15:54:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:18 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:18 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 15:54:18 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 15:54:18 INFO - Using env: {'DISPLAY': ':0', 15:54:18 INFO - 'HOME': '/home/cltbld', 15:54:18 INFO - 'LANG': 'en_US.UTF-8', 15:54:18 INFO - 'LANGUAGE': 'en_US:en', 15:54:18 INFO - 'LOGNAME': 'cltbld', 15:54:18 INFO - 'MAIL': '/var/mail/cltbld', 15:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:18 INFO - 'MOZ_NO_REMOTE': '1', 15:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:18 INFO - 'NO_EM_RESTART': '1', 15:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:18 INFO - 'PWD': '/builds/slave/test', 15:54:18 INFO - 'SHELL': '/bin/bash', 15:54:18 INFO - 'SHLVL': '1', 15:54:18 INFO - 'TERM': 'linux', 15:54:18 INFO - 'TMOUT': '86400', 15:54:18 INFO - 'USER': 'cltbld', 15:54:18 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:18 INFO - '_': '/tools/buildbot/bin/python'} 15:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 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)) 15:54:18 INFO - Cleaning up... 15:54:18 INFO - Return code: 0 15:54:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:18 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 0x1e4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', '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 15:54:18 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 15:54:18 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 15:54:18 INFO - Using env: {'DISPLAY': ':0', 15:54:18 INFO - 'HOME': '/home/cltbld', 15:54:18 INFO - 'LANG': 'en_US.UTF-8', 15:54:18 INFO - 'LANGUAGE': 'en_US:en', 15:54:18 INFO - 'LOGNAME': 'cltbld', 15:54:18 INFO - 'MAIL': '/var/mail/cltbld', 15:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:18 INFO - 'MOZ_NO_REMOTE': '1', 15:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:18 INFO - 'NO_EM_RESTART': '1', 15:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:18 INFO - 'PWD': '/builds/slave/test', 15:54:18 INFO - 'SHELL': '/bin/bash', 15:54:18 INFO - 'SHLVL': '1', 15:54:18 INFO - 'TERM': 'linux', 15:54:18 INFO - 'TMOUT': '86400', 15:54:18 INFO - 'USER': 'cltbld', 15:54:18 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:18 INFO - '_': '/tools/buildbot/bin/python'} 15:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:18 INFO - Cleaning up... 15:54:18 INFO - Return code: 0 15:54:18 INFO - Running post-action listener: _resource_record_post_action 15:54:18 INFO - Running post-action listener: _start_resource_monitoring 15:54:18 INFO - Starting resource monitoring. 15:54:18 INFO - [mozharness: 2016-10-10 22:54:18.757262Z] Finished create-virtualenv step (success) 15:54:18 INFO - [mozharness: 2016-10-10 22:54:18.757743Z] Running install step. 15:54:18 INFO - Running pre-action listener: _resource_record_pre_action 15:54:18 INFO - Running main action method: install 15:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:18 INFO - Reading from file tmpfile_stdout 15:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:19 INFO - Reading from file tmpfile_stdout 15:54:19 INFO - Output received: 15:54:19 INFO - Usage: mozinstall [options] installer 15:54:19 INFO - Options: 15:54:19 INFO - -h, --help show this help message and exit 15:54:19 INFO - -d DEST, --destination=DEST 15:54:19 INFO - Directory to install application into. [default: 15:54:19 INFO - "/builds/slave/test"] 15:54:19 INFO - --app=APP Application being installed. [default: firefox] 15:54:19 INFO - mkdir: /builds/slave/test/build/application 15:54:19 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'] 15:54:19 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 15:54:32 INFO - Reading from file tmpfile_stdout 15:54:32 INFO - Output received: 15:54:32 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:32 INFO - Running post-action listener: _resource_record_post_action 15:54:32 INFO - [mozharness: 2016-10-10 22:54:32.657061Z] Finished install step (success) 15:54:32 INFO - [mozharness: 2016-10-10 22:54:32.657336Z] Running run-tests step. 15:54:32 INFO - Running pre-action listener: _resource_record_pre_action 15:54:32 INFO - Running main action method: run_tests 15:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:32 INFO - Python 2.7.3 15:54:32 INFO - Return code: 0 15:54:32 INFO - grabbing minidump binary from tooltool 15:54:32 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')]} 15:54:32 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 0x2109570>, '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 0x210a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:32 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 15:54:32 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 15:54:32 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 15:54:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:32 INFO - Return code: 0 15:54:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:32 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/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 15:54:32 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/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 15:54:32 INFO - Using env: {'DISPLAY': ':0', 15:54:32 INFO - 'HOME': '/home/cltbld', 15:54:32 INFO - 'LANG': 'en_US.UTF-8', 15:54:32 INFO - 'LANGUAGE': 'en_US:en', 15:54:32 INFO - 'LOGNAME': 'cltbld', 15:54:32 INFO - 'MAIL': '/var/mail/cltbld', 15:54:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:32 INFO - 'MOZ_NO_REMOTE': '1', 15:54:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:32 INFO - 'NO_EM_RESTART': '1', 15:54:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:32 INFO - 'PWD': '/builds/slave/test', 15:54:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:32 INFO - 'SHELL': '/bin/bash', 15:54:32 INFO - 'SHLVL': '1', 15:54:32 INFO - 'TERM': 'linux', 15:54:32 INFO - 'TMOUT': '86400', 15:54:32 INFO - 'USER': 'cltbld', 15:54:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332', 15:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:32 INFO - '_': '/tools/buildbot/bin/python'} 15:54:32 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/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 15:54:32 INFO - mozversion application_buildid: 20161010132824 15:54:32 INFO - mozversion application_changeset: 9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30 15:54:32 INFO - mozversion application_display_name: Firefox 15:54:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:32 INFO - mozversion application_name: Firefox 15:54:32 INFO - mozversion application_remotingname: firefox 15:54:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:54:32 INFO - mozversion application_vendor: Mozilla 15:54:32 INFO - mozversion application_version: 50.0 15:54:32 INFO - mozversion platform_buildid: 20161010132824 15:54:32 INFO - mozversion platform_changeset: 9f5ef22fc76fcfe7cdd48ab0e6cf8733e4279f30 15:54:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:54:32 INFO - mozversion platform_version: 50.0 15:54:32 INFO - using testdate: 1476140072 15:54:32 INFO - actual date: 1476140072 15:54:32 INFO - starting webserver on 'localhost:60222' 15:54:32 INFO - SUITE-START | Running 2 tests 15:54:32 INFO - TEST-START | dromaeo_css 15:54:32 INFO - operating with platform_type : linux_ 15:54:32 INFO - Initialising browser for dromaeo_css test... 15:54:32 INFO - TEST-INFO | started process 22592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOR9GM/profile http://localhost:60222/getInfo.html) 15:54:37 INFO - PROCESS | 22592 | __metrics Screen width/height:1600/1200 15:54:37 INFO - PROCESS | 22592 | colorDepth:24 15:54:37 INFO - PROCESS | 22592 | Browser inner width/height: 1024/697 15:54:37 INFO - PROCESS | 22592 | __metrics 15:54:37 ERROR - PROCESS | 22592 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:54:38 INFO - TEST-INFO | 22592: exit 0 15:54:38 INFO - Browser initialized. 15:54:38 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:38 INFO - TEST-INFO | started process 22716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOR9GM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:50 INFO - PROCESS | 22716 | RSS: Main: 150192128 15:54:50 INFO - PROCESS | 22716 | 15:55:40 INFO - PROCESS | 22716 | 1476140140010 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] 15:57:48 INFO - PROCESS | 22716 | Cycle 1(1): loaded http://localhost:60222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60222/tests/dromaeo/cssquery-ext.html) 15:57:49 INFO - PROCESS | 22716 | RSS: Main: 158490624 15:57:49 INFO - PROCESS | 22716 | 16:00:51 INFO - PROCESS | 22716 | Cycle 1(1): loaded http://localhost:60222/tests/dromaeo/cssquery-ext.html (next: http://localhost:60222/tests/dromaeo/cssquery-jquery.html) 16:00:51 INFO - PROCESS | 22716 | RSS: Main: 155611136 16:00:51 INFO - PROCESS | 22716 | 16:03:53 INFO - PROCESS | 22716 | Cycle 1(1): loaded http://localhost:60222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60222/tests/dromaeo/cssquery-mootools.html) 16:03:54 INFO - PROCESS | 22716 | RSS: Main: 155238400 16:03:54 INFO - PROCESS | 22716 | 16:06:56 INFO - PROCESS | 22716 | Cycle 1(1): loaded http://localhost:60222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60222/tests/dromaeo/cssquery-prototype.html) 16:06:56 INFO - PROCESS | 22716 | RSS: Main: 156426240 16:06:56 INFO - PROCESS | 22716 | 16:09:59 INFO - PROCESS | 22716 | Cycle 1(1): loaded http://localhost:60222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60222/tests/dromaeo/cssquery-yui.html) 16:09:59 INFO - PROCESS | 22716 | RSS: Main: 157736960 16:09:59 INFO - PROCESS | 22716 | 16:13:01 INFO - PROCESS | 22716 | Cycle 1(1): loaded http://localhost:60222/tests/dromaeo/cssquery-yui.html (next: http://localhost:60222/tests/dromaeo/cssquery-dojo.html) 16:13:02 INFO - PROCESS | 22716 | RSS: Main: 157454336 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | __start_tp_report 16:13:02 INFO - PROCESS | 22716 | _x_x_mozilla_page_load 16:13:02 INFO - PROCESS | 22716 | _x_x_mozilla_page_load_details 16:13:02 INFO - PROCESS | 22716 | |i|pagename|runs| 16:13:02 INFO - PROCESS | 22716 | |0;dojo.html;3182.984085079575;3265.053134590968;3269.5586095877065;3280.2291461506557;3291.2594666200107;5661.745221465034;5691.3170419549715;5707.514861236795;5712.485876271135;5721.284839395081;5703.230063941367;5743.54051675866;5755.884882302352;5775.3358363788175;5801.622894511865;5233.528982391594;5258.710770907599;5266.894662106755;5303.734813259341;5309.707966061865;5298.311219541454;5300.09898317287;5302.045631786277;5308.92036619451;5331.840044798643;5148.948510514884;5168.586513078944;5268.841934741964;5269.446708095652;5291.3385826771655;5215.191645294966;5289.259503669489;5299.867503312448;5300.92048619271;5347.0909945309395;5212.166053431471;5265.76304066318;5285.312909321802;5285.920711189336;5295.0468915595175;5571.359293681238;5676.063449530864;5715.857103572403;5798.797042103548;5830.212921255618;6128.816135515942;6168.722407491674;6184.721687524027;6196;6226.750929962796;6228.190335256433;6237.594556353868;6242.625442473421;6251.9687401562705;6257.937420625781;5601.047821870292;5693.544516438675;5825.1844741736195;5830.562707796932;5885.588008839383;6121.727351053007;6201.224846894138;6214.5960512566535;6225.564210505312;6229.781957631461;5944.256967879015;5978.641281523122;5980.970095149583;5984.072468767348;5992.43071908168;5984.581079324405;6001.969990150022;6044.063170208625;6050.727717252734;6117.188044311255;6137.60105593135;6215.906761398583;6216.316205217422;6220.222472190976;6223.315435302113;6227.875442491125;6232.376762323732;6235.781747638902;6236.532260080512;6237.75048998035;4572.725636461823;4623.260278355447;4748.074125545486;4767.904641907143;4770.952290477051;4118.9588104119175;4175.68682348825;4180.143070670505;4210.789460527023;4222.472190976128;5858.384869588717;5868.325142608569;5884.6469211847425;5896;5909.3204281507315;5922.2597175353085;6123.648682309606;6170.228721409824;6180.196574445384;6218.036204388327;5877.206577112121;5920.023196172583;5941.673207973517;5943.10853371989;5983.371745966698;5323.361196656426;5326.2543243945875;5361.839144825662;5375.059364611177;5390.19147127934;6215.254169499689;6278.874422511615;6309.779157729457;6449.838754031187;6458;6261;6269.5611307208055;6275.466585340206;6276.686165691606;6278.591891527036;6400.39196276353;6412.519061070531;6429.9678501607195;6451.935480645134;6467.773627923;6002.279726432856;6067.484263837623;6081.209442772411;6093.872633562805;6148.44663980244;6250.593711408744;6250.749970001149;6255.530835187288;6257.4994000480765;6277.2781130170615;6102.237220347457;6135.662538560422;6162.969185154046;6163.630182189083;6164.3835616438;5909.881802364014;6038.094285857156;6055;6112.724927378367;6121.173641558511;6072.362401947732;6112.473085128157;6123.510119190543;6125.448709616156;6143.262808463013;6161.059594737842;6175.876482470415;6194.38056194395;6208.689565521616;6221.346758590283;5856.209411729362;5924.585279030599;5925.40745925404;6051.7296349432745;6054.939450605438 16:13:02 INFO - PROCESS | 22716 | |1;ext.html;581.813819577735;606.9817905462836;637.1175921348931;643.9420452159304;682.2188594059799;40899.59100408999;44970.100597988065;45039.54960450395;45117;45164;45553;46319.30521042187;46380.3042954356;46453;46475.070498590096;8881;9132.634694612207;9135.954320228422;9137.314701397388;9142.360034797566;9017.729468115967;9109.04355042721;9113.544322783868;9115.589798459052;9119.133682300171;9117.726468205965;9143.31425143117;9162;9163.633454661805;9175.49534775587;9128.26973842091;9130.406523575946;9161.633534658606;9162.35863489556;9170.403923744969;9009.954950225207;9095.818083638356;9100.954495227481;9103.908960910372;9112.134347237003;42587;43147.78426107881;43195.78402107969;43305.35041974373;43347;3700.093477098128;3733.663970242691;3941.7437866538585;4231.915361692749;4366.694331396803;34300.65699343;34334.31331373384;34392.312153756786;34461;34650;4687.109449204674;4699.882502937419;4778.139934811733;4803.78382972767;4827.831025914112;351865;354163;354206;354263;356121;37697.62302376996;58488.707556461944;58616.70691646515;58771.70614146902;58808.11787823186;37227.069323266594;39457.60542394597;39815.00462488461;39846.800765995984;39973.20053598912;16426.260818263207;16487.917560412123;16581.502554923372;16583.419580314872;16619.41832035897;14357.712845743026;14371.712565748627;14378.568642940729;14379.85620143806;14447.133172009713;9147.222486088756;9229.861552076723;9237.769055773526;9245.075492450702;9337.859932101024;3548.6806187443253;3586.3903136466865;3606.7114630829997;3607.2424790794225;3669.688076513473;1037.9481025948671;1057.3233130796295;1080.8919108089128;1085.159001773616;1162.9883701163048;34294;34448.138796530286;34727.47908781371;34920.65079349174;34977.12557186091;1154.203599516331;1157.7915975124558;1158.2182027131653;1228.7112528555783;1316.2563151819384;17253.051082190348;17681;17997.320696618972;18064.729029064576;18205;610215;618608;619012;619457;619483;62884;63436.682816586545;63540.68229658915;63613.681931590974;63617.681911590145;1462.7878957551095;1479.3564799312333;1493.2384483913283;1494.3798323695762;1506.5179142674458;32740;33192.502112467846;33329.66670333266;33476.1630959228;33934.151646209044;54752.726236368566;54772;54930.176047358524;55050;55204.44795551993;511003;512375;514626;516743;517473;26976.460470790866;27097.72902270952;27116;27138.1858544244;27223.04719334814;51064.48935510597;51466.48533514617;51482.742586286826;51838;52313.21530176974;43520.78239608908;43576;44522.10955780931;45308;45916.54083459256;43238.78380608077;44941.550584495046;45181.77409112934;45872.770636146604;46441.767791160826;43736.78131609321;44322.778386107864;44381.33427998518;44681.32978005397;47762.044759105316;39068.413973790986;39425.40861887017;39527.80236098801;40338.798306008284;40672.79663601663;29717.554236686035;29732.40535189241;30052.549211762278;30226.54660180055;30726.692733072385 16:13:02 INFO - PROCESS | 22716 | |2;jquery.html;411.67066346922473;416.7270437863197;428.49651659300326;436.45661151865914;439.7295663167153;19383.903080484597;20017.399478015664;20876.791232087675;21122.471938201554;21208.4697882553;19706.802931970677;21173.57652846942;21280.14879404822;21824.23615173469;22064.779352206475;6516.641584712839;6782.762603308885;6836.794896153098;6971.33772291634;6987;6693.364130407604;6781.186257649089;6800.523963322569;6852.177738671367;6857.725690972356;6777.525573209878;6797.082393876837;6830.077939478181;6830.692618832164;6832.145981752281;6729.091572637681;6829.965850170742;6838.14523184602;6847.691853866588;6919.8962015569805;6655.966720166417;6663.4669226461765;6692.0296556998965;6711.194656641185;6718;25275.74724252771;26797;27207.86396068007;27397.863010685018;27556.586651200247;2659.6675415573054;2685.328667833042;2691.690455597592;2801.789865760056;3433.399155147864;16212;16497.505074847773;16550.83449165505;17129.48611541656;17182.22679979404;2201.0975500044906;2242.708447901762;2261.705978222837;2336.5210131922913;2499.3751562109474;97825.5108724459;98770;99722.002779972;99734.50132749362;102529.4873525635;18345.816541834676;18753.343632973054;19561;19590.21639134447;20127.597448050958;34063.65936340654;34106.48840267398;34293.14267143291;34419.4837077444;34434.82782586071;10787.56849726018;11003.449827508593;11066.612668556561;11145.554177832959;11230.943845280884;9284.3036772241;9351.672691455902;9517.143457088756;9630.614775409045;9633.759156021015;9135.269178465707;9143.817123657489;9404.717858464257;9496.715098547054;9702.854457183148;3345.1637090727318;3375.3080618473155;3501.9124521887156;3554.608993010767;3596.730245231618;919.5861862162054;958.1472489484364;963.2486660404895;983.7343917142332;1018.1854516387009;19370.903145484182;20356;20467;20724.378268651966;21279.148834046773;1012.6911292055846;1016.4765145949842;1076.0692001418715;1080.9189310801721;1082.107261509258;10594.258401911793;11863.406829658483;11914.642560723192;11944.940275298568;11952.103592230444;549171;556610;568904;574880;578181;94061;94557.5272123635;95506;96132;108159.45920270505;1040.105509262034;1062.7236918401272;1066.5040756048475;1106.1427393769893;1111.6220485035126;18038.72941905846;18772;18812.153453094917;18955;19000.429987100408;31418.21454463657;36352.81823590865;45295.32057019213;45622.31566526438;46314;67427;67760;68094;68838;69383.30616693769;9055.230305424113;9274.397164184307;9299.349045566745;9349.579268932779;9428.57571409302;13127.934360328138;13981.161130332213;14271.286435678383;14364.784528232294;14417.13497190172;11563.768724625628;11752.059835213333;11837.112216583619;12147.088968327587;12154.696132596402;11059.778804424028;11173.05029072538;11712.824307635221;11775.76448471043;11867.228630139014;11581.363025033705;11622.825657614974;12186.390680465764;12515.499380024698;12547.74904501923;8877.600507977028;8893.510856902933;8903.109689031304;9212.401193922642;9286.72139835806;11492.770144597229;12736.6815829605;12738.363081846055;12827;12852.485900563872 16:13:02 INFO - PROCESS | 22716 | |3;mootools.html;1518.7645914883194;1551.573317337732;1738.1743671755917;1821.5355084453463;1836.109486898853;8336;8833.07252738463;8902.688405905794;9749.756256093593;9755.219582433398;8887.955560222206;9069.682561110363;9271.258299336054;9315.394499357537;9316;2465.6055031195015;2528.506941146477;2533.987330063347;2537.568613335737;2538.0736031348515;2389.0324418610403;2440.3655049687122;2442.780149786519;2450.4241503246812;2459.5080983803223;2432.2095319021387;2432.598621227495;2437.439388940536;2499.9999999999964;2510.648509208703;2376.4771750215014;2385.451346190377;2389.7729715676983;2489.2781093482868;2504.8622325772076;2450.840695354814;2455.0670745116918;2462.0398044762555;2466.1121996081397;2496.987515062431;9102.77243068922;9115.544222788834;9177.357584969055;9206.631734730603;9207.355485116044;5554.611177217596;5684.63049901755;5690.658560486384;5694.202811606378;5697.774978379627;3461.792292462435;3492.6158122606494;3494.2662040971427;3522.277933023724;3538.6461353864406;1183.5798291606527;1228.7542491501647;1243.5958313548133;1263.7282984158358;1279.494599633149;12710.491580336775;12902;12968.09223354375;13013.34933253343;13039.478420863248;4810.182269014276;4895.290182923456;4946.134426475424;5063.367079115111;5077.339945807095;10938.56245750161;10977.506012229469;11003.22977391575;11014;11025.503852326665;5649.322081350264;5719.456651618089;5731.369549349568;5735.025045742151;5736.741846616912;4528.139653465831;5002.974985125051;5085.313482679865;5119.692818430832;5195.376554813447;4241.957580424156;4262.168877069003;4386.692931494765;4390.275604525282;4397.802098905557;1309.8428188617427;1336.712606789545;1350.2438634364787;1352.6145048661085;1357.830271216098;975.2246963663904;1036.9429681367446;1069.4492336446735;1089.215764649451;1091.5033659684825;6205.968970155121;6328.145700330397;6406.839829004312;6428;6459.386358295955;477.2626292378284;477.7539567122935;481.2588613535117;490.33069859642046;491.36368402918305;4073.694472914484;4110.671146308288;4131.318332475168;4133.545310015896;4251.511076226274;11084.113270938306;11492.195546311677;11505.539778408769;11565.248258863146;11598.94200528992;11357.318560886373;11456.312621242752;11458.77082458363;11471.885281147248;11475.942620287013;8628.697995570124;8634.438761480484;8655.221030107195;8695.782605434788;8723.738287851374;6196.194494715838;6220.813375598739;6364.299927007933;6400.07198956158;6463.676816159267;10555.050045495942;10737.89262107369;10758.13934885223;10779.353238805697;10780.622678206226;10108.494575271354;10543.736406589896;10648.680539583826;10710.678679639623;10823.945880270549;7831.373490120663;7955;8159.3064589508185;8160.795980100545;8345.749627511184;9311.580978856104;9320.161185493338;9351.298652600946;9370.203532699798;9377.015413381496;8033;8218.671253149807;8224.62989165477;8336;8431.620577074169;7684.500507466997;7687.423443241667;7688.154303026551;7702.191269916802;7734.922650773646;7290.198078211499;7384.852302953804;7487.925120748723;7563.319301262913;7572.129205141479;5536.418676039119;5540.806071787468;5631.352394474688;5641.294838145232;5710.114932185518;5518.392976772632;5606.775728970959;5656.575756818337;5773.1051686988585;5806.129080637938 16:13:02 INFO - PROCESS | 22716 | |4;prototype.html;339.90142858571016;348.4077068982729;349.55955496074944;357.15889081213726;359.8686479435007;5685.630434021786;5731.254936858202;5776.873509665616;5898.174255604214;5906.70466476676;5736.713164341787;5743.942560574393;5777.1623114648455;5785.363610002896;5794.82615521535;4569.794359253825;4577.679562430631;4586.7477288749105;4593.104344652794;4598.425196850394;4482.193205223059;4539.863804085882;4552.044070745147;4563.612092972101;4564.657650676212;4504.594586487216;4514.729116253019;4520.2767557190855;4521.174266083698;4523.434570678665;4511.436070491189;4527.61515271199;4529.614982726489;4552.408186935711;4554.453465584118;3900.7659540427667;4008.178323443687;4011.2378648056774;4060.1067765091634;4060.9644540642244;5626.6624002559565;5626.971865140689;5631.887362252773;5641;5668.744906479218;5175.223716442526;5181.507756763139;5195.636305458619;5223.9290945356115;5260;5867.677277749722;6023.668698221596;6043.576949613529;6050.394960503959;6077.665728384937;4431.534688857656;4435.379046933432;4441.179850794769;4443.80002899867;4449.421575195236;6133.018717005258;6278.963970944788;6294.905576416358;6300.5589608727405;6306.5179682774515;4517.119161763425;4525.52481989393;4527.932081018787;4537.818487260539;4545.522720114341;4592.127495775859;4598.770061496912;4606.424196975378;4620.630349572093;4627.444706635158;5201.08980928336;5206.505381988705;5216.739163041832;5218.399884013311;5265.262863199156;5893.734781934823;6055.969720151371;6078.179445774764;6114.361954636984;6173.475254603409;1526.5954522051666;1554.114154931678;1555.9611009724847;1560.4694403902727;1571.4499925026378;955.0306438964457;981.4700061966458;983.5918093991056;997.3018886779283;1002.754325190333;5155.278261043457;5170.586353091744;5170.793168273227;5173.741312934339;5217.452167522356;5422.5119739223655;5470.8085217017215;5482.890342193134;5490.890182196334;5574.49147883454;4986.850394488099;5201.5838732901275;5216.243644671501;5218;5241.31862857826;2922.3570814420796;2924.6782853886057;2932.882684692631;2933.05779761099;2933.8093023953375;5610.523105535994;5630.8331834442215;5650.406707295675;5652.74562644682;5667.829965101054;5193.532582067556;5594.440555944454;5598;5623.690697011703;5634.32388113429;5593.371115575755;5628.802991895346;5634.3802181759975;5685.715714214272;5701.686407247558;5258.474152584864;5477.972610136924;5494.945050549443;5500.80747173847;5601.215829783752;5417.04986204958;5423.864403389789;5424.2406063151975;5441.29263195782;5472.972635136958;5647.661140331593;5677.990664947584;5681.982896071835;5682.715864206691;5784.814113106719;3861.8455261790336;3874.1016901718517;3915.667168290727;3951.5060617422823;4030.2544029354663;5452.918206226989;5462.159676967875;5562.777488900399;6094.2077529920825;6373.776917807854;6187.566870319214;6236.906446403217;6275.246970363585;6293.181886354744;6316.968415157895;6072.570971611391;6154.307565419545;6184.783532576338;6207.6275423474735;6223.159873417031;6067.696615169312;6129.540284478593;6136.417040381157;6140.846478837886;6168.629882207082;6294.937050629435;6312.779052733133;6324.873502530016;6331.891918914263;6351.062925807673;5926.318473375444;6012.398760124128;6062.363451837494;6065.636061836304;6147.139400483847 16:13:02 INFO - PROCESS | 22716 | |5;yui.html;810.6797814863129;814.727066432745;816.8121332093615;896.3232759266753;899.9865002024967;16786.83213167868;17191.828081719195;17562.385316513926;17563.209655565497;17639.823601763994;16270.918645406757;16407.261673224704;16456.670866582663;16508.669826603462;16568.50294491164;711.2496316386237;839.689314953468;851.1148405658124;853.9402241843073;863.1239292118505;853.7481442974338;858.6737039924819;862.6851199312238;862.9525376104311;864.3906046237388;924.9768755781092;929.6699671616581;933.5845548730817;938.1134827587932;938.816930698514;918.1415376622846;925.8611208318739;929.8419268724266;930.5114814722325;931.8602209668536;681.2778454837838;681.7204945972177;683.2518392360357;683.9863202735967;684.3498676257575;15815.683686326209;15819.209039547977;15889.04665720049;15894.205289735466;15904.20478976058;14500.564983050524;14626.268686565629;14969.476068337555;15158.393664253417;15170.317335719808;14572.854271457256;14789.482368117171;14808.407663693439;14835.25823708821;15209.695806083928;4840.540148685869;4877.926856091654;4883.8779030524165;4938.728369939652;4984.725840078794;90000.54999724959;91081;91279.54360228223;91569.08430915672;91807.08192918052;12165.513379464723;12206.877931220752;12558.74882502345;12615.810762838564;13053.412596433183;22399.88800055989;22588.54822903533;22676.206332778274;22677.319680409615;22723.431914201945;8682.088380720059;8795.780105497286;8906.465612063168;8959.328050396247;8970.237529809909;5199.870003249949;5203.895922081537;5206.088934436459;5215.348081489814;5221.791128354899;3824.5028146340796;3939.6454319110844;3945.072907866649;3946.940795888064;3949.7235193536176;655.5312951239887;658.9110470086476;679.100192245277;679.5379142183363;681.6251061915926;746.220199891115;759.9354054905396;767.3285874859498;782.9060512738508;790.7983464216588;9756.121949024622;10788.568457261621;10885;10939.453027348602;11078.667639970814;626.3235705438116;716.6703316474376;757.7650928212272;763.5189830406808;772.9381649468029;4888.755562221946;5017.523335283142;5082.237664350377;5125.461826508237;5178.71517066565;116524.41737791426;119616;124752.37623811823;128524.37810945274;131584;108666;111592;112196.43901780603;112336.43831780789;112677;95237.52381238189;95840.52079739557;99266;99919.0016199672;101673;9840.803183936137;9888.851667224853;9957;9974.800503990025;10138.543765530421;57838;59153;59244;59461.58322184639;60031;58270;82351.58824205841;84760.57619711861;86319.56840215759;86473.56763216143;12126.393680316125;12194.878051219373;12452.750944981231;12463.189892656948;12468.314242716737;13528.458861645424;13825.792613111013;13991.300434978413;14607.707845842811;14617;12652.17760845542;12653.27954489789;12900.612981610566;12906.290154041619;13077.67305817324;13412.32938353098;13422.798658020332;13571.660708482366;13665.831921263713;13843.100198487065;11908.642740717793;11957.468193194092;12233.938830306148;12243.75512489763;12618.55835045769;10559.102476289601;10728.088112510524;10731.570737170427;10801.621943231949;10885.346879187275;10530.894691052992;10544.420056896945;10553.63062292816;10570.630027948984;10676.412797296223 16:13:02 INFO - PROCESS | 22716 | __end_tp_report 16:13:02 INFO - PROCESS | 22716 | __start_cc_report 16:13:02 INFO - PROCESS | 22716 | _x_x_mozilla_cycle_collect,328 16:13:02 INFO - PROCESS | 22716 | __end_cc_report 16:13:02 INFO - PROCESS | 22716 | __startTimestamp1476141182070__endTimestamp 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | ------- Summary: start ------- 16:13:02 INFO - PROCESS | 22716 | Number of tests: 6 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | [#0] dojo.html Cycles:165 Average:5747.45 Median:5983.37 stddev:667.82 (11.2%) stddev-sans-first:638.85 16:13:02 INFO - PROCESS | 22716 | Values: 3183.0 3265.1 3269.6 3280.2 3291.3 5661.7 5691.3 5707.5 5712.5 5721.3 5703.2 5743.5 5755.9 5775.3 5801.6 5233.5 5258.7 5266.9 5303.7 5309.7 5298.3 5300.1 5302.0 5308.9 5331.8 5148.9 5168.6 5268.8 5269.4 5291.3 5215.2 5289.3 5299.9 5300.9 5347.1 5212.2 5265.8 5285.3 5285.9 5295.0 5571.4 5676.1 5715.9 5798.8 5830.2 6128.8 6168.7 6184.7 6196.0 6226.8 6228.2 6237.6 6242.6 6252.0 6257.9 5601.0 5693.5 5825.2 5830.6 5885.6 6121.7 6201.2 6214.6 6225.6 6229.8 5944.3 5978.6 5981.0 5984.1 5992.4 5984.6 6002.0 6044.1 6050.7 6117.2 6137.6 6215.9 6216.3 6220.2 6223.3 6227.9 6232.4 6235.8 6236.5 6237.8 4572.7 4623.3 4748.1 4767.9 4771.0 4119.0 4175.7 4180.1 4210.8 4222.5 5858.4 5868.3 5884.6 5896.0 5909.3 5922.3 6123.6 6170.2 6180.2 6218.0 5877.2 5920.0 5941.7 5943.1 5983.4 5323.4 5326.3 5361.8 5375.1 5390.2 6215.3 6278.9 6309.8 6449.8 6458.0 6261.0 6269.6 6275.5 6276.7 6278.6 6400.4 6412.5 6430.0 6451.9 6467.8 6002.3 6067.5 6081.2 6093.9 6148.4 6250.6 6250.7 6255.5 6257.5 6277.3 6102.2 6135.7 6163.0 6163.6 6164.4 5909.9 6038.1 6055.0 6112.7 6121.2 6072.4 6112.5 6123.5 6125.4 6143.3 6161.1 6175.9 6194.4 6208.7 6221.3 5856.2 5924.6 5925.4 6051.7 6054.9 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | [#1] ext.html Cycles:180 Average:64936.40 Median:44029.78 stddev:135136.77 (306.9%) stddev-sans-first:135429.48 16:13:02 INFO - PROCESS | 22716 | Values: 581.8 607.0 637.1 643.9 682.2 40899.6 44970.1 45039.5 45117.0 45164.0 45553.0 46319.3 46380.3 46453.0 46475.1 8881.0 9132.6 9136.0 9137.3 9142.4 9017.7 9109.0 9113.5 9115.6 9119.1 9117.7 9143.3 9162.0 9163.6 9175.5 9128.3 9130.4 9161.6 9162.4 9170.4 9010.0 9095.8 9101.0 9103.9 9112.1 42587.0 43147.8 43195.8 43305.4 43347.0 3700.1 3733.7 3941.7 4231.9 4366.7 34300.7 34334.3 34392.3 34461.0 34650.0 4687.1 4699.9 4778.1 4803.8 4827.8 351865.0 354163.0 354206.0 354263.0 356121.0 37697.6 58488.7 58616.7 58771.7 58808.1 37227.1 39457.6 39815.0 39846.8 39973.2 16426.3 16487.9 16581.5 16583.4 16619.4 14357.7 14371.7 14378.6 14379.9 14447.1 9147.2 9229.9 9237.8 9245.1 9337.9 3548.7 3586.4 3606.7 3607.2 3669.7 1037.9 1057.3 1080.9 1085.2 1163.0 34294.0 34448.1 34727.5 34920.7 34977.1 1154.2 1157.8 1158.2 1228.7 1316.3 17253.1 17681.0 17997.3 18064.7 18205.0 610215.0 618608.0 619012.0 619457.0 619483.0 62884.0 63436.7 63540.7 63613.7 63617.7 1462.8 1479.4 1493.2 1494.4 1506.5 32740.0 33192.5 33329.7 33476.2 33934.2 54752.7 54772.0 54930.2 55050.0 55204.4 511003.0 512375.0 514626.0 516743.0 517473.0 26976.5 27097.7 27116.0 27138.2 27223.0 51064.5 51466.5 51482.7 51838.0 52313.2 43520.8 43576.0 44522.1 45308.0 45916.5 43238.8 44941.6 45181.8 45872.8 46441.8 43736.8 44322.8 44381.3 44681.3 47762.0 39068.4 39425.4 39527.8 40338.8 40672.8 29717.6 29732.4 30052.5 30226.5 30726.7 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | [#2] jquery.html Cycles:180 Average:33841.38 Median:15179.19 stddev:93124.42 (613.5%) stddev-sans-first:93351.83 16:13:02 INFO - PROCESS | 22716 | Values: 411.7 416.7 428.5 436.5 439.7 19383.9 20017.4 20876.8 21122.5 21208.5 19706.8 21173.6 21280.1 21824.2 22064.8 6516.6 6782.8 6836.8 6971.3 6987.0 6693.4 6781.2 6800.5 6852.2 6857.7 6777.5 6797.1 6830.1 6830.7 6832.1 6729.1 6830.0 6838.1 6847.7 6919.9 6656.0 6663.5 6692.0 6711.2 6718.0 25275.7 26797.0 27207.9 27397.9 27556.6 2659.7 2685.3 2691.7 2801.8 3433.4 16212.0 16497.5 16550.8 17129.5 17182.2 2201.1 2242.7 2261.7 2336.5 2499.4 97825.5 98770.0 99722.0 99734.5 102529.5 18345.8 18753.3 19561.0 19590.2 20127.6 34063.7 34106.5 34293.1 34419.5 34434.8 10787.6 11003.4 11066.6 11145.6 11230.9 9284.3 9351.7 9517.1 9630.6 9633.8 9135.3 9143.8 9404.7 9496.7 9702.9 3345.2 3375.3 3501.9 3554.6 3596.7 919.6 958.1 963.2 983.7 1018.2 19370.9 20356.0 20467.0 20724.4 21279.1 1012.7 1016.5 1076.1 1080.9 1082.1 10594.3 11863.4 11914.6 11944.9 11952.1 549171.0 556610.0 568904.0 574880.0 578181.0 94061.0 94557.5 95506.0 96132.0 108159.5 1040.1 1062.7 1066.5 1106.1 1111.6 18038.7 18772.0 18812.2 18955.0 19000.4 31418.2 36352.8 45295.3 45622.3 46314.0 67427.0 67760.0 68094.0 68838.0 69383.3 9055.2 9274.4 9299.3 9349.6 9428.6 13127.9 13981.2 14271.3 14364.8 14417.1 11563.8 11752.1 11837.1 12147.1 12154.7 11059.8 11173.1 11712.8 11775.8 11867.2 11581.4 11622.8 12186.4 12515.5 12547.7 8877.6 8893.5 8903.1 9212.4 9286.7 11492.8 12736.7 12738.4 12827.0 12852.5 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | [#3] mootools.html Cycles:180 Average:6124.12 Median:477.51 stddev:3480.47 (728.9%) stddev-sans-first:3473.02 16:13:02 INFO - PROCESS | 22716 | Values: 1518.8 1551.6 1738.2 1821.5 1836.1 8336.0 8833.1 8902.7 9749.8 9755.2 8888.0 9069.7 9271.3 9315.4 9316.0 2465.6 2528.5 2534.0 2537.6 2538.1 2389.0 2440.4 2442.8 2450.4 2459.5 2432.2 2432.6 2437.4 2500.0 2510.6 2376.5 2385.5 2389.8 2489.3 2504.9 2450.8 2455.1 2462.0 2466.1 2497.0 9102.8 9115.5 9177.4 9206.6 9207.4 5554.6 5684.6 5690.7 5694.2 5697.8 3461.8 3492.6 3494.3 3522.3 3538.6 1183.6 1228.8 1243.6 1263.7 1279.5 12710.5 12902.0 12968.1 13013.3 13039.5 4810.2 4895.3 4946.1 5063.4 5077.3 10938.6 10977.5 11003.2 11014.0 11025.5 5649.3 5719.5 5731.4 5735.0 5736.7 4528.1 5003.0 5085.3 5119.7 5195.4 4242.0 4262.2 4386.7 4390.3 4397.8 1309.8 1336.7 1350.2 1352.6 1357.8 975.2 1036.9 1069.4 1089.2 1091.5 6206.0 6328.1 6406.8 6428.0 6459.4 477.3 477.8 481.3 490.3 491.4 4073.7 4110.7 4131.3 4133.5 4251.5 11084.1 11492.2 11505.5 11565.2 11598.9 11357.3 11456.3 11458.8 11471.9 11475.9 8628.7 8634.4 8655.2 8695.8 8723.7 6196.2 6220.8 6364.3 6400.1 6463.7 10555.1 10737.9 10758.1 10779.4 10780.6 10108.5 10543.7 10648.7 10710.7 10823.9 7831.4 7955.0 8159.3 8160.8 8345.7 9311.6 9320.2 9351.3 9370.2 9377.0 8033.0 8218.7 8224.6 8336.0 8431.6 7684.5 7687.4 7688.2 7702.2 7734.9 7290.2 7384.9 7487.9 7563.3 7572.1 5536.4 5540.8 5631.4 5641.3 5710.1 5518.4 5606.8 5656.6 5773.1 5806.1 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | [#4] prototype.html Cycles:180 Average:4929.30 Median:5471.89 stddev:1429.00 (26.1%) stddev-sans-first:1390.87 16:13:02 INFO - PROCESS | 22716 | Values: 339.9 348.4 349.6 357.2 359.9 5685.6 5731.3 5776.9 5898.2 5906.7 5736.7 5743.9 5777.2 5785.4 5794.8 4569.8 4577.7 4586.7 4593.1 4598.4 4482.2 4539.9 4552.0 4563.6 4564.7 4504.6 4514.7 4520.3 4521.2 4523.4 4511.4 4527.6 4529.6 4552.4 4554.5 3900.8 4008.2 4011.2 4060.1 4061.0 5626.7 5627.0 5631.9 5641.0 5668.7 5175.2 5181.5 5195.6 5223.9 5260.0 5867.7 6023.7 6043.6 6050.4 6077.7 4431.5 4435.4 4441.2 4443.8 4449.4 6133.0 6279.0 6294.9 6300.6 6306.5 4517.1 4525.5 4527.9 4537.8 4545.5 4592.1 4598.8 4606.4 4620.6 4627.4 5201.1 5206.5 5216.7 5218.4 5265.3 5893.7 6056.0 6078.2 6114.4 6173.5 1526.6 1554.1 1556.0 1560.5 1571.4 955.0 981.5 983.6 997.3 1002.8 5155.3 5170.6 5170.8 5173.7 5217.5 5422.5 5470.8 5482.9 5490.9 5574.5 4986.9 5201.6 5216.2 5218.0 5241.3 2922.4 2924.7 2932.9 2933.1 2933.8 5610.5 5630.8 5650.4 5652.7 5667.8 5193.5 5594.4 5598.0 5623.7 5634.3 5593.4 5628.8 5634.4 5685.7 5701.7 5258.5 5478.0 5494.9 5500.8 5601.2 5417.0 5423.9 5424.2 5441.3 5473.0 5647.7 5678.0 5682.0 5682.7 5784.8 3861.8 3874.1 3915.7 3951.5 4030.3 5452.9 5462.2 5562.8 6094.2 6373.8 6187.6 6236.9 6275.2 6293.2 6317.0 6072.6 6154.3 6184.8 6207.6 6223.2 6067.7 6129.5 6136.4 6140.8 6168.6 6294.9 6312.8 6324.9 6331.9 6351.1 5926.3 6012.4 6062.4 6065.6 6147.1 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - PROCESS | 22716 | [#5] yui.html Cycles:180 Average:22798.91 Median:4395.13 stddev:33646.51 (765.5%) stddev-sans-first:33700.39 16:13:02 INFO - PROCESS | 22716 | Values: 810.7 814.7 816.8 896.3 900.0 16786.8 17191.8 17562.4 17563.2 17639.8 16270.9 16407.3 16456.7 16508.7 16568.5 711.2 839.7 851.1 853.9 863.1 853.7 858.7 862.7 863.0 864.4 925.0 929.7 933.6 938.1 938.8 918.1 925.9 929.8 930.5 931.9 681.3 681.7 683.3 684.0 684.3 15815.7 15819.2 15889.0 15894.2 15904.2 14500.6 14626.3 14969.5 15158.4 15170.3 14572.9 14789.5 14808.4 14835.3 15209.7 4840.5 4877.9 4883.9 4938.7 4984.7 90000.5 91081.0 91279.5 91569.1 91807.1 12165.5 12206.9 12558.7 12615.8 13053.4 22399.9 22588.5 22676.2 22677.3 22723.4 8682.1 8795.8 8906.5 8959.3 8970.2 5199.9 5203.9 5206.1 5215.3 5221.8 3824.5 3939.6 3945.1 3946.9 3949.7 655.5 658.9 679.1 679.5 681.6 746.2 759.9 767.3 782.9 790.8 9756.1 10788.6 10885.0 10939.5 11078.7 626.3 716.7 757.8 763.5 772.9 4888.8 5017.5 5082.2 5125.5 5178.7 116524.4 119616.0 124752.4 128524.4 131584.0 108666.0 111592.0 112196.4 112336.4 112677.0 95237.5 95840.5 99266.0 99919.0 101673.0 9840.8 9888.9 9957.0 9974.8 10138.5 57838.0 59153.0 59244.0 59461.6 60031.0 58270.0 82351.6 84760.6 86319.6 86473.6 12126.4 12194.9 12452.8 12463.2 12468.3 13528.5 13825.8 13991.3 14607.7 14617.0 12652.2 12653.3 12900.6 12906.3 13077.7 13412.3 13422.8 13571.7 13665.8 13843.1 11908.6 11957.5 12233.9 12243.8 12618.6 10559.1 10728.1 10731.6 10801.6 10885.3 10530.9 10544.4 10553.6 10570.6 10676.4 16:13:02 INFO - PROCESS | 22716 | -------- Summary: end -------- 16:13:02 INFO - PROCESS | 22716 | 16:13:02 INFO - TEST-INFO | 22716: exit 0 16:13:02 INFO - TEST-OK | dromaeo_css | took 1109851ms 16:13:02 INFO - TEST-START | kraken 16:13:02 INFO - operating with platform_type : linux_ 16:13:02 INFO - Initialising browser for kraken test... 16:13:02 INFO - TEST-INFO | started process 22957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkZzdl/profile http://localhost:60222/getInfo.html) 16:13:07 INFO - PROCESS | 22957 | __metrics Screen width/height:1600/1200 16:13:07 INFO - PROCESS | 22957 | colorDepth:24 16:13:07 INFO - PROCESS | 22957 | Browser inner width/height: 1024/697 16:13:07 INFO - PROCESS | 22957 | __metrics 16:13:07 ERROR - PROCESS | 22957 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:13:08 INFO - TEST-INFO | 22957: exit 0 16:13:08 INFO - Browser initialized. 16:13:08 INFO - Running cycle 1/1 for kraken test... 16:13:08 INFO - TEST-INFO | started process 23081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkZzdl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:20 INFO - PROCESS | 23081 | RSS: Main: 150011904 16:13:20 INFO - PROCESS | 23081 | 16:13:22 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60222/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:23 INFO - PROCESS | 23081 | RSS: Main: 156573696 16:13:23 INFO - PROCESS | 23081 | 16:13:26 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60222/tests/kraken/driver.html?testName=audio-dft) 16:13:27 INFO - PROCESS | 23081 | RSS: Main: 155537408 16:13:27 INFO - PROCESS | 23081 | 16:13:29 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60222/tests/kraken/driver.html?testName=audio-fft) 16:13:30 INFO - PROCESS | 23081 | RSS: Main: 156041216 16:13:30 INFO - PROCESS | 23081 | 16:13:32 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60222/tests/kraken/driver.html?testName=audio-oscillator) 16:13:33 INFO - PROCESS | 23081 | RSS: Main: 155770880 16:13:33 INFO - PROCESS | 23081 | 16:13:35 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:36 INFO - PROCESS | 23081 | RSS: Main: 155758592 16:13:36 INFO - PROCESS | 23081 | 16:13:39 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60222/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:39 INFO - PROCESS | 23081 | RSS: Main: 155602944 16:13:39 INFO - PROCESS | 23081 | 16:13:43 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60222/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:43 INFO - PROCESS | 23081 | RSS: Main: 156131328 16:13:43 INFO - PROCESS | 23081 | 16:13:46 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60222/tests/kraken/driver.html?testName=json-parse-financial) 16:13:47 INFO - PROCESS | 23081 | RSS: Main: 156577792 16:13:47 INFO - PROCESS | 23081 | 16:13:48 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:49 INFO - PROCESS | 23081 | RSS: Main: 155598848 16:13:49 INFO - PROCESS | 23081 | 16:13:51 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:51 INFO - PROCESS | 23081 | RSS: Main: 156012544 16:13:51 INFO - PROCESS | 23081 | 16:13:53 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:54 INFO - PROCESS | 23081 | RSS: Main: 156176384 16:13:54 INFO - PROCESS | 23081 | 16:13:56 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:57 INFO - PROCESS | 23081 | RSS: Main: 157175808 16:13:57 INFO - PROCESS | 23081 | 16:14:00 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:00 INFO - PROCESS | 23081 | RSS: Main: 157134848 16:14:00 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | Cycle 1(1): loaded http://localhost:60222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60222/tests/kraken/driver.html?testName=ai-astar) 16:14:02 INFO - PROCESS | 23081 | RSS: Main: 158650368 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | __start_tp_report 16:14:02 INFO - PROCESS | 23081 | _x_x_mozilla_page_load 16:14:02 INFO - PROCESS | 23081 | _x_x_mozilla_page_load_details 16:14:02 INFO - PROCESS | 23081 | |i|pagename|runs| 16:14:02 INFO - PROCESS | 23081 | |0;ai-astar;101;111;105;110;110;112;110;111;110;111 16:14:02 INFO - PROCESS | 23081 | |1;audio-beat-detection;141;117;144;174;117;148;152;118;186;118 16:14:02 INFO - PROCESS | 23081 | |2;audio-dft;162;162;163;160;162;163;161;162;160;160 16:14:02 INFO - PROCESS | 23081 | |3;audio-fft;75;76;75;185;75;77;74;76;166;77 16:14:02 INFO - PROCESS | 23081 | |4;audio-oscillator;86;84;147;84;84;84;134;84;85;144 16:14:02 INFO - PROCESS | 23081 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;118;118 16:14:02 INFO - PROCESS | 23081 | |6;imaging-darkroom;151;150;152;147;149;148;147;146;148;148 16:14:02 INFO - PROCESS | 23081 | |7;imaging-desaturate;95;95;97;95;95;95;95;96;95;95 16:14:02 INFO - PROCESS | 23081 | |8;json-parse-financial;57;49;51;52;54;51;54;52;51;51 16:14:02 INFO - PROCESS | 23081 | |9;json-stringify-tinderbox;59;59;59;60;60;59;59;60;63;60 16:14:02 INFO - PROCESS | 23081 | |10;stanford-crypto-aes;74;75;72;82;72;73;73;72;79;73 16:14:02 INFO - PROCESS | 23081 | |11;stanford-crypto-ccm;123;123;130;136;130;134;122;119;160;131 16:14:02 INFO - PROCESS | 23081 | |12;stanford-crypto-pbkdf2;156;153;155;154;152;155;152;151;156;151 16:14:02 INFO - PROCESS | 23081 | |13;stanford-crypto-sha256-iterative;64;62;62;64;63;62;68;61;60;60 16:14:02 INFO - PROCESS | 23081 | __end_tp_report 16:14:02 INFO - PROCESS | 23081 | __start_cc_report 16:14:02 INFO - PROCESS | 23081 | _x_x_mozilla_cycle_collect,892 16:14:02 INFO - PROCESS | 23081 | __end_cc_report 16:14:02 INFO - PROCESS | 23081 | __startTimestamp1476141242731__endTimestamp 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | ------- Summary: start ------- 16:14:02 INFO - PROCESS | 23081 | Number of tests: 14 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.41 (3.1%) stddev-sans-first:2.00 16:14:02 INFO - PROCESS | 23081 | Values: 101.0 111.0 105.0 110.0 110.0 112.0 110.0 111.0 110.0 111.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:146.00 stddev:24.72 (16.9%) stddev-sans-first:26.22 16:14:02 INFO - PROCESS | 23081 | Values: 141.0 117.0 144.0 174.0 117.0 148.0 152.0 118.0 186.0 118.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 16:14:02 INFO - PROCESS | 23081 | Values: 162.0 162.0 163.0 160.0 162.0 163.0 161.0 162.0 160.0 160.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.50 stddev:42.36 (56.1%) stddev-sans-first:44.27 16:14:02 INFO - PROCESS | 23081 | Values: 75.0 76.0 75.0 185.0 75.0 77.0 74.0 76.0 166.0 77.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:27.84 (33.1%) stddev-sans-first:28.95 16:14:02 INFO - PROCESS | 23081 | Values: 86.0 84.0 147.0 84.0 84.0 84.0 134.0 84.0 85.0 144.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:14:02 INFO - PROCESS | 23081 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.90 (1.3%) stddev-sans-first:1.80 16:14:02 INFO - PROCESS | 23081 | Values: 151.0 150.0 152.0 147.0 149.0 148.0 147.0 146.0 148.0 148.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:14:02 INFO - PROCESS | 23081 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:2.25 (4.3%) stddev-sans-first:1.58 16:14:02 INFO - PROCESS | 23081 | Values: 57.0 49.0 51.0 52.0 54.0 51.0 54.0 52.0 51.0 51.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:1.23 (2.0%) stddev-sans-first:1.27 16:14:02 INFO - PROCESS | 23081 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 59.0 60.0 63.0 60.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:73.50 stddev:3.37 (4.6%) stddev-sans-first:3.57 16:14:02 INFO - PROCESS | 23081 | Values: 74.0 75.0 72.0 82.0 72.0 73.0 73.0 72.0 79.0 73.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:130.50 stddev:11.69 (9.0%) stddev-sans-first:12.05 16:14:02 INFO - PROCESS | 23081 | Values: 123.0 123.0 130.0 136.0 130.0 134.0 122.0 119.0 160.0 131.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:154.50 stddev:1.96 (1.3%) stddev-sans-first:1.86 16:14:02 INFO - PROCESS | 23081 | Values: 156.0 153.0 155.0 154.0 152.0 155.0 152.0 151.0 156.0 151.0 16:14:02 INFO - PROCESS | 23081 | 16:14:02 INFO - PROCESS | 23081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:2.37 (3.8%) stddev-sans-first:2.46 16:14:02 INFO - PROCESS | 23081 | Values: 64.0 62.0 62.0 64.0 63.0 62.0 68.0 61.0 60.0 60.0 16:14:02 INFO - PROCESS | 23081 | -------- Summary: end -------- 16:14:02 INFO - PROCESS | 23081 | 16:14:03 INFO - TEST-INFO | 23081: exit 0 16:14:03 INFO - TEST-OK | kraken | took 60877ms 16:14:03 INFO - SUITE-END | took 1170s 16:14:03 INFO - Completed test suite (00:19:30) 16:14:03 INFO - javascript benchmark 16:14:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7775.708747297514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3182.984085079575, 3265.053134590968, 3269.5586095877065, 3280.2291461506557, 3291.2594666200107, 5661.745221465034, 5691.3170419549715, 5707.514861236795, 5712.485876271135, 5721.284839395081, 5703.230063941367, 5743.54051675866, 5755.884882302352, 5775.3358363788175, 5801.622894511865, 5233.528982391594, 5258.710770907599, 5266.894662106755, 5303.734813259341, 5309.707966061865, 5298.311219541454, 5300.09898317287, 5302.045631786277, 5308.92036619451, 5331.840044798643, 5148.948510514884, 5168.586513078944, 5268.841934741964, 5269.446708095652, 5291.3385826771655, 5215.191645294966, 5289.259503669489, 5299.867503312448, 5300.92048619271, 5347.0909945309395, 5212.166053431471, 5265.76304066318, 5285.312909321802, 5285.920711189336, 5295.0468915595175, 5571.359293681238, 5676.063449530864, 5715.857103572403, 5798.797042103548, 5830.212921255618, 6128.816135515942, 6168.722407491674, 6184.721687524027, 6196.0, 6226.750929962796, 6228.190335256433, 6237.594556353868, 6242.625442473421, 6251.9687401562705, 6257.937420625781, 5601.047821870292, 5693.544516438675, 5825.1844741736195, 5830.562707796932, 5885.588008839383, 6121.727351053007, 6201.224846894138, 6214.5960512566535, 6225.564210505312, 6229.781957631461, 5944.256967879015, 5978.641281523122, 5980.970095149583, 5984.072468767348, 5992.43071908168, 5984.581079324405, 6001.969990150022, 6044.063170208625, 6050.727717252734, 6117.188044311255, 6137.60105593135, 6215.906761398583, 6216.316205217422, 6220.222472190976, 6223.315435302113, 6227.875442491125, 6232.376762323732, 6235.781747638902, 6236.532260080512, 6237.75048998035, 4572.725636461823, 4623.260278355447, 4748.074125545486, 4767.904641907143, 4770.952290477051, 4118.9588104119175, 4175.68682348825, 4180.143070670505, 4210.789460527023, 4222.472190976128, 5858.384869588717, 5868.325142608569, 5884.6469211847425, 5896.0, 5909.3204281507315, 5922.2597175353085, 6123.648682309606, 6170.228721409824, 6180.196574445384, 6218.036204388327, 5877.206577112121, 5920.023196172583, 5941.673207973517, 5943.10853371989, 5983.371745966698, 5323.361196656426, 5326.2543243945875, 5361.839144825662, 5375.059364611177, 5390.19147127934, 6215.254169499689, 6278.874422511615, 6309.779157729457, 6449.838754031187, 6458.0, 6261.0, 6269.5611307208055, 6275.466585340206, 6276.686165691606, 6278.591891527036, 6400.39196276353, 6412.519061070531, 6429.9678501607195, 6451.935480645134, 6467.773627923, 6002.279726432856, 6067.484263837623, 6081.209442772411, 6093.872633562805, 6148.44663980244, 6250.593711408744, 6250.749970001149, 6255.530835187288, 6257.4994000480765, 6277.2781130170615, 6102.237220347457, 6135.662538560422, 6162.969185154046, 6163.630182189083, 6164.3835616438, 5909.881802364014, 6038.094285857156, 6055.0, 6112.724927378367, 6121.173641558511, 6072.362401947732, 6112.473085128157, 6123.510119190543, 6125.448709616156, 6143.262808463013, 6161.059594737842, 6175.876482470415, 6194.38056194395, 6208.689565521616, 6221.346758590283, 5856.209411729362, 5924.585279030599, 5925.40745925404, 6051.7296349432745, 6054.939450605438], "value": 5700.614290670865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.813819577735, 606.9817905462836, 637.1175921348931, 643.9420452159304, 682.2188594059799, 40899.59100408999, 44970.100597988065, 45039.54960450395, 45117.0, 45164.0, 45553.0, 46319.30521042187, 46380.3042954356, 46453.0, 46475.070498590096, 8881.0, 9132.634694612207, 9135.954320228422, 9137.314701397388, 9142.360034797566, 9017.729468115967, 9109.04355042721, 9113.544322783868, 9115.589798459052, 9119.133682300171, 9117.726468205965, 9143.31425143117, 9162.0, 9163.633454661805, 9175.49534775587, 9128.26973842091, 9130.406523575946, 9161.633534658606, 9162.35863489556, 9170.403923744969, 9009.954950225207, 9095.818083638356, 9100.954495227481, 9103.908960910372, 9112.134347237003, 42587.0, 43147.78426107881, 43195.78402107969, 43305.35041974373, 43347.0, 3700.093477098128, 3733.663970242691, 3941.7437866538585, 4231.915361692749, 4366.694331396803, 34300.65699343, 34334.31331373384, 34392.312153756786, 34461.0, 34650.0, 4687.109449204674, 4699.882502937419, 4778.139934811733, 4803.78382972767, 4827.831025914112, 351865.0, 354163.0, 354206.0, 354263.0, 356121.0, 37697.62302376996, 58488.707556461944, 58616.70691646515, 58771.70614146902, 58808.11787823186, 37227.069323266594, 39457.60542394597, 39815.00462488461, 39846.800765995984, 39973.20053598912, 16426.260818263207, 16487.917560412123, 16581.502554923372, 16583.419580314872, 16619.41832035897, 14357.712845743026, 14371.712565748627, 14378.568642940729, 14379.85620143806, 14447.133172009713, 9147.222486088756, 9229.861552076723, 9237.769055773526, 9245.075492450702, 9337.859932101024, 3548.6806187443253, 3586.3903136466865, 3606.7114630829997, 3607.2424790794225, 3669.688076513473, 1037.9481025948671, 1057.3233130796295, 1080.8919108089128, 1085.159001773616, 1162.9883701163048, 34294.0, 34448.138796530286, 34727.47908781371, 34920.65079349174, 34977.12557186091, 1154.203599516331, 1157.7915975124558, 1158.2182027131653, 1228.7112528555783, 1316.2563151819384, 17253.051082190348, 17681.0, 17997.320696618972, 18064.729029064576, 18205.0, 610215.0, 618608.0, 619012.0, 619457.0, 619483.0, 62884.0, 63436.682816586545, 63540.68229658915, 63613.681931590974, 63617.681911590145, 1462.7878957551095, 1479.3564799312333, 1493.2384483913283, 1494.3798323695762, 1506.5179142674458, 32740.0, 33192.502112467846, 33329.66670333266, 33476.1630959228, 33934.151646209044, 54752.726236368566, 54772.0, 54930.176047358524, 55050.0, 55204.44795551993, 511003.0, 512375.0, 514626.0, 516743.0, 517473.0, 26976.460470790866, 27097.72902270952, 27116.0, 27138.1858544244, 27223.04719334814, 51064.48935510597, 51466.48533514617, 51482.742586286826, 51838.0, 52313.21530176974, 43520.78239608908, 43576.0, 44522.10955780931, 45308.0, 45916.54083459256, 43238.78380608077, 44941.550584495046, 45181.77409112934, 45872.770636146604, 46441.767791160826, 43736.78131609321, 44322.778386107864, 44381.33427998518, 44681.32978005397, 47762.044759105316, 39068.413973790986, 39425.40861887017, 39527.80236098801, 40338.798306008284, 40672.79663601663, 29717.554236686035, 29732.40535189241, 30052.549211762278, 30226.54660180055, 30726.692733072385], "value": 20166.721874497634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.67066346922473, 416.7270437863197, 428.49651659300326, 436.45661151865914, 439.7295663167153, 19383.903080484597, 20017.399478015664, 20876.791232087675, 21122.471938201554, 21208.4697882553, 19706.802931970677, 21173.57652846942, 21280.14879404822, 21824.23615173469, 22064.779352206475, 6516.641584712839, 6782.762603308885, 6836.794896153098, 6971.33772291634, 6987.0, 6693.364130407604, 6781.186257649089, 6800.523963322569, 6852.177738671367, 6857.725690972356, 6777.525573209878, 6797.082393876837, 6830.077939478181, 6830.692618832164, 6832.145981752281, 6729.091572637681, 6829.965850170742, 6838.14523184602, 6847.691853866588, 6919.8962015569805, 6655.966720166417, 6663.4669226461765, 6692.0296556998965, 6711.194656641185, 6718.0, 25275.74724252771, 26797.0, 27207.86396068007, 27397.863010685018, 27556.586651200247, 2659.6675415573054, 2685.328667833042, 2691.690455597592, 2801.789865760056, 3433.399155147864, 16212.0, 16497.505074847773, 16550.83449165505, 17129.48611541656, 17182.22679979404, 2201.0975500044906, 2242.708447901762, 2261.705978222837, 2336.5210131922913, 2499.3751562109474, 97825.5108724459, 98770.0, 99722.002779972, 99734.50132749362, 102529.4873525635, 18345.816541834676, 18753.343632973054, 19561.0, 19590.21639134447, 20127.597448050958, 34063.65936340654, 34106.48840267398, 34293.14267143291, 34419.4837077444, 34434.82782586071, 10787.56849726018, 11003.449827508593, 11066.612668556561, 11145.554177832959, 11230.943845280884, 9284.3036772241, 9351.672691455902, 9517.143457088756, 9630.614775409045, 9633.759156021015, 9135.269178465707, 9143.817123657489, 9404.717858464257, 9496.715098547054, 9702.854457183148, 3345.1637090727318, 3375.3080618473155, 3501.9124521887156, 3554.608993010767, 3596.730245231618, 919.5861862162054, 958.1472489484364, 963.2486660404895, 983.7343917142332, 1018.1854516387009, 19370.903145484182, 20356.0, 20467.0, 20724.378268651966, 21279.148834046773, 1012.6911292055846, 1016.4765145949842, 1076.0692001418715, 1080.9189310801721, 1082.107261509258, 10594.258401911793, 11863.406829658483, 11914.642560723192, 11944.940275298568, 11952.103592230444, 549171.0, 556610.0, 568904.0, 574880.0, 578181.0, 94061.0, 94557.5272123635, 95506.0, 96132.0, 108159.45920270505, 1040.105509262034, 1062.7236918401272, 1066.5040756048475, 1106.1427393769893, 1111.6220485035126, 18038.72941905846, 18772.0, 18812.153453094917, 18955.0, 19000.429987100408, 31418.21454463657, 36352.81823590865, 45295.32057019213, 45622.31566526438, 46314.0, 67427.0, 67760.0, 68094.0, 68838.0, 69383.30616693769, 9055.230305424113, 9274.397164184307, 9299.349045566745, 9349.579268932779, 9428.57571409302, 13127.934360328138, 13981.161130332213, 14271.286435678383, 14364.784528232294, 14417.13497190172, 11563.768724625628, 11752.059835213333, 11837.112216583619, 12147.088968327587, 12154.696132596402, 11059.778804424028, 11173.05029072538, 11712.824307635221, 11775.76448471043, 11867.228630139014, 11581.363025033705, 11622.825657614974, 12186.390680465764, 12515.499380024698, 12547.74904501923, 8877.600507977028, 8893.510856902933, 8903.109689031304, 9212.401193922642, 9286.72139835806, 11492.770144597229, 12736.6815829605, 12738.363081846055, 12827.0, 12852.485900563872], "value": 11021.348676498359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.7645914883194, 1551.573317337732, 1738.1743671755917, 1821.5355084453463, 1836.109486898853, 8336.0, 8833.07252738463, 8902.688405905794, 9749.756256093593, 9755.219582433398, 8887.955560222206, 9069.682561110363, 9271.258299336054, 9315.394499357537, 9316.0, 2465.6055031195015, 2528.506941146477, 2533.987330063347, 2537.568613335737, 2538.0736031348515, 2389.0324418610403, 2440.3655049687122, 2442.780149786519, 2450.4241503246812, 2459.5080983803223, 2432.2095319021387, 2432.598621227495, 2437.439388940536, 2499.9999999999964, 2510.648509208703, 2376.4771750215014, 2385.451346190377, 2389.7729715676983, 2489.2781093482868, 2504.8622325772076, 2450.840695354814, 2455.0670745116918, 2462.0398044762555, 2466.1121996081397, 2496.987515062431, 9102.77243068922, 9115.544222788834, 9177.357584969055, 9206.631734730603, 9207.355485116044, 5554.611177217596, 5684.63049901755, 5690.658560486384, 5694.202811606378, 5697.774978379627, 3461.792292462435, 3492.6158122606494, 3494.2662040971427, 3522.277933023724, 3538.6461353864406, 1183.5798291606527, 1228.7542491501647, 1243.5958313548133, 1263.7282984158358, 1279.494599633149, 12710.491580336775, 12902.0, 12968.09223354375, 13013.34933253343, 13039.478420863248, 4810.182269014276, 4895.290182923456, 4946.134426475424, 5063.367079115111, 5077.339945807095, 10938.56245750161, 10977.506012229469, 11003.22977391575, 11014.0, 11025.503852326665, 5649.322081350264, 5719.456651618089, 5731.369549349568, 5735.025045742151, 5736.741846616912, 4528.139653465831, 5002.974985125051, 5085.313482679865, 5119.692818430832, 5195.376554813447, 4241.957580424156, 4262.168877069003, 4386.692931494765, 4390.275604525282, 4397.802098905557, 1309.8428188617427, 1336.712606789545, 1350.2438634364787, 1352.6145048661085, 1357.830271216098, 975.2246963663904, 1036.9429681367446, 1069.4492336446735, 1089.215764649451, 1091.5033659684825, 6205.968970155121, 6328.145700330397, 6406.839829004312, 6428.0, 6459.386358295955, 477.2626292378284, 477.7539567122935, 481.2588613535117, 490.33069859642046, 491.36368402918305, 4073.694472914484, 4110.671146308288, 4131.318332475168, 4133.545310015896, 4251.511076226274, 11084.113270938306, 11492.195546311677, 11505.539778408769, 11565.248258863146, 11598.94200528992, 11357.318560886373, 11456.312621242752, 11458.77082458363, 11471.885281147248, 11475.942620287013, 8628.697995570124, 8634.438761480484, 8655.221030107195, 8695.782605434788, 8723.738287851374, 6196.194494715838, 6220.813375598739, 6364.299927007933, 6400.07198956158, 6463.676816159267, 10555.050045495942, 10737.89262107369, 10758.13934885223, 10779.353238805697, 10780.622678206226, 10108.494575271354, 10543.736406589896, 10648.680539583826, 10710.678679639623, 10823.945880270549, 7831.373490120663, 7955.0, 8159.3064589508185, 8160.795980100545, 8345.749627511184, 9311.580978856104, 9320.161185493338, 9351.298652600946, 9370.203532699798, 9377.015413381496, 8033.0, 8218.671253149807, 8224.62989165477, 8336.0, 8431.620577074169, 7684.500507466997, 7687.423443241667, 7688.154303026551, 7702.191269916802, 7734.922650773646, 7290.198078211499, 7384.852302953804, 7487.925120748723, 7563.319301262913, 7572.129205141479, 5536.418676039119, 5540.806071787468, 5631.352394474688, 5641.294838145232, 5710.114932185518, 5518.392976772632, 5606.775728970959, 5656.575756818337, 5773.1051686988585, 5806.129080637938], "value": 4830.944659882338, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.90142858571016, 348.4077068982729, 349.55955496074944, 357.15889081213726, 359.8686479435007, 5685.630434021786, 5731.254936858202, 5776.873509665616, 5898.174255604214, 5906.70466476676, 5736.713164341787, 5743.942560574393, 5777.1623114648455, 5785.363610002896, 5794.82615521535, 4569.794359253825, 4577.679562430631, 4586.7477288749105, 4593.104344652794, 4598.425196850394, 4482.193205223059, 4539.863804085882, 4552.044070745147, 4563.612092972101, 4564.657650676212, 4504.594586487216, 4514.729116253019, 4520.2767557190855, 4521.174266083698, 4523.434570678665, 4511.436070491189, 4527.61515271199, 4529.614982726489, 4552.408186935711, 4554.453465584118, 3900.7659540427667, 4008.178323443687, 4011.2378648056774, 4060.1067765091634, 4060.9644540642244, 5626.6624002559565, 5626.971865140689, 5631.887362252773, 5641.0, 5668.744906479218, 5175.223716442526, 5181.507756763139, 5195.636305458619, 5223.9290945356115, 5260.0, 5867.677277749722, 6023.668698221596, 6043.576949613529, 6050.394960503959, 6077.665728384937, 4431.534688857656, 4435.379046933432, 4441.179850794769, 4443.80002899867, 4449.421575195236, 6133.018717005258, 6278.963970944788, 6294.905576416358, 6300.5589608727405, 6306.5179682774515, 4517.119161763425, 4525.52481989393, 4527.932081018787, 4537.818487260539, 4545.522720114341, 4592.127495775859, 4598.770061496912, 4606.424196975378, 4620.630349572093, 4627.444706635158, 5201.08980928336, 5206.505381988705, 5216.739163041832, 5218.399884013311, 5265.262863199156, 5893.734781934823, 6055.969720151371, 6078.179445774764, 6114.361954636984, 6173.475254603409, 1526.5954522051666, 1554.114154931678, 1555.9611009724847, 1560.4694403902727, 1571.4499925026378, 955.0306438964457, 981.4700061966458, 983.5918093991056, 997.3018886779283, 1002.754325190333, 5155.278261043457, 5170.586353091744, 5170.793168273227, 5173.741312934339, 5217.452167522356, 5422.5119739223655, 5470.8085217017215, 5482.890342193134, 5490.890182196334, 5574.49147883454, 4986.850394488099, 5201.5838732901275, 5216.243644671501, 5218.0, 5241.31862857826, 2922.3570814420796, 2924.6782853886057, 2932.882684692631, 2933.05779761099, 2933.8093023953375, 5610.523105535994, 5630.8331834442215, 5650.406707295675, 5652.74562644682, 5667.829965101054, 5193.532582067556, 5594.440555944454, 5598.0, 5623.690697011703, 5634.32388113429, 5593.371115575755, 5628.802991895346, 5634.3802181759975, 5685.715714214272, 5701.686407247558, 5258.474152584864, 5477.972610136924, 5494.945050549443, 5500.80747173847, 5601.215829783752, 5417.04986204958, 5423.864403389789, 5424.2406063151975, 5441.29263195782, 5472.972635136958, 5647.661140331593, 5677.990664947584, 5681.982896071835, 5682.715864206691, 5784.814113106719, 3861.8455261790336, 3874.1016901718517, 3915.667168290727, 3951.5060617422823, 4030.2544029354663, 5452.918206226989, 5462.159676967875, 5562.777488900399, 6094.2077529920825, 6373.776917807854, 6187.566870319214, 6236.906446403217, 6275.246970363585, 6293.181886354744, 6316.968415157895, 6072.570971611391, 6154.307565419545, 6184.783532576338, 6207.6275423474735, 6223.159873417031, 6067.696615169312, 6129.540284478593, 6136.417040381157, 6140.846478837886, 6168.629882207082, 6294.937050629435, 6312.779052733133, 6324.873502530016, 6331.891918914263, 6351.062925807673, 5926.318473375444, 6012.398760124128, 6062.363451837494, 6065.636061836304, 6147.139400483847], "value": 4472.884390816052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.6797814863129, 814.727066432745, 816.8121332093615, 896.3232759266753, 899.9865002024967, 16786.83213167868, 17191.828081719195, 17562.385316513926, 17563.209655565497, 17639.823601763994, 16270.918645406757, 16407.261673224704, 16456.670866582663, 16508.669826603462, 16568.50294491164, 711.2496316386237, 839.689314953468, 851.1148405658124, 853.9402241843073, 863.1239292118505, 853.7481442974338, 858.6737039924819, 862.6851199312238, 862.9525376104311, 864.3906046237388, 924.9768755781092, 929.6699671616581, 933.5845548730817, 938.1134827587932, 938.816930698514, 918.1415376622846, 925.8611208318739, 929.8419268724266, 930.5114814722325, 931.8602209668536, 681.2778454837838, 681.7204945972177, 683.2518392360357, 683.9863202735967, 684.3498676257575, 15815.683686326209, 15819.209039547977, 15889.04665720049, 15894.205289735466, 15904.20478976058, 14500.564983050524, 14626.268686565629, 14969.476068337555, 15158.393664253417, 15170.317335719808, 14572.854271457256, 14789.482368117171, 14808.407663693439, 14835.25823708821, 15209.695806083928, 4840.540148685869, 4877.926856091654, 4883.8779030524165, 4938.728369939652, 4984.725840078794, 90000.54999724959, 91081.0, 91279.54360228223, 91569.08430915672, 91807.08192918052, 12165.513379464723, 12206.877931220752, 12558.74882502345, 12615.810762838564, 13053.412596433183, 22399.88800055989, 22588.54822903533, 22676.206332778274, 22677.319680409615, 22723.431914201945, 8682.088380720059, 8795.780105497286, 8906.465612063168, 8959.328050396247, 8970.237529809909, 5199.870003249949, 5203.895922081537, 5206.088934436459, 5215.348081489814, 5221.791128354899, 3824.5028146340796, 3939.6454319110844, 3945.072907866649, 3946.940795888064, 3949.7235193536176, 655.5312951239887, 658.9110470086476, 679.100192245277, 679.5379142183363, 681.6251061915926, 746.220199891115, 759.9354054905396, 767.3285874859498, 782.9060512738508, 790.7983464216588, 9756.121949024622, 10788.568457261621, 10885.0, 10939.453027348602, 11078.667639970814, 626.3235705438116, 716.6703316474376, 757.7650928212272, 763.5189830406808, 772.9381649468029, 4888.755562221946, 5017.523335283142, 5082.237664350377, 5125.461826508237, 5178.71517066565, 116524.41737791426, 119616.0, 124752.37623811823, 128524.37810945274, 131584.0, 108666.0, 111592.0, 112196.43901780603, 112336.43831780789, 112677.0, 95237.52381238189, 95840.52079739557, 99266.0, 99919.0016199672, 101673.0, 9840.803183936137, 9888.851667224853, 9957.0, 9974.800503990025, 10138.543765530421, 57838.0, 59153.0, 59244.0, 59461.58322184639, 60031.0, 58270.0, 82351.58824205841, 84760.57619711861, 86319.56840215759, 86473.56763216143, 12126.393680316125, 12194.878051219373, 12452.750944981231, 12463.189892656948, 12468.314242716737, 13528.458861645424, 13825.792613111013, 13991.300434978413, 14607.707845842811, 14617.0, 12652.17760845542, 12653.27954489789, 12900.612981610566, 12906.290154041619, 13077.67305817324, 13412.32938353098, 13422.798658020332, 13571.660708482366, 13665.831921263713, 13843.100198487065, 11908.642740717793, 11957.468193194092, 12233.938830306148, 12243.75512489763, 12618.55835045769, 10559.102476289601, 10728.088112510524, 10731.570737170427, 10801.621943231949, 10885.346879187275, 10530.894691052992, 10544.420056896945, 10553.63062292816, 10570.630027948984, 10676.412797296223], "value": 8072.084022222236, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 110.0, 110.0, 112.0, 110.0, 111.0, 110.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 144.0, 174.0, 117.0, 148.0, 152.0, 118.0, 186.0, 118.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 160.0, 162.0, 163.0, 161.0, 162.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 185.0, 75.0, 77.0, 74.0, 76.0, 166.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 147.0, 84.0, 84.0, 84.0, 134.0, 84.0, 85.0, 144.0], "value": 101.6, "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, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 147.0, 149.0, 148.0, 147.0, 146.0, 148.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 49.0, 51.0, 52.0, 54.0, 51.0, 54.0, 52.0, 51.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 63.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 82.0, 72.0, 73.0, 73.0, 72.0, 79.0, 73.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 130.0, 136.0, 130.0, 134.0, 122.0, 119.0, 160.0, 131.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 155.0, 154.0, 152.0, 155.0, 152.0, 151.0, 156.0, 151.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 64.0, 63.0, 62.0, 68.0, 61.0, 60.0, 60.0], "value": 62.6, "unit": "score"}]}]} 16:14:03 INFO - Return code: 0 16:14:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:04 ERROR - # TBPL SUCCESS # 16:14:04 INFO - Running post-action listener: _resource_record_post_action 16:14:04 INFO - [mozharness: 2016-10-10 23:14:04.040526Z] Finished run-tests step (success) 16:14:04 INFO - Running post-run listener: _resource_record_post_run 16:14:04 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288641024; Read time: 680; Write time: 327704 16:14:04 INFO - TinderboxPrint: CPU usage
13.3% 16:14:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 680 16:14:04 INFO - TinderboxPrint: I/O write bytes / time
288,641,024 / 327,704 16:14:04 INFO - TinderboxPrint: CPU idle
8,199.6 (86.7%) 16:14:04 INFO - TinderboxPrint: CPU user
1,199.8 (12.7%) 16:14:04 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:04 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 4096; Write bytes: 71303168; Read time: 292; Write time: 57952 16:14:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217337856; Read time: 388; Write time: 269752 16:14:04 INFO - Running post-run listener: _upload_blobber_files 16:14:04 INFO - Blob upload gear active. 16:14:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:04 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 16:14:04 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'] 16:14:04 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 16:14:05 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:14:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:05 INFO - (blobuploader) - INFO - Done attempting. 16:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:09 INFO - (blobuploader) - INFO - Done attempting. 16:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:10 INFO - (blobuploader) - INFO - Done attempting. 16:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:10 INFO - Return code: 0 16:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/535d580e8fdc1326eca6bc2891befb8862d3813c51971e49e6b8d132deed58a77f06efd329bb57fffcb3aeaeefb348db4aaf6fb88cb9ef87e0abd89e9d5dceda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e69616b9a0c013ee2090f3a4befd00698226631039e10c0fb438f6007e12e276843dcb33a8923ff0ec65cb9c66977c8a17322c0d2be2e31e8dcc28ada4958b57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3795b884ab224865bff99cdde97c8799fff156b4610865ed0fd42fb3110432228dd18d4dc67abfcd7e160166180c9aad520e2f9e798909a94ce2643625d33688"} 16:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:14:10 INFO - Contents: 16:14:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/535d580e8fdc1326eca6bc2891befb8862d3813c51971e49e6b8d132deed58a77f06efd329bb57fffcb3aeaeefb348db4aaf6fb88cb9ef87e0abd89e9d5dceda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e69616b9a0c013ee2090f3a4befd00698226631039e10c0fb438f6007e12e276843dcb33a8923ff0ec65cb9c66977c8a17322c0d2be2e31e8dcc28ada4958b57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3795b884ab224865bff99cdde97c8799fff156b4610865ed0fd42fb3110432228dd18d4dc67abfcd7e160166180c9aad520e2f9e798909a94ce2643625d33688"} 16:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:10 INFO - Copying logs to upload dir... 16:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.241599 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-10 16:14:08.163902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:08.167170) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332 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/535d580e8fdc1326eca6bc2891befb8862d3813c51971e49e6b8d132deed58a77f06efd329bb57fffcb3aeaeefb348db4aaf6fb88cb9ef87e0abd89e9d5dceda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e69616b9a0c013ee2090f3a4befd00698226631039e10c0fb438f6007e12e276843dcb33a8923ff0ec65cb9c66977c8a17322c0d2be2e31e8dcc28ada4958b57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3795b884ab224865bff99cdde97c8799fff156b4610865ed0fd42fb3110432228dd18d4dc67abfcd7e160166180c9aad520e2f9e798909a94ce2643625d33688"} build_url:https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/RAWXIckmQgiv5Jreg6hiCg/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/535d580e8fdc1326eca6bc2891befb8862d3813c51971e49e6b8d132deed58a77f06efd329bb57fffcb3aeaeefb348db4aaf6fb88cb9ef87e0abd89e9d5dceda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e69616b9a0c013ee2090f3a4befd00698226631039e10c0fb438f6007e12e276843dcb33a8923ff0ec65cb9c66977c8a17322c0d2be2e31e8dcc28ada4958b57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3795b884ab224865bff99cdde97c8799fff156b4610865ed0fd42fb3110432228dd18d4dc67abfcd7e160166180c9aad520e2f9e798909a94ce2643625d33688"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:08.192320) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:08.192665) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1476139458.438868-2073753332 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:08.275685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 16:14:08.275997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 16:14:08.276284) ========= ========= Total master_lag: 0.13 =========