builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1470958843.83 results: success (0) buildid: 20160811134122 builduid: 40acb629e5cd4507b861a8ca17b86619 revision: 352ba6b9460229871e3031e19f6fcc2c6a6afb25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.829248) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.829680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.829977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.848347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.848646) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 16:40:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.7M=0.001s 2016-08-11 16:40:44 (12.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.966908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:43.967236) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017708 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.017014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.017374) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 352ba6b9460229871e3031e19f6fcc2c6a6afb25 --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-aurora --rev 352ba6b9460229871e3031e19f6fcc2c6a6afb25 --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=e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 16:40:44,464 truncating revision to first 12 chars 2016-08-11 16:40:44,464 Setting DEBUG logging. 2016-08-11 16:40:44,464 attempt 1/10 2016-08-11 16:40:44,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/352ba6b94602?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 16:40:44,889 unpacking tar archive at: mozilla-aurora-352ba6b94602/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.779152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.779463) ========= script_repo_revision: 352ba6b9460229871e3031e19f6fcc2c6a6afb25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.779854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.780121) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 16:40:44.791276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-08-11 16:40:44.791639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:40:45 INFO - MultiFileLogger online at 20160811 16:40:45 in /builds/slave/test 16:40:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:40:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:40:45 INFO - {'append_to_log': False, 16:40:45 INFO - 'base_work_dir': '/builds/slave/test', 16:40:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:40:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:40:45 INFO - 'branch': 'Mozilla-Aurora', 16:40:45 INFO - 'buildbot_json_path': 'buildprops.json', 16:40:45 INFO - 'config_files': ('talos/linux_config.py',), 16:40:45 INFO - 'default_actions': ('clobber', 16:40:45 INFO - 'read-buildbot-config', 16:40:45 INFO - 'download-and-extract', 16:40:45 INFO - 'populate-webroot', 16:40:45 INFO - 'create-virtualenv', 16:40:45 INFO - 'install', 16:40:45 INFO - 'run-tests'), 16:40:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:40:45 INFO - 'download_minidump_stackwalk': True, 16:40:45 INFO - 'download_symbols': 'ondemand', 16:40:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:40:45 INFO - 'tooltool.py': '/tools/tooltool.py', 16:40:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:40:45 INFO - '/tools/misc-python/virtualenv.py')}, 16:40:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:40:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:40:45 INFO - 'installer_path': 'installer.exe', 16:40:45 INFO - 'log_level': 'info', 16:40:45 INFO - 'log_name': 'talos', 16:40:45 INFO - 'log_to_console': True, 16:40:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:40:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:40:45 INFO - 'opt_config_files': (), 16:40:45 INFO - 'pip_index': False, 16:40:45 INFO - 'sps_profile': False, 16:40:45 INFO - 'sps_profile_interval': 0, 16:40:45 INFO - 'suite': 'dromaeojs-e10s', 16:40:45 INFO - 'system_bits': '32', 16:40:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:40:45 INFO - 'title': 'talos-linux64-ix-067', 16:40:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:40:45 INFO - 'use_talos_json': True, 16:40:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:40:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:40:45 INFO - 'work_dir': 'build'} 16:40:45 INFO - [mozharness: 2016-08-11 23:40:45.330768Z] Running clobber step. 16:40:45 INFO - Running pre-action listener: _resource_record_pre_action 16:40:45 INFO - Running main action method: clobber 16:40:45 INFO - rmtree: /builds/slave/test/build 16:40:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:40:46 INFO - Running post-action listener: _resource_record_post_action 16:40:46 INFO - [mozharness: 2016-08-11 23:40:46.310072Z] Finished clobber step (success) 16:40:46 INFO - [mozharness: 2016-08-11 23:40:46.310172Z] Running read-buildbot-config step. 16:40:46 INFO - Running pre-action listener: _resource_record_pre_action 16:40:46 INFO - Running main action method: read_buildbot_config 16:40:46 INFO - Using buildbot properties: 16:40:46 INFO - { 16:40:46 INFO - "project": "", 16:40:46 INFO - "product": "firefox", 16:40:46 INFO - "script_repo_revision": "production", 16:40:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:40:46 INFO - "repository": "", 16:40:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:40:46 INFO - "buildid": "20160811134122", 16:40:46 INFO - "pgo_build": "True", 16:40:46 INFO - "basedir": "/builds/slave/test", 16:40:46 INFO - "buildnumber": 453, 16:40:46 INFO - "slavename": "talos-linux64-ix-067", 16:40:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:40:46 INFO - "platform": "ubuntu64_hw", 16:40:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:40:46 INFO - "branch": "mozilla-aurora", 16:40:46 INFO - "repo_path": "releases/mozilla-aurora", 16:40:46 INFO - "revision": "352ba6b9460229871e3031e19f6fcc2c6a6afb25", 16:40:46 INFO - "stage_platform": "linux64-pgo", 16:40:46 INFO - "builduid": "40acb629e5cd4507b861a8ca17b86619", 16:40:46 INFO - "slavebuilddir": "test" 16:40:46 INFO - } 16:40:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 16:40:46 INFO - Running post-action listener: _resource_record_post_action 16:40:46 INFO - [mozharness: 2016-08-11 23:40:46.312601Z] Finished read-buildbot-config step (success) 16:40:46 INFO - [mozharness: 2016-08-11 23:40:46.312690Z] Running download-and-extract step. 16:40:46 INFO - Running pre-action listener: _resource_record_pre_action 16:40:46 INFO - Running main action method: download_and_extract 16:40:46 INFO - mkdir: /builds/slave/test/build/tests 16:40:46 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')]} 16:40:46 INFO - https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:40:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:40:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:40:46 INFO - retry: Failed, sleeping 30 seconds before retrying 16:41:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 16:41:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:41:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:41:16 INFO - retry: Failed, sleeping 60 seconds before retrying 16:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 16:42:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:42:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 16:42:16 INFO - Caught exception: HTTP Error 404: Not Found 16:42:16 INFO - Caught exception: HTTP Error 404: Not Found 16:42:16 INFO - Caught exception: HTTP Error 404: Not Found 16:42:16 INFO - trying https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - Downloading https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:42:16 INFO - Downloaded 1361 bytes. 16:42:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - Using the following test package requirements: 16:42:16 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 16:42:16 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:42:16 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:42:16 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'jsshell-linux-x86_64.zip'], 16:42:16 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:42:16 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 16:42:16 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:42:16 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:42:16 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:42:16 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:16 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:42:16 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:42:16 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')]} 16:42:16 INFO - https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:42:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:42:17 INFO - retry: Failed, sleeping 30 seconds before retrying 16:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 16:42:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:42:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:42:47 INFO - retry: Failed, sleeping 60 seconds before retrying 16:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 16:43:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:43:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 16:43:47 INFO - Caught exception: HTTP Error 404: Not Found 16:43:47 INFO - Caught exception: HTTP Error 404: Not Found 16:43:47 INFO - Caught exception: HTTP Error 404: Not Found 16:43:47 INFO - trying https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:47 INFO - Downloading https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:43:47 INFO - Downloaded 21766627 bytes. 16:43:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:43:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:43:49 INFO - Return code: 0 16:43:49 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:43: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')]} 16:43:49 INFO - https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:43:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:43:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:43:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:43:49 INFO - retry: Failed, sleeping 30 seconds before retrying 16:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 16:44:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:44:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:44:19 INFO - retry: Failed, sleeping 60 seconds before retrying 16:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 16:45:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:45:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:45:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 16:45:19 INFO - Caught exception: HTTP Error 404: Not Found 16:45:19 INFO - Caught exception: HTTP Error 404: Not Found 16:45:19 INFO - Caught exception: HTTP Error 404: Not Found 16:45:19 INFO - trying https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:45:19 INFO - Downloading https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 16:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:45:20 INFO - Downloaded 21766627 bytes. 16:45:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:45:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:45:21 INFO - Return code: 0 16:45: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')]} 16:45:21 INFO - https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:45:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:45:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:45:21 INFO - retry: Failed, sleeping 30 seconds before retrying 16:45:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 16:45:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:45:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:45:51 INFO - retry: Failed, sleeping 60 seconds before retrying 16:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 16:46:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:46:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:46:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 16:46:51 INFO - Caught exception: HTTP Error 404: Not Found 16:46:51 INFO - Caught exception: HTTP Error 404: Not Found 16:46:51 INFO - Caught exception: HTTP Error 404: Not Found 16:46:51 INFO - trying https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:46:51 INFO - Downloading https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 16:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:46:52 INFO - Downloaded 14413723 bytes. 16:46:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:46:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:46:52 INFO - Return code: 0 16:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:52 INFO - https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:46:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:46:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 16:46:52 INFO - retry: Failed, sleeping 30 seconds before retrying 16:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 16:47:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:47:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 16:47:23 INFO - retry: Failed, sleeping 60 seconds before retrying 16:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 16:48:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:48:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 16:48:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 16:48:23 INFO - Caught exception: HTTP Error 404: Not Found 16:48:23 INFO - Caught exception: HTTP Error 404: Not Found 16:48:23 INFO - Caught exception: HTTP Error 404: Not Found 16:48:23 INFO - trying https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:48:23 INFO - Downloading https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:48:24 INFO - Downloaded 63745477 bytes. 16:48:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:48:24 INFO - mkdir: /builds/slave/test/properties 16:48:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:24 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:24 INFO - Contents: 16:48:24 INFO - build_url:https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 16:48:25 INFO - Running post-action listener: _resource_record_post_action 16:48:25 INFO - Running post-action listener: set_extra_try_arguments 16:48:25 INFO - [mozharness: 2016-08-11 23:48:25.039449Z] Finished download-and-extract step (success) 16:48:25 INFO - [mozharness: 2016-08-11 23:48:25.039681Z] Running populate-webroot step. 16:48:25 INFO - Running pre-action listener: _resource_record_pre_action 16:48:25 INFO - Running main action method: populate_webroot 16:48:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:25 INFO - '--tppagecycles', 16:48:25 INFO - '7'], 16:48:25 INFO - 'tests': ['tsvgm']}}, 16:48:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:48:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:48:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['damp', 'tps']}, 16:48:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'tests': ['damp', 'tps']}, 16:48:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['dromaeo_dom']}, 16:48:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['basic_compositor_video']}, 16:48:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:48:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['a11yr', 16:48:25 INFO - 'ts_paint', 16:48:25 INFO - 'tpaint', 16:48:25 INFO - 'sessionrestore', 16:48:25 INFO - 'sessionrestore_no_auto_restore', 16:48:25 INFO - 'tabpaint']}, 16:48:25 INFO - 'other-e10s': {'tests': ['a11yr', 16:48:25 INFO - 'ts_paint', 16:48:25 INFO - 'tpaint', 16:48:25 INFO - 'sessionrestore', 16:48:25 INFO - 'sessionrestore_no_auto_restore', 16:48:25 INFO - 'tabpaint']}, 16:48:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:48:25 INFO - 'ts_paint', 16:48:25 INFO - 'tpaint', 16:48:25 INFO - 'sessionrestore', 16:48:25 INFO - 'sessionrestore_no_auto_restore', 16:48:25 INFO - 'tabpaint']}, 16:48:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:48:25 INFO - 'ts_paint', 16:48:25 INFO - 'tpaint', 16:48:25 INFO - 'sessionrestore', 16:48:25 INFO - 'sessionrestore_no_auto_restore', 16:48:25 INFO - 'tabpaint']}, 16:48:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['a11yr', 16:48:25 INFO - 'ts_paint', 16:48:25 INFO - 'tpaint', 16:48:25 INFO - 'sessionrestore', 16:48:25 INFO - 'sessionrestore_no_auto_restore', 16:48:25 INFO - 'tabpaint']}, 16:48:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['a11yr', 16:48:25 INFO - 'ts_paint', 16:48:25 INFO - 'tpaint', 16:48:25 INFO - 'sessionrestore', 16:48:25 INFO - 'sessionrestore_no_auto_restore', 16:48:25 INFO - 'tabpaint']}, 16:48:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['tsvgx', 16:48:25 INFO - 'tsvgr_opacity', 16:48:25 INFO - 'tart', 16:48:25 INFO - 'tscrollx', 16:48:25 INFO - 'cart']}, 16:48:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:48:25 INFO - 'tsvgr_opacity', 16:48:25 INFO - 'tart', 16:48:25 INFO - 'tscrollx', 16:48:25 INFO - 'cart']}, 16:48:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'talos_options': ['--disable-e10s'], 16:48:25 INFO - 'tests': ['tp5o']}, 16:48:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'tests': ['tp5o']}, 16:48:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'talos_options': ['--disable-e10s', 16:48:25 INFO - '--xperf_path', 16:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:25 INFO - 'tests': ['tp5n']}, 16:48:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:25 INFO - 'talos_options': ['--xperf_path', 16:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:25 INFO - 'tests': ['tp5n']}}, 16:48:25 INFO - 'talos.zip': {'path': '', 16:48:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:25 INFO - Running post-action listener: _resource_record_post_action 16:48:25 INFO - [mozharness: 2016-08-11 23:48:25.059018Z] Finished populate-webroot step (success) 16:48:25 INFO - [mozharness: 2016-08-11 23:48:25.059107Z] Running create-virtualenv step. 16:48:25 INFO - Running pre-action listener: _resource_record_pre_action 16:48:25 INFO - Running main action method: create_virtualenv 16:48:25 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:25 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 16:48:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:25 INFO - Using real prefix '/usr' 16:48:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:25 INFO - Installing distribute.............................................................................................................................................................................................done. 16:48:27 INFO - Installing pip.................done. 16:48:27 INFO - Return code: 0 16:48:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:48:27 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')]} 16:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:27 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')]} 16:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:27 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:27 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 16:48:27 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 16:48:27 INFO - Using env: {'DISPLAY': ':0', 16:48:27 INFO - 'HOME': '/home/cltbld', 16:48:27 INFO - 'LANG': 'en_US.UTF-8', 16:48:27 INFO - 'LANGUAGE': 'en_US:en', 16:48:27 INFO - 'LOGNAME': 'cltbld', 16:48:27 INFO - 'MAIL': '/var/mail/cltbld', 16:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:27 INFO - 'MOZ_NO_REMOTE': '1', 16:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:27 INFO - 'NO_EM_RESTART': '1', 16:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:27 INFO - 'PWD': '/builds/slave/test', 16:48:27 INFO - 'SHELL': '/bin/bash', 16:48:27 INFO - 'SHLVL': '1', 16:48:27 INFO - 'TERM': 'linux', 16:48:27 INFO - 'TMOUT': '86400', 16:48:27 INFO - 'USER': 'cltbld', 16:48:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:27 INFO - '_': '/tools/buildbot/bin/python'} 16:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:27 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 16:48:27 INFO - Cleaning up... 16:48:27 INFO - Return code: 0 16:48:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:48:27 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')]} 16:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:27 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')]} 16:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:27 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:27 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 16:48:27 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 16:48:27 INFO - Using env: {'DISPLAY': ':0', 16:48:27 INFO - 'HOME': '/home/cltbld', 16:48:27 INFO - 'LANG': 'en_US.UTF-8', 16:48:27 INFO - 'LANGUAGE': 'en_US:en', 16:48:27 INFO - 'LOGNAME': 'cltbld', 16:48:27 INFO - 'MAIL': '/var/mail/cltbld', 16:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:27 INFO - 'MOZ_NO_REMOTE': '1', 16:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:27 INFO - 'NO_EM_RESTART': '1', 16:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:27 INFO - 'PWD': '/builds/slave/test', 16:48:27 INFO - 'SHELL': '/bin/bash', 16:48:27 INFO - 'SHLVL': '1', 16:48:27 INFO - 'TERM': 'linux', 16:48:27 INFO - 'TMOUT': '86400', 16:48:27 INFO - 'USER': 'cltbld', 16:48:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:27 INFO - '_': '/tools/buildbot/bin/python'} 16:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:28 INFO - Downloading/unpacking psutil>=3.1.1 16:48:28 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 16:48:28 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 16:48:28 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 16:48:28 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 16:48:28 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 16:48:28 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 16:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:30 INFO - Installing collected packages: psutil 16:48:30 INFO - Running setup.py install for psutil 16:48:30 INFO - building 'psutil._psutil_linux' extension 16:48:30 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 16:48:30 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 16:48:30 INFO - building 'psutil._psutil_posix' extension 16:48:30 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 16:48:30 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 16:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:30 INFO - Successfully installed psutil 16:48:30 INFO - Cleaning up... 16:48:30 INFO - Return code: 0 16:48:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:48:30 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')]} 16:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:30 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')]} 16:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:30 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:30 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 16:48:30 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 16:48:30 INFO - Using env: {'DISPLAY': ':0', 16:48:30 INFO - 'HOME': '/home/cltbld', 16:48:30 INFO - 'LANG': 'en_US.UTF-8', 16:48:30 INFO - 'LANGUAGE': 'en_US:en', 16:48:30 INFO - 'LOGNAME': 'cltbld', 16:48:30 INFO - 'MAIL': '/var/mail/cltbld', 16:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:30 INFO - 'MOZ_NO_REMOTE': '1', 16:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:30 INFO - 'NO_EM_RESTART': '1', 16:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:30 INFO - 'PWD': '/builds/slave/test', 16:48:30 INFO - 'SHELL': '/bin/bash', 16:48:30 INFO - 'SHLVL': '1', 16:48:30 INFO - 'TERM': 'linux', 16:48:30 INFO - 'TMOUT': '86400', 16:48:30 INFO - 'USER': 'cltbld', 16:48:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:30 INFO - '_': '/tools/buildbot/bin/python'} 16:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:48:30 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 16:48:30 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 16:48:30 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 16:48:30 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 16:48:30 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 16:48:30 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 16:48:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:48:32 INFO - Installing collected packages: mozsystemmonitor 16:48:32 INFO - Running setup.py install for mozsystemmonitor 16:48:32 INFO - Successfully installed mozsystemmonitor 16:48:32 INFO - Cleaning up... 16:48:32 INFO - Return code: 0 16:48:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:48: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')]} 16:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48: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')]} 16:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:32 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:32 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 16:48:32 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 16:48:32 INFO - Using env: {'DISPLAY': ':0', 16:48:32 INFO - 'HOME': '/home/cltbld', 16:48:32 INFO - 'LANG': 'en_US.UTF-8', 16:48:32 INFO - 'LANGUAGE': 'en_US:en', 16:48:32 INFO - 'LOGNAME': 'cltbld', 16:48:32 INFO - 'MAIL': '/var/mail/cltbld', 16:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:32 INFO - 'MOZ_NO_REMOTE': '1', 16:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:32 INFO - 'NO_EM_RESTART': '1', 16:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:32 INFO - 'PWD': '/builds/slave/test', 16:48:32 INFO - 'SHELL': '/bin/bash', 16:48:32 INFO - 'SHLVL': '1', 16:48:32 INFO - 'TERM': 'linux', 16:48:32 INFO - 'TMOUT': '86400', 16:48:32 INFO - 'USER': 'cltbld', 16:48:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:32 INFO - '_': '/tools/buildbot/bin/python'} 16:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:33 INFO - Downloading/unpacking jsonschema==2.5.1 16:48:33 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 16:48:33 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 16:48:33 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 16:48:33 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 16:48:33 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 16:48:33 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 16:48:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:48:35 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 16:48:35 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 16:48:35 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 16:48:35 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 16:48:35 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 16:48:35 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 16:48:35 INFO - Downloading functools32-3.2.3-2.tar.gz 16:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:48:35 INFO - warning: no files found matching '*.txt' 16:48:35 INFO - no previously-included directories found matching 'build' 16:48:35 INFO - no previously-included directories found matching 'dist' 16:48:35 INFO - no previously-included directories found matching '.git*' 16:48:35 INFO - Installing collected packages: jsonschema, functools32 16:48:35 INFO - Running setup.py install for functools32 16:48:35 INFO - warning: no files found matching '*.txt' 16:48:35 INFO - no previously-included directories found matching 'build' 16:48:35 INFO - no previously-included directories found matching 'dist' 16:48:35 INFO - no previously-included directories found matching '.git*' 16:48:35 INFO - Successfully installed jsonschema functools32 16:48:35 INFO - Cleaning up... 16:48:35 INFO - Return code: 0 16:48:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:48:35 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')]} 16:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:35 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')]} 16:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:35 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:35 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 16:48:35 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 16:48:35 INFO - Using env: {'DISPLAY': ':0', 16:48:35 INFO - 'HOME': '/home/cltbld', 16:48:35 INFO - 'LANG': 'en_US.UTF-8', 16:48:35 INFO - 'LANGUAGE': 'en_US:en', 16:48:35 INFO - 'LOGNAME': 'cltbld', 16:48:35 INFO - 'MAIL': '/var/mail/cltbld', 16:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:35 INFO - 'MOZ_NO_REMOTE': '1', 16:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:35 INFO - 'NO_EM_RESTART': '1', 16:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:35 INFO - 'PWD': '/builds/slave/test', 16:48:35 INFO - 'SHELL': '/bin/bash', 16:48:35 INFO - 'SHLVL': '1', 16:48:35 INFO - 'TERM': 'linux', 16:48:35 INFO - 'TMOUT': '86400', 16:48:35 INFO - 'USER': 'cltbld', 16:48:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:35 INFO - '_': '/tools/buildbot/bin/python'} 16:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:48:35 INFO - Cleaning up... 16:48:35 INFO - Return code: 0 16:48:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:48:35 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')]} 16:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:35 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')]} 16:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:35 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:35 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 16:48:35 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 16:48:35 INFO - Using env: {'DISPLAY': ':0', 16:48:35 INFO - 'HOME': '/home/cltbld', 16:48:35 INFO - 'LANG': 'en_US.UTF-8', 16:48:35 INFO - 'LANGUAGE': 'en_US:en', 16:48:35 INFO - 'LOGNAME': 'cltbld', 16:48:35 INFO - 'MAIL': '/var/mail/cltbld', 16:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:35 INFO - 'MOZ_NO_REMOTE': '1', 16:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:35 INFO - 'NO_EM_RESTART': '1', 16:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:35 INFO - 'PWD': '/builds/slave/test', 16:48:35 INFO - 'SHELL': '/bin/bash', 16:48:35 INFO - 'SHLVL': '1', 16:48:35 INFO - 'TERM': 'linux', 16:48:35 INFO - 'TMOUT': '86400', 16:48:35 INFO - 'USER': 'cltbld', 16:48:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:35 INFO - '_': '/tools/buildbot/bin/python'} 16:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 16:48:36 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 16:48:36 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 16:48:36 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 16:48:36 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 16:48:36 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 16:48:36 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 16:48:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:48:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:48:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 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 16:48:38 INFO - Downloading docopt-0.6.1.tar.gz 16:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:48:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:48:38 INFO - Running setup.py install for blobuploader 16:48:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:48:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:48:38 INFO - Running setup.py install for requests 16:48:39 INFO - Running setup.py install for docopt 16:48:39 INFO - Successfully installed blobuploader requests docopt 16:48:39 INFO - Cleaning up... 16:48:39 INFO - Return code: 0 16:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:39 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')]} 16:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:39 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')]} 16:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:39 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:39 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 16:48:39 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 16:48:39 INFO - Using env: {'DISPLAY': ':0', 16:48:39 INFO - 'HOME': '/home/cltbld', 16:48:39 INFO - 'LANG': 'en_US.UTF-8', 16:48:39 INFO - 'LANGUAGE': 'en_US:en', 16:48:39 INFO - 'LOGNAME': 'cltbld', 16:48:39 INFO - 'MAIL': '/var/mail/cltbld', 16:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:39 INFO - 'MOZ_NO_REMOTE': '1', 16:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:39 INFO - 'NO_EM_RESTART': '1', 16:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:39 INFO - 'PWD': '/builds/slave/test', 16:48:39 INFO - 'SHELL': '/bin/bash', 16:48:39 INFO - 'SHLVL': '1', 16:48:39 INFO - 'TERM': 'linux', 16:48:39 INFO - 'TMOUT': '86400', 16:48:39 INFO - 'USER': 'cltbld', 16:48:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:39 INFO - '_': '/tools/buildbot/bin/python'} 16:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:39 INFO - Running setup.py (path:/tmp/pip-t8lF1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:39 INFO - Running setup.py (path:/tmp/pip-NgKO7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:39 INFO - Running setup.py (path:/tmp/pip-Uk5YyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:39 INFO - Running setup.py (path:/tmp/pip-iLl7k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:39 INFO - Running setup.py (path:/tmp/pip-pCixfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:39 INFO - Running setup.py (path:/tmp/pip-149fDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:39 INFO - Running setup.py (path:/tmp/pip-P4yQ_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:40 INFO - Running setup.py (path:/tmp/pip-WMCeSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:40 INFO - Running setup.py (path:/tmp/pip-fjm8ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:40 INFO - Running setup.py (path:/tmp/pip-qAXClG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:40 INFO - Running setup.py (path:/tmp/pip-FATU71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:40 INFO - Running setup.py (path:/tmp/pip-Zi9wBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:40 INFO - Running setup.py (path:/tmp/pip-YQotEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:40 INFO - Running setup.py (path:/tmp/pip-rcsaBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:40 INFO - Running setup.py (path:/tmp/pip-MOW3Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:40 INFO - Running setup.py (path:/tmp/pip-DT1w80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:40 INFO - Running setup.py (path:/tmp/pip-sDuqXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:48:40 INFO - Running setup.py install for manifestparser 16:48:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:48:40 INFO - Running setup.py install for mozcrash 16:48:40 INFO - Running setup.py install for mozdebug 16:48:41 INFO - Running setup.py install for mozdevice 16:48:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Running setup.py install for mozfile 16:48:41 INFO - Running setup.py install for mozhttpd 16:48:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Running setup.py install for mozinfo 16:48:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Running setup.py install for mozInstall 16:48:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Running setup.py install for mozleak 16:48:41 INFO - Running setup.py install for mozlog 16:48:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Running setup.py install for moznetwork 16:48:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:48:41 INFO - Running setup.py install for mozprocess 16:48:41 INFO - Running setup.py install for mozprofile 16:48:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:48:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:48:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:48:42 INFO - Running setup.py install for mozrunner 16:48:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:48:42 INFO - Running setup.py install for mozscreenshot 16:48:42 INFO - Running setup.py install for moztest 16:48:42 INFO - Running setup.py install for mozversion 16:48:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:48:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:48:42 INFO - Cleaning up... 16:48:42 INFO - Return code: 0 16:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:42 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:42 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 16:48:42 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 16:48:42 INFO - Using env: {'DISPLAY': ':0', 16:48:42 INFO - 'HOME': '/home/cltbld', 16:48:42 INFO - 'LANG': 'en_US.UTF-8', 16:48:42 INFO - 'LANGUAGE': 'en_US:en', 16:48:42 INFO - 'LOGNAME': 'cltbld', 16:48:42 INFO - 'MAIL': '/var/mail/cltbld', 16:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:42 INFO - 'MOZ_NO_REMOTE': '1', 16:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:42 INFO - 'NO_EM_RESTART': '1', 16:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:42 INFO - 'PWD': '/builds/slave/test', 16:48:42 INFO - 'SHELL': '/bin/bash', 16:48:42 INFO - 'SHLVL': '1', 16:48:42 INFO - 'TERM': 'linux', 16:48:42 INFO - 'TMOUT': '86400', 16:48:42 INFO - 'USER': 'cltbld', 16:48:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:42 INFO - '_': '/tools/buildbot/bin/python'} 16:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:42 INFO - Running setup.py (path:/tmp/pip-5QqurS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:42 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)) 16:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:42 INFO - Running setup.py (path:/tmp/pip-Xbxw4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:42 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)) 16:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:42 INFO - Running setup.py (path:/tmp/pip-A2gBOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:42 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)) 16:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:43 INFO - Running setup.py (path:/tmp/pip-BwoGUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:43 INFO - Running setup.py (path:/tmp/pip-BK_Q0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:43 INFO - Running setup.py (path:/tmp/pip-7heErS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:43 INFO - Running setup.py (path:/tmp/pip-xX6CuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:43 INFO - Running setup.py (path:/tmp/pip-oEinsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:43 INFO - Running setup.py (path:/tmp/pip-kbGPmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:43 INFO - Running setup.py (path:/tmp/pip-wC9VEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:43 INFO - Running setup.py (path:/tmp/pip-plNeRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:43 INFO - Running setup.py (path:/tmp/pip-3R59e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:43 INFO - Running setup.py (path:/tmp/pip-EGSIzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:43 INFO - Running setup.py (path:/tmp/pip-w7QzAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:43 INFO - Running setup.py (path:/tmp/pip-2jVUfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:43 INFO - Running setup.py (path:/tmp/pip-GFcsGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:43 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)) 16:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:43 INFO - Running setup.py (path:/tmp/pip-LFjHgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:44 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)) 16:48:44 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)) 16:48:44 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)) 16:48:44 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)) 16:48:44 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)) 16:48:44 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)) 16:48:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:48:44 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 16:48:44 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 16:48:44 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 16:48:44 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 16:48:44 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 16:48:44 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 16:48:45 INFO - Downloading blessings-1.6.tar.gz 16:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:48:45 INFO - Installing collected packages: blessings 16:48:45 INFO - Running setup.py install for blessings 16:48:46 INFO - Successfully installed blessings 16:48:46 INFO - Cleaning up... 16:48:46 INFO - Return code: 0 16:48:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:48:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:46 INFO - Reading from file tmpfile_stdout 16:48:46 INFO - Current package versions: 16:48:46 INFO - argparse == 1.2.1 16:48:46 INFO - blessings == 1.6 16:48:46 INFO - blobuploader == 1.2.4 16:48:46 INFO - docopt == 0.6.1 16:48:46 INFO - functools32 == 3.2.3-2 16:48:46 INFO - jsonschema == 2.5.1 16:48:46 INFO - manifestparser == 1.1 16:48:46 INFO - mozInstall == 1.12 16:48:46 INFO - mozcrash == 0.17 16:48:46 INFO - mozdebug == 0.1 16:48:46 INFO - mozdevice == 0.48 16:48:46 INFO - mozfile == 1.2 16:48:46 INFO - mozhttpd == 0.7 16:48:46 INFO - mozinfo == 0.9 16:48:46 INFO - mozleak == 0.1 16:48:46 INFO - mozlog == 3.3 16:48:46 INFO - moznetwork == 0.27 16:48:46 INFO - mozprocess == 0.23 16:48:46 INFO - mozprofile == 0.28 16:48:46 INFO - mozrunner == 6.12 16:48:46 INFO - mozscreenshot == 0.1 16:48:46 INFO - mozsystemmonitor == 0.3 16:48:46 INFO - moztest == 0.7 16:48:46 INFO - mozversion == 1.4 16:48:46 INFO - psutil == 3.1.1 16:48:46 INFO - requests == 1.2.3 16:48:46 INFO - wsgiref == 0.1.2 16:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:46 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')]} 16:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:46 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')]} 16:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:46 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:46 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 16:48:46 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 16:48:46 INFO - Using env: {'DISPLAY': ':0', 16:48:46 INFO - 'HOME': '/home/cltbld', 16:48:46 INFO - 'LANG': 'en_US.UTF-8', 16:48:46 INFO - 'LANGUAGE': 'en_US:en', 16:48:46 INFO - 'LOGNAME': 'cltbld', 16:48:46 INFO - 'MAIL': '/var/mail/cltbld', 16:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:46 INFO - 'MOZ_NO_REMOTE': '1', 16:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:46 INFO - 'NO_EM_RESTART': '1', 16:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:46 INFO - 'PWD': '/builds/slave/test', 16:48:46 INFO - 'SHELL': '/bin/bash', 16:48:46 INFO - 'SHLVL': '1', 16:48:46 INFO - 'TERM': 'linux', 16:48:46 INFO - 'TMOUT': '86400', 16:48:46 INFO - 'USER': 'cltbld', 16:48:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:46 INFO - '_': '/tools/buildbot/bin/python'} 16:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 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)) 16:48:46 INFO - Cleaning up... 16:48:46 INFO - Return code: 0 16:48:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:48:46 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')]} 16:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:46 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')]} 16:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:46 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 0xbcd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', '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 16:48:46 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 16:48:46 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 16:48:46 INFO - Using env: {'DISPLAY': ':0', 16:48:46 INFO - 'HOME': '/home/cltbld', 16:48:46 INFO - 'LANG': 'en_US.UTF-8', 16:48:46 INFO - 'LANGUAGE': 'en_US:en', 16:48:46 INFO - 'LOGNAME': 'cltbld', 16:48:46 INFO - 'MAIL': '/var/mail/cltbld', 16:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:46 INFO - 'MOZ_NO_REMOTE': '1', 16:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:46 INFO - 'NO_EM_RESTART': '1', 16:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:46 INFO - 'PWD': '/builds/slave/test', 16:48:46 INFO - 'SHELL': '/bin/bash', 16:48:46 INFO - 'SHLVL': '1', 16:48:46 INFO - 'TERM': 'linux', 16:48:46 INFO - 'TMOUT': '86400', 16:48:46 INFO - 'USER': 'cltbld', 16:48:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:46 INFO - '_': '/tools/buildbot/bin/python'} 16:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:48:46 INFO - Cleaning up... 16:48:46 INFO - Return code: 0 16:48:46 INFO - Running post-action listener: _resource_record_post_action 16:48:46 INFO - Running post-action listener: _start_resource_monitoring 16:48:46 INFO - Starting resource monitoring. 16:48:46 INFO - [mozharness: 2016-08-11 23:48:46.822711Z] Finished create-virtualenv step (success) 16:48:46 INFO - [mozharness: 2016-08-11 23:48:46.823148Z] Running install step. 16:48:46 INFO - Running pre-action listener: _resource_record_pre_action 16:48:46 INFO - Running main action method: install 16:48:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:47 INFO - Reading from file tmpfile_stdout 16:48:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:48:47 INFO - Reading from file tmpfile_stdout 16:48:47 INFO - Output received: 16:48:47 INFO - Usage: mozinstall [options] installer 16:48:47 INFO - Options: 16:48:47 INFO - -h, --help show this help message and exit 16:48:47 INFO - -d DEST, --destination=DEST 16:48:47 INFO - Directory to install application into. [default: 16:48:47 INFO - "/builds/slave/test"] 16:48:47 INFO - --app=APP Application being installed. [default: firefox] 16:48:47 INFO - mkdir: /builds/slave/test/build/application 16:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:49:03 INFO - Reading from file tmpfile_stdout 16:49:03 INFO - Output received: 16:49:03 INFO - /builds/slave/test/build/application/firefox/firefox 16:49:03 INFO - Running post-action listener: _resource_record_post_action 16:49:03 INFO - [mozharness: 2016-08-11 23:49:03.635435Z] Finished install step (success) 16:49:03 INFO - [mozharness: 2016-08-11 23:49:03.635714Z] Running run-tests step. 16:49:03 INFO - Running pre-action listener: _resource_record_pre_action 16:49:03 INFO - Running main action method: run_tests 16:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:49:03 INFO - Python 2.7.3 16:49:03 INFO - Return code: 0 16:49:03 INFO - grabbing minidump binary from tooltool 16:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:03 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 0xe8b570>, '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 0xe8c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:49:03 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 16:49:03 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 16:49:03 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 16:49:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:03 INFO - Return code: 0 16:49:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:49:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:49:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:49:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:49:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 16:49:03 INFO - Using env: {'DISPLAY': ':0', 16:49:03 INFO - 'HOME': '/home/cltbld', 16:49:03 INFO - 'LANG': 'en_US.UTF-8', 16:49:03 INFO - 'LANGUAGE': 'en_US:en', 16:49:03 INFO - 'LOGNAME': 'cltbld', 16:49:03 INFO - 'MAIL': '/var/mail/cltbld', 16:49:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:03 INFO - 'MOZ_NO_REMOTE': '1', 16:49:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:03 INFO - 'NO_EM_RESTART': '1', 16:49:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:03 INFO - 'PWD': '/builds/slave/test', 16:49:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:03 INFO - 'SHELL': '/bin/bash', 16:49:03 INFO - 'SHLVL': '1', 16:49:03 INFO - 'TERM': 'linux', 16:49:03 INFO - 'TMOUT': '86400', 16:49:03 INFO - 'USER': 'cltbld', 16:49:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216', 16:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:03 INFO - '_': '/tools/buildbot/bin/python'} 16:49:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:49:03 INFO - mozversion application_buildid: 20160811134122 16:49:03 INFO - mozversion application_changeset: 352ba6b9460229871e3031e19f6fcc2c6a6afb25 16:49:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:49:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:03 INFO - mozversion application_name: Firefox 16:49:03 INFO - mozversion application_remotingname: firefox-dev 16:49:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:49:03 INFO - mozversion application_vendor: Mozilla 16:49:03 INFO - mozversion application_version: 50.0a2 16:49:03 INFO - mozversion platform_buildid: 20160811134122 16:49:03 INFO - mozversion platform_changeset: 352ba6b9460229871e3031e19f6fcc2c6a6afb25 16:49:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:49:03 INFO - mozversion platform_version: 50.0a2 16:49:03 INFO - using testdate: 1470959343 16:49:03 INFO - actual date: 1470959343 16:49:03 INFO - starting webserver on 'localhost:50105' 16:49:03 INFO - SUITE-START | Running 2 tests 16:49:03 INFO - TEST-START | dromaeo_css 16:49:03 INFO - operating with platform_type : linux_ 16:49:03 INFO - Initialising browser for dromaeo_css test... 16:49:03 INFO - TEST-INFO | started process 24974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8ZNEY/profile http://localhost:50105/getInfo.html) 16:49:07 INFO - PROCESS | 24974 | __metrics Screen width/height:1600/1200 16:49:07 INFO - PROCESS | 24974 | colorDepth:24 16:49:07 INFO - PROCESS | 24974 | Browser inner width/height: 1024/697 16:49:07 INFO - PROCESS | 24974 | __metrics 16:49:08 ERROR - PROCESS | 24974 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:49:09 INFO - TEST-INFO | 24974: exit 0 16:49:09 INFO - Browser initialized. 16:49:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:09 INFO - TEST-INFO | started process 25100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8ZNEY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:20 INFO - PROCESS | 25100 | RSS: Main: 152621056 16:49:20 INFO - PROCESS | 25100 | 16:50:10 INFO - PROCESS | 25100 | 1470959410452 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] 16:52:18 INFO - PROCESS | 25100 | Cycle 1(1): loaded http://localhost:50105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50105/tests/dromaeo/cssquery-ext.html) 16:52:19 INFO - PROCESS | 25100 | RSS: Main: 158404608 16:52:19 INFO - PROCESS | 25100 | 16:55:21 INFO - PROCESS | 25100 | Cycle 1(1): loaded http://localhost:50105/tests/dromaeo/cssquery-ext.html (next: http://localhost:50105/tests/dromaeo/cssquery-jquery.html) 16:55:22 INFO - PROCESS | 25100 | RSS: Main: 153509888 16:55:22 INFO - PROCESS | 25100 | 16:58:24 INFO - PROCESS | 25100 | Cycle 1(1): loaded http://localhost:50105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50105/tests/dromaeo/cssquery-mootools.html) 16:58:25 INFO - PROCESS | 25100 | RSS: Main: 154017792 16:58:25 INFO - PROCESS | 25100 | 17:01:26 INFO - PROCESS | 25100 | Cycle 1(1): loaded http://localhost:50105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50105/tests/dromaeo/cssquery-prototype.html) 17:01:27 INFO - PROCESS | 25100 | RSS: Main: 152817664 17:01:27 INFO - PROCESS | 25100 | 17:04:30 INFO - PROCESS | 25100 | Cycle 1(1): loaded http://localhost:50105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50105/tests/dromaeo/cssquery-yui.html) 17:04:30 INFO - PROCESS | 25100 | RSS: Main: 155168768 17:04:30 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | Cycle 1(1): loaded http://localhost:50105/tests/dromaeo/cssquery-yui.html (next: http://localhost:50105/tests/dromaeo/cssquery-dojo.html) 17:07:33 INFO - PROCESS | 25100 | RSS: Main: 155176960 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | __start_tp_report 17:07:33 INFO - PROCESS | 25100 | _x_x_mozilla_page_load 17:07:33 INFO - PROCESS | 25100 | _x_x_mozilla_page_load_details 17:07:33 INFO - PROCESS | 25100 | |i|pagename|runs| 17:07:33 INFO - PROCESS | 25100 | |0;dojo.html;3263.934721305574;3296.0441471973145;3309.751768617354;3309.768316217865;3314.2542927841237;5626.437356264377;5679.914801277974;5680.886382272352;5699.515541178999;5736.254286942692;5583.190437386576;5678.886422271552;5707.12166468537;5712.542996560275;5739.196512488255;5121.641485096054;5164.483551644824;5182.740862956856;5213.218017297398;5257.526822585966;5111.795528178868;5118.4113826909825;5143.614228932826;5171.612129090333;5184.481551844823;5144.125498665236;5154.381474223099;5178.922316165261;5227.973860130694;5271.815486457975;5217.373915130171;5223.973880130613;5229.477052294778;5231.372235331765;5268.420473747885;4970.15507363749;5006.874828129289;5096.719680417576;5150.124478838607;5220.6084543659;5564.081926482126;5651.886962260732;5654.886902261973;5656.236408084897;5668.404817494145;6033.849153771191;6051.062085376773;6070.9982852829235;6077.453029227347;6090.36051214625;5935.49548288396;6010.248718910137;6118.785842495491;6137.386261373871;6141.969290153565;5617.578681598897;5689.2603961485565;5694.20281160642;5710.257666503369;5762.625429347079;6223.813285601439;6227.906581401283;6244.219472565929;6247.500199983991;6267.6866156691985;5871.266091738533;5875.559333049953;5922.792702255487;5997.580169388101;6038.879222415527;5979.701014949323;6094.238220222473;6100.542459315569;6106.542009349317;6123.755049797958;6019.398060193946;6040.395960403925;6079.361667024988;6093.390660933871;6104.816855494342;5894.852628684232;5975.43233392827;6085.817425477243;6089.269287685506;6097.939020609826;4603.309503574491;4684.929726054112;4687.742174180453;4708.011317623269;4709.364235828188;4166.604172603597;4171.124063946544;4176.83292668296;4186.832526698959;4207.789610519523;5605.131204663284;5624.55003599711;5868.589198756132;5880.411958804086;5880.852978675567;5949.970250148722;6028.5478589106;6056.909146362808;6082.847928801727;6085.69571521431;5750.25246717924;5750.396208398141;5751.626144300691;5764.798232061941;5779.450952159538;5092.032513822362;5134.666246693953;5177.938522602857;5177.948220517822;5211.530962213419;6263.31103578606;6343.841403964938;6362.713677884413;6372.936270637327;6391.360863913665;6169.907451388143;6175.166352542529;6176.3514830943;6194.659293738888;6215.65813880241;6095.3904609538695;6260.280067792262;6312.084747711648;6356.523260755369;6399.7440102395385;5952.434518720715;5990.880182396415;5994.430529099728;6001.669908154919;6039.698015099315;6087.269527656709;6098.603590766586;6116.724747386467;6144.293406258337;6149.046897730859;5768.077107662753;5827.912581311369;5892.057270836645;5913.91129133072;5920.230370051866;5960.731767070579;5972.492338151132;5977.850553736192;5996.340402555628;5998.9100163496705;5894.115882617642;5896.587238893237;5898.262717160355;5939.881202375842;5995.940040599538;5900.43945825146;5937.435943585352;5961.254843144607;5964.642121472725;6016.398360163948;5872.207252020922;5941.881162376815;5953.553483488669;5960.642361458326;5985.760569577168 17:07:33 INFO - PROCESS | 25100 | |1;ext.html;581.595790925307;635.1711017122655;655.285738544986;655.2922843329208;704.4927652090493;43172.568274317244;47851.52148478514;47909;47925.52074479254;47929.52070479294;46627;47146.29280560794;47515.76242118784;47618.761906190506;47719.52280477194;9140.177384035436;9229.307801914849;9283.860742088875;9291.070892910722;9313.813723725521;9328.39365441244;9402.81194376112;9463.81072378552;9469.195118414944;9475.052494750538;9403.858942115874;9459.337846350758;9461.337706360524;9480.099390557885;9480.241580673564;9425.38734982224;9429.66996155138;9447.763805904839;9449.338546301728;9466.479343636098;9376.437413755197;9436.103570160823;9438.716838494856;9440.905590944072;9447.385919915252;44621.77689111534;44989.55010449886;45031;45211;45235;4090.713650044498;4502;4644.303354496818;4739.0758802033615;4773.06925149596;36448;36478.27043459116;36618.267634647425;36818.263634727155;37991;4648.418947631546;4659.5573420525;4664.137134630104;4697.553732395417;4699.953000469985;365757;368473;369295;370281;371063;38603.80698096492;68155.65922170457;68408;68445;68519.65740171267;39048.60951390507;41445.58554414478;41915;42115.368269475985;42121;14330.21183834899;14384.208868512333;14436.206008669624;14459.638509037359;14490;11564.13269004828;11569.76860462786;11608.361540115375;11620.535178592761;11625.24435911663;9322.953385233166;9351.205147562398;9392.154706076486;9434.292428067922;9537.427754334762;3450.810205438675;3495.685388315064;3505.1762835733584;3532.4877892705413;3563.501109844624;1094.9835752463719;1120.5461787975883;1152.4065106470175;1178.640514643042;1208.5528354508713;34923.30153396918;34950.30099397998;35416;35676.97430069584;35711.64288357083;1184.1769969870857;1199.4122879789015;1202.0263586494793;1206.4088596587785;1258.150748244931;18468.81531184671;18562.350317738816;18694;18711.625767484846;18818.059097045094;647320;649247;948832;952324;959206;62903.6854815723;63903;69612.3038769616;69897;70199;1434.978475322871;1467.4130347860728;1499.6850661361236;1507.0580886945659;1514.8560886715745;35552.28895422129;35979.28041439209;36267.637323626426;36378.42045505194;36492.45261321029;59406.70296648489;60577.39422605894;60647.393526064174;60704.392956069874;60719.39280607137;543014;549874;550705;552618;552698;50434.74782626063;50595.49404505908;50702.74648626881;51254.74372628262;51648;58022.41977580339;58337;58843.70578147082;63833.3616663846;64482.67758661177;41852.37221441742;44562.77718611386;47325.763371182926;48343.27485087797;49605.50394496009;48408.75795620999;48429.27356089591;49129.263061053396;49245.261321079495;50145.24782128344;48480.27279590879;48881.51118488912;49056.75471622619;49188.50811491839;51838.481615183366;43120.56879431166;43181;43652.781736091114;43830.34254486249;43903;32205.355892881544;32663.34673306473;32832;32860.83569582137;33500 17:07:33 INFO - PROCESS | 25100 | |2;jquery.html;405.74235360546044;409.19388804056;428.0732214755055;433.1402166699103;434.54372908446146;19372.321968731096;20364.99999999998;20899.582008359823;21388.35834924951;21636.134554617835;20349.389518314474;20517;20633.38099857007;20899.477513062142;20999.37001889942;5786.739596718136;5978.671173085479;6009.87980240395;6011.2786465624185;6011.849703757397;5856.092305692625;5856.2094117294255;5875.441833025856;5886.676232807194;5956.225690660208;5749.482546570808;5838.824835254928;5863.58954873159;5877.529797616202;5898.8230353089475;5794.159846822229;5829.854253643651;5840.795572154975;5869.999999999979;5885.264341957255;5311.9468805311835;5333.1733581294575;5351.545118664879;5352.143657014859;5360.437154098802;24601.50796984068;24785.62821557678;24845.875770621213;24850.751492485026;24899.875500622562;2314.259436980167;2615.9476810463875;3023.7883348165637;3278.4426647469986;3345.2974875276223;11093.611723589636;11301.208915375926;11344;11366.147538934612;11537;2051.3845846246218;2065.8450616203845;2126.0645316061036;2129.4676330917273;2143.949464762271;65397;87847.12152878453;88311.55844220801;98542;102262;17802.37691680785;18604.44186674402;18639.670041244844;19023.431836702144;19143.712844307345;35300.64699353025;35852.282954340764;35862.820685896404;35955.28089438197;36031.4595281071;9404.200642945289;9572.186364159124;9717.862070344512;9934.105930466292;9989.850152247722;7752.7286544971785;7798.961005194938;7805.33654639362;7971.163027882105;8006.639701213459;9353.204977576846;9440.244780417688;9652;9837.360571562825;9838.409695418297;3562.98218508911;3576.195356044869;3587.65917237862;3681.3005528949416;3806.6193380662266;966.6471737815788;1005.5525291245472;1016.506994107857;1053.1048608682559;1090.1003331139132;19784.20863165486;20838.895805521177;21120.627159234602;21136.78863211379;21334.679979800316;1036.9429681367596;1046.947652617366;1049.6483677967967;1053.331134729437;1091.858058452412;11089.27919685218;11714.355710435837;11745.236559623598;11747.412629368497;11803.527858885549;525969;545850;555295;555604;557144;94900;95167.52416238013;96297;97925.51037244768;97952;997.491279447487;1011.9392836429838;1028.1106842581262;1038.0294424712918;1041.1150522056191;18174.818251817313;18741.250349986392;18968.810311896705;19143.329983450512;19349.613007739485;44154;44773.32840007338;45406.31890521711;45751.54248457606;45878.85302867455;63059.684701576196;63061.36938630555;63657.68171159115;64031.6798416005;65995;9166.908330916873;9428.811423771624;9431.292653050912;9477.383970041925;9511.429314241168;12446.315452650191;13747.518836840663;13940.233287168898;14007.859921400655;14315.498957536436;11983.460744266355;12175.817362739388;12561.623151305475;12570.811437828257;12845.807312890127;12075.51697932073;12361.876381236432;12506.812397814221;12532.624021279376;12566.811497827357;11540.653780386601;12159.75680486403;12344.938275308567;12480.75038499243;12486.375681216085;7994.360451163777;8154.877676834971;8256.25693687571;9037.231835294073;9359.204467620057;9496.715098547054;12110.394480275774;12500.874991249972;12697.873021269668;13049.086563940813 17:07:33 INFO - PROCESS | 25100 | |3;mootools.html;1524.161711058918;1561.515930061681;1722.2594284457687;1827.8629102817283;1856.5358660334916;8639.654413823455;9013.954930225347;9254.583543740531;9617.615295388185;9619.951900240489;9317.021712720169;9670.516474176298;9681.080297371738;9739.902600973988;9752.171065459444;2475.9257222283313;2527.0776166699206;2529.456166924111;2534.759197876199;2535.4168541235526;2487.800975921931;2560.46230291639;2572.588385858254;2574.897004119833;2575.420530380668;2520.2943175910773;2525.1919385796555;2530.215633153728;2542.9872850635816;2549.1078122657013;2451.9877400612972;2467.8395904266254;2471.9629205561932;2509.2346834215555;2523.949521009588;2425.9757402425926;2481.2308184462695;2484.080890070685;2487.4278915849277;2532.683414573178;9817.410955342702;9898;9908.355956862853;9916.702498925044;9939.105480506789;5740.253767010262;5893.852653683649;5911.379305172981;5915.349311575723;5928.7332070056955;3421.794692318469;3448.8792892248903;3520.6655367740022;3581.4806853006166;3635.600083990759;1127.4588197665084;1193.421190722499;1205.3491114797998;1210.661014915825;1228.8218208359738;13744.725105497933;13846.861531384659;13853.722925541533;13864.792028119586;13910.791338129937;5009.924851127236;5140.357455318085;5231.267622532772;5270.051390749625;5277.393099793496;11681.18231723788;11695.415229238504;11720.17958742897;11727.35499547516;11751.059915206763;5905.084711869581;5915.408459154136;5923.881522369528;5946.494547963385;5965.73154208053;4880.926786098212;5291.761870715827;5385.973070134624;5391.191321301758;5409.513143817076;4452.688311818141;4511.684182107221;4517.593416592523;4528.50186479487;4546.499885012646;1408.021425109539;1441.7837324401214;1459.7518421868097;1463.0636392708675;1477.4016523308078;1041.1202533858877;1045.7333379988206;1055.9788804224027;1059.9841002384971;1067.130288814629;6292.370762923762;6341.936580634135;6427.614343139427;6484.935150648527;6605.57063790852;501.53357377639145;507.6091409614576;507.64464874587935;512.4107276631903;518.6084506197872;4506.053728716941;4534.047849951481;4547.363369128325;4596.333531637893;4603.056373443436;10962.56149754001;11849.822252666218;12104.092193085553;12209.633710988684;12256.938715306545;11210.55157793679;11333.43332833355;11709.473073711704;11728.94135529317;11757.059435245159;8888.511131887808;9001.324900632479;9002.864957025518;9005.694174344815;9038.593263303168;6350.4919606432295;6445.967770161119;6503.837404064936;6507.642079685663;6545.14913061299;10791.244612877023;11072.833907491555;11150;11247.66257012291;11302.547898084313;10501.36991780465;11298.435078246219;11398.031167350868;11414;11561.30632162073;8962.551872406224;9093.499857507635;9206.907930920874;9220.815583688154;9428.669996550088;9684.854727178958;9702.70891873245;9707.223422126353;9716.75708107303;9750.463724495221;8026.558539280396;8289.461185022954;8352.540610266493;8381.078081411162;8689.522076285612;8099.554524501209;8175.059868115005;8237.258646721824;8254.504729716236;8349.415540912078;7606.619669016416;7659.042619672541;7685.269899359552;7694.307512323918;7699.846003080019;5545.750441230073;5638.85902852432;5724.313082430135;5846.853828654318;5855.94144058554;5904.084866845646;5937.168796368598;6040.214772079602;6063.272407311151;6087.726052327567 17:07:33 INFO - PROCESS | 25100 | |4;prototype.html;351.86277351832786;353.8319298333292;357.79248036139023;362.089345296579;363.2045819654957;5883.323417806953;5934.554908381867;5951.494122999545;5958.582899197063;5977.850553736159;5739.253896993385;5774.152271273194;5804.82585522434;5821.476067153955;5865;4544.386507821451;4574.954250457503;4591.403117594708;4592.655550833684;4594.908101837961;4589.35748995141;4589.931151032737;4600.35595016698;4601.263797792354;4624.838130665427;4502.2571275739465;4537.977310113445;4544.863654090383;4580.3358513015755;4600.148972440093;4505.797239124215;4511.932321015187;4560.635149188073;4561.566651168134;4574.88562785933;4048.898777530556;4057.371107478316;4073.551909289976;4080.6939479538855;4081.653059489947;5572.136318870582;5676.631018983794;5705.372409035002;5734.16854556087;5750.769969201227;5200.453952334989;5278.656887302313;5301.1783173608155;5314.511936657742;5320.494553017457;6090.8781824363705;6164.106204600353;6181.258249010148;6187.969060154715;6198.4813720638285;4222.59885310895;4395.252807022814;4460.1525710114975;4473.597376236122;4507.256302710049;6086.543509236825;6248.937510624926;6293.143522660826;6320.5891617044745;6326.367363263636;4486.932696009562;4492.865214043584;4505.873531617096;4521.751303678329;4542.500324964251;4573.748443835621;4581.885452863705;4583.129205450954;4608;4610.40064791575;5087.898242035212;5199.66202196856;5232.686038837682;5261.289725887033;5279.366476022825;6151.769646070804;6160.905292200584;6171.56799024073;6178.41305076017;6188.040853667599;1564.2960667699354;1572.7640853871783;1578.0373971877145;1587.206396801599;1591.4111778641977;984.542187882638;984.9113579777854;995.6415690351467;999.6900960702205;1010.6967909627083;5260.710660913686;5273.44628813969;5278.683279003272;5301.231321458367;5369.24830523727;5558.610897237155;5571.359293681197;5633.887322253614;5634.436556344414;5672.943270567242;5319.707416092075;5334.37301623001;5565.582581306418;5919.467247947706;5988.461038506555;3331.2504686445354;3360.6639336066196;3369.949450758241;3387.644297348743;3389.4748412432896;6321.431071203614;6461.741530338828;6502.60984340941;6529.183852018497;6550.901736473957;6458.6770661466735;6466.515011374166;6474.223093228748;6488.967555162194;6500.772472963518;6312.842178945563;6482.448991835747;6505.316941721146;6515.315891831384;6517.3808488193545;6287.30839607652;6294.622322660655;6326.462250708557;6326.899819088521;6400.775972840928;6214.918002469223;6266.929204689578;6272.435480806749;6299.842503937438;6324.936750632435;6215.254169499508;6354.936450635434;6495.512836537184;6496.220453545605;6514.9348506514325;4458.665600080072;4486.237339652333;4502.662300327423;4505.774711264489;4513.323001549663;6153.292371377349;6276.74893004293;6279.277883043325;6387.297397286387;6393.904091438725;6147.108669243024;6184.5980011299125;6188.628682278898;6196.721147548281;6211.254649442096;5873;6150.723217455315;6153.907691384722;6187.474064704371;6242.906356404748;6073.787417440369;6081.300650425258;6100.6949652516305;6157;6196.411340922605;6109.663968481598;6175.1902884188485;6237.937620623736;6250.656213908279;6284.780032699016;5804.796832110856;6011.398860113954;6012.038073908154;6029.306629737636;6047.395260473917 17:07:33 INFO - PROCESS | 25100 | |5;yui.html;810.4245985350401;818.2186012358198;826.4091174810013;917.7155081924602;921.3228277216249;16537.834621653794;16786.74819877701;17055.232514536845;17137.22882470289;18036.098195090257;17790.555236119104;18034.5491362716;18095.09524523775;18108.185131669074;18112.094395280248;871.6339137562223;899.1727610598265;906.6010955179732;907.1654078248027;907.7912080221553;735.1325435985535;866.6923242249005;881.8941726992738;899.0425197165031;899.8155378147464;899.9055099214586;902.0303174087849;902.1880307723036;905.5245995852165;906.8277027364812;889.3907673243849;897.8922529296461;900.7612982559627;901.0944001278706;902.4179404284233;659.4427708586237;661.2759028863387;662.258270736778;662.2615783401473;663.0485253661012;15028.323725432381;15030.17334046627;15092.622684432867;15147.848521514865;15205.239738013055;15596.59630633237;16353.345866165339;16452.917735411367;16568.917155414147;16638.83361166397;13340.799888001688;13394.129381590263;13441.596752097452;13570.050096493249;13661.385237664328;3919.9216015679526;4025.5169379674626;4100.097978444737;4151.27352713274;4233.259179643581;93364.53317733436;94082.52958735163;94409.52795236048;94959.52520237424;96374.51812740891;11399.544018239178;11646;11693.123015773852;12410.262563241153;12872.227666339862;23632.7636723634;23651.172208972603;23839;23890.64164037541;23898.163564275168;8496.915030849612;8499.787505312293;8534.74395768128;8577.528235946958;8609.69866054685;5102.846914592568;5180.922286165711;5214.608904332114;5225.6603320784025;5315.681059136464;3946.546147193052;4041.1109555898242;4063.9390409143884;4068.3287257602756;4071.6131967463043;661.147120214927;670.5540815357732;693.1405057728381;695.3811108113783;698.9231184569693;722.2055738687507;768.4659161882438;784.9803754906173;794.5550491724653;805.8468890910708;10616.097631701392;11098.944505277583;11504.482298296596;11574.247673901338;11615.178305353993;747.9065116860393;764.8776195808755;775.5230533222028;815.2825513548158;823.5100115431309;5224.477552244821;5429.67421954684;5455.1271796512365;5529.612927095145;5538.9169162462595;71683.2831671687;88420;106535;129913;134166;77938.61030694924;115669.42165289288;116730;118025;120165.39917300358;78731;79932.20067799247;80153;89185;91544.54227728953;10297.40390239514;10687.786244274916;11327.716807079889;11385.601503947322;11630.185886987829;46512;46733.29900051434;48583.75708121437;53940.112096076446;54921.72539137279;50713;52007.47992520178;63997;77310.2268977303;83981.58009209915;13699.657508562366;13766.862331376959;14530.418783248551;14930.701385972437;14975.326110324844;16306.755398669267;16558.337666493688;16634.3346266148;16650.417235396704;17704.734428983316;15501.457448989231;15667.921660391625;16089.597760056093;16779.9865313145;16903.070331131414;13834.308284585932;14450.421983120557;14481.710365792836;14756.48352307664;15048.473303434328;15606.063636181865;15642.530724078295;15762.76355854686;15905.681886361977;16276.67446651084;11539;12237.571684990982;12491.250524968531;12607.558735444216;12845.678858028625;12262;12712.74574508523;13054.282014489294;13115.344232788131;13416.262105584286 17:07:33 INFO - PROCESS | 25100 | __end_tp_report 17:07:33 INFO - PROCESS | 25100 | __start_cc_report 17:07:33 INFO - PROCESS | 25100 | _x_x_mozilla_cycle_collect,336 17:07:33 INFO - PROCESS | 25100 | __end_cc_report 17:07:33 INFO - PROCESS | 25100 | __startTimestamp1470960453356__endTimestamp 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | ------- Summary: start ------- 17:07:33 INFO - PROCESS | 25100 | Number of tests: 6 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | [#0] dojo.html Cycles:165 Average:5652.78 Median:5894.85 stddev:641.95 (10.9%) stddev-sans-first:615.96 17:07:33 INFO - PROCESS | 25100 | Values: 3263.9 3296.0 3309.8 3309.8 3314.3 5626.4 5679.9 5680.9 5699.5 5736.3 5583.2 5678.9 5707.1 5712.5 5739.2 5121.6 5164.5 5182.7 5213.2 5257.5 5111.8 5118.4 5143.6 5171.6 5184.5 5144.1 5154.4 5178.9 5228.0 5271.8 5217.4 5224.0 5229.5 5231.4 5268.4 4970.2 5006.9 5096.7 5150.1 5220.6 5564.1 5651.9 5654.9 5656.2 5668.4 6033.8 6051.1 6071.0 6077.5 6090.4 5935.5 6010.2 6118.8 6137.4 6142.0 5617.6 5689.3 5694.2 5710.3 5762.6 6223.8 6227.9 6244.2 6247.5 6267.7 5871.3 5875.6 5922.8 5997.6 6038.9 5979.7 6094.2 6100.5 6106.5 6123.8 6019.4 6040.4 6079.4 6093.4 6104.8 5894.9 5975.4 6085.8 6089.3 6097.9 4603.3 4684.9 4687.7 4708.0 4709.4 4166.6 4171.1 4176.8 4186.8 4207.8 5605.1 5624.6 5868.6 5880.4 5880.9 5950.0 6028.5 6056.9 6082.8 6085.7 5750.3 5750.4 5751.6 5764.8 5779.5 5092.0 5134.7 5177.9 5177.9 5211.5 6263.3 6343.8 6362.7 6372.9 6391.4 6169.9 6175.2 6176.4 6194.7 6215.7 6095.4 6260.3 6312.1 6356.5 6399.7 5952.4 5990.9 5994.4 6001.7 6039.7 6087.3 6098.6 6116.7 6144.3 6149.0 5768.1 5827.9 5892.1 5913.9 5920.2 5960.7 5972.5 5977.9 5996.3 5998.9 5894.1 5896.6 5898.3 5939.9 5995.9 5900.4 5937.4 5961.3 5964.6 6016.4 5872.2 5941.9 5953.6 5960.6 5985.8 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | [#1] ext.html Cycles:180 Average:74456.71 Median:26127.42 stddev:166653.52 (637.8%) stddev-sans-first:167028.73 17:07:33 INFO - PROCESS | 25100 | Values: 581.6 635.2 655.3 655.3 704.5 43172.6 47851.5 47909.0 47925.5 47929.5 46627.0 47146.3 47515.8 47618.8 47719.5 9140.2 9229.3 9283.9 9291.1 9313.8 9328.4 9402.8 9463.8 9469.2 9475.1 9403.9 9459.3 9461.3 9480.1 9480.2 9425.4 9429.7 9447.8 9449.3 9466.5 9376.4 9436.1 9438.7 9440.9 9447.4 44621.8 44989.6 45031.0 45211.0 45235.0 4090.7 4502.0 4644.3 4739.1 4773.1 36448.0 36478.3 36618.3 36818.3 37991.0 4648.4 4659.6 4664.1 4697.6 4700.0 365757.0 368473.0 369295.0 370281.0 371063.0 38603.8 68155.7 68408.0 68445.0 68519.7 39048.6 41445.6 41915.0 42115.4 42121.0 14330.2 14384.2 14436.2 14459.6 14490.0 11564.1 11569.8 11608.4 11620.5 11625.2 9323.0 9351.2 9392.2 9434.3 9537.4 3450.8 3495.7 3505.2 3532.5 3563.5 1095.0 1120.5 1152.4 1178.6 1208.6 34923.3 34950.3 35416.0 35677.0 35711.6 1184.2 1199.4 1202.0 1206.4 1258.2 18468.8 18562.4 18694.0 18711.6 18818.1 647320.0 649247.0 948832.0 952324.0 959206.0 62903.7 63903.0 69612.3 69897.0 70199.0 1435.0 1467.4 1499.7 1507.1 1514.9 35552.3 35979.3 36267.6 36378.4 36492.5 59406.7 60577.4 60647.4 60704.4 60719.4 543014.0 549874.0 550705.0 552618.0 552698.0 50434.7 50595.5 50702.7 51254.7 51648.0 58022.4 58337.0 58843.7 63833.4 64482.7 41852.4 44562.8 47325.8 48343.3 49605.5 48408.8 48429.3 49129.3 49245.3 50145.2 48480.3 48881.5 49056.8 49188.5 51838.5 43120.6 43181.0 43652.8 43830.3 43903.0 32205.4 32663.3 32832.0 32860.8 33500.0 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | [#2] jquery.html Cycles:180 Average:32619.78 Median:19714.24 stddev:90172.34 (457.4%) stddev-sans-first:90392.85 17:07:33 INFO - PROCESS | 25100 | Values: 405.7 409.2 428.1 433.1 434.5 19372.3 20365.0 20899.6 21388.4 21636.1 20349.4 20517.0 20633.4 20899.5 20999.4 5786.7 5978.7 6009.9 6011.3 6011.8 5856.1 5856.2 5875.4 5886.7 5956.2 5749.5 5838.8 5863.6 5877.5 5898.8 5794.2 5829.9 5840.8 5870.0 5885.3 5311.9 5333.2 5351.5 5352.1 5360.4 24601.5 24785.6 24845.9 24850.8 24899.9 2314.3 2615.9 3023.8 3278.4 3345.3 11093.6 11301.2 11344.0 11366.1 11537.0 2051.4 2065.8 2126.1 2129.5 2143.9 65397.0 87847.1 88311.6 98542.0 102262.0 17802.4 18604.4 18639.7 19023.4 19143.7 35300.6 35852.3 35862.8 35955.3 36031.5 9404.2 9572.2 9717.9 9934.1 9989.9 7752.7 7799.0 7805.3 7971.2 8006.6 9353.2 9440.2 9652.0 9837.4 9838.4 3563.0 3576.2 3587.7 3681.3 3806.6 966.6 1005.6 1016.5 1053.1 1090.1 19784.2 20838.9 21120.6 21136.8 21334.7 1036.9 1046.9 1049.6 1053.3 1091.9 11089.3 11714.4 11745.2 11747.4 11803.5 525969.0 545850.0 555295.0 555604.0 557144.0 94900.0 95167.5 96297.0 97925.5 97952.0 997.5 1011.9 1028.1 1038.0 1041.1 18174.8 18741.3 18968.8 19143.3 19349.6 44154.0 44773.3 45406.3 45751.5 45878.9 63059.7 63061.4 63657.7 64031.7 65995.0 9166.9 9428.8 9431.3 9477.4 9511.4 12446.3 13747.5 13940.2 14007.9 14315.5 11983.5 12175.8 12561.6 12570.8 12845.8 12075.5 12361.9 12506.8 12532.6 12566.8 11540.7 12159.8 12344.9 12480.8 12486.4 7994.4 8154.9 8256.3 9037.2 9359.2 9496.7 12110.4 12500.9 12697.9 13049.1 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | [#3] mootools.html Cycles:180 Average:6393.85 Median:4945.43 stddev:3672.90 (74.3%) stddev-sans-first:3664.97 17:07:33 INFO - PROCESS | 25100 | Values: 1524.2 1561.5 1722.3 1827.9 1856.5 8639.7 9014.0 9254.6 9617.6 9620.0 9317.0 9670.5 9681.1 9739.9 9752.2 2475.9 2527.1 2529.5 2534.8 2535.4 2487.8 2560.5 2572.6 2574.9 2575.4 2520.3 2525.2 2530.2 2543.0 2549.1 2452.0 2467.8 2472.0 2509.2 2523.9 2426.0 2481.2 2484.1 2487.4 2532.7 9817.4 9898.0 9908.4 9916.7 9939.1 5740.3 5893.9 5911.4 5915.3 5928.7 3421.8 3448.9 3520.7 3581.5 3635.6 1127.5 1193.4 1205.3 1210.7 1228.8 13744.7 13846.9 13853.7 13864.8 13910.8 5009.9 5140.4 5231.3 5270.1 5277.4 11681.2 11695.4 11720.2 11727.4 11751.1 5905.1 5915.4 5923.9 5946.5 5965.7 4880.9 5291.8 5386.0 5391.2 5409.5 4452.7 4511.7 4517.6 4528.5 4546.5 1408.0 1441.8 1459.8 1463.1 1477.4 1041.1 1045.7 1056.0 1060.0 1067.1 6292.4 6341.9 6427.6 6484.9 6605.6 501.5 507.6 507.6 512.4 518.6 4506.1 4534.0 4547.4 4596.3 4603.1 10962.6 11849.8 12104.1 12209.6 12256.9 11210.6 11333.4 11709.5 11728.9 11757.1 8888.5 9001.3 9002.9 9005.7 9038.6 6350.5 6446.0 6503.8 6507.6 6545.1 10791.2 11072.8 11150.0 11247.7 11302.5 10501.4 11298.4 11398.0 11414.0 11561.3 8962.6 9093.5 9206.9 9220.8 9428.7 9684.9 9702.7 9707.2 9716.8 9750.5 8026.6 8289.5 8352.5 8381.1 8689.5 8099.6 8175.1 8237.3 8254.5 8349.4 7606.6 7659.0 7685.3 7694.3 7699.8 5545.8 5638.9 5724.3 5846.9 5855.9 5904.1 5937.2 6040.2 6063.3 6087.7 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | [#4] prototype.html Cycles:180 Average:5140.51 Median:5789.47 stddev:1506.75 (26.0%) stddev-sans-first:1467.49 17:07:33 INFO - PROCESS | 25100 | Values: 351.9 353.8 357.8 362.1 363.2 5883.3 5934.6 5951.5 5958.6 5977.9 5739.3 5774.2 5804.8 5821.5 5865.0 4544.4 4575.0 4591.4 4592.7 4594.9 4589.4 4589.9 4600.4 4601.3 4624.8 4502.3 4538.0 4544.9 4580.3 4600.1 4505.8 4511.9 4560.6 4561.6 4574.9 4048.9 4057.4 4073.6 4080.7 4081.7 5572.1 5676.6 5705.4 5734.2 5750.8 5200.5 5278.7 5301.2 5314.5 5320.5 6090.9 6164.1 6181.3 6188.0 6198.5 4222.6 4395.3 4460.2 4473.6 4507.3 6086.5 6248.9 6293.1 6320.6 6326.4 4486.9 4492.9 4505.9 4521.8 4542.5 4573.7 4581.9 4583.1 4608.0 4610.4 5087.9 5199.7 5232.7 5261.3 5279.4 6151.8 6160.9 6171.6 6178.4 6188.0 1564.3 1572.8 1578.0 1587.2 1591.4 984.5 984.9 995.6 999.7 1010.7 5260.7 5273.4 5278.7 5301.2 5369.2 5558.6 5571.4 5633.9 5634.4 5672.9 5319.7 5334.4 5565.6 5919.5 5988.5 3331.3 3360.7 3369.9 3387.6 3389.5 6321.4 6461.7 6502.6 6529.2 6550.9 6458.7 6466.5 6474.2 6489.0 6500.8 6312.8 6482.4 6505.3 6515.3 6517.4 6287.3 6294.6 6326.5 6326.9 6400.8 6214.9 6266.9 6272.4 6299.8 6324.9 6215.3 6354.9 6495.5 6496.2 6514.9 4458.7 4486.2 4502.7 4505.8 4513.3 6153.3 6276.7 6279.3 6387.3 6393.9 6147.1 6184.6 6188.6 6196.7 6211.3 5873.0 6150.7 6153.9 6187.5 6242.9 6073.8 6081.3 6100.7 6157.0 6196.4 6109.7 6175.2 6237.9 6250.7 6284.8 5804.8 6011.4 6012.0 6029.3 6047.4 17:07:33 INFO - PROCESS | 25100 | 17:07:33 INFO - PROCESS | 25100 | [#5] yui.html Cycles:180 Average:21830.45 Median:4052.52 stddev:30799.21 (760.0%) stddev-sans-first:30845.17 17:07:33 INFO - PROCESS | 25100 | Values: 810.4 818.2 826.4 917.7 921.3 16537.8 16786.7 17055.2 17137.2 18036.1 17790.6 18034.5 18095.1 18108.2 18112.1 871.6 899.2 906.6 907.2 907.8 735.1 866.7 881.9 899.0 899.8 899.9 902.0 902.2 905.5 906.8 889.4 897.9 900.8 901.1 902.4 659.4 661.3 662.3 662.3 663.0 15028.3 15030.2 15092.6 15147.8 15205.2 15596.6 16353.3 16452.9 16568.9 16638.8 13340.8 13394.1 13441.6 13570.1 13661.4 3919.9 4025.5 4100.1 4151.3 4233.3 93364.5 94082.5 94409.5 94959.5 96374.5 11399.5 11646.0 11693.1 12410.3 12872.2 23632.8 23651.2 23839.0 23890.6 23898.2 8496.9 8499.8 8534.7 8577.5 8609.7 5102.8 5180.9 5214.6 5225.7 5315.7 3946.5 4041.1 4063.9 4068.3 4071.6 661.1 670.6 693.1 695.4 698.9 722.2 768.5 785.0 794.6 805.8 10616.1 11098.9 11504.5 11574.2 11615.2 747.9 764.9 775.5 815.3 823.5 5224.5 5429.7 5455.1 5529.6 5538.9 71683.3 88420.0 106535.0 129913.0 134166.0 77938.6 115669.4 116730.0 118025.0 120165.4 78731.0 79932.2 80153.0 89185.0 91544.5 10297.4 10687.8 11327.7 11385.6 11630.2 46512.0 46733.3 48583.8 53940.1 54921.7 50713.0 52007.5 63997.0 77310.2 83981.6 13699.7 13766.9 14530.4 14930.7 14975.3 16306.8 16558.3 16634.3 16650.4 17704.7 15501.5 15667.9 16089.6 16780.0 16903.1 13834.3 14450.4 14481.7 14756.5 15048.5 15606.1 15642.5 15762.8 15905.7 16276.7 11539.0 12237.6 12491.3 12607.6 12845.7 12262.0 12712.7 13054.3 13115.3 13416.3 17:07:33 INFO - PROCESS | 25100 | -------- Summary: end -------- 17:07:33 INFO - PROCESS | 25100 | 17:07:34 INFO - TEST-INFO | 25100: exit 0 17:07:34 INFO - TEST-OK | dromaeo_css | took 1110168ms 17:07:34 INFO - TEST-START | kraken 17:07:34 INFO - operating with platform_type : linux_ 17:07:34 INFO - Initialising browser for kraken test... 17:07:34 INFO - TEST-INFO | started process 25362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphScv3W/profile http://localhost:50105/getInfo.html) 17:07:37 INFO - PROCESS | 25362 | __metrics Screen width/height:1600/1200 17:07:37 INFO - PROCESS | 25362 | colorDepth:24 17:07:37 INFO - PROCESS | 25362 | Browser inner width/height: 1024/697 17:07:37 INFO - PROCESS | 25362 | __metrics 17:07:38 ERROR - PROCESS | 25362 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:07:39 INFO - TEST-INFO | 25362: exit 0 17:07:39 INFO - Browser initialized. 17:07:39 INFO - Running cycle 1/1 for kraken test... 17:07:39 INFO - TEST-INFO | started process 25487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphScv3W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:50 INFO - PROCESS | 25487 | RSS: Main: 152358912 17:07:50 INFO - PROCESS | 25487 | 17:07:53 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50105/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:54 INFO - PROCESS | 25487 | RSS: Main: 157990912 17:07:54 INFO - PROCESS | 25487 | 17:07:56 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50105/tests/kraken/driver.html?testName=audio-dft) 17:07:57 INFO - PROCESS | 25487 | RSS: Main: 156717056 17:07:57 INFO - PROCESS | 25487 | 17:08:00 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50105/tests/kraken/driver.html?testName=audio-fft) 17:08:00 INFO - PROCESS | 25487 | RSS: Main: 157556736 17:08:00 INFO - PROCESS | 25487 | 17:08:02 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50105/tests/kraken/driver.html?testName=audio-oscillator) 17:08:03 INFO - PROCESS | 25487 | RSS: Main: 157356032 17:08:03 INFO - PROCESS | 25487 | 17:08:05 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:06 INFO - PROCESS | 25487 | RSS: Main: 156975104 17:08:06 INFO - PROCESS | 25487 | 17:08:09 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50105/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:10 INFO - PROCESS | 25487 | RSS: Main: 156291072 17:08:10 INFO - PROCESS | 25487 | 17:08:13 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50105/tests/kraken/driver.html?testName=imaging-desaturate) 17:08:14 INFO - PROCESS | 25487 | RSS: Main: 156250112 17:08:14 INFO - PROCESS | 25487 | 17:08:16 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50105/tests/kraken/driver.html?testName=json-parse-financial) 17:08:17 INFO - PROCESS | 25487 | RSS: Main: 157650944 17:08:17 INFO - PROCESS | 25487 | 17:08:19 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:08:19 INFO - PROCESS | 25487 | RSS: Main: 156962816 17:08:19 INFO - PROCESS | 25487 | 17:08:21 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:08:22 INFO - PROCESS | 25487 | RSS: Main: 157528064 17:08:22 INFO - PROCESS | 25487 | 17:08:24 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:08:24 INFO - PROCESS | 25487 | RSS: Main: 158142464 17:08:24 INFO - PROCESS | 25487 | 17:08:27 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:08:27 INFO - PROCESS | 25487 | RSS: Main: 157814784 17:08:27 INFO - PROCESS | 25487 | 17:08:30 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:08:31 INFO - PROCESS | 25487 | RSS: Main: 158117888 17:08:31 INFO - PROCESS | 25487 | 17:08:32 INFO - PROCESS | 25487 | Cycle 1(1): loaded http://localhost:50105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50105/tests/kraken/driver.html?testName=ai-astar) 17:08:33 INFO - PROCESS | 25487 | RSS: Main: 159133696 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | __start_tp_report 17:08:33 INFO - PROCESS | 25487 | _x_x_mozilla_page_load 17:08:33 INFO - PROCESS | 25487 | _x_x_mozilla_page_load_details 17:08:33 INFO - PROCESS | 25487 | |i|pagename|runs| 17:08:33 INFO - PROCESS | 25487 | |0;ai-astar;104;110;103;111;110;112;108;109;109;110 17:08:33 INFO - PROCESS | 25487 | |1;audio-beat-detection;142;116;146;173;121;140;145;118;171;117 17:08:33 INFO - PROCESS | 25487 | |2;audio-dft;163;162;162;165;161;162;165;163;163;164 17:08:33 INFO - PROCESS | 25487 | |3;audio-fft;75;76;75;165;76;74;75;77;175;78 17:08:33 INFO - PROCESS | 25487 | |4;audio-oscillator;83;83;142;84;83;84;136;85;84;145 17:08:33 INFO - PROCESS | 25487 | |5;imaging-gaussian-blur;118;118;118;119;119;118;118;117;118;117 17:08:33 INFO - PROCESS | 25487 | |6;imaging-darkroom;147;147;146;149;148;149;147;147;148;150 17:08:33 INFO - PROCESS | 25487 | |7;imaging-desaturate;97;96;95;95;95;95;96;96;96;95 17:08:33 INFO - PROCESS | 25487 | |8;json-parse-financial;53;51;51;51;55;51;50;51;50;52 17:08:33 INFO - PROCESS | 25487 | |9;json-stringify-tinderbox;70;62;60;61;62;62;60;61;61;62 17:08:33 INFO - PROCESS | 25487 | |10;stanford-crypto-aes;73;83;74;75;73;73;74;82;76;72 17:08:33 INFO - PROCESS | 25487 | |11;stanford-crypto-ccm;124;123;129;117;129;116;139;122;150;122 17:08:33 INFO - PROCESS | 25487 | |12;stanford-crypto-pbkdf2;157;151;151;160;148;158;151;149;159;154 17:08:33 INFO - PROCESS | 25487 | |13;stanford-crypto-sha256-iterative;61;63;61;61;63;63;65;62;62;61 17:08:33 INFO - PROCESS | 25487 | __end_tp_report 17:08:33 INFO - PROCESS | 25487 | __start_cc_report 17:08:33 INFO - PROCESS | 25487 | _x_x_mozilla_cycle_collect,833 17:08:33 INFO - PROCESS | 25487 | __end_cc_report 17:08:33 INFO - PROCESS | 25487 | __startTimestamp1470960513106__endTimestamp 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | ------- Summary: start ------- 17:08:33 INFO - PROCESS | 25487 | Number of tests: 14 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:2.91 (2.6%) stddev-sans-first:2.57 17:08:33 INFO - PROCESS | 25487 | Values: 104.0 110.0 103.0 111.0 110.0 112.0 108.0 109.0 109.0 110.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:143.50 stddev:21.22 (14.8%) stddev-sans-first:22.48 17:08:33 INFO - PROCESS | 25487 | Values: 142.0 116.0 146.0 173.0 121.0 140.0 145.0 118.0 171.0 117.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 17:08:33 INFO - PROCESS | 25487 | Values: 163.0 162.0 162.0 165.0 161.0 162.0 165.0 163.0 163.0 164.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.50 stddev:39.83 (52.7%) stddev-sans-first:41.60 17:08:33 INFO - PROCESS | 25487 | Values: 75.0 76.0 75.0 165.0 76.0 74.0 75.0 77.0 175.0 78.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:83.50 stddev:27.76 (33.2%) stddev-sans-first:28.68 17:08:33 INFO - PROCESS | 25487 | Values: 83.0 83.0 142.0 84.0 83.0 84.0 136.0 85.0 84.0 145.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:08:33 INFO - PROCESS | 25487 | Values: 118.0 118.0 118.0 119.0 119.0 118.0 118.0 117.0 118.0 117.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 17:08:33 INFO - PROCESS | 25487 | Values: 147.0 147.0 146.0 149.0 148.0 149.0 147.0 147.0 148.0 150.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 17:08:33 INFO - PROCESS | 25487 | Values: 97.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.00 stddev:1.51 (3.0%) stddev-sans-first:1.50 17:08:33 INFO - PROCESS | 25487 | Values: 53.0 51.0 51.0 51.0 55.0 51.0 50.0 51.0 50.0 52.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:2.88 (4.7%) stddev-sans-first:0.83 17:08:33 INFO - PROCESS | 25487 | Values: 70.0 62.0 60.0 61.0 62.0 62.0 60.0 61.0 61.0 62.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:74.50 stddev:3.87 (5.2%) stddev-sans-first:3.99 17:08:33 INFO - PROCESS | 25487 | Values: 73.0 83.0 74.0 75.0 73.0 73.0 74.0 82.0 76.0 72.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:126.50 stddev:10.42 (8.2%) stddev-sans-first:10.99 17:08:33 INFO - PROCESS | 25487 | Values: 124.0 123.0 129.0 117.0 129.0 116.0 139.0 122.0 150.0 122.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:155.50 stddev:4.39 (2.8%) stddev-sans-first:4.50 17:08:33 INFO - PROCESS | 25487 | Values: 157.0 151.0 151.0 160.0 148.0 158.0 151.0 149.0 159.0 154.0 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - PROCESS | 25487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.32 (2.1%) stddev-sans-first:1.32 17:08:33 INFO - PROCESS | 25487 | Values: 61.0 63.0 61.0 61.0 63.0 63.0 65.0 62.0 62.0 61.0 17:08:33 INFO - PROCESS | 25487 | -------- Summary: end -------- 17:08:33 INFO - PROCESS | 25487 | 17:08:33 INFO - TEST-INFO | 25487: exit 0 17:08:34 INFO - TEST-OK | kraken | took 59963ms 17:08:34 INFO - SUITE-END | took 1170s 17:08:34 INFO - Completed test suite (00:19:30) 17:08:34 INFO - javascript benchmark 17:08:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7903.751175913908, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.934721305574, 3296.0441471973145, 3309.751768617354, 3309.768316217865, 3314.2542927841237, 5626.437356264377, 5679.914801277974, 5680.886382272352, 5699.515541178999, 5736.254286942692, 5583.190437386576, 5678.886422271552, 5707.12166468537, 5712.542996560275, 5739.196512488255, 5121.641485096054, 5164.483551644824, 5182.740862956856, 5213.218017297398, 5257.526822585966, 5111.795528178868, 5118.4113826909825, 5143.614228932826, 5171.612129090333, 5184.481551844823, 5144.125498665236, 5154.381474223099, 5178.922316165261, 5227.973860130694, 5271.815486457975, 5217.373915130171, 5223.973880130613, 5229.477052294778, 5231.372235331765, 5268.420473747885, 4970.15507363749, 5006.874828129289, 5096.719680417576, 5150.124478838607, 5220.6084543659, 5564.081926482126, 5651.886962260732, 5654.886902261973, 5656.236408084897, 5668.404817494145, 6033.849153771191, 6051.062085376773, 6070.9982852829235, 6077.453029227347, 6090.36051214625, 5935.49548288396, 6010.248718910137, 6118.785842495491, 6137.386261373871, 6141.969290153565, 5617.578681598897, 5689.2603961485565, 5694.20281160642, 5710.257666503369, 5762.625429347079, 6223.813285601439, 6227.906581401283, 6244.219472565929, 6247.500199983991, 6267.6866156691985, 5871.266091738533, 5875.559333049953, 5922.792702255487, 5997.580169388101, 6038.879222415527, 5979.701014949323, 6094.238220222473, 6100.542459315569, 6106.542009349317, 6123.755049797958, 6019.398060193946, 6040.395960403925, 6079.361667024988, 6093.390660933871, 6104.816855494342, 5894.852628684232, 5975.43233392827, 6085.817425477243, 6089.269287685506, 6097.939020609826, 4603.309503574491, 4684.929726054112, 4687.742174180453, 4708.011317623269, 4709.364235828188, 4166.604172603597, 4171.124063946544, 4176.83292668296, 4186.832526698959, 4207.789610519523, 5605.131204663284, 5624.55003599711, 5868.589198756132, 5880.411958804086, 5880.852978675567, 5949.970250148722, 6028.5478589106, 6056.909146362808, 6082.847928801727, 6085.69571521431, 5750.25246717924, 5750.396208398141, 5751.626144300691, 5764.798232061941, 5779.450952159538, 5092.032513822362, 5134.666246693953, 5177.938522602857, 5177.948220517822, 5211.530962213419, 6263.31103578606, 6343.841403964938, 6362.713677884413, 6372.936270637327, 6391.360863913665, 6169.907451388143, 6175.166352542529, 6176.3514830943, 6194.659293738888, 6215.65813880241, 6095.3904609538695, 6260.280067792262, 6312.084747711648, 6356.523260755369, 6399.7440102395385, 5952.434518720715, 5990.880182396415, 5994.430529099728, 6001.669908154919, 6039.698015099315, 6087.269527656709, 6098.603590766586, 6116.724747386467, 6144.293406258337, 6149.046897730859, 5768.077107662753, 5827.912581311369, 5892.057270836645, 5913.91129133072, 5920.230370051866, 5960.731767070579, 5972.492338151132, 5977.850553736192, 5996.340402555628, 5998.9100163496705, 5894.115882617642, 5896.587238893237, 5898.262717160355, 5939.881202375842, 5995.940040599538, 5900.43945825146, 5937.435943585352, 5961.254843144607, 5964.642121472725, 6016.398360163948, 5872.207252020922, 5941.881162376815, 5953.553483488669, 5960.642361458326, 5985.760569577168], "value": 5609.545544734084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.595790925307, 635.1711017122655, 655.285738544986, 655.2922843329208, 704.4927652090493, 43172.568274317244, 47851.52148478514, 47909.0, 47925.52074479254, 47929.52070479294, 46627.0, 47146.29280560794, 47515.76242118784, 47618.761906190506, 47719.52280477194, 9140.177384035436, 9229.307801914849, 9283.860742088875, 9291.070892910722, 9313.813723725521, 9328.39365441244, 9402.81194376112, 9463.81072378552, 9469.195118414944, 9475.052494750538, 9403.858942115874, 9459.337846350758, 9461.337706360524, 9480.099390557885, 9480.241580673564, 9425.38734982224, 9429.66996155138, 9447.763805904839, 9449.338546301728, 9466.479343636098, 9376.437413755197, 9436.103570160823, 9438.716838494856, 9440.905590944072, 9447.385919915252, 44621.77689111534, 44989.55010449886, 45031.0, 45211.0, 45235.0, 4090.713650044498, 4502.0, 4644.303354496818, 4739.0758802033615, 4773.06925149596, 36448.0, 36478.27043459116, 36618.267634647425, 36818.263634727155, 37991.0, 4648.418947631546, 4659.5573420525, 4664.137134630104, 4697.553732395417, 4699.953000469985, 365757.0, 368473.0, 369295.0, 370281.0, 371063.0, 38603.80698096492, 68155.65922170457, 68408.0, 68445.0, 68519.65740171267, 39048.60951390507, 41445.58554414478, 41915.0, 42115.368269475985, 42121.0, 14330.21183834899, 14384.208868512333, 14436.206008669624, 14459.638509037359, 14490.0, 11564.13269004828, 11569.76860462786, 11608.361540115375, 11620.535178592761, 11625.24435911663, 9322.953385233166, 9351.205147562398, 9392.154706076486, 9434.292428067922, 9537.427754334762, 3450.810205438675, 3495.685388315064, 3505.1762835733584, 3532.4877892705413, 3563.501109844624, 1094.9835752463719, 1120.5461787975883, 1152.4065106470175, 1178.640514643042, 1208.5528354508713, 34923.30153396918, 34950.30099397998, 35416.0, 35676.97430069584, 35711.64288357083, 1184.1769969870857, 1199.4122879789015, 1202.0263586494793, 1206.4088596587785, 1258.150748244931, 18468.81531184671, 18562.350317738816, 18694.0, 18711.625767484846, 18818.059097045094, 647320.0, 649247.0, 948832.0, 952324.0, 959206.0, 62903.6854815723, 63903.0, 69612.3038769616, 69897.0, 70199.0, 1434.978475322871, 1467.4130347860728, 1499.6850661361236, 1507.0580886945659, 1514.8560886715745, 35552.28895422129, 35979.28041439209, 36267.637323626426, 36378.42045505194, 36492.45261321029, 59406.70296648489, 60577.39422605894, 60647.393526064174, 60704.392956069874, 60719.39280607137, 543014.0, 549874.0, 550705.0, 552618.0, 552698.0, 50434.74782626063, 50595.49404505908, 50702.74648626881, 51254.74372628262, 51648.0, 58022.41977580339, 58337.0, 58843.70578147082, 63833.3616663846, 64482.67758661177, 41852.37221441742, 44562.77718611386, 47325.763371182926, 48343.27485087797, 49605.50394496009, 48408.75795620999, 48429.27356089591, 49129.263061053396, 49245.261321079495, 50145.24782128344, 48480.27279590879, 48881.51118488912, 49056.75471622619, 49188.50811491839, 51838.481615183366, 43120.56879431166, 43181.0, 43652.781736091114, 43830.34254486249, 43903.0, 32205.355892881544, 32663.34673306473, 32832.0, 32860.83569582137, 33500.0], "value": 21477.38716688178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.74235360546044, 409.19388804056, 428.0732214755055, 433.1402166699103, 434.54372908446146, 19372.321968731096, 20364.99999999998, 20899.582008359823, 21388.35834924951, 21636.134554617835, 20349.389518314474, 20517.0, 20633.38099857007, 20899.477513062142, 20999.37001889942, 5786.739596718136, 5978.671173085479, 6009.87980240395, 6011.2786465624185, 6011.849703757397, 5856.092305692625, 5856.2094117294255, 5875.441833025856, 5886.676232807194, 5956.225690660208, 5749.482546570808, 5838.824835254928, 5863.58954873159, 5877.529797616202, 5898.8230353089475, 5794.159846822229, 5829.854253643651, 5840.795572154975, 5869.999999999979, 5885.264341957255, 5311.9468805311835, 5333.1733581294575, 5351.545118664879, 5352.143657014859, 5360.437154098802, 24601.50796984068, 24785.62821557678, 24845.875770621213, 24850.751492485026, 24899.875500622562, 2314.259436980167, 2615.9476810463875, 3023.7883348165637, 3278.4426647469986, 3345.2974875276223, 11093.611723589636, 11301.208915375926, 11344.0, 11366.147538934612, 11537.0, 2051.3845846246218, 2065.8450616203845, 2126.0645316061036, 2129.4676330917273, 2143.949464762271, 65397.0, 87847.12152878453, 88311.55844220801, 98542.0, 102262.0, 17802.37691680785, 18604.44186674402, 18639.670041244844, 19023.431836702144, 19143.712844307345, 35300.64699353025, 35852.282954340764, 35862.820685896404, 35955.28089438197, 36031.4595281071, 9404.200642945289, 9572.186364159124, 9717.862070344512, 9934.105930466292, 9989.850152247722, 7752.7286544971785, 7798.961005194938, 7805.33654639362, 7971.163027882105, 8006.639701213459, 9353.204977576846, 9440.244780417688, 9652.0, 9837.360571562825, 9838.409695418297, 3562.98218508911, 3576.195356044869, 3587.65917237862, 3681.3005528949416, 3806.6193380662266, 966.6471737815788, 1005.5525291245472, 1016.506994107857, 1053.1048608682559, 1090.1003331139132, 19784.20863165486, 20838.895805521177, 21120.627159234602, 21136.78863211379, 21334.679979800316, 1036.9429681367596, 1046.947652617366, 1049.6483677967967, 1053.331134729437, 1091.858058452412, 11089.27919685218, 11714.355710435837, 11745.236559623598, 11747.412629368497, 11803.527858885549, 525969.0, 545850.0, 555295.0, 555604.0, 557144.0, 94900.0, 95167.52416238013, 96297.0, 97925.51037244768, 97952.0, 997.491279447487, 1011.9392836429838, 1028.1106842581262, 1038.0294424712918, 1041.1150522056191, 18174.818251817313, 18741.250349986392, 18968.810311896705, 19143.329983450512, 19349.613007739485, 44154.0, 44773.32840007338, 45406.31890521711, 45751.54248457606, 45878.85302867455, 63059.684701576196, 63061.36938630555, 63657.68171159115, 64031.6798416005, 65995.0, 9166.908330916873, 9428.811423771624, 9431.292653050912, 9477.383970041925, 9511.429314241168, 12446.315452650191, 13747.518836840663, 13940.233287168898, 14007.859921400655, 14315.498957536436, 11983.460744266355, 12175.817362739388, 12561.623151305475, 12570.811437828257, 12845.807312890127, 12075.51697932073, 12361.876381236432, 12506.812397814221, 12532.624021279376, 12566.811497827357, 11540.653780386601, 12159.75680486403, 12344.938275308567, 12480.75038499243, 12486.375681216085, 7994.360451163777, 8154.877676834971, 8256.25693687571, 9037.231835294073, 9359.204467620057, 9496.715098547054, 12110.394480275774, 12500.874991249972, 12697.873021269668, 13049.086563940813], "value": 10515.579067135503, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.161711058918, 1561.515930061681, 1722.2594284457687, 1827.8629102817283, 1856.5358660334916, 8639.654413823455, 9013.954930225347, 9254.583543740531, 9617.615295388185, 9619.951900240489, 9317.021712720169, 9670.516474176298, 9681.080297371738, 9739.902600973988, 9752.171065459444, 2475.9257222283313, 2527.0776166699206, 2529.456166924111, 2534.759197876199, 2535.4168541235526, 2487.800975921931, 2560.46230291639, 2572.588385858254, 2574.897004119833, 2575.420530380668, 2520.2943175910773, 2525.1919385796555, 2530.215633153728, 2542.9872850635816, 2549.1078122657013, 2451.9877400612972, 2467.8395904266254, 2471.9629205561932, 2509.2346834215555, 2523.949521009588, 2425.9757402425926, 2481.2308184462695, 2484.080890070685, 2487.4278915849277, 2532.683414573178, 9817.410955342702, 9898.0, 9908.355956862853, 9916.702498925044, 9939.105480506789, 5740.253767010262, 5893.852653683649, 5911.379305172981, 5915.349311575723, 5928.7332070056955, 3421.794692318469, 3448.8792892248903, 3520.6655367740022, 3581.4806853006166, 3635.600083990759, 1127.4588197665084, 1193.421190722499, 1205.3491114797998, 1210.661014915825, 1228.8218208359738, 13744.725105497933, 13846.861531384659, 13853.722925541533, 13864.792028119586, 13910.791338129937, 5009.924851127236, 5140.357455318085, 5231.267622532772, 5270.051390749625, 5277.393099793496, 11681.18231723788, 11695.415229238504, 11720.17958742897, 11727.35499547516, 11751.059915206763, 5905.084711869581, 5915.408459154136, 5923.881522369528, 5946.494547963385, 5965.73154208053, 4880.926786098212, 5291.761870715827, 5385.973070134624, 5391.191321301758, 5409.513143817076, 4452.688311818141, 4511.684182107221, 4517.593416592523, 4528.50186479487, 4546.499885012646, 1408.021425109539, 1441.7837324401214, 1459.7518421868097, 1463.0636392708675, 1477.4016523308078, 1041.1202533858877, 1045.7333379988206, 1055.9788804224027, 1059.9841002384971, 1067.130288814629, 6292.370762923762, 6341.936580634135, 6427.614343139427, 6484.935150648527, 6605.57063790852, 501.53357377639145, 507.6091409614576, 507.64464874587935, 512.4107276631903, 518.6084506197872, 4506.053728716941, 4534.047849951481, 4547.363369128325, 4596.333531637893, 4603.056373443436, 10962.56149754001, 11849.822252666218, 12104.092193085553, 12209.633710988684, 12256.938715306545, 11210.55157793679, 11333.43332833355, 11709.473073711704, 11728.94135529317, 11757.059435245159, 8888.511131887808, 9001.324900632479, 9002.864957025518, 9005.694174344815, 9038.593263303168, 6350.4919606432295, 6445.967770161119, 6503.837404064936, 6507.642079685663, 6545.14913061299, 10791.244612877023, 11072.833907491555, 11150.0, 11247.66257012291, 11302.547898084313, 10501.36991780465, 11298.435078246219, 11398.031167350868, 11414.0, 11561.30632162073, 8962.551872406224, 9093.499857507635, 9206.907930920874, 9220.815583688154, 9428.669996550088, 9684.854727178958, 9702.70891873245, 9707.223422126353, 9716.75708107303, 9750.463724495221, 8026.558539280396, 8289.461185022954, 8352.540610266493, 8381.078081411162, 8689.522076285612, 8099.554524501209, 8175.059868115005, 8237.258646721824, 8254.504729716236, 8349.415540912078, 7606.619669016416, 7659.042619672541, 7685.269899359552, 7694.307512323918, 7699.846003080019, 5545.750441230073, 5638.85902852432, 5724.313082430135, 5846.853828654318, 5855.94144058554, 5904.084866845646, 5937.168796368598, 6040.214772079602, 6063.272407311151, 6087.726052327567], "value": 5015.023597111052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.86277351832786, 353.8319298333292, 357.79248036139023, 362.089345296579, 363.2045819654957, 5883.323417806953, 5934.554908381867, 5951.494122999545, 5958.582899197063, 5977.850553736159, 5739.253896993385, 5774.152271273194, 5804.82585522434, 5821.476067153955, 5865.0, 4544.386507821451, 4574.954250457503, 4591.403117594708, 4592.655550833684, 4594.908101837961, 4589.35748995141, 4589.931151032737, 4600.35595016698, 4601.263797792354, 4624.838130665427, 4502.2571275739465, 4537.977310113445, 4544.863654090383, 4580.3358513015755, 4600.148972440093, 4505.797239124215, 4511.932321015187, 4560.635149188073, 4561.566651168134, 4574.88562785933, 4048.898777530556, 4057.371107478316, 4073.551909289976, 4080.6939479538855, 4081.653059489947, 5572.136318870582, 5676.631018983794, 5705.372409035002, 5734.16854556087, 5750.769969201227, 5200.453952334989, 5278.656887302313, 5301.1783173608155, 5314.511936657742, 5320.494553017457, 6090.8781824363705, 6164.106204600353, 6181.258249010148, 6187.969060154715, 6198.4813720638285, 4222.59885310895, 4395.252807022814, 4460.1525710114975, 4473.597376236122, 4507.256302710049, 6086.543509236825, 6248.937510624926, 6293.143522660826, 6320.5891617044745, 6326.367363263636, 4486.932696009562, 4492.865214043584, 4505.873531617096, 4521.751303678329, 4542.500324964251, 4573.748443835621, 4581.885452863705, 4583.129205450954, 4608.0, 4610.40064791575, 5087.898242035212, 5199.66202196856, 5232.686038837682, 5261.289725887033, 5279.366476022825, 6151.769646070804, 6160.905292200584, 6171.56799024073, 6178.41305076017, 6188.040853667599, 1564.2960667699354, 1572.7640853871783, 1578.0373971877145, 1587.206396801599, 1591.4111778641977, 984.542187882638, 984.9113579777854, 995.6415690351467, 999.6900960702205, 1010.6967909627083, 5260.710660913686, 5273.44628813969, 5278.683279003272, 5301.231321458367, 5369.24830523727, 5558.610897237155, 5571.359293681197, 5633.887322253614, 5634.436556344414, 5672.943270567242, 5319.707416092075, 5334.37301623001, 5565.582581306418, 5919.467247947706, 5988.461038506555, 3331.2504686445354, 3360.6639336066196, 3369.949450758241, 3387.644297348743, 3389.4748412432896, 6321.431071203614, 6461.741530338828, 6502.60984340941, 6529.183852018497, 6550.901736473957, 6458.6770661466735, 6466.515011374166, 6474.223093228748, 6488.967555162194, 6500.772472963518, 6312.842178945563, 6482.448991835747, 6505.316941721146, 6515.315891831384, 6517.3808488193545, 6287.30839607652, 6294.622322660655, 6326.462250708557, 6326.899819088521, 6400.775972840928, 6214.918002469223, 6266.929204689578, 6272.435480806749, 6299.842503937438, 6324.936750632435, 6215.254169499508, 6354.936450635434, 6495.512836537184, 6496.220453545605, 6514.9348506514325, 4458.665600080072, 4486.237339652333, 4502.662300327423, 4505.774711264489, 4513.323001549663, 6153.292371377349, 6276.74893004293, 6279.277883043325, 6387.297397286387, 6393.904091438725, 6147.108669243024, 6184.5980011299125, 6188.628682278898, 6196.721147548281, 6211.254649442096, 5873.0, 6150.723217455315, 6153.907691384722, 6187.474064704371, 6242.906356404748, 6073.787417440369, 6081.300650425258, 6100.6949652516305, 6157.0, 6196.411340922605, 6109.663968481598, 6175.1902884188485, 6237.937620623736, 6250.656213908279, 6284.780032699016, 5804.796832110856, 6011.398860113954, 6012.038073908154, 6029.306629737636, 6047.395260473917], "value": 4655.320507120015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.4245985350401, 818.2186012358198, 826.4091174810013, 917.7155081924602, 921.3228277216249, 16537.834621653794, 16786.74819877701, 17055.232514536845, 17137.22882470289, 18036.098195090257, 17790.555236119104, 18034.5491362716, 18095.09524523775, 18108.185131669074, 18112.094395280248, 871.6339137562223, 899.1727610598265, 906.6010955179732, 907.1654078248027, 907.7912080221553, 735.1325435985535, 866.6923242249005, 881.8941726992738, 899.0425197165031, 899.8155378147464, 899.9055099214586, 902.0303174087849, 902.1880307723036, 905.5245995852165, 906.8277027364812, 889.3907673243849, 897.8922529296461, 900.7612982559627, 901.0944001278706, 902.4179404284233, 659.4427708586237, 661.2759028863387, 662.258270736778, 662.2615783401473, 663.0485253661012, 15028.323725432381, 15030.17334046627, 15092.622684432867, 15147.848521514865, 15205.239738013055, 15596.59630633237, 16353.345866165339, 16452.917735411367, 16568.917155414147, 16638.83361166397, 13340.799888001688, 13394.129381590263, 13441.596752097452, 13570.050096493249, 13661.385237664328, 3919.9216015679526, 4025.5169379674626, 4100.097978444737, 4151.27352713274, 4233.259179643581, 93364.53317733436, 94082.52958735163, 94409.52795236048, 94959.52520237424, 96374.51812740891, 11399.544018239178, 11646.0, 11693.123015773852, 12410.262563241153, 12872.227666339862, 23632.7636723634, 23651.172208972603, 23839.0, 23890.64164037541, 23898.163564275168, 8496.915030849612, 8499.787505312293, 8534.74395768128, 8577.528235946958, 8609.69866054685, 5102.846914592568, 5180.922286165711, 5214.608904332114, 5225.6603320784025, 5315.681059136464, 3946.546147193052, 4041.1109555898242, 4063.9390409143884, 4068.3287257602756, 4071.6131967463043, 661.147120214927, 670.5540815357732, 693.1405057728381, 695.3811108113783, 698.9231184569693, 722.2055738687507, 768.4659161882438, 784.9803754906173, 794.5550491724653, 805.8468890910708, 10616.097631701392, 11098.944505277583, 11504.482298296596, 11574.247673901338, 11615.178305353993, 747.9065116860393, 764.8776195808755, 775.5230533222028, 815.2825513548158, 823.5100115431309, 5224.477552244821, 5429.67421954684, 5455.1271796512365, 5529.612927095145, 5538.9169162462595, 71683.2831671687, 88420.0, 106535.0, 129913.0, 134166.0, 77938.61030694924, 115669.42165289288, 116730.0, 118025.0, 120165.39917300358, 78731.0, 79932.20067799247, 80153.0, 89185.0, 91544.54227728953, 10297.40390239514, 10687.786244274916, 11327.716807079889, 11385.601503947322, 11630.185886987829, 46512.0, 46733.29900051434, 48583.75708121437, 53940.112096076446, 54921.72539137279, 50713.0, 52007.47992520178, 63997.0, 77310.2268977303, 83981.58009209915, 13699.657508562366, 13766.862331376959, 14530.418783248551, 14930.701385972437, 14975.326110324844, 16306.755398669267, 16558.337666493688, 16634.3346266148, 16650.417235396704, 17704.734428983316, 15501.457448989231, 15667.921660391625, 16089.597760056093, 16779.9865313145, 16903.070331131414, 13834.308284585932, 14450.421983120557, 14481.710365792836, 14756.48352307664, 15048.473303434328, 15606.063636181865, 15642.530724078295, 15762.76355854686, 15905.681886361977, 16276.67446651084, 11539.0, 12237.571684990982, 12491.250524968531, 12607.558735444216, 12845.678858028625, 12262.0, 12712.74574508523, 13054.282014489294, 13115.344232788131, 13416.262105584286], "value": 8241.245302663217, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 103.0, 111.0, 110.0, 112.0, 108.0, 109.0, 109.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 146.0, 173.0, 121.0, 140.0, 145.0, 118.0, 171.0, 117.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 165.0, 161.0, 162.0, 165.0, 163.0, 163.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 165.0, 76.0, 74.0, 75.0, 77.0, 175.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 142.0, 84.0, 83.0, 84.0, 136.0, 85.0, 84.0, 145.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 149.0, 148.0, 149.0, 147.0, 147.0, 148.0, 150.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 55.0, 51.0, 50.0, 51.0, 50.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 62.0, 60.0, 61.0, 62.0, 62.0, 60.0, 61.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 83.0, 74.0, 75.0, 73.0, 73.0, 74.0, 82.0, 76.0, 72.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 129.0, 117.0, 129.0, 116.0, 139.0, 122.0, 150.0, 122.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 151.0, 151.0, 160.0, 148.0, 158.0, 151.0, 149.0, 159.0, 154.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 63.0, 63.0, 65.0, 62.0, 62.0, 61.0], "value": 62.2, "unit": "score"}]}]} 17:08:34 INFO - Return code: 0 17:08:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:08:34 ERROR - # TBPL SUCCESS # 17:08:34 INFO - Running post-action listener: _resource_record_post_action 17:08:34 INFO - [mozharness: 2016-08-12 00:08:34.423607Z] Finished run-tests step (success) 17:08:34 INFO - Running post-run listener: _resource_record_post_run 17:08:34 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329818112; Read time: 76; Write time: 189432 17:08:34 INFO - TinderboxPrint: CPU usage
13.2% 17:08:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 76 17:08:34 INFO - TinderboxPrint: I/O write bytes / time
329,818,112 / 189,432 17:08:34 INFO - TinderboxPrint: CPU idle
8,216.4 (86.7%) 17:08:34 INFO - TinderboxPrint: CPU user
1,201.0 (12.7%) 17:08:34 INFO - TinderboxPrint: Swap in / out
0 / 0 17:08:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77037568; Read time: 0; Write time: 60248 17:08:34 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250327040; Read time: 76; Write time: 128984 17:08:35 INFO - Running post-run listener: _upload_blobber_files 17:08:35 INFO - Blob upload gear active. 17:08:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:08:35 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 17:08:35 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:08:35 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:08:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:36 INFO - (blobuploader) - INFO - Done attempting. 17:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:40 INFO - (blobuploader) - INFO - Done attempting. 17:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:40 INFO - (blobuploader) - INFO - Done attempting. 17:08:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:08:40 INFO - Return code: 0 17:08:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:08:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:08:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102452bca907846d08410cfa931d7d56ca3262a7d2bc27f5165f40ad9fdd2eb541769744e8ea5fa50aabac7c88f0df92995660117038185c114888a6970aac5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611e55baabcb7b0c37df7592b751037bcfc8da54e03eda1bab9b419c41b2fe92a9d728d87ecfe644d9080c66b9091b1103cd1be93210f5b85d76bb30ba51d2e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/faf53e4a90d1234a49437c976b2c08152534c727ac57413be043bbb49a514d248d56888113554731322c6351f3be730839ea94c07bf7dba7e54675a31a3eb584"} 17:08:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:08:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:08:40 INFO - Contents: 17:08:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102452bca907846d08410cfa931d7d56ca3262a7d2bc27f5165f40ad9fdd2eb541769744e8ea5fa50aabac7c88f0df92995660117038185c114888a6970aac5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611e55baabcb7b0c37df7592b751037bcfc8da54e03eda1bab9b419c41b2fe92a9d728d87ecfe644d9080c66b9091b1103cd1be93210f5b85d76bb30ba51d2e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/faf53e4a90d1234a49437c976b2c08152534c727ac57413be043bbb49a514d248d56888113554731322c6351f3be730839ea94c07bf7dba7e54675a31a3eb584"} 17:08:40 INFO - Running post-run listener: copy_logs_to_upload_dir 17:08:40 INFO - Copying logs to upload dir... 17:08:40 INFO - mkdir: /builds/slave/test/build/upload/logs 17:08:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.812837 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-08-11 17:08:40.605492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 17:08:40.608764) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216 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-Aurora/sha512/102452bca907846d08410cfa931d7d56ca3262a7d2bc27f5165f40ad9fdd2eb541769744e8ea5fa50aabac7c88f0df92995660117038185c114888a6970aac5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611e55baabcb7b0c37df7592b751037bcfc8da54e03eda1bab9b419c41b2fe92a9d728d87ecfe644d9080c66b9091b1103cd1be93210f5b85d76bb30ba51d2e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/faf53e4a90d1234a49437c976b2c08152534c727ac57413be043bbb49a514d248d56888113554731322c6351f3be730839ea94c07bf7dba7e54675a31a3eb584"} build_url:https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/RW28YxF0TDOpwV71g4Q72A/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/102452bca907846d08410cfa931d7d56ca3262a7d2bc27f5165f40ad9fdd2eb541769744e8ea5fa50aabac7c88f0df92995660117038185c114888a6970aac5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611e55baabcb7b0c37df7592b751037bcfc8da54e03eda1bab9b419c41b2fe92a9d728d87ecfe644d9080c66b9091b1103cd1be93210f5b85d76bb30ba51d2e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/faf53e4a90d1234a49437c976b2c08152534c727ac57413be043bbb49a514d248d56888113554731322c6351f3be730839ea94c07bf7dba7e54675a31a3eb584"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 17:08:40.635334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:08:40.635732) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470958688.608435-1218538216 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 17:08:40.720368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 17:08:40.720760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 17:08:40.721085) ========= ========= Total master_lag: 0.16 =========