builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0052 starttime: 1461795423.71 results: success (0) buildid: 20160427132147 builduid: af8cbe5b872147b9854b3a133c36c2eb revision: f1ff46a78fa5f30b208b33269b48ba4ba367b34f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.710415) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.710866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.711141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.731180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.731545) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WijCJh3zQG/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-27 15:17:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-04-27 15:17:03 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.839005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.839514) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WijCJh3zQG/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.035994 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:03.893114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 15:17:03.893427) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1ff46a78fa5f30b208b33269b48ba4ba367b34f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f1ff46a78fa5f30b208b33269b48ba4ba367b34f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WijCJh3zQG/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-27 15:17:03,961 truncating revision to first 12 chars 2016-04-27 15:17:03,961 Setting DEBUG logging. 2016-04-27 15:17:03,961 attempt 1/10 2016-04-27 15:17:03,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1ff46a78fa5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 15:17:05,265 unpacking tar archive at: fx-team-f1ff46a78fa5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 15:17:05.464403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:05.464721) ========= script_repo_revision: f1ff46a78fa5f30b208b33269b48ba4ba367b34f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:05.465125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:05.465401) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 15:17:05.479562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-27 15:17:05.479862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WijCJh3zQG/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:17:05 INFO - MultiFileLogger online at 20160427 15:17:05 in /builds/slave/test 15:17:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:17:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:05 INFO - {'append_to_log': False, 15:17:05 INFO - 'base_work_dir': '/builds/slave/test', 15:17:05 INFO - 'blob_upload_branch': 'Fx-Team', 15:17:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:05 INFO - 'branch': 'Fx-Team', 15:17:05 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:05 INFO - 'config_files': ('talos/mac_config.py',), 15:17:05 INFO - 'default_actions': ('clobber', 15:17:05 INFO - 'read-buildbot-config', 15:17:05 INFO - 'download-and-extract', 15:17:05 INFO - 'populate-webroot', 15:17:05 INFO - 'create-virtualenv', 15:17:05 INFO - 'install', 15:17:05 INFO - 'run-tests'), 15:17:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:05 INFO - 'download_minidump_stackwalk': True, 15:17:05 INFO - 'download_symbols': 'ondemand', 15:17:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:05 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:05 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:05 INFO - 'installer_path': 'installer.exe', 15:17:05 INFO - 'log_level': 'info', 15:17:05 INFO - 'log_name': 'talos', 15:17:05 INFO - 'log_to_console': True, 15:17:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:17:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:17:05 INFO - 'opt_config_files': (), 15:17:05 INFO - 'pip_index': False, 15:17:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:17:05 INFO - 'cmd': ('bash', 15:17:05 INFO - '-c', 15:17:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:17:05 INFO - 'enabled': True, 15:17:05 INFO - 'halt_on_failure': False, 15:17:05 INFO - 'name': 'check_screen_resolution'},), 15:17:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:17:05 INFO - 'cmd': ('bash', 15:17:05 INFO - '-c', 15:17:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:17:05 INFO - 'enabled': True, 15:17:05 INFO - 'halt_on_failure': False, 15:17:05 INFO - 'name': 'check_screen_resolution'},), 15:17:05 INFO - 'run_cmd_checks_enabled': True, 15:17:05 INFO - 'sps_profile': False, 15:17:05 INFO - 'sps_profile_interval': 0, 15:17:05 INFO - 'suite': 'dromaeojs-e10s', 15:17:05 INFO - 'system_bits': '32', 15:17:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:05 INFO - 'title': 't-yosemite-r7-0052', 15:17:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:05 INFO - 'use_talos_json': True, 15:17:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:05 INFO - 'work_dir': 'build'} 15:17:05 INFO - ##### 15:17:05 INFO - ##### Running clobber step. 15:17:05 INFO - ##### 15:17:05 INFO - Running pre-action listener: _resource_record_pre_action 15:17:05 INFO - Running main action method: clobber 15:17:05 INFO - rmtree: /builds/slave/test/build 15:17:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:07 INFO - Running post-action listener: _resource_record_post_action 15:17:07 INFO - ##### 15:17:07 INFO - ##### Running read-buildbot-config step. 15:17:07 INFO - ##### 15:17:07 INFO - Running pre-action listener: _resource_record_pre_action 15:17:07 INFO - Running main action method: read_buildbot_config 15:17:07 INFO - Using buildbot properties: 15:17:07 INFO - { 15:17:07 INFO - "project": "", 15:17:07 INFO - "product": "firefox", 15:17:07 INFO - "script_repo_revision": "production", 15:17:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:17:07 INFO - "repository": "", 15:17:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:17:07 INFO - "buildid": "20160427132147", 15:17:07 INFO - "pgo_build": "False", 15:17:07 INFO - "basedir": "/builds/slave/test", 15:17:07 INFO - "buildnumber": 650, 15:17:07 INFO - "slavename": "t-yosemite-r7-0052", 15:17:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:17:07 INFO - "platform": "yosemite_r7", 15:17:07 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 15:17:07 INFO - "branch": "fx-team", 15:17:07 INFO - "repo_path": "integration/fx-team", 15:17:07 INFO - "revision": "f1ff46a78fa5f30b208b33269b48ba4ba367b34f", 15:17:07 INFO - "stage_platform": "macosx64", 15:17:07 INFO - "builduid": "af8cbe5b872147b9854b3a133c36c2eb", 15:17:07 INFO - "slavebuilddir": "test" 15:17:07 INFO - } 15:17:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 15:17:07 INFO - Running post-action listener: _resource_record_post_action 15:17:07 INFO - ##### 15:17:07 INFO - ##### Running download-and-extract step. 15:17:07 INFO - ##### 15:17:07 INFO - Running pre-action listener: _resource_record_pre_action 15:17:07 INFO - Running main action method: download_and_extract 15:17:07 INFO - mkdir: /builds/slave/test/build/tests 15:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:07 INFO - https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 15:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 15:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 15:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 15:17:11 INFO - Downloaded 1199 bytes. 15:17:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 15:17:11 INFO - Using the following test package requirements: 15:17:11 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 15:17:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 15:17:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 15:17:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'jsshell-mac.zip'], 15:17:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 15:17:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 15:17:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 15:17:11 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 15:17:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 15:17:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 15:17:11 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 15:17:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:11 INFO - https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:17:15 INFO - Downloaded 18117662 bytes. 15:17:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:17:18 INFO - Return code: 0 15:17:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:18 INFO - https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 15:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:17:20 INFO - Downloaded 18117662 bytes. 15:17:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:17:23 INFO - Return code: 0 15:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:23 INFO - https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 15:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 15:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 15:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:17:25 INFO - Downloaded 10840145 bytes. 15:17:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:17:25 INFO - Return code: 0 15:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:25 INFO - https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:17:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:17:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:17:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 15:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 15:17:30 INFO - Downloaded 110190860 bytes. 15:17:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:17:30 INFO - mkdir: /builds/slave/test/properties 15:17:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:30 INFO - Contents: 15:17:30 INFO - build_url:https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 15:17:32 INFO - Running post-action listener: _resource_record_post_action 15:17:32 INFO - Running post-action listener: set_extra_try_arguments 15:17:32 INFO - ##### 15:17:32 INFO - ##### Running populate-webroot step. 15:17:32 INFO - ##### 15:17:32 INFO - Running pre-action listener: _resource_record_pre_action 15:17:32 INFO - Running main action method: populate_webroot 15:17:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:32 INFO - '--tppagecycles', 15:17:32 INFO - '7'], 15:17:32 INFO - 'tests': ['tsvgm']}}, 15:17:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:17:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:17:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['damp', 'tps']}, 15:17:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'tests': ['damp', 'tps']}, 15:17:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['dromaeo_dom']}, 15:17:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['a11yr', 15:17:32 INFO - 'ts_paint', 15:17:32 INFO - 'tpaint', 15:17:32 INFO - 'sessionrestore', 15:17:32 INFO - 'sessionrestore_no_auto_restore', 15:17:32 INFO - 'tabpaint']}, 15:17:32 INFO - 'other-e10s': {'tests': ['a11yr', 15:17:32 INFO - 'ts_paint', 15:17:32 INFO - 'tpaint', 15:17:32 INFO - 'sessionrestore', 15:17:32 INFO - 'sessionrestore_no_auto_restore', 15:17:32 INFO - 'tabpaint']}, 15:17:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:17:32 INFO - 'ts_paint', 15:17:32 INFO - 'tpaint', 15:17:32 INFO - 'sessionrestore', 15:17:32 INFO - 'sessionrestore_no_auto_restore', 15:17:32 INFO - 'tabpaint']}, 15:17:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:17:32 INFO - 'ts_paint', 15:17:32 INFO - 'tpaint', 15:17:32 INFO - 'sessionrestore', 15:17:32 INFO - 'sessionrestore_no_auto_restore', 15:17:32 INFO - 'tabpaint']}, 15:17:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['a11yr', 15:17:32 INFO - 'ts_paint', 15:17:32 INFO - 'tpaint', 15:17:32 INFO - 'sessionrestore', 15:17:32 INFO - 'sessionrestore_no_auto_restore', 15:17:32 INFO - 'tabpaint']}, 15:17:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['a11yr', 15:17:32 INFO - 'ts_paint', 15:17:32 INFO - 'tpaint', 15:17:32 INFO - 'sessionrestore', 15:17:32 INFO - 'sessionrestore_no_auto_restore', 15:17:32 INFO - 'tabpaint']}, 15:17:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['tsvgx', 15:17:32 INFO - 'tsvgr_opacity', 15:17:32 INFO - 'tart', 15:17:32 INFO - 'tscrollx', 15:17:32 INFO - 'cart']}, 15:17:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:17:32 INFO - 'tsvgr_opacity', 15:17:32 INFO - 'tart', 15:17:32 INFO - 'tscrollx', 15:17:32 INFO - 'cart']}, 15:17:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'talos_options': ['--disable-e10s'], 15:17:32 INFO - 'tests': ['tp5o']}, 15:17:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'tests': ['tp5o']}, 15:17:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'talos_options': ['--disable-e10s', 15:17:32 INFO - '--xperf_path', 15:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:32 INFO - 'tests': ['tp5n']}, 15:17:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:32 INFO - 'talos_options': ['--xperf_path', 15:17:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:32 INFO - 'tests': ['tp5n']}}, 15:17:32 INFO - 'talos.zip': {'path': '', 15:17:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:32 INFO - Running post-action listener: _resource_record_post_action 15:17:32 INFO - ##### 15:17:32 INFO - ##### Running create-virtualenv step. 15:17:32 INFO - ##### 15:17:32 INFO - Running pre-action listener: _resource_record_pre_action 15:17:32 INFO - Running main action method: create_virtualenv 15:17:32 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:17:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:32 INFO - Using real prefix '/tools/python27' 15:17:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:33 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:35 INFO - Installing pip.................done. 15:17:36 INFO - Return code: 0 15:17:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:36 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 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:36 INFO - 'HOME': '/Users/cltbld', 15:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:36 INFO - 'LOGNAME': 'cltbld', 15:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:36 INFO - 'MOZ_NO_REMOTE': '1', 15:17:36 INFO - 'NO_EM_RESTART': '1', 15:17:36 INFO - 'PAGER': '/bin/cat', 15:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:36 INFO - 'PWD': '/builds/slave/test', 15:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:36 INFO - 'SHELL': '/bin/bash', 15:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:36 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:36 INFO - 'USER': 'cltbld', 15:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:36 INFO - 'XPC_FLAGS': '0x0', 15:17:36 INFO - 'XPC_SERVICE_NAME': '0', 15:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:17:36 INFO - Cleaning up... 15:17:36 INFO - Return code: 0 15:17:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:36 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:36 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>=0.7.1'] in /builds/slave/test/build 15:17:36 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>=0.7.1 15:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:36 INFO - 'HOME': '/Users/cltbld', 15:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:36 INFO - 'LOGNAME': 'cltbld', 15:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:36 INFO - 'MOZ_NO_REMOTE': '1', 15:17:36 INFO - 'NO_EM_RESTART': '1', 15:17:36 INFO - 'PAGER': '/bin/cat', 15:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:36 INFO - 'PWD': '/builds/slave/test', 15:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:36 INFO - 'SHELL': '/bin/bash', 15:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:36 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:36 INFO - 'USER': 'cltbld', 15:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:36 INFO - 'XPC_FLAGS': '0x0', 15:17:36 INFO - 'XPC_SERVICE_NAME': '0', 15:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:36 INFO - Downloading/unpacking psutil>=0.7.1 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:39 INFO - Installing collected packages: psutil 15:17:39 INFO - Running setup.py install for psutil 15:17:39 INFO - building 'psutil._psutil_osx' extension 15:17:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:17:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:17:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:17:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:17:40 INFO - building 'psutil._psutil_posix' extension 15:17:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:17:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:17:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:17:40 INFO - ^ 15:17:40 INFO - 1 warning generated. 15:17:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:40 INFO - Successfully installed psutil 15:17:40 INFO - Cleaning up... 15:17:40 INFO - Return code: 0 15:17:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:40 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:40 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.0.0'] in /builds/slave/test/build 15:17:40 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.0.0 15:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:40 INFO - 'HOME': '/Users/cltbld', 15:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:40 INFO - 'LOGNAME': 'cltbld', 15:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:40 INFO - 'MOZ_NO_REMOTE': '1', 15:17:40 INFO - 'NO_EM_RESTART': '1', 15:17:40 INFO - 'PAGER': '/bin/cat', 15:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:40 INFO - 'PWD': '/builds/slave/test', 15:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:40 INFO - 'SHELL': '/bin/bash', 15:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:40 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:40 INFO - 'USER': 'cltbld', 15:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:40 INFO - 'XPC_FLAGS': '0x0', 15:17:40 INFO - 'XPC_SERVICE_NAME': '0', 15:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:17:43 INFO - Installing collected packages: mozsystemmonitor 15:17:43 INFO - Running setup.py install for mozsystemmonitor 15:17:43 INFO - Successfully installed mozsystemmonitor 15:17:43 INFO - Cleaning up... 15:17:43 INFO - Return code: 0 15:17:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 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 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:17:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:43 INFO - 'HOME': '/Users/cltbld', 15:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:43 INFO - 'LOGNAME': 'cltbld', 15:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:43 INFO - 'MOZ_NO_REMOTE': '1', 15:17:43 INFO - 'NO_EM_RESTART': '1', 15:17:43 INFO - 'PAGER': '/bin/cat', 15:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:43 INFO - 'PWD': '/builds/slave/test', 15:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:43 INFO - 'SHELL': '/bin/bash', 15:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:43 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:43 INFO - 'USER': 'cltbld', 15:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:43 INFO - 'XPC_FLAGS': '0x0', 15:17:43 INFO - 'XPC_SERVICE_NAME': '0', 15:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:43 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17: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 15:17: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 15:17: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 15:17:46 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:47 INFO - Downloading docopt-0.6.1.tar.gz 15:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:47 INFO - Running setup.py install for blobuploader 15:17:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:47 INFO - Running setup.py install for requests 15:17:48 INFO - Running setup.py install for docopt 15:17:48 INFO - Successfully installed blobuploader requests docopt 15:17:48 INFO - Cleaning up... 15:17:48 INFO - Return code: 0 15:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:48 INFO - 'HOME': '/Users/cltbld', 15:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:48 INFO - 'LOGNAME': 'cltbld', 15:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:48 INFO - 'MOZ_NO_REMOTE': '1', 15:17:48 INFO - 'NO_EM_RESTART': '1', 15:17:48 INFO - 'PAGER': '/bin/cat', 15:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:48 INFO - 'PWD': '/builds/slave/test', 15:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:48 INFO - 'SHELL': '/bin/bash', 15:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:48 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:48 INFO - 'USER': 'cltbld', 15:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:48 INFO - 'XPC_FLAGS': '0x0', 15:17:48 INFO - 'XPC_SERVICE_NAME': '0', 15:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:48 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Vf_OVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:48 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6aGjyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-N7pvy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-TS2v3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-UlW0No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-YFT31m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-y3KVZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-UYzq_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-padmDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Mv0SSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:49 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-JdGblh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:50 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-HfcS5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:50 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-WAostO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:50 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-y5bjzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:50 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-H32S2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:50 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-C5vkhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:50 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-aPxDcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:50 INFO - Running setup.py install for manifestparser 15:17:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:50 INFO - Running setup.py install for mozcrash 15:17:50 INFO - Running setup.py install for mozdebug 15:17:51 INFO - Running setup.py install for mozdevice 15:17:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Running setup.py install for mozfile 15:17:51 INFO - Running setup.py install for mozhttpd 15:17:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Running setup.py install for mozinfo 15:17:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Running setup.py install for mozInstall 15:17:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Running setup.py install for mozleak 15:17:51 INFO - Running setup.py install for mozlog 15:17:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for moznetwork 15:17:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozprocess 15:17:52 INFO - Running setup.py install for mozprofile 15:17:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozrunner 15:17:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozscreenshot 15:17:52 INFO - Running setup.py install for moztest 15:17:53 INFO - Running setup.py install for mozversion 15:17:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:53 INFO - Cleaning up... 15:17:53 INFO - Return code: 0 15:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 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 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:53 INFO - 'HOME': '/Users/cltbld', 15:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:53 INFO - 'LOGNAME': 'cltbld', 15:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:53 INFO - 'MOZ_NO_REMOTE': '1', 15:17:53 INFO - 'NO_EM_RESTART': '1', 15:17:53 INFO - 'PAGER': '/bin/cat', 15:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:53 INFO - 'PWD': '/builds/slave/test', 15:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:53 INFO - 'SHELL': '/bin/bash', 15:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:53 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:53 INFO - 'USER': 'cltbld', 15:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:53 INFO - 'XPC_FLAGS': '0x0', 15:17:53 INFO - 'XPC_SERVICE_NAME': '0', 15:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:53 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-mHc6uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:53 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4Iqynt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:53 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tnOlzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:53 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4Lp2UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:53 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-D7X_gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-msypVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zawL71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6l9cQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-0y6wf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-YHxkgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ZtjfXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GKJVH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-BT9Mbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XvPres-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-l4suBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-qvkyNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XbDXMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:17:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:57 INFO - Downloading blessings-1.6.tar.gz 15:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:57 INFO - Installing collected packages: blessings 15:17:57 INFO - Running setup.py install for blessings 15:17:57 INFO - Successfully installed blessings 15:17:57 INFO - Cleaning up... 15:17:58 INFO - Return code: 0 15:17:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:58 INFO - Reading from file tmpfile_stdout 15:17:58 INFO - Current package versions: 15:17:58 INFO - blessings == 1.6 15:17:58 INFO - blobuploader == 1.2.4 15:17:58 INFO - docopt == 0.6.1 15:17:58 INFO - manifestparser == 1.1 15:17:58 INFO - mozInstall == 1.12 15:17:58 INFO - mozcrash == 0.17 15:17:58 INFO - mozdebug == 0.1 15:17:58 INFO - mozdevice == 0.48 15:17:58 INFO - mozfile == 1.2 15:17:58 INFO - mozhttpd == 0.7 15:17:58 INFO - mozinfo == 0.9 15:17:58 INFO - mozleak == 0.1 15:17:58 INFO - mozlog == 3.1 15:17:58 INFO - moznetwork == 0.27 15:17:58 INFO - mozprocess == 0.22 15:17:58 INFO - mozprofile == 0.28 15:17:58 INFO - mozrunner == 6.11 15:17:58 INFO - mozscreenshot == 0.1 15:17:58 INFO - mozsystemmonitor == 0.0 15:17:58 INFO - moztest == 0.7 15:17:58 INFO - mozversion == 1.4 15:17:58 INFO - psutil == 3.1.1 15:17:58 INFO - requests == 1.2.3 15:17:58 INFO - wsgiref == 0.1.2 15:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:58 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 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:58 INFO - 'HOME': '/Users/cltbld', 15:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:58 INFO - 'LOGNAME': 'cltbld', 15:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:58 INFO - 'MOZ_NO_REMOTE': '1', 15:17:58 INFO - 'NO_EM_RESTART': '1', 15:17:58 INFO - 'PAGER': '/bin/cat', 15:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:58 INFO - 'PWD': '/builds/slave/test', 15:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:58 INFO - 'SHELL': '/bin/bash', 15:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:58 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:58 INFO - 'USER': 'cltbld', 15:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:58 INFO - 'XPC_FLAGS': '0x0', 15:17:58 INFO - 'XPC_SERVICE_NAME': '0', 15:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:17:58 INFO - Cleaning up... 15:17:59 INFO - Return code: 0 15:17:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:59 INFO - 'HOME': '/Users/cltbld', 15:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:59 INFO - 'LOGNAME': 'cltbld', 15:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:59 INFO - 'MOZ_NO_REMOTE': '1', 15:17:59 INFO - 'NO_EM_RESTART': '1', 15:17:59 INFO - 'PAGER': '/bin/cat', 15:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:59 INFO - 'PWD': '/builds/slave/test', 15:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:59 INFO - 'SHELL': '/bin/bash', 15:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:17:59 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:59 INFO - 'USER': 'cltbld', 15:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:59 INFO - 'XPC_FLAGS': '0x0', 15:17:59 INFO - 'XPC_SERVICE_NAME': '0', 15:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:59 INFO - Downloading/unpacking jsonschema 15:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:02 INFO - Downloading/unpacking functools32 (from jsonschema) 15:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:02 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:02 INFO - warning: no files found matching '*.txt' 15:18:02 INFO - no previously-included directories found matching 'build' 15:18:02 INFO - no previously-included directories found matching 'dist' 15:18:02 INFO - no previously-included directories found matching '.git*' 15:18:02 INFO - Installing collected packages: jsonschema, functools32 15:18:02 INFO - Running setup.py install for functools32 15:18:02 INFO - warning: no files found matching '*.txt' 15:18:02 INFO - no previously-included directories found matching 'build' 15:18:02 INFO - no previously-included directories found matching 'dist' 15:18:02 INFO - no previously-included directories found matching '.git*' 15:18:02 INFO - Successfully installed jsonschema functools32 15:18:02 INFO - Cleaning up... 15:18:02 INFO - Return code: 0 15:18:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c65a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c75420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4d357f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:18:02 INFO - 'HOME': '/Users/cltbld', 15:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:18:02 INFO - 'LOGNAME': 'cltbld', 15:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:02 INFO - 'MOZ_NO_REMOTE': '1', 15:18:02 INFO - 'NO_EM_RESTART': '1', 15:18:02 INFO - 'PAGER': '/bin/cat', 15:18:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:02 INFO - 'PWD': '/builds/slave/test', 15:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:18:02 INFO - 'SHELL': '/bin/bash', 15:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:18:02 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:18:02 INFO - 'USER': 'cltbld', 15:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:02 INFO - 'XPC_FLAGS': '0x0', 15:18:02 INFO - 'XPC_SERVICE_NAME': '0', 15:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:03 INFO - Downloading/unpacking flake8 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:18:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:18:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:06 INFO - no previously-included directories found matching 'docs/_build' 15:18:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:18:06 INFO - Running setup.py install for pep8 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:06 INFO - no previously-included directories found matching 'docs/_build' 15:18:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:18:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:18:06 INFO - Cleaning up... 15:18:07 INFO - Return code: 0 15:18:07 INFO - Running post-action listener: _resource_record_post_action 15:18:07 INFO - Running post-action listener: _start_resource_monitoring 15:18:07 INFO - Starting resource monitoring. 15:18:07 INFO - ##### 15:18:07 INFO - ##### Running install step. 15:18:07 INFO - ##### 15:18:07 INFO - Running pre-action listener: _resource_record_pre_action 15:18:07 INFO - Running main action method: install 15:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:07 INFO - Reading from file tmpfile_stdout 15:18:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:07 INFO - Reading from file tmpfile_stdout 15:18:07 INFO - Output received: 15:18:07 INFO - Usage: mozinstall [options] installer 15:18:07 INFO - Options: 15:18:07 INFO - -h, --help show this help message and exit 15:18:07 INFO - -d DEST, --destination=DEST 15:18:07 INFO - Directory to install application into. [default: 15:18:07 INFO - "/builds/slave/test"] 15:18:07 INFO - --app=APP Application being installed. [default: firefox] 15:18:07 INFO - mkdir: /builds/slave/test/build/application 15:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:18:41 INFO - Reading from file tmpfile_stdout 15:18:41 INFO - Output received: 15:18:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:18:41 INFO - Running post-action listener: _resource_record_post_action 15:18:41 INFO - ##### 15:18:41 INFO - ##### Running run-tests step. 15:18:41 INFO - ##### 15:18:41 INFO - Running pre-action listener: _resource_record_pre_action 15:18:41 INFO - Running main action method: run_tests 15:18:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:18:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:18:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:18:41 INFO - 2016-04-27 15:18:41.550 screenresolution[1641:7457] starting screenresolution argv=screenresolution get 15:18:41 INFO - 2016-04-27 15:18:41.552 screenresolution[1641:7457] Display 0: 1600x1200x32@60 15:18:41 INFO - 2016-04-27 15:18:41.558 screenresolution[1642:7459] starting screenresolution argv=screenresolution list 15:18:41 INFO - Available Modes on Display 0 15:18:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:18:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:18:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:18:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:18:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:18:41 INFO - Intel Iris: 15:18:41 INFO - Chipset Model: Intel Iris 15:18:41 INFO - Type: GPU 15:18:41 INFO - Bus: Built-In 15:18:41 INFO - VRAM (Dynamic, Max): 1536 MB 15:18:41 INFO - Vendor: Intel (0x8086) 15:18:41 INFO - Device ID: 0x0a2e 15:18:41 INFO - Revision ID: 0x0009 15:18:41 INFO - Displays: 15:18:41 INFO - Display: 15:18:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:18:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:18:41 INFO - Display Serial Number: 1600x1200 60 15:18:41 INFO - Main Display: Yes 15:18:41 INFO - Mirror: Off 15:18:41 INFO - Online: Yes 15:18:41 INFO - Rotation: Supported 15:18:41 INFO - Return code: 0 15:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:41 INFO - Python 2.7.3 15:18:41 INFO - Return code: 0 15:18:41 INFO - grabbing minidump binary from tooltool 15:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:41 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b04e00>, '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 0x10696ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106affb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:41 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:18:41 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:18:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:42 INFO - Return code: 0 15:18:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:18:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:18:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:18:43 INFO - Return code: 0 15:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WijCJh3zQG/Render', 15:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:18:43 INFO - 'HOME': '/Users/cltbld', 15:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:18:43 INFO - 'LOGNAME': 'cltbld', 15:18:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:43 INFO - 'MOZ_NO_REMOTE': '1', 15:18:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:43 INFO - 'NO_EM_RESTART': '1', 15:18:43 INFO - 'PAGER': '/bin/cat', 15:18:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:43 INFO - 'PWD': '/builds/slave/test', 15:18:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:18:43 INFO - 'SHELL': '/bin/bash', 15:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners', 15:18:43 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:18:43 INFO - 'USER': 'cltbld', 15:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:43 INFO - 'XPC_FLAGS': '0x0', 15:18:43 INFO - 'XPC_SERVICE_NAME': '0', 15:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:18:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:18:43 INFO - mozversion application_buildid: 20160427132147 15:18:43 INFO - mozversion application_changeset: f1ff46a78fa5f30b208b33269b48ba4ba367b34f 15:18:43 INFO - mozversion application_display_name: Nightly 15:18:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:43 INFO - mozversion application_name: Firefox 15:18:43 INFO - mozversion application_remotingname: firefox 15:18:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:18:43 INFO - mozversion application_vendor: Mozilla 15:18:43 INFO - mozversion application_version: 49.0a1 15:18:43 INFO - mozversion platform_buildid: 20160427132147 15:18:43 INFO - mozversion platform_changeset: f1ff46a78fa5f30b208b33269b48ba4ba367b34f 15:18:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:18:43 INFO - mozversion platform_version: 49.0a1 15:18:43 INFO - using testdate: 1461795523 15:18:43 INFO - actual date: 1461795523 15:18:43 INFO - starting webserver on 'localhost:49275' 15:18:43 INFO - SUITE-START | Running 2 tests 15:18:43 INFO - TEST-START | dromaeo_css 15:18:43 INFO - operating with platform_type : mac_ 15:18:43 INFO - Initialising browser for dromaeo_css test... 15:18:43 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpyqKgpp/profile http://localhost:49275/getInfo.html) 15:18:46 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 15:18:46 INFO - PROCESS | 1663 | colorDepth:24 15:18:46 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 15:18:46 INFO - PROCESS | 1663 | __metrics 15:18:46 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:18:47 INFO - TEST-INFO | 1663: exit 0 15:18:47 INFO - Browser initialized. 15:18:47 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:47 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpyqKgpp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:58 INFO - PROCESS | 1666 | RSS: Main: 249737216 15:18:58 INFO - PROCESS | 1666 | 15:19:48 INFO - PROCESS | 1666 | 1461795588642 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:21:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 15:22:00 INFO - PROCESS | 1666 | RSS: Main: 261726208 15:22:00 INFO - PROCESS | 1666 | 15:25:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 15:25:03 INFO - PROCESS | 1666 | RSS: Main: 274296832 15:25:03 INFO - PROCESS | 1666 | 15:28:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 15:28:05 INFO - PROCESS | 1666 | RSS: Main: 275673088 15:28:05 INFO - PROCESS | 1666 | 15:31:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 15:31:08 INFO - PROCESS | 1666 | RSS: Main: 277262336 15:31:08 INFO - PROCESS | 1666 | 15:34:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 15:34:11 INFO - PROCESS | 1666 | RSS: Main: 280076288 15:34:11 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 15:37:14 INFO - PROCESS | 1666 | RSS: Main: 281755648 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | __start_tp_report 15:37:14 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 15:37:14 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 15:37:14 INFO - PROCESS | 1666 | |i|pagename|runs| 15:37:14 INFO - PROCESS | 1666 | |0;dojo.html;3067.509198528235;3507.719382449403;3519.806410647415;3559.4660800879847;3587.390143675575;5763.337216220136;5804.709764511778;5809.2738407699035;5839.532837373011;5861.941380586203;5428.4300148484435;5739.167820666001;5816.883662326751;5914.733836977346;5927.88144237115;5197.766100525467;5198.2722418861385;5273.578113750891;5286.577073834103;5343.1985202219785;855.1717780743339;5195.844124676247;5288.6562373445795;5295.020421222067;5370.060239458098;5250.028744682246;5263.578913686896;5280.471952804727;5280.894382112375;5301.3373328333955;5235.973820130913;5334.946650533522;5348.652337598043;5357.276767636397;5398.6220964532495;5200.791968321262;5213.817516386946;5219.660722053092;5272.525472707474;5319.601029922771;5268.31511903454;5706.77172913083;5732.541396688255;5746.25298711169;5788.479036886701;6138.449706860586;6147.569670123094;6151;6215.844603884894;6219.813405597839;6156.3843615638525;6188.752449901998;6214.4407003369915;6228.159198508189;6233.844153896189;5910.852228694274;5975.790847320366;5979.252593425778;6012.128241404972;6024.668643224621;6225.408586184305;6301.306856245809;6323.336049714806;6346.2067241594805;6383.457406120532;6204.410580994799;6224.844378890564;6225.564210505312;6234.906476402857;6246.469050130699;6193.969030154821;6220.066989951453;6223.253209614784;6228.532860035515;6232.501399888089;4891.828785992473;6131.988406491147;6138.9095594588325;6173.135760993465;6190.783322583688;5189.506996835295;6096.364786074546;6103.389661033861;6114.175715401326;6166.321704612489;4732.881677958078;4829.840838198807;4914.213725803854;4959.504049595012;4994.525520075587;4399.054203346296;4430.313301438282;4455.376247325377;4485.955140448554;4538.682292239578;4916.582090522345;5823.330317013513;5843.065109582446;5850.64896106235;5928.3775203603;6098.734805259241;6238;6238.190924631896;6239.313675495692;6258.405451482102;5832.737526811219;5929.584929055011;5935.940640593539;5946.821595352147;5949.672767997715;5447.5641948644015;5466.01611709888;5469.206964990054;5477.3427188737605;5486.396496385394;5668.546516278688;6134.069235337226;6380.234371875405;6446.871062578723;6451.806445806634;4957.355543779286;5285.550728188147;5404;6161.84595385119;6352.36476352361;6404.391582799627;6414;6424.967875160782;6428.292887782433;6434.4852411806005;6116.974953844038;6126.111713801563;6144.880016394337;6232.220972378453;6233.2208473940755;6179.16581261524;6186.876262474635;6203.31763506023;6207.348228435949;6242.406971337716;4733.006068725606;5466.699331536644;6106.358832322542;6232.844178895564;6249.625022498664;6088.6042407243385;6142.662153581596;6164.599301045418;6198.442140207403;6220.720067596879;4822.927656085091;6006.399360063959;6012;6109.252844142398;6109.580594149992;5628.971855140698;5667.376588575171;5677.801276955287;6161.983272759944;6196.628202307876;5942.702864856654;6030.336662966983;6083.513318934563;6103.30736498198;6117.26592808848 15:37:14 INFO - PROCESS | 1666 | |1;ext.html;522.2271038862483;527.3592585009214;529.4573062610824;535.4912832808833;551.57804279726;37484.62515374846;38153;38155.618443815554;38209.426858597144;38312.233755324945;38930.80534597323;39020;39729.404058939064;39790.80104599473;39801;9230.95384523078;9431.528423578828;9504.809903801919;9512.143907048365;9541.570629321697;9306.72079837606;9440.763980900463;9563.904360956405;9581.712548623518;9605.327627066108;9474.810503789955;9542.42745435276;9601.991790861928;9612.759681007996;9641.276904232176;9507.096825801538;9540.189083927875;9578.371676814959;9578.425294482284;9583.04169583043;9383.249340052847;9405.57674904631;9520.761980950463;9528.475933823636;9554.092361225672;37451;37807;38272.234555308736;38407.03982400434;38431;2791.4556661451024;3037.3971429140693;3107.0989413070183;3178.332550164468;3372.392969265531;25936.351591210183;25940.22179334604;25971.961121555116;25974.610380844304;26190.607140892902;2588.262345231619;2601.414681696622;2626.592878103897;2649.4568613434394;2700.9594856077174;305167;306623;309013.45493272616;309138.45430772926;309557.45221273974;33659;33886;35253;35272;35289.64710352915;36039.4594081089;36186.09534761652;61143;62831;62945.370546294864;16552.172391380383;16827.326906923587;16829.83170168307;16849.663006739796;16897.408590699266;12828.935855320664;12865.614031579067;12911.418986145645;12913.09608327408;12923.547675831489;18678.906605466887;18863.43409697711;19147.712784308245;19223.903880480786;19255.13351899168;6368.554201205964;7773.766786996399;7834.608269586498;7839.451238413257;7863.174366691529;887.573964497045;889.4307643108416;992.831218692824;1013.3970287678819;1064.5741703318733;29030.564541531894;29188.562171567442;29397;29698;29763.85118074439;1043.222799014739;1076.6931424543968;1107.545906178463;1124.7694222684331;1138.8120960041665;15061.774073388908;15150.393984240727;15170.31733571992;15180.937334386486;15421.306041228172;429021;495056;496528;502211;505998;57970.71014644984;58121.128183077286;58168.709156453944;59020.70489647524;59065.40934590685;1268.923864568129;1471.5953112893826;1476.5939366674036;1485.829129650104;1488.8436714145075;28680;28804.30980200155;28997.42005159927;29055.854720727108;29632.555511667775;51529.742351288005;51735.48264517307;51949.74025130001;52237.7388113057;52324;446183;447907;448435;449307;449319;24973.250802475955;25334.873325633253;25367.238982830546;25655.358616034748;26929.326766830985;45405;45579.316310256036;45945;46245.30632040455;46525.53474465347;37178.25643487169;37428.43857342088;37633;38047.619523805515;38317.616823831406;36698.633013669525;36800.815995919846;36851.262974740894;37536.812315939336;37787.43318850274;30992.84503577558;36307;36423.3609487579;36461.27077458383;36790.26419471542;25038.499230015663;25756.61365079563;28587.42825143527;32319.676803231665;33655.32689346249;22977.540449190587;24143.51712965766;24320.87839560791;24840.503189936462;24884 15:37:14 INFO - PROCESS | 1666 | |2;jquery.html;303.4628707188277;382.74738672476155;390.83584894344375;391.5986114232912;396.4350800109843;15407.614809629766;18555.443336699904;19266.325678601253;19938.401847944548;20006.899965500153;18974.71537926932;19813.20747170115;19851;20257.290994815183;20269.695954560695;5575.972120139394;5724.370319264867;5915.1718759373725;5944.10838374243;5954.31525374581;5759.625624334426;5818.563607729416;5820.301563812327;5834.824955251349;5847.386024467433;5652.547796176316;5704.857378565527;5783.566232532556;5784.68184249866;5785.161151633031;5685.260916080903;5748.281464816898;5789.392113828029;5807.390224026459;5808.30300363959;4956.4547899731;5055.469175736532;5068.163752980754;5101.795928162869;5101.95409940965;23921;24110.39724006914;24412;24601.63097553538;24676.876615616988;2100.2124203423714;2132.76539580646;2159.2334721173916;2196.3520761375435;2453.5092981403614;14075;14543.709125817424;14608.669626377927;14714.55856324312;14944.925275373662;1405.6415614018463;1641.6716656668596;1658.7029698539632;1696.3129932377408;1706.8549173320282;99273.50363248137;100318;101545;101970.99999999926;103170;10403.791924161475;10436.63471778484;11261.211715180023;11299.54801807935;11397;14207.573772786833;14449.92775036139;14478.276086195649;14482.927585362217;14549.34527946245;8343.249107580346;8468.534230617375;8576.356773242032;8607.870881936777;8630.964284285927;8328.958355208186;8460.238578527962;8461.323094152453;8558.090249315263;8586.797848301243;3949.2101579683604;4117.938230926538;4569.13186494565;4613.1465678848845;4703.576678098988;1595.1658028255904;1827.1777700035038;1923.2210954563425;1946.3090602836073;1977.5056235941015;897.4839467306325;931.3247895276006;946.3091942881597;994.4580203788807;998.1715176403568;14083;14966.551003469913;17653.82346176522;18418.43443307334;20537.2811951581;771.5409331447779;975.4732444480044;987.8518222266717;998.510729742421;1006.8590397344377;10114.54484548197;10447.111995480318;10660.253782235324;10692.89307106919;10751.677449676523;633780;642839.5716042874;652583;657849;666519;76504.61747691338;76591.61704191555;106977;112474;117916.41041794737;444.7798339821744;460.9539046095431;462.5836746927792;463.52488699083034;467.72638006766425;10149.289549731744;10853.131749459866;10969.067629251604;11196.496157673088;11232.943835280772;48364.516354836;48773.75613121912;49184;50085;52335.47664523306;71107;71577.56844863178;72155.63922180356;72989;73641.26358736344;7525.435592330487;7688.8077798053255;7757.3794096473275;8030.478018928751;8221.671133154607;11527.538898444303;11919.404029798301;12115.575954841539;12188.085893558196;12258.26450412978;10388.740281493023;10558.630447934285;10565.418901960466;10625.149988001096;10702.09032232269;9015.323850711091;9952.950235248778;10001.699949001542;10306.278560500694;10906.563737450731;10765.623203188165;10768.784624307627;10908.563657453613;11073.390963497084;11296.983271505604;8053.557054361832;8054.315383192495;8081.191880811872;8237.50574965504;8279;9827;10612.257141999986;10975.396353200651;10996.560137594406;10998.34009959405 15:37:14 INFO - PROCESS | 1666 | |3;mootools.html;1612.8467795559422;1616.4827255278308;1898.5538398476356;1940.2045161483795;1966.1840336260443;7911.762647120581;8448;8468.53423061732;8850.822983540333;8851.955740221307;8484.44851084679;8519.701810436636;8620.353473489498;8640.740777776677;8657.783555411117;2401.86789726565;2448.4980578981354;2452.0559584559896;2453.828232023759;2465.506898620274;2087.217293514932;2360.6695062691238;2410.590199666061;2411.5056413435204;2429.137656132074;2150.7849215078522;2420.770026847447;2424.5756992526326;2445.8410203336816;2477.876106194692;2426.5874801283826;2428.5021570577987;2430.647556104364;2450.4608986023045;2456.987715061431;2072.782357852419;2095.4970807006207;2118.353902059871;2431.805455563551;2455.9263222103364;7656;8724.38929274951;8798.29613630908;8849.247813935823;8879.822403551892;5111.258867464197;5336.279602253685;5390.110631745757;5421.376541697716;5424.240606315119;2795.580662900561;3512.227309991798;3564.2515071834687;3576;3579.838907249154;1017.2218253036433;1038.9324693894873;1040.5785656809005;1040.869891263592;1041.3491567770143;11305.265157764801;11403.714907127305;11437.913398227156;11496.94251528737;11509.136814738844;4642.814287428532;4647.930281045787;4649.325847752057;4657.86026419208;4684.812607495662;9255.67605133817;9256.398334108397;9264.67573634933;9274.211692006254;9310.86033709495;5239.161734122522;5325.440828713007;5333.040052790458;5351.411344752074;5374.381946076252;4404.339349097661;4699.4360676718325;4877.975610121997;4932.1861892788;4960.379952505937;3948.407738839197;3957.406389041667;4067.2882245607493;4083.5099788025627;4113.197926404322;1325.15190278222;1354.4311389216355;1367.193355920012;1367.8153449284218;1375.9724805503834;916.8945571259258;920.8222553660545;933.1974501928336;942.4439580647314;968.7529679931572;5626.578006649518;5768.855778605568;5926.970365148147;5938.109283607407;6034.719346130603;441.9535948725402;455.2079381875513;465.9627229821606;467.18709445564474;473.3515084334484;3591.3715099857423;3827.4258861170492;3864.555576108727;3909.257241124177;3920.2159568086495;10255.846162307571;10319.587216511256;10501.159907207406;10773.78452430947;10773.78452430947;10373.688789336333;10533.894661053444;10625.628103016357;10652.733681657866;10712.35725856451;7896.486728362638;8109.472884262504;8198.344132469507;8258.463199891868;8328;5613.46672066153;5735.225744524602;5769.192313076089;5883.323417806836;5984.9401505986125;9339.066093390607;9825.754356141153;9855.063768941938;9926.702198933755;9931.205503559842;9511.04889511071;9952.353097048668;9989.500524973868;10013;10077.042680945298;7367.926320736724;7502.812429689301;7560.092788865371;7630.656620451982;7651.1583725789005;8157.06193787722;8227.753167404988;8247.670093196444;8332.458390204618;8344.83310333802;7174.3184397482155;7180.856382872209;7441.479096463196;7498;7581.583012934341;7189.5686258824635;7317.524360916524;7376.041114655275;7380.630968451664;7434.628268586657;6843.897341539781;6857.485688573277;6871;6918.238993710587;6928.411085057826;4327.8485253016;4385.1010542838;4809.687370320918;4951.405831300267;5127.53852153308;4923.975380123076;4966.279889415942;4967.677100988569;5050.065737838511;5165.638405311592 15:37:14 INFO - PROCESS | 1666 | |4;prototype.html;311.4409634705703;314.4340187662209;315.0658298145998;318.4872355507634;320.9791363561369;4731.266653668683;4855.126077306083;4985.725785081814;5501.752421141048;5539.169124631308;5328.893422131555;5426.538744206738;5450.4549545045475;5452.863678408032;5463.31708536433;2968.61408016958;3572.017695133833;3661.853525858976;4037.416053725618;4217.683673724468;3451.9482207766905;3895.552011518669;4141.302066152878;4204.852830150945;4212.431321771553;3662;3906.5312162540536;4121.5466298707115;4189.9790501047455;4198.1393814268;3832.2527107214105;3896.947174938061;4171.937420938689;4193.580641935812;4249.235137675218;3293.4565796643524;3641.4901913732097;3658.8902332930056;3667.9362984734394;3671.8531258749617;4000.4999375078114;4420.491643461011;4455.888602784924;5220.947790522122;5284.497972692588;4048.838046478137;4541.43232095988;4806.735629540374;4814.807407703687;4834.806607735686;5318.0589084984085;5414.485623865727;5707.400722924075;5742.564358910273;5743.339515955635;3611.458281257806;3760.7213547394017;4035.899102522431;4036.798160091984;4040.2121586290687;5354.41101478837;5627.552014873543;5920.496757775594;6045.183900173464;6121.959266924633;3448.706859916885;3586.5337506124038;3921.490206273223;3953.6639385651965;3992.7803970781306;4054.5134583849535;4057.3711074783455;4066.6543343815515;4075.7758323292505;4077.734947228421;4252.659787217015;4435.512093669694;4680.040591678766;4732.361131247307;4761.642876784255;5175.818846340435;5358.4373640767935;5415.702136382458;5674.347450043216;5781.935574145709;1472.2565104622097;1473.6242258224083;1487.1077353587762;1488.4864721671006;1492.4925525321444;840.9159084091542;893.848045832197;915.5651065743851;935;956.9808154315632;4113.547509773923;4775.928361074587;4830.980637101811;5207.916833266648;5440.619156658996;5247.449017853147;5972.580290585022;5982.252218472691;5992.520598352121;5997.7001149942325;4616.8614941551805;5206.921896171485;5429.239906413105;5446.509814116748;5455.372632147274;2951.7638588913264;3243.140567749548;3441.1225137589754;3462.4113900636953;3475.9826200868833;5964.61230020056;6437.300770437607;6691.631960242234;6874.690638921261;6935.202451718117;5157.510036546522;6724.865502690017;6735.292794256533;6735.29279425663;6748.122744043243;6835.692393842289;6859.142607174103;6869.210040845367;6876.553024053421;6903.861922761516;6339.334369891095;6531.575447595891;6543.901841472477;6547.901781473186;6557.573757705733;5662.745176467151;6057.57596968208;6435.935640643721;6440.29156792743;6519.185101862267;5392.460753924576;6317.526185536011;6332.620042797263;6347.095871238517;6826.488013399115;3486;3572.821358932095;4038.293298672779;4145.336746120606;4180.205760905418;5768.884802206929;5854.326752423526;6002.969985150046;6040.697965101639;6056.6076399822705;4691.953080469151;4838.661293709407;5695.686737229326;5708.429157084258;5786.94213057864;4976.925346119739;5511.098670958513;5770;5830;5838.1826544282985;4330.254330004586;4369.453818272716;4805.183118869871;5173.042987047258;5717.256756621779;5035.420926593489;5608.971955140199;5756.913646295226;5859.677717725566;5917.112433135064;4814.422269327703;5645.237892884572;5753.18094133863;5760.481556659753;5761.8559536011935 15:37:14 INFO - PROCESS | 1666 | |5;yui.html;662.6951602262959;685.492735375822;724.0442615747214;732.2713899669826;749.835036292016;12562;14965.176915269656;15101.093934363946;15229;16317.265723042461;16192.83807161928;16261.18694065295;16283.918580407111;16292.02247865129;16318.265678044487;772.775894990455;911.4759013567209;917.4862077236735;922.8523436250201;923.5797712041006;721.0878239027634;883.2845395229853;901.3780491460903;901.5762591581946;903.0202230579829;931.0596297739298;937.3579098317674;939.5114540438967;939.8825146856643;948.3882895532378;912.7535565397305;934.7476181430976;934.7990182110844;935.4527601353217;948.4356807699443;685.8114018644862;686.9622170780605;693.5318659904544;699.5942353434996;702.7961891051589;15201.847981520154;15368.231588420535;15394.615134621612;15417.3833046678;15444.45944391952;12145.878541214563;12234.632961011095;12264.141510094298;12310.81533776994;12514.249145051235;9883.703488895273;9898.80202395948;10180.745481362952;10473.738156546071;10618.25672202946;3382.0530251529613;3412.522246885438;3463.2554000889677;3508.438649816017;3523.1016090896915;81844;82996;83130;83379;84554.73167902486;9247.167754902091;9257.768555786159;9302.395344302598;9553.426794392359;9559.569819358145;21039.263625773332;21079.789202108088;21184.15263389478;21231.78768212298;21591.78408215929;7031.191412987469;7228.963855180796;7408.629568521553;7476;7565.130010048915;4026.778527181033;4041.2725709372594;4043.272211001989;4061.1674606705556;4063.837446502166;3450.258194488197;3529.523514325533;3531.9646803531637;3548.8935331940083;3549.6450354964295;615.9414855588711;632.6425569553188;637.0571554099959;637.3403527349171;647.5273050673035;512.7743792731186;571.9914201286985;581.9767209311665;582.967936763482;606.8816580766708;8148.470349427387;8207.466514676527;8239;8348;8414.074451810297;557.7713137613559;558.837936998266;566.6543408520881;595.9582829202001;597.1609888107216;2996.955045674317;3656.213914008501;3754.55449651886;3857.324968130566;3969.6030396960073;64180.35819641837;77878.83181752278;79160.60419697865;92465.075349247;92657.53671231601;59455;74237;75170;77910.83133752998;78823;72109.27890721131;72254;72338.55322893512;72465.2753472469;73485.99999999894;7589.58257295854;7654.770356889302;7733.729319473791;7845.0585929688805;7867.409944254089;44550.777246114856;44952.77523612361;45030.324545132506;45085.32372014488;46249.76875115603;65223.02165467427;65719;65722.34277657354;66411.66794166192;66592.66703666451;10204.4387558685;10976.670699879016;11184.776304474028;11463.885361146615;11833.585824496102;11735;11805.350705711267;12101.765522713607;12297.323647199131;12757.107002509736;9466.384684995453;11413.885861141282;11662.739146063703;11859.644210673694;12016.82095843578;11412.885871141183;11518.36648984314;11702.590409335973;11871.525138994344;12392.132550721362;11106.944465277946;11329.943350283196;11361.659150225507;11401.885981140082;11407.828882566602;9003.234725048444;9441.433513989183;9815.018498150128;9956.303058785816;9957.402555846673;9485.383450075724;9571.760705982406;9676.70969870905;9690.32167748279;9742.464164471023 15:37:14 INFO - PROCESS | 1666 | __end_tp_report 15:37:14 INFO - PROCESS | 1666 | __start_cc_report 15:37:14 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,424 15:37:14 INFO - PROCESS | 1666 | __end_cc_report 15:37:14 INFO - PROCESS | 1666 | __startTimestamp1461796634635__endTimestamp 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | ------- Summary: start ------- 15:37:14 INFO - PROCESS | 1666 | Number of tests: 6 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5699.34 Median:5949.67 stddev:743.96 (12.5%) stddev-sans-first:717.02 15:37:14 INFO - PROCESS | 1666 | Values: 3067.5 3507.7 3519.8 3559.5 3587.4 5763.3 5804.7 5809.3 5839.5 5861.9 5428.4 5739.2 5816.9 5914.7 5927.9 5197.8 5198.3 5273.6 5286.6 5343.2 855.2 5195.8 5288.7 5295.0 5370.1 5250.0 5263.6 5280.5 5280.9 5301.3 5236.0 5334.9 5348.7 5357.3 5398.6 5200.8 5213.8 5219.7 5272.5 5319.6 5268.3 5706.8 5732.5 5746.3 5788.5 6138.4 6147.6 6151.0 6215.8 6219.8 6156.4 6188.8 6214.4 6228.2 6233.8 5910.9 5975.8 5979.3 6012.1 6024.7 6225.4 6301.3 6323.3 6346.2 6383.5 6204.4 6224.8 6225.6 6234.9 6246.5 6194.0 6220.1 6223.3 6228.5 6232.5 4891.8 6132.0 6138.9 6173.1 6190.8 5189.5 6096.4 6103.4 6114.2 6166.3 4732.9 4829.8 4914.2 4959.5 4994.5 4399.1 4430.3 4455.4 4486.0 4538.7 4916.6 5823.3 5843.1 5850.6 5928.4 6098.7 6238.0 6238.2 6239.3 6258.4 5832.7 5929.6 5935.9 5946.8 5949.7 5447.6 5466.0 5469.2 5477.3 5486.4 5668.5 6134.1 6380.2 6446.9 6451.8 4957.4 5285.6 5404.0 6161.8 6352.4 6404.4 6414.0 6425.0 6428.3 6434.5 6117.0 6126.1 6144.9 6232.2 6233.2 6179.2 6186.9 6203.3 6207.3 6242.4 4733.0 5466.7 6106.4 6232.8 6249.6 6088.6 6142.7 6164.6 6198.4 6220.7 4822.9 6006.4 6012.0 6109.3 6109.6 5629.0 5667.4 5677.8 6162.0 6196.6 5942.7 6030.3 6083.5 6103.3 6117.3 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:55632.79 Median:36826.04 stddev:111858.42 (303.7%) stddev-sans-first:112095.68 15:37:14 INFO - PROCESS | 1666 | Values: 522.2 527.4 529.5 535.5 551.6 37484.6 38153.0 38155.6 38209.4 38312.2 38930.8 39020.0 39729.4 39790.8 39801.0 9231.0 9431.5 9504.8 9512.1 9541.6 9306.7 9440.8 9563.9 9581.7 9605.3 9474.8 9542.4 9602.0 9612.8 9641.3 9507.1 9540.2 9578.4 9578.4 9583.0 9383.2 9405.6 9520.8 9528.5 9554.1 37451.0 37807.0 38272.2 38407.0 38431.0 2791.5 3037.4 3107.1 3178.3 3372.4 25936.4 25940.2 25972.0 25974.6 26190.6 2588.3 2601.4 2626.6 2649.5 2701.0 305167.0 306623.0 309013.5 309138.5 309557.5 33659.0 33886.0 35253.0 35272.0 35289.6 36039.5 36186.1 61143.0 62831.0 62945.4 16552.2 16827.3 16829.8 16849.7 16897.4 12828.9 12865.6 12911.4 12913.1 12923.5 18678.9 18863.4 19147.7 19223.9 19255.1 6368.6 7773.8 7834.6 7839.5 7863.2 887.6 889.4 992.8 1013.4 1064.6 29030.6 29188.6 29397.0 29698.0 29763.9 1043.2 1076.7 1107.5 1124.8 1138.8 15061.8 15150.4 15170.3 15180.9 15421.3 429021.0 495056.0 496528.0 502211.0 505998.0 57970.7 58121.1 58168.7 59020.7 59065.4 1268.9 1471.6 1476.6 1485.8 1488.8 28680.0 28804.3 28997.4 29055.9 29632.6 51529.7 51735.5 51949.7 52237.7 52324.0 446183.0 447907.0 448435.0 449307.0 449319.0 24973.3 25334.9 25367.2 25655.4 26929.3 45405.0 45579.3 45945.0 46245.3 46525.5 37178.3 37428.4 37633.0 38047.6 38317.6 36698.6 36800.8 36851.3 37536.8 37787.4 30992.8 36307.0 36423.4 36461.3 36790.3 25038.5 25756.6 28587.4 32319.7 33655.3 22977.5 24143.5 24320.9 24840.5 24884.0 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34491.38 Median:343.11 stddev:107289.67 (31270.2%) stddev-sans-first:107559.93 15:37:14 INFO - PROCESS | 1666 | Values: 303.5 382.7 390.8 391.6 396.4 15407.6 18555.4 19266.3 19938.4 20006.9 18974.7 19813.2 19851.0 20257.3 20269.7 5576.0 5724.4 5915.2 5944.1 5954.3 5759.6 5818.6 5820.3 5834.8 5847.4 5652.5 5704.9 5783.6 5784.7 5785.2 5685.3 5748.3 5789.4 5807.4 5808.3 4956.5 5055.5 5068.2 5101.8 5102.0 23921.0 24110.4 24412.0 24601.6 24676.9 2100.2 2132.8 2159.2 2196.4 2453.5 14075.0 14543.7 14608.7 14714.6 14944.9 1405.6 1641.7 1658.7 1696.3 1706.9 99273.5 100318.0 101545.0 101971.0 103170.0 10403.8 10436.6 11261.2 11299.5 11397.0 14207.6 14449.9 14478.3 14482.9 14549.3 8343.2 8468.5 8576.4 8607.9 8631.0 8329.0 8460.2 8461.3 8558.1 8586.8 3949.2 4117.9 4569.1 4613.1 4703.6 1595.2 1827.2 1923.2 1946.3 1977.5 897.5 931.3 946.3 994.5 998.2 14083.0 14966.6 17653.8 18418.4 20537.3 771.5 975.5 987.9 998.5 1006.9 10114.5 10447.1 10660.3 10692.9 10751.7 633780.0 642839.6 652583.0 657849.0 666519.0 76504.6 76591.6 106977.0 112474.0 117916.4 444.8 461.0 462.6 463.5 467.7 10149.3 10853.1 10969.1 11196.5 11232.9 48364.5 48773.8 49184.0 50085.0 52335.5 71107.0 71577.6 72155.6 72989.0 73641.3 7525.4 7688.8 7757.4 8030.5 8221.7 11527.5 11919.4 12115.6 12188.1 12258.3 10388.7 10558.6 10565.4 10625.1 10702.1 9015.3 9953.0 10001.7 10306.3 10906.6 10765.6 10768.8 10908.6 11073.4 11297.0 8053.6 8054.3 8081.2 8237.5 8279.0 9827.0 10612.3 10975.4 10996.6 10998.3 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5636.42 Median:4955.89 stddev:3135.31 (63.3%) stddev-sans-first:3129.53 15:37:14 INFO - PROCESS | 1666 | Values: 1612.8 1616.5 1898.6 1940.2 1966.2 7911.8 8448.0 8468.5 8850.8 8852.0 8484.4 8519.7 8620.4 8640.7 8657.8 2401.9 2448.5 2452.1 2453.8 2465.5 2087.2 2360.7 2410.6 2411.5 2429.1 2150.8 2420.8 2424.6 2445.8 2477.9 2426.6 2428.5 2430.6 2450.5 2457.0 2072.8 2095.5 2118.4 2431.8 2455.9 7656.0 8724.4 8798.3 8849.2 8879.8 5111.3 5336.3 5390.1 5421.4 5424.2 2795.6 3512.2 3564.3 3576.0 3579.8 1017.2 1038.9 1040.6 1040.9 1041.3 11305.3 11403.7 11437.9 11496.9 11509.1 4642.8 4647.9 4649.3 4657.9 4684.8 9255.7 9256.4 9264.7 9274.2 9310.9 5239.2 5325.4 5333.0 5351.4 5374.4 4404.3 4699.4 4878.0 4932.2 4960.4 3948.4 3957.4 4067.3 4083.5 4113.2 1325.2 1354.4 1367.2 1367.8 1376.0 916.9 920.8 933.2 942.4 968.8 5626.6 5768.9 5927.0 5938.1 6034.7 442.0 455.2 466.0 467.2 473.4 3591.4 3827.4 3864.6 3909.3 3920.2 10255.8 10319.6 10501.2 10773.8 10773.8 10373.7 10533.9 10625.6 10652.7 10712.4 7896.5 8109.5 8198.3 8258.5 8328.0 5613.5 5735.2 5769.2 5883.3 5984.9 9339.1 9825.8 9855.1 9926.7 9931.2 9511.0 9952.4 9989.5 10013.0 10077.0 7367.9 7502.8 7560.1 7630.7 7651.2 8157.1 8227.8 8247.7 8332.5 8344.8 7174.3 7180.9 7441.5 7498.0 7581.6 7189.6 7317.5 7376.0 7380.6 7434.6 6843.9 6857.5 6871.0 6918.2 6928.4 4327.8 4385.1 4809.7 4951.4 5127.5 4924.0 4966.3 4967.7 5050.1 5165.6 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4722.22 Median:5191.37 stddev:1530.60 (29.5%) stddev-sans-first:1498.67 15:37:14 INFO - PROCESS | 1666 | Values: 311.4 314.4 315.1 318.5 321.0 4731.3 4855.1 4985.7 5501.8 5539.2 5328.9 5426.5 5450.5 5452.9 5463.3 2968.6 3572.0 3661.9 4037.4 4217.7 3451.9 3895.6 4141.3 4204.9 4212.4 3662.0 3906.5 4121.5 4190.0 4198.1 3832.3 3896.9 4171.9 4193.6 4249.2 3293.5 3641.5 3658.9 3667.9 3671.9 4000.5 4420.5 4455.9 5220.9 5284.5 4048.8 4541.4 4806.7 4814.8 4834.8 5318.1 5414.5 5707.4 5742.6 5743.3 3611.5 3760.7 4035.9 4036.8 4040.2 5354.4 5627.6 5920.5 6045.2 6122.0 3448.7 3586.5 3921.5 3953.7 3992.8 4054.5 4057.4 4066.7 4075.8 4077.7 4252.7 4435.5 4680.0 4732.4 4761.6 5175.8 5358.4 5415.7 5674.3 5781.9 1472.3 1473.6 1487.1 1488.5 1492.5 840.9 893.8 915.6 935.0 957.0 4113.5 4775.9 4831.0 5207.9 5440.6 5247.4 5972.6 5982.3 5992.5 5997.7 4616.9 5206.9 5429.2 5446.5 5455.4 2951.8 3243.1 3441.1 3462.4 3476.0 5964.6 6437.3 6691.6 6874.7 6935.2 5157.5 6724.9 6735.3 6735.3 6748.1 6835.7 6859.1 6869.2 6876.6 6903.9 6339.3 6531.6 6543.9 6547.9 6557.6 5662.7 6057.6 6435.9 6440.3 6519.2 5392.5 6317.5 6332.6 6347.1 6826.5 3486.0 3572.8 4038.3 4145.3 4180.2 5768.9 5854.3 6003.0 6040.7 6056.6 4692.0 4838.7 5695.7 5708.4 5786.9 4976.9 5511.1 5770.0 5830.0 5838.2 4330.3 4369.5 4805.2 5173.0 5717.3 5035.4 5609.0 5756.9 5859.7 5917.1 4814.4 5645.2 5753.2 5760.5 5761.9 15:37:14 INFO - PROCESS | 1666 | 15:37:14 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17848.64 Median:637.20 stddev:24690.69 (3874.9%) stddev-sans-first:24726.23 15:37:14 INFO - PROCESS | 1666 | Values: 662.7 685.5 724.0 732.3 749.8 12562.0 14965.2 15101.1 15229.0 16317.3 16192.8 16261.2 16283.9 16292.0 16318.3 772.8 911.5 917.5 922.9 923.6 721.1 883.3 901.4 901.6 903.0 931.1 937.4 939.5 939.9 948.4 912.8 934.7 934.8 935.5 948.4 685.8 687.0 693.5 699.6 702.8 15201.8 15368.2 15394.6 15417.4 15444.5 12145.9 12234.6 12264.1 12310.8 12514.2 9883.7 9898.8 10180.7 10473.7 10618.3 3382.1 3412.5 3463.3 3508.4 3523.1 81844.0 82996.0 83130.0 83379.0 84554.7 9247.2 9257.8 9302.4 9553.4 9559.6 21039.3 21079.8 21184.2 21231.8 21591.8 7031.2 7229.0 7408.6 7476.0 7565.1 4026.8 4041.3 4043.3 4061.2 4063.8 3450.3 3529.5 3532.0 3548.9 3549.6 615.9 632.6 637.1 637.3 647.5 512.8 572.0 582.0 583.0 606.9 8148.5 8207.5 8239.0 8348.0 8414.1 557.8 558.8 566.7 596.0 597.2 2997.0 3656.2 3754.6 3857.3 3969.6 64180.4 77878.8 79160.6 92465.1 92657.5 59455.0 74237.0 75170.0 77910.8 78823.0 72109.3 72254.0 72338.6 72465.3 73486.0 7589.6 7654.8 7733.7 7845.1 7867.4 44550.8 44952.8 45030.3 45085.3 46249.8 65223.0 65719.0 65722.3 66411.7 66592.7 10204.4 10976.7 11184.8 11463.9 11833.6 11735.0 11805.4 12101.8 12297.3 12757.1 9466.4 11413.9 11662.7 11859.6 12016.8 11412.9 11518.4 11702.6 11871.5 12392.1 11106.9 11329.9 11361.7 11401.9 11407.8 9003.2 9441.4 9815.0 9956.3 9957.4 9485.4 9571.8 9676.7 9690.3 9742.5 15:37:14 INFO - PROCESS | 1666 | -------- Summary: end -------- 15:37:14 INFO - PROCESS | 1666 | 15:37:15 INFO - TEST-INFO | 1666: exit 0 15:37:15 INFO - TEST-OK | dromaeo_css | took 1111915ms 15:37:15 INFO - TEST-START | kraken 15:37:15 INFO - operating with platform_type : mac_ 15:37:15 INFO - Initialising browser for kraken test... 15:37:15 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpvM2Uoo/profile http://localhost:49275/getInfo.html) 15:37:18 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 15:37:18 INFO - PROCESS | 1676 | colorDepth:24 15:37:18 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 15:37:18 INFO - PROCESS | 1676 | __metrics 15:37:18 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 15:37:19 INFO - TEST-INFO | 1676: exit 0 15:37:19 INFO - Browser initialized. 15:37:19 INFO - Running cycle 1/1 for kraken test... 15:37:19 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpvM2Uoo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:31 INFO - PROCESS | 1679 | RSS: Main: 250093568 15:37:31 INFO - PROCESS | 1679 | 15:37:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:35 INFO - PROCESS | 1679 | RSS: Main: 262201344 15:37:35 INFO - PROCESS | 1679 | 15:37:37 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 15:37:38 INFO - PROCESS | 1679 | RSS: Main: 271589376 15:37:38 INFO - PROCESS | 1679 | 15:37:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 15:37:42 INFO - PROCESS | 1679 | RSS: Main: 274071552 15:37:42 INFO - PROCESS | 1679 | 15:37:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 15:37:45 INFO - PROCESS | 1679 | RSS: Main: 276598784 15:37:45 INFO - PROCESS | 1679 | 15:37:47 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:47 INFO - PROCESS | 1679 | RSS: Main: 276983808 15:37:47 INFO - PROCESS | 1679 | 15:37:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:51 INFO - PROCESS | 1679 | RSS: Main: 277200896 15:37:51 INFO - PROCESS | 1679 | 15:37:54 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:54 INFO - PROCESS | 1679 | RSS: Main: 277327872 15:37:54 INFO - PROCESS | 1679 | 15:37:58 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 15:37:58 INFO - PROCESS | 1679 | RSS: Main: 278007808 15:37:58 INFO - PROCESS | 1679 | 15:38:00 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:01 INFO - PROCESS | 1679 | RSS: Main: 276840448 15:38:01 INFO - PROCESS | 1679 | 15:38:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:03 INFO - PROCESS | 1679 | RSS: Main: 276930560 15:38:03 INFO - PROCESS | 1679 | 15:38:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:06 INFO - PROCESS | 1679 | RSS: Main: 277135360 15:38:06 INFO - PROCESS | 1679 | 15:38:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:10 INFO - PROCESS | 1679 | RSS: Main: 277024768 15:38:10 INFO - PROCESS | 1679 | 15:38:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:13 INFO - PROCESS | 1679 | RSS: Main: 277090304 15:38:13 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 15:38:15 INFO - PROCESS | 1679 | RSS: Main: 278794240 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | __start_tp_report 15:38:15 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 15:38:15 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 15:38:15 INFO - PROCESS | 1679 | |i|pagename|runs| 15:38:15 INFO - PROCESS | 1679 | |0;ai-astar;163;158;120;117;117;129;117;117;121;164 15:38:15 INFO - PROCESS | 1679 | |1;audio-beat-detection;163;155;145;165;120;140;125;160;158;123 15:38:15 INFO - PROCESS | 1679 | |2;audio-dft;199;215;224;205;201;199;202;197;202;197 15:38:15 INFO - PROCESS | 1679 | |3;audio-fft;64;74;80;143;57;56;76;89;165;51 15:38:15 INFO - PROCESS | 1679 | |4;audio-oscillator;80;87;135;78;80;80;121;82;80;123 15:38:15 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;93;90;92;90;93;90;92;89;93;91 15:38:15 INFO - PROCESS | 1679 | |6;imaging-darkroom;104;98;96;98;102;113;107;149;137;133 15:38:15 INFO - PROCESS | 1679 | |7;imaging-desaturate;129;126;91;143;83;75;145;141;112;144 15:38:15 INFO - PROCESS | 1679 | |8;json-parse-financial;51;61;88;88;88;61;62;84;67;72 15:38:15 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;67;62;63;71;72;74;69;71;93;62 15:38:15 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;85;83;84;86;83;85;84;92;107 15:38:15 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;141;144;143;139;149;164;163;142;171;143 15:38:15 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;207;202;204;199;201;200;205;220;207;180 15:38:15 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;72;73;72;80;84;72;60;70;85;82 15:38:15 INFO - PROCESS | 1679 | __end_tp_report 15:38:15 INFO - PROCESS | 1679 | __start_cc_report 15:38:15 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1114 15:38:15 INFO - PROCESS | 1679 | __end_cc_report 15:38:15 INFO - PROCESS | 1679 | __startTimestamp1461796695955__endTimestamp 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | ------- Summary: start ------- 15:38:15 INFO - PROCESS | 1679 | Number of tests: 14 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:132.30 Median:125.00 stddev:20.64 (16.5%) stddev-sans-first:18.66 15:38:15 INFO - PROCESS | 1679 | Values: 163.0 158.0 120.0 117.0 117.0 129.0 117.0 117.0 121.0 164.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:156.50 stddev:17.48 (11.2%) stddev-sans-first:17.34 15:38:15 INFO - PROCESS | 1679 | Values: 163.0 155.0 145.0 165.0 120.0 140.0 125.0 160.0 158.0 123.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:204.10 Median:202.00 stddev:8.74 (4.3%) stddev-sans-first:9.07 15:38:15 INFO - PROCESS | 1679 | Values: 199.0 215.0 224.0 205.0 201.0 199.0 202.0 197.0 202.0 197.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:85.50 Median:69.00 stddev:38.34 (55.6%) stddev-sans-first:39.86 15:38:15 INFO - PROCESS | 1679 | Values: 64.0 74.0 80.0 143.0 57.0 56.0 76.0 89.0 165.0 51.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:80.00 stddev:22.31 (27.9%) stddev-sans-first:23.03 15:38:15 INFO - PROCESS | 1679 | Values: 80.0 87.0 135.0 78.0 80.0 80.0 121.0 82.0 80.0 123.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:92.00 stddev:1.49 (1.6%) stddev-sans-first:1.45 15:38:15 INFO - PROCESS | 1679 | Values: 93.0 90.0 92.0 90.0 93.0 90.0 92.0 89.0 93.0 91.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:113.70 Median:143.00 stddev:18.99 (13.3%) stddev-sans-first:19.81 15:38:15 INFO - PROCESS | 1679 | Values: 104.0 98.0 96.0 98.0 102.0 113.0 107.0 149.0 137.0 133.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:118.90 Median:144.50 stddev:27.03 (18.7%) stddev-sans-first:28.42 15:38:15 INFO - PROCESS | 1679 | Values: 129.0 126.0 91.0 143.0 83.0 75.0 145.0 141.0 112.0 144.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:72.20 Median:78.00 stddev:13.82 (17.7%) stddev-sans-first:12.35 15:38:15 INFO - PROCESS | 1679 | Values: 51.0 61.0 88.0 88.0 88.0 61.0 62.0 84.0 67.0 72.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:9.05 (12.7%) stddev-sans-first:9.51 15:38:15 INFO - PROCESS | 1679 | Values: 67.0 62.0 63.0 71.0 72.0 74.0 69.0 71.0 93.0 62.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:84.50 stddev:7.45 (8.8%) stddev-sans-first:7.75 15:38:15 INFO - PROCESS | 1679 | Values: 83.0 85.0 83.0 84.0 86.0 83.0 85.0 84.0 92.0 107.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:146.50 stddev:11.58 (7.9%) stddev-sans-first:11.83 15:38:15 INFO - PROCESS | 1679 | Values: 141.0 144.0 143.0 139.0 149.0 164.0 163.0 142.0 171.0 143.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.50 Median:204.50 stddev:9.90 (4.8%) stddev-sans-first:10.37 15:38:15 INFO - PROCESS | 1679 | Values: 207.0 202.0 204.0 199.0 201.0 200.0 205.0 220.0 207.0 180.0 15:38:15 INFO - PROCESS | 1679 | 15:38:15 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:76.50 stddev:7.72 (10.1%) stddev-sans-first:8.11 15:38:15 INFO - PROCESS | 1679 | Values: 72.0 73.0 72.0 80.0 84.0 72.0 60.0 70.0 85.0 82.0 15:38:15 INFO - PROCESS | 1679 | -------- Summary: end -------- 15:38:15 INFO - PROCESS | 1679 | 15:38:16 INFO - TEST-INFO | 1679: exit 0 15:38:16 INFO - TEST-OK | kraken | took 61613ms 15:38:16 INFO - SUITE-END | took 1173s 15:38:17 INFO - Completed test suite (00:19:33) 15:38:17 INFO - javascript benchmark 15:38:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.509198528235, 3507.719382449403, 3519.806410647415, 3559.4660800879847, 3587.390143675575, 5763.337216220136, 5804.709764511778, 5809.2738407699035, 5839.532837373011, 5861.941380586203, 5428.4300148484435, 5739.167820666001, 5816.883662326751, 5914.733836977346, 5927.88144237115, 5197.766100525467, 5198.2722418861385, 5273.578113750891, 5286.577073834103, 5343.1985202219785, 855.1717780743339, 5195.844124676247, 5288.6562373445795, 5295.020421222067, 5370.060239458098, 5250.028744682246, 5263.578913686896, 5280.471952804727, 5280.894382112375, 5301.3373328333955, 5235.973820130913, 5334.946650533522, 5348.652337598043, 5357.276767636397, 5398.6220964532495, 5200.791968321262, 5213.817516386946, 5219.660722053092, 5272.525472707474, 5319.601029922771, 5268.31511903454, 5706.77172913083, 5732.541396688255, 5746.25298711169, 5788.479036886701, 6138.449706860586, 6147.569670123094, 6151.0, 6215.844603884894, 6219.813405597839, 6156.3843615638525, 6188.752449901998, 6214.4407003369915, 6228.159198508189, 6233.844153896189, 5910.852228694274, 5975.790847320366, 5979.252593425778, 6012.128241404972, 6024.668643224621, 6225.408586184305, 6301.306856245809, 6323.336049714806, 6346.2067241594805, 6383.457406120532, 6204.410580994799, 6224.844378890564, 6225.564210505312, 6234.906476402857, 6246.469050130699, 6193.969030154821, 6220.066989951453, 6223.253209614784, 6228.532860035515, 6232.501399888089, 4891.828785992473, 6131.988406491147, 6138.9095594588325, 6173.135760993465, 6190.783322583688, 5189.506996835295, 6096.364786074546, 6103.389661033861, 6114.175715401326, 6166.321704612489, 4732.881677958078, 4829.840838198807, 4914.213725803854, 4959.504049595012, 4994.525520075587, 4399.054203346296, 4430.313301438282, 4455.376247325377, 4485.955140448554, 4538.682292239578, 4916.582090522345, 5823.330317013513, 5843.065109582446, 5850.64896106235, 5928.3775203603, 6098.734805259241, 6238.0, 6238.190924631896, 6239.313675495692, 6258.405451482102, 5832.737526811219, 5929.584929055011, 5935.940640593539, 5946.821595352147, 5949.672767997715, 5447.5641948644015, 5466.01611709888, 5469.206964990054, 5477.3427188737605, 5486.396496385394, 5668.546516278688, 6134.069235337226, 6380.234371875405, 6446.871062578723, 6451.806445806634, 4957.355543779286, 5285.550728188147, 5404.0, 6161.84595385119, 6352.36476352361, 6404.391582799627, 6414.0, 6424.967875160782, 6428.292887782433, 6434.4852411806005, 6116.974953844038, 6126.111713801563, 6144.880016394337, 6232.220972378453, 6233.2208473940755, 6179.16581261524, 6186.876262474635, 6203.31763506023, 6207.348228435949, 6242.406971337716, 4733.006068725606, 5466.699331536644, 6106.358832322542, 6232.844178895564, 6249.625022498664, 6088.6042407243385, 6142.662153581596, 6164.599301045418, 6198.442140207403, 6220.720067596879, 4822.927656085091, 6006.399360063959, 6012.0, 6109.252844142398, 6109.580594149992, 5628.971855140698, 5667.376588575171, 5677.801276955287, 6161.983272759944, 6196.628202307876, 5942.702864856654, 6030.336662966983, 6083.513318934563, 6103.30736498198, 6117.26592808848], "value": 5657.800019015265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.2271038862483, 527.3592585009214, 529.4573062610824, 535.4912832808833, 551.57804279726, 37484.62515374846, 38153.0, 38155.618443815554, 38209.426858597144, 38312.233755324945, 38930.80534597323, 39020.0, 39729.404058939064, 39790.80104599473, 39801.0, 9230.95384523078, 9431.528423578828, 9504.809903801919, 9512.143907048365, 9541.570629321697, 9306.72079837606, 9440.763980900463, 9563.904360956405, 9581.712548623518, 9605.327627066108, 9474.810503789955, 9542.42745435276, 9601.991790861928, 9612.759681007996, 9641.276904232176, 9507.096825801538, 9540.189083927875, 9578.371676814959, 9578.425294482284, 9583.04169583043, 9383.249340052847, 9405.57674904631, 9520.761980950463, 9528.475933823636, 9554.092361225672, 37451.0, 37807.0, 38272.234555308736, 38407.03982400434, 38431.0, 2791.4556661451024, 3037.3971429140693, 3107.0989413070183, 3178.332550164468, 3372.392969265531, 25936.351591210183, 25940.22179334604, 25971.961121555116, 25974.610380844304, 26190.607140892902, 2588.262345231619, 2601.414681696622, 2626.592878103897, 2649.4568613434394, 2700.9594856077174, 305167.0, 306623.0, 309013.45493272616, 309138.45430772926, 309557.45221273974, 33659.0, 33886.0, 35253.0, 35272.0, 35289.64710352915, 36039.4594081089, 36186.09534761652, 61143.0, 62831.0, 62945.370546294864, 16552.172391380383, 16827.326906923587, 16829.83170168307, 16849.663006739796, 16897.408590699266, 12828.935855320664, 12865.614031579067, 12911.418986145645, 12913.09608327408, 12923.547675831489, 18678.906605466887, 18863.43409697711, 19147.712784308245, 19223.903880480786, 19255.13351899168, 6368.554201205964, 7773.766786996399, 7834.608269586498, 7839.451238413257, 7863.174366691529, 887.573964497045, 889.4307643108416, 992.831218692824, 1013.3970287678819, 1064.5741703318733, 29030.564541531894, 29188.562171567442, 29397.0, 29698.0, 29763.85118074439, 1043.222799014739, 1076.6931424543968, 1107.545906178463, 1124.7694222684331, 1138.8120960041665, 15061.774073388908, 15150.393984240727, 15170.31733571992, 15180.937334386486, 15421.306041228172, 429021.0, 495056.0, 496528.0, 502211.0, 505998.0, 57970.71014644984, 58121.128183077286, 58168.709156453944, 59020.70489647524, 59065.40934590685, 1268.923864568129, 1471.5953112893826, 1476.5939366674036, 1485.829129650104, 1488.8436714145075, 28680.0, 28804.30980200155, 28997.42005159927, 29055.854720727108, 29632.555511667775, 51529.742351288005, 51735.48264517307, 51949.74025130001, 52237.7388113057, 52324.0, 446183.0, 447907.0, 448435.0, 449307.0, 449319.0, 24973.250802475955, 25334.873325633253, 25367.238982830546, 25655.358616034748, 26929.326766830985, 45405.0, 45579.316310256036, 45945.0, 46245.30632040455, 46525.53474465347, 37178.25643487169, 37428.43857342088, 37633.0, 38047.619523805515, 38317.616823831406, 36698.633013669525, 36800.815995919846, 36851.262974740894, 37536.812315939336, 37787.43318850274, 30992.84503577558, 36307.0, 36423.3609487579, 36461.27077458383, 36790.26419471542, 25038.499230015663, 25756.61365079563, 28587.42825143527, 32319.676803231665, 33655.32689346249, 22977.540449190587, 24143.51712965766, 24320.87839560791, 24840.503189936462, 24884.0], "value": 18563.80808409764, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.4628707188277, 382.74738672476155, 390.83584894344375, 391.5986114232912, 396.4350800109843, 15407.614809629766, 18555.443336699904, 19266.325678601253, 19938.401847944548, 20006.899965500153, 18974.71537926932, 19813.20747170115, 19851.0, 20257.290994815183, 20269.695954560695, 5575.972120139394, 5724.370319264867, 5915.1718759373725, 5944.10838374243, 5954.31525374581, 5759.625624334426, 5818.563607729416, 5820.301563812327, 5834.824955251349, 5847.386024467433, 5652.547796176316, 5704.857378565527, 5783.566232532556, 5784.68184249866, 5785.161151633031, 5685.260916080903, 5748.281464816898, 5789.392113828029, 5807.390224026459, 5808.30300363959, 4956.4547899731, 5055.469175736532, 5068.163752980754, 5101.795928162869, 5101.95409940965, 23921.0, 24110.39724006914, 24412.0, 24601.63097553538, 24676.876615616988, 2100.2124203423714, 2132.76539580646, 2159.2334721173916, 2196.3520761375435, 2453.5092981403614, 14075.0, 14543.709125817424, 14608.669626377927, 14714.55856324312, 14944.925275373662, 1405.6415614018463, 1641.6716656668596, 1658.7029698539632, 1696.3129932377408, 1706.8549173320282, 99273.50363248137, 100318.0, 101545.0, 101970.99999999926, 103170.0, 10403.791924161475, 10436.63471778484, 11261.211715180023, 11299.54801807935, 11397.0, 14207.573772786833, 14449.92775036139, 14478.276086195649, 14482.927585362217, 14549.34527946245, 8343.249107580346, 8468.534230617375, 8576.356773242032, 8607.870881936777, 8630.964284285927, 8328.958355208186, 8460.238578527962, 8461.323094152453, 8558.090249315263, 8586.797848301243, 3949.2101579683604, 4117.938230926538, 4569.13186494565, 4613.1465678848845, 4703.576678098988, 1595.1658028255904, 1827.1777700035038, 1923.2210954563425, 1946.3090602836073, 1977.5056235941015, 897.4839467306325, 931.3247895276006, 946.3091942881597, 994.4580203788807, 998.1715176403568, 14083.0, 14966.551003469913, 17653.82346176522, 18418.43443307334, 20537.2811951581, 771.5409331447779, 975.4732444480044, 987.8518222266717, 998.510729742421, 1006.8590397344377, 10114.54484548197, 10447.111995480318, 10660.253782235324, 10692.89307106919, 10751.677449676523, 633780.0, 642839.5716042874, 652583.0, 657849.0, 666519.0, 76504.61747691338, 76591.61704191555, 106977.0, 112474.0, 117916.41041794737, 444.7798339821744, 460.9539046095431, 462.5836746927792, 463.52488699083034, 467.72638006766425, 10149.289549731744, 10853.131749459866, 10969.067629251604, 11196.496157673088, 11232.943835280772, 48364.516354836, 48773.75613121912, 49184.0, 50085.0, 52335.47664523306, 71107.0, 71577.56844863178, 72155.63922180356, 72989.0, 73641.26358736344, 7525.435592330487, 7688.8077798053255, 7757.3794096473275, 8030.478018928751, 8221.671133154607, 11527.538898444303, 11919.404029798301, 12115.575954841539, 12188.085893558196, 12258.26450412978, 10388.740281493023, 10558.630447934285, 10565.418901960466, 10625.149988001096, 10702.09032232269, 9015.323850711091, 9952.950235248778, 10001.699949001542, 10306.278560500694, 10906.563737450731, 10765.623203188165, 10768.784624307627, 10908.563657453613, 11073.390963497084, 11296.983271505604, 8053.557054361832, 8054.315383192495, 8081.191880811872, 8237.50574965504, 8279.0, 9827.0, 10612.257141999986, 10975.396353200651, 10996.560137594406, 10998.34009959405], "value": 8927.435572725202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1612.8467795559422, 1616.4827255278308, 1898.5538398476356, 1940.2045161483795, 1966.1840336260443, 7911.762647120581, 8448.0, 8468.53423061732, 8850.822983540333, 8851.955740221307, 8484.44851084679, 8519.701810436636, 8620.353473489498, 8640.740777776677, 8657.783555411117, 2401.86789726565, 2448.4980578981354, 2452.0559584559896, 2453.828232023759, 2465.506898620274, 2087.217293514932, 2360.6695062691238, 2410.590199666061, 2411.5056413435204, 2429.137656132074, 2150.7849215078522, 2420.770026847447, 2424.5756992526326, 2445.8410203336816, 2477.876106194692, 2426.5874801283826, 2428.5021570577987, 2430.647556104364, 2450.4608986023045, 2456.987715061431, 2072.782357852419, 2095.4970807006207, 2118.353902059871, 2431.805455563551, 2455.9263222103364, 7656.0, 8724.38929274951, 8798.29613630908, 8849.247813935823, 8879.822403551892, 5111.258867464197, 5336.279602253685, 5390.110631745757, 5421.376541697716, 5424.240606315119, 2795.580662900561, 3512.227309991798, 3564.2515071834687, 3576.0, 3579.838907249154, 1017.2218253036433, 1038.9324693894873, 1040.5785656809005, 1040.869891263592, 1041.3491567770143, 11305.265157764801, 11403.714907127305, 11437.913398227156, 11496.94251528737, 11509.136814738844, 4642.814287428532, 4647.930281045787, 4649.325847752057, 4657.86026419208, 4684.812607495662, 9255.67605133817, 9256.398334108397, 9264.67573634933, 9274.211692006254, 9310.86033709495, 5239.161734122522, 5325.440828713007, 5333.040052790458, 5351.411344752074, 5374.381946076252, 4404.339349097661, 4699.4360676718325, 4877.975610121997, 4932.1861892788, 4960.379952505937, 3948.407738839197, 3957.406389041667, 4067.2882245607493, 4083.5099788025627, 4113.197926404322, 1325.15190278222, 1354.4311389216355, 1367.193355920012, 1367.8153449284218, 1375.9724805503834, 916.8945571259258, 920.8222553660545, 933.1974501928336, 942.4439580647314, 968.7529679931572, 5626.578006649518, 5768.855778605568, 5926.970365148147, 5938.109283607407, 6034.719346130603, 441.9535948725402, 455.2079381875513, 465.9627229821606, 467.18709445564474, 473.3515084334484, 3591.3715099857423, 3827.4258861170492, 3864.555576108727, 3909.257241124177, 3920.2159568086495, 10255.846162307571, 10319.587216511256, 10501.159907207406, 10773.78452430947, 10773.78452430947, 10373.688789336333, 10533.894661053444, 10625.628103016357, 10652.733681657866, 10712.35725856451, 7896.486728362638, 8109.472884262504, 8198.344132469507, 8258.463199891868, 8328.0, 5613.46672066153, 5735.225744524602, 5769.192313076089, 5883.323417806836, 5984.9401505986125, 9339.066093390607, 9825.754356141153, 9855.063768941938, 9926.702198933755, 9931.205503559842, 9511.04889511071, 9952.353097048668, 9989.500524973868, 10013.0, 10077.042680945298, 7367.926320736724, 7502.812429689301, 7560.092788865371, 7630.656620451982, 7651.1583725789005, 8157.06193787722, 8227.753167404988, 8247.670093196444, 8332.458390204618, 8344.83310333802, 7174.3184397482155, 7180.856382872209, 7441.479096463196, 7498.0, 7581.583012934341, 7189.5686258824635, 7317.524360916524, 7376.041114655275, 7380.630968451664, 7434.628268586657, 6843.897341539781, 6857.485688573277, 6871.0, 6918.238993710587, 6928.411085057826, 4327.8485253016, 4385.1010542838, 4809.687370320918, 4951.405831300267, 5127.53852153308, 4923.975380123076, 4966.279889415942, 4967.677100988569, 5050.065737838511, 5165.638405311592], "value": 4487.287641729107, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.4409634705703, 314.4340187662209, 315.0658298145998, 318.4872355507634, 320.9791363561369, 4731.266653668683, 4855.126077306083, 4985.725785081814, 5501.752421141048, 5539.169124631308, 5328.893422131555, 5426.538744206738, 5450.4549545045475, 5452.863678408032, 5463.31708536433, 2968.61408016958, 3572.017695133833, 3661.853525858976, 4037.416053725618, 4217.683673724468, 3451.9482207766905, 3895.552011518669, 4141.302066152878, 4204.852830150945, 4212.431321771553, 3662.0, 3906.5312162540536, 4121.5466298707115, 4189.9790501047455, 4198.1393814268, 3832.2527107214105, 3896.947174938061, 4171.937420938689, 4193.580641935812, 4249.235137675218, 3293.4565796643524, 3641.4901913732097, 3658.8902332930056, 3667.9362984734394, 3671.8531258749617, 4000.4999375078114, 4420.491643461011, 4455.888602784924, 5220.947790522122, 5284.497972692588, 4048.838046478137, 4541.43232095988, 4806.735629540374, 4814.807407703687, 4834.806607735686, 5318.0589084984085, 5414.485623865727, 5707.400722924075, 5742.564358910273, 5743.339515955635, 3611.458281257806, 3760.7213547394017, 4035.899102522431, 4036.798160091984, 4040.2121586290687, 5354.41101478837, 5627.552014873543, 5920.496757775594, 6045.183900173464, 6121.959266924633, 3448.706859916885, 3586.5337506124038, 3921.490206273223, 3953.6639385651965, 3992.7803970781306, 4054.5134583849535, 4057.3711074783455, 4066.6543343815515, 4075.7758323292505, 4077.734947228421, 4252.659787217015, 4435.512093669694, 4680.040591678766, 4732.361131247307, 4761.642876784255, 5175.818846340435, 5358.4373640767935, 5415.702136382458, 5674.347450043216, 5781.935574145709, 1472.2565104622097, 1473.6242258224083, 1487.1077353587762, 1488.4864721671006, 1492.4925525321444, 840.9159084091542, 893.848045832197, 915.5651065743851, 935.0, 956.9808154315632, 4113.547509773923, 4775.928361074587, 4830.980637101811, 5207.916833266648, 5440.619156658996, 5247.449017853147, 5972.580290585022, 5982.252218472691, 5992.520598352121, 5997.7001149942325, 4616.8614941551805, 5206.921896171485, 5429.239906413105, 5446.509814116748, 5455.372632147274, 2951.7638588913264, 3243.140567749548, 3441.1225137589754, 3462.4113900636953, 3475.9826200868833, 5964.61230020056, 6437.300770437607, 6691.631960242234, 6874.690638921261, 6935.202451718117, 5157.510036546522, 6724.865502690017, 6735.292794256533, 6735.29279425663, 6748.122744043243, 6835.692393842289, 6859.142607174103, 6869.210040845367, 6876.553024053421, 6903.861922761516, 6339.334369891095, 6531.575447595891, 6543.901841472477, 6547.901781473186, 6557.573757705733, 5662.745176467151, 6057.57596968208, 6435.935640643721, 6440.29156792743, 6519.185101862267, 5392.460753924576, 6317.526185536011, 6332.620042797263, 6347.095871238517, 6826.488013399115, 3486.0, 3572.821358932095, 4038.293298672779, 4145.336746120606, 4180.205760905418, 5768.884802206929, 5854.326752423526, 6002.969985150046, 6040.697965101639, 6056.6076399822705, 4691.953080469151, 4838.661293709407, 5695.686737229326, 5708.429157084258, 5786.94213057864, 4976.925346119739, 5511.098670958513, 5770.0, 5830.0, 5838.1826544282985, 4330.254330004586, 4369.453818272716, 4805.183118869871, 5173.042987047258, 5717.256756621779, 5035.420926593489, 5608.971955140199, 5756.913646295226, 5859.677717725566, 5917.112433135064, 4814.422269327703, 5645.237892884572, 5753.18094133863, 5760.481556659753, 5761.8559536011935], "value": 4247.130943803216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.6951602262959, 685.492735375822, 724.0442615747214, 732.2713899669826, 749.835036292016, 12562.0, 14965.176915269656, 15101.093934363946, 15229.0, 16317.265723042461, 16192.83807161928, 16261.18694065295, 16283.918580407111, 16292.02247865129, 16318.265678044487, 772.775894990455, 911.4759013567209, 917.4862077236735, 922.8523436250201, 923.5797712041006, 721.0878239027634, 883.2845395229853, 901.3780491460903, 901.5762591581946, 903.0202230579829, 931.0596297739298, 937.3579098317674, 939.5114540438967, 939.8825146856643, 948.3882895532378, 912.7535565397305, 934.7476181430976, 934.7990182110844, 935.4527601353217, 948.4356807699443, 685.8114018644862, 686.9622170780605, 693.5318659904544, 699.5942353434996, 702.7961891051589, 15201.847981520154, 15368.231588420535, 15394.615134621612, 15417.3833046678, 15444.45944391952, 12145.878541214563, 12234.632961011095, 12264.141510094298, 12310.81533776994, 12514.249145051235, 9883.703488895273, 9898.80202395948, 10180.745481362952, 10473.738156546071, 10618.25672202946, 3382.0530251529613, 3412.522246885438, 3463.2554000889677, 3508.438649816017, 3523.1016090896915, 81844.0, 82996.0, 83130.0, 83379.0, 84554.73167902486, 9247.167754902091, 9257.768555786159, 9302.395344302598, 9553.426794392359, 9559.569819358145, 21039.263625773332, 21079.789202108088, 21184.15263389478, 21231.78768212298, 21591.78408215929, 7031.191412987469, 7228.963855180796, 7408.629568521553, 7476.0, 7565.130010048915, 4026.778527181033, 4041.2725709372594, 4043.272211001989, 4061.1674606705556, 4063.837446502166, 3450.258194488197, 3529.523514325533, 3531.9646803531637, 3548.8935331940083, 3549.6450354964295, 615.9414855588711, 632.6425569553188, 637.0571554099959, 637.3403527349171, 647.5273050673035, 512.7743792731186, 571.9914201286985, 581.9767209311665, 582.967936763482, 606.8816580766708, 8148.470349427387, 8207.466514676527, 8239.0, 8348.0, 8414.074451810297, 557.7713137613559, 558.837936998266, 566.6543408520881, 595.9582829202001, 597.1609888107216, 2996.955045674317, 3656.213914008501, 3754.55449651886, 3857.324968130566, 3969.6030396960073, 64180.35819641837, 77878.83181752278, 79160.60419697865, 92465.075349247, 92657.53671231601, 59455.0, 74237.0, 75170.0, 77910.83133752998, 78823.0, 72109.27890721131, 72254.0, 72338.55322893512, 72465.2753472469, 73485.99999999894, 7589.58257295854, 7654.770356889302, 7733.729319473791, 7845.0585929688805, 7867.409944254089, 44550.777246114856, 44952.77523612361, 45030.324545132506, 45085.32372014488, 46249.76875115603, 65223.02165467427, 65719.0, 65722.34277657354, 66411.66794166192, 66592.66703666451, 10204.4387558685, 10976.670699879016, 11184.776304474028, 11463.885361146615, 11833.585824496102, 11735.0, 11805.350705711267, 12101.765522713607, 12297.323647199131, 12757.107002509736, 9466.384684995453, 11413.885861141282, 11662.739146063703, 11859.644210673694, 12016.82095843578, 11412.885871141183, 11518.36648984314, 11702.590409335973, 11871.525138994344, 12392.132550721362, 11106.944465277946, 11329.943350283196, 11361.659150225507, 11401.885981140082, 11407.828882566602, 9003.234725048444, 9441.433513989183, 9815.018498150128, 9956.303058785816, 9957.402555846673, 9485.383450075724, 9571.760705982406, 9676.70969870905, 9690.32167748279, 9742.464164471023], "value": 6831.248628685787, "unit": "score"}], "name": "dromaeo_css", "value": 7043.314486738646, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 158.0, 120.0, 117.0, 117.0, 129.0, 117.0, 117.0, 121.0, 164.0], "value": 132.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 155.0, 145.0, 165.0, 120.0, 140.0, 125.0, 160.0, 158.0, 123.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 215.0, 224.0, 205.0, 201.0, 199.0, 202.0, 197.0, 202.0, 197.0], "value": 204.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 80.0, 143.0, 57.0, 56.0, 76.0, 89.0, 165.0, 51.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 135.0, 78.0, 80.0, 80.0, 121.0, 82.0, 80.0, 123.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 92.0, 90.0, 93.0, 90.0, 92.0, 89.0, 93.0, 91.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 98.0, 96.0, 98.0, 102.0, 113.0, 107.0, 149.0, 137.0, 133.0], "value": 113.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 126.0, 91.0, 143.0, 83.0, 75.0, 145.0, 141.0, 112.0, 144.0], "value": 118.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 61.0, 88.0, 88.0, 88.0, 61.0, 62.0, 84.0, 67.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 63.0, 71.0, 72.0, 74.0, 69.0, 71.0, 93.0, 62.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 84.0, 86.0, 83.0, 85.0, 84.0, 92.0, 107.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 143.0, 139.0, 149.0, 164.0, 163.0, 142.0, 171.0, 143.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 202.0, 204.0, 199.0, 201.0, 200.0, 205.0, 220.0, 207.0, 180.0], "value": 202.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 80.0, 84.0, 72.0, 60.0, 70.0, 85.0, 82.0], "value": 75.0, "unit": "score"}], "name": "kraken", "value": 1643.0000000000002, "alertThreshold": 2.0}]} 15:38:17 INFO - Return code: 0 15:38:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:38:17 ERROR - # TBPL SUCCESS # 15:38:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:38:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:38:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:38:17 INFO - 2016-04-27 15:38:17.289 screenresolution[1684:10290] starting screenresolution argv=screenresolution get 15:38:17 INFO - 2016-04-27 15:38:17.292 screenresolution[1684:10290] Display 0: 1600x1200x32@60 15:38:17 INFO - 2016-04-27 15:38:17.299 screenresolution[1685:10293] starting screenresolution argv=screenresolution list 15:38:17 INFO - Available Modes on Display 0 15:38:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:38:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:38:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:38:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:38:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:38:17 INFO - Intel Iris: 15:38:17 INFO - Chipset Model: Intel Iris 15:38:17 INFO - Type: GPU 15:38:17 INFO - Bus: Built-In 15:38:17 INFO - VRAM (Dynamic, Max): 1536 MB 15:38:17 INFO - Vendor: Intel (0x8086) 15:38:17 INFO - Device ID: 0x0a2e 15:38:17 INFO - Revision ID: 0x0009 15:38:17 INFO - Displays: 15:38:17 INFO - Display: 15:38:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:38:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:38:17 INFO - Display Serial Number: 1600x1200 60 15:38:17 INFO - Main Display: Yes 15:38:17 INFO - Mirror: Off 15:38:17 INFO - Online: Yes 15:38:17 INFO - Rotation: Supported 15:38:17 INFO - Return code: 0 15:38:17 INFO - Running post-action listener: _resource_record_post_action 15:38:17 INFO - Running post-run listener: _resource_record_post_run 15:38:18 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37578240; Write bytes: 699337728; Read time: 395; Write time: 2005 15:38:18 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 387119616; Write bytes: 382322688; Read time: 29563; Write time: 782 15:38:18 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31506432; Write bytes: 299271168; Read time: 315; Write time: 1187 15:38:18 INFO - Running post-run listener: _upload_blobber_files 15:38:18 INFO - Blob upload gear active. 15:38:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:18 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 15:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:38:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:20 INFO - (blobuploader) - INFO - Done attempting. 15:38:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:38:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:38:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:21 INFO - (blobuploader) - INFO - Done attempting. 15:38:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:21 INFO - Return code: 0 15:38:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7745bd2319630d09b51ca57c0348b41000547422cd097f43a53b679206434f0a51bbad71abb38fbe89258a6e63393f7550c07b8cd0c28d98f898f8794f8e4aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23deb7f5f6b5283d73ab70f87f93b2ba7bd8df94700bb17131f6765cf7f3dde1ee8c985e613c8aa0f583a59cf642ad4cb76f305cb725c2e302223f440c36e8be"} 15:38:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:21 INFO - Contents: 15:38:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7745bd2319630d09b51ca57c0348b41000547422cd097f43a53b679206434f0a51bbad71abb38fbe89258a6e63393f7550c07b8cd0c28d98f898f8794f8e4aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23deb7f5f6b5283d73ab70f87f93b2ba7bd8df94700bb17131f6765cf7f3dde1ee8c985e613c8aa0f583a59cf642ad4cb76f305cb725c2e302223f440c36e8be"} 15:38:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:21 INFO - Copying logs to upload dir... 15:38:21 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.778974 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-27 15:38:21.293105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 15:38:21.296247) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WijCJh3zQG/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7745bd2319630d09b51ca57c0348b41000547422cd097f43a53b679206434f0a51bbad71abb38fbe89258a6e63393f7550c07b8cd0c28d98f898f8794f8e4aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23deb7f5f6b5283d73ab70f87f93b2ba7bd8df94700bb17131f6765cf7f3dde1ee8c985e613c8aa0f583a59cf642ad4cb76f305cb725c2e302223f440c36e8be"} build_url:https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/LwDKtZhTTlmR74TLYdQCNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7745bd2319630d09b51ca57c0348b41000547422cd097f43a53b679206434f0a51bbad71abb38fbe89258a6e63393f7550c07b8cd0c28d98f898f8794f8e4aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23deb7f5f6b5283d73ab70f87f93b2ba7bd8df94700bb17131f6765cf7f3dde1ee8c985e613c8aa0f583a59cf642ad4cb76f305cb725c2e302223f440c36e8be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 15:38:21.324696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:38:21.325037) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WijCJh3zQG/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RlPDXpo7aB/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005347 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 15:38:21.373821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 15:38:21.374153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 15:38:21.374617) ========= ========= Total master_lag: 0.15 =========