builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1475623664.34 results: success (0) buildid: 20161004141800 builduid: f61eb53279fb4e5ea39e289ca98da3a7 revision: 43c3d294f63cd8e49fca491a686f729cfd66a365 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.345228) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.345692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.345980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.369711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.370125) ========= 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.KWoI1V8vjr/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.elweUiRi8u/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-10-04 16:27:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.5M=0.001s 2016-10-04 16:27:44 (20.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.513782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.514113) ========= 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.KWoI1V8vjr/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.elweUiRi8u/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.021094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:44.564717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 16:27:44.565184) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 43c3d294f63cd8e49fca491a686f729cfd66a365 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 43c3d294f63cd8e49fca491a686f729cfd66a365 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KWoI1V8vjr/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.elweUiRi8u/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-10-04 16:27:44,633 truncating revision to first 12 chars 2016-10-04 16:27:44,633 Setting DEBUG logging. 2016-10-04 16:27:44,634 attempt 1/10 2016-10-04 16:27:44,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/43c3d294f63c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 16:27:46,402 unpacking tar archive at: mozilla-aurora-43c3d294f63c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.036803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 16:27:46.624622) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.625037) ========= script_repo_revision: 43c3d294f63cd8e49fca491a686f729cfd66a365 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.625434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.625698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.644149) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 16:27:46.644543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KWoI1V8vjr/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.elweUiRi8u/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:27:46 INFO - MultiFileLogger online at 20161004 16:27:46 in /builds/slave/test 16:27:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:27:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:27:46 INFO - {'append_to_log': False, 16:27:46 INFO - 'base_work_dir': '/builds/slave/test', 16:27:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:27:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:27:46 INFO - 'branch': 'Mozilla-Aurora', 16:27:46 INFO - 'buildbot_json_path': 'buildprops.json', 16:27:46 INFO - 'config_files': ('talos/mac_config.py',), 16:27:46 INFO - 'default_actions': ('clobber', 16:27:46 INFO - 'read-buildbot-config', 16:27:46 INFO - 'download-and-extract', 16:27:46 INFO - 'populate-webroot', 16:27:46 INFO - 'create-virtualenv', 16:27:46 INFO - 'install', 16:27:46 INFO - 'run-tests'), 16:27:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:27:46 INFO - 'download_minidump_stackwalk': True, 16:27:46 INFO - 'download_symbols': 'ondemand', 16:27:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:27:46 INFO - 'tooltool.py': '/tools/tooltool.py', 16:27:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:27:46 INFO - '/tools/misc-python/virtualenv.py')}, 16:27:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:27:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:27:46 INFO - 'installer_path': 'installer.exe', 16:27:46 INFO - 'log_level': 'info', 16:27:46 INFO - 'log_name': 'talos', 16:27:46 INFO - 'log_to_console': True, 16:27:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:27:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:27:46 INFO - 'opt_config_files': (), 16:27:46 INFO - 'pip_index': False, 16:27:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:27:46 INFO - 'cmd': ('bash', 16:27:46 INFO - '-c', 16:27:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:27:46 INFO - 'enabled': True, 16:27:46 INFO - 'halt_on_failure': False, 16:27:46 INFO - 'name': 'check_screen_resolution'},), 16:27:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:27:46 INFO - 'cmd': ('bash', 16:27:46 INFO - '-c', 16:27:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:27:46 INFO - 'enabled': True, 16:27:46 INFO - 'halt_on_failure': False, 16:27:46 INFO - 'name': 'check_screen_resolution'},), 16:27:46 INFO - 'run_cmd_checks_enabled': True, 16:27:46 INFO - 'sps_profile': False, 16:27:46 INFO - 'sps_profile_interval': 0, 16:27:46 INFO - 'suite': 'dromaeojs', 16:27:46 INFO - 'system_bits': '32', 16:27:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:27:46 INFO - 'title': 't-yosemite-r7-0097', 16:27:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:27:46 INFO - 'use_talos_json': True, 16:27:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:27:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:27:46 INFO - 'work_dir': 'build'} 16:27:46 INFO - [mozharness: 2016-10-04 23:27:46.837982Z] Running clobber step. 16:27:46 INFO - Running pre-action listener: _resource_record_pre_action 16:27:46 INFO - Running main action method: clobber 16:27:46 INFO - rmtree: /builds/slave/test/build 16:27:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:27:47 INFO - Running post-action listener: _resource_record_post_action 16:27:47 INFO - [mozharness: 2016-10-04 23:27:47.175614Z] Finished clobber step (success) 16:27:47 INFO - [mozharness: 2016-10-04 23:27:47.175736Z] Running read-buildbot-config step. 16:27:47 INFO - Running pre-action listener: _resource_record_pre_action 16:27:47 INFO - Running main action method: read_buildbot_config 16:27:47 INFO - Using buildbot properties: 16:27:47 INFO - { 16:27:47 INFO - "project": "", 16:27:47 INFO - "product": "firefox", 16:27:47 INFO - "script_repo_revision": "production", 16:27:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:27:47 INFO - "repository": "", 16:27:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:27:47 INFO - "buildid": "20161004141800", 16:27:47 INFO - "pgo_build": "False", 16:27:47 INFO - "basedir": "/builds/slave/test", 16:27:47 INFO - "buildnumber": 35, 16:27:47 INFO - "slavename": "t-yosemite-r7-0097", 16:27:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:27:47 INFO - "platform": "yosemite_r7", 16:27:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:27:47 INFO - "branch": "mozilla-aurora", 16:27:47 INFO - "repo_path": "releases/mozilla-aurora", 16:27:47 INFO - "revision": "43c3d294f63cd8e49fca491a686f729cfd66a365", 16:27:47 INFO - "stage_platform": "macosx64", 16:27:47 INFO - "builduid": "f61eb53279fb4e5ea39e289ca98da3a7", 16:27:47 INFO - "slavebuilddir": "test" 16:27:47 INFO - } 16:27:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:27:47 INFO - Running post-action listener: _resource_record_post_action 16:27:47 INFO - [mozharness: 2016-10-04 23:27:47.179118Z] Finished read-buildbot-config step (success) 16:27:47 INFO - [mozharness: 2016-10-04 23:27:47.179215Z] Running download-and-extract step. 16:27:47 INFO - Running pre-action listener: _resource_record_pre_action 16:27:47 INFO - Running main action method: download_and_extract 16:27:47 INFO - mkdir: /builds/slave/test/build/tests 16:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:27:47 INFO - trying https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:27:48 INFO - Downloaded 1199 bytes. 16:27:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:27:48 INFO - Using the following test package requirements: 16:27:48 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:27:48 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:27:48 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:27:48 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'jsshell-mac.zip'], 16:27:48 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:27:48 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:27:48 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:27:48 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:27:48 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:27:48 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:48 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:27:48 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:27:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:27:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:27:48 INFO - Fetch https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:27:49 INFO - Expected file size: 16434087 16:27:56 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:27:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:27:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:27:56 INFO - Fetch https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:27:57 INFO - Expected file size: 16434087 16:28:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:28:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:28:03 INFO - Fetch https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:28:05 INFO - Expected file size: 14414059 16:28:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:05 INFO - trying https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:28:08 INFO - Downloaded 115317312 bytes. 16:28:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:28:08 INFO - mkdir: /builds/slave/test/properties 16:28:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:08 INFO - Contents: 16:28:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:28:09 INFO - Running post-action listener: _resource_record_post_action 16:28:09 INFO - Running post-action listener: set_extra_try_arguments 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.398880Z] Finished download-and-extract step (success) 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.399003Z] Running populate-webroot step. 16:28:09 INFO - Running pre-action listener: _resource_record_pre_action 16:28:09 INFO - Running main action method: populate_webroot 16:28:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:09 INFO - '--tppagecycles', 16:28:09 INFO - '7'], 16:28:09 INFO - 'tests': ['tsvgm']}}, 16:28:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['damp', 'tps']}, 16:28:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'tests': ['damp', 'tps']}, 16:28:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['dromaeo_dom']}, 16:28:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['basic_compositor_video']}, 16:28:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tsvgx', 16:28:09 INFO - 'tsvgr_opacity', 16:28:09 INFO - 'tart', 16:28:09 INFO - 'tscrollx', 16:28:09 INFO - 'cart']}, 16:28:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:09 INFO - 'tsvgr_opacity', 16:28:09 INFO - 'tart', 16:28:09 INFO - 'tscrollx', 16:28:09 INFO - 'cart']}, 16:28:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tp5o']}, 16:28:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'tests': ['tp5o']}, 16:28:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s', 16:28:09 INFO - '--xperf_path', 16:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:09 INFO - 'tests': ['tp5n']}, 16:28:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--xperf_path', 16:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:09 INFO - 'tests': ['tp5n']}}, 16:28:09 INFO - 'talos.zip': {'path': '', 16:28:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:09 INFO - Running post-action listener: _resource_record_post_action 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.417574Z] Finished populate-webroot step (success) 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.417659Z] Running create-virtualenv step. 16:28:09 INFO - Running pre-action listener: _resource_record_pre_action 16:28:09 INFO - Running main action method: create_virtualenv 16:28:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:28:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:09 INFO - Using real prefix '/tools/python27' 16:28:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:13 INFO - Installing pip.................done. 16:28:13 INFO - Return code: 0 16:28:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 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 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:13 INFO - 'HOME': '/Users/cltbld', 16:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:13 INFO - 'LOGNAME': 'cltbld', 16:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:13 INFO - 'MOZ_NO_REMOTE': '1', 16:28:13 INFO - 'NO_EM_RESTART': '1', 16:28:13 INFO - 'PAGER': '/bin/cat', 16:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:13 INFO - 'PWD': '/builds/slave/test', 16:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:13 INFO - 'SHELL': '/bin/bash', 16:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:13 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:13 INFO - 'USER': 'cltbld', 16:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:13 INFO - 'XPC_FLAGS': '0x0', 16:28:13 INFO - 'XPC_SERVICE_NAME': '0', 16:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:28:13 INFO - Cleaning up... 16:28:13 INFO - Return code: 0 16:28:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:13 INFO - 'HOME': '/Users/cltbld', 16:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:13 INFO - 'LOGNAME': 'cltbld', 16:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:13 INFO - 'MOZ_NO_REMOTE': '1', 16:28:13 INFO - 'NO_EM_RESTART': '1', 16:28:13 INFO - 'PAGER': '/bin/cat', 16:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:13 INFO - 'PWD': '/builds/slave/test', 16:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:13 INFO - 'SHELL': '/bin/bash', 16:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:13 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:13 INFO - 'USER': 'cltbld', 16:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:13 INFO - 'XPC_FLAGS': '0x0', 16:28:13 INFO - 'XPC_SERVICE_NAME': '0', 16:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:13 INFO - Downloading/unpacking psutil>=3.1.1 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:17 INFO - Installing collected packages: psutil 16:28:17 INFO - Running setup.py install for psutil 16:28:17 INFO - building 'psutil._psutil_osx' extension 16:28:17 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 16:28:17 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 16:28:17 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 16:28:17 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 16:28:17 INFO - building 'psutil._psutil_posix' extension 16:28:17 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 16:28:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:28:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:28:17 INFO - ^ 16:28:17 INFO - 1 warning generated. 16:28:17 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 16:28:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:18 INFO - Successfully installed psutil 16:28:18 INFO - Cleaning up... 16:28:18 INFO - Return code: 0 16:28:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:18 INFO - 'HOME': '/Users/cltbld', 16:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:18 INFO - 'LOGNAME': 'cltbld', 16:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:18 INFO - 'MOZ_NO_REMOTE': '1', 16:28:18 INFO - 'NO_EM_RESTART': '1', 16:28:18 INFO - 'PAGER': '/bin/cat', 16:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:18 INFO - 'PWD': '/builds/slave/test', 16:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:18 INFO - 'SHELL': '/bin/bash', 16:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:18 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:18 INFO - 'USER': 'cltbld', 16:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:18 INFO - 'XPC_FLAGS': '0x0', 16:28:18 INFO - 'XPC_SERVICE_NAME': '0', 16:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:28:20 INFO - Installing collected packages: mozsystemmonitor 16:28:20 INFO - Running setup.py install for mozsystemmonitor 16:28:21 INFO - Successfully installed mozsystemmonitor 16:28:21 INFO - Cleaning up... 16:28:21 INFO - Return code: 0 16:28:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:21 INFO - 'HOME': '/Users/cltbld', 16:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:21 INFO - 'LOGNAME': 'cltbld', 16:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:21 INFO - 'MOZ_NO_REMOTE': '1', 16:28:21 INFO - 'NO_EM_RESTART': '1', 16:28:21 INFO - 'PAGER': '/bin/cat', 16:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:21 INFO - 'PWD': '/builds/slave/test', 16:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:21 INFO - 'SHELL': '/bin/bash', 16:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:21 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:21 INFO - 'USER': 'cltbld', 16:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:21 INFO - 'XPC_FLAGS': '0x0', 16:28:21 INFO - 'XPC_SERVICE_NAME': '0', 16:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:28:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:24 INFO - Downloading functools32-3.2.3-2.tar.gz 16:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:28:24 INFO - warning: no files found matching '*.txt' 16:28:24 INFO - no previously-included directories found matching 'build' 16:28:24 INFO - no previously-included directories found matching 'dist' 16:28:24 INFO - no previously-included directories found matching '.git*' 16:28:24 INFO - Installing collected packages: jsonschema, functools32 16:28:24 INFO - Running setup.py install for functools32 16:28:24 INFO - warning: no files found matching '*.txt' 16:28:24 INFO - no previously-included directories found matching 'build' 16:28:24 INFO - no previously-included directories found matching 'dist' 16:28:24 INFO - no previously-included directories found matching '.git*' 16:28:24 INFO - Successfully installed jsonschema functools32 16:28:24 INFO - Cleaning up... 16:28:24 INFO - Return code: 0 16:28:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:28:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:24 INFO - 'HOME': '/Users/cltbld', 16:28:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:24 INFO - 'LOGNAME': 'cltbld', 16:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:24 INFO - 'MOZ_NO_REMOTE': '1', 16:28:24 INFO - 'NO_EM_RESTART': '1', 16:28:24 INFO - 'PAGER': '/bin/cat', 16:28:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:24 INFO - 'PWD': '/builds/slave/test', 16:28:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:24 INFO - 'SHELL': '/bin/bash', 16:28:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:24 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:24 INFO - 'USER': 'cltbld', 16:28:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:24 INFO - 'XPC_FLAGS': '0x0', 16:28:24 INFO - 'XPC_SERVICE_NAME': '0', 16:28:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:28:25 INFO - Cleaning up... 16:28:25 INFO - Return code: 0 16:28:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:25 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 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:25 INFO - 'HOME': '/Users/cltbld', 16:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:25 INFO - 'LOGNAME': 'cltbld', 16:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:25 INFO - 'MOZ_NO_REMOTE': '1', 16:28:25 INFO - 'NO_EM_RESTART': '1', 16:28:25 INFO - 'PAGER': '/bin/cat', 16:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:25 INFO - 'PWD': '/builds/slave/test', 16:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:25 INFO - 'SHELL': '/bin/bash', 16:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:25 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:25 INFO - 'USER': 'cltbld', 16:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:25 INFO - 'XPC_FLAGS': '0x0', 16:28:25 INFO - 'XPC_SERVICE_NAME': '0', 16:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:25 INFO - Downloading/unpacking blobuploader==1.2.4 16:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:27 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:28 INFO - Downloading docopt-0.6.1.tar.gz 16:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:29 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:29 INFO - Running setup.py install for blobuploader 16:28:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:29 INFO - Running setup.py install for requests 16:28:29 INFO - Running setup.py install for docopt 16:28:29 INFO - Successfully installed blobuploader requests docopt 16:28:29 INFO - Cleaning up... 16:28:29 INFO - Return code: 0 16:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:29 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 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:29 INFO - 'HOME': '/Users/cltbld', 16:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:29 INFO - 'LOGNAME': 'cltbld', 16:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:29 INFO - 'MOZ_NO_REMOTE': '1', 16:28:29 INFO - 'NO_EM_RESTART': '1', 16:28:29 INFO - 'PAGER': '/bin/cat', 16:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:29 INFO - 'PWD': '/builds/slave/test', 16:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:29 INFO - 'SHELL': '/bin/bash', 16:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:29 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:29 INFO - 'USER': 'cltbld', 16:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:29 INFO - 'XPC_FLAGS': '0x0', 16:28:29 INFO - 'XPC_SERVICE_NAME': '0', 16:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-DgMOr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-vyp_pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-WG0ome-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-0r0_LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-7mx6zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-xH29yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CGMkZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-2ThSWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:30 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-XpCOBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-sfAQFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-gfTdzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-wCcL7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-q1MANu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-JJzlp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-LxrvTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-RIkx1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:31 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-C_ph2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:31 INFO - Running setup.py install for manifestparser 16:28:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozcrash 16:28:32 INFO - Running setup.py install for mozdebug 16:28:32 INFO - Running setup.py install for mozdevice 16:28:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozfile 16:28:32 INFO - Running setup.py install for mozhttpd 16:28:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozinfo 16:28:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozInstall 16:28:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for mozleak 16:28:33 INFO - Running setup.py install for mozlog 16:28:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for moznetwork 16:28:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for mozprocess 16:28:33 INFO - Running setup.py install for mozprofile 16:28:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for mozrunner 16:28:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Running setup.py install for mozscreenshot 16:28:34 INFO - Running setup.py install for moztest 16:28:34 INFO - Running setup.py install for mozversion 16:28:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:28:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:28:34 INFO - Cleaning up... 16:28:34 INFO - Return code: 0 16:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:34 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 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:28:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:34 INFO - 'HOME': '/Users/cltbld', 16:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:34 INFO - 'LOGNAME': 'cltbld', 16:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:34 INFO - 'MOZ_NO_REMOTE': '1', 16:28:34 INFO - 'NO_EM_RESTART': '1', 16:28:34 INFO - 'PAGER': '/bin/cat', 16:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:34 INFO - 'PWD': '/builds/slave/test', 16:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:34 INFO - 'SHELL': '/bin/bash', 16:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:34 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:34 INFO - 'USER': 'cltbld', 16:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:34 INFO - 'XPC_FLAGS': '0x0', 16:28:34 INFO - 'XPC_SERVICE_NAME': '0', 16:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:34 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-tnFq4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-MYJFGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-kZsemF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-od3Tu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-kunZmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-cQm9A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-UnQXAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ken2X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-TvgnZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-NkhooJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:35 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ubLG1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-wYv7Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QzGVgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-vi61mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-f2guNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-e4Y3ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-dSSpsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:28:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:39 INFO - Downloading blessings-1.6.tar.gz 16:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:28:39 INFO - Installing collected packages: blessings 16:28:39 INFO - Running setup.py install for blessings 16:28:39 INFO - Successfully installed blessings 16:28:39 INFO - Cleaning up... 16:28:39 INFO - Return code: 0 16:28:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:39 INFO - Reading from file tmpfile_stdout 16:28:39 INFO - Current package versions: 16:28:39 INFO - blessings == 1.6 16:28:39 INFO - blobuploader == 1.2.4 16:28:39 INFO - docopt == 0.6.1 16:28:39 INFO - functools32 == 3.2.3-2 16:28:39 INFO - jsonschema == 2.5.1 16:28:39 INFO - manifestparser == 1.1 16:28:39 INFO - mozInstall == 1.12 16:28:39 INFO - mozcrash == 0.17 16:28:39 INFO - mozdebug == 0.1 16:28:39 INFO - mozdevice == 0.48 16:28:39 INFO - mozfile == 1.2 16:28:39 INFO - mozhttpd == 0.7 16:28:39 INFO - mozinfo == 0.9 16:28:39 INFO - mozleak == 0.1 16:28:39 INFO - mozlog == 3.4 16:28:39 INFO - moznetwork == 0.27 16:28:39 INFO - mozprocess == 0.23 16:28:39 INFO - mozprofile == 0.28 16:28:39 INFO - mozrunner == 6.12 16:28:39 INFO - mozscreenshot == 0.1 16:28:39 INFO - mozsystemmonitor == 0.3 16:28:39 INFO - moztest == 0.7 16:28:39 INFO - mozversion == 1.4 16:28:39 INFO - psutil == 3.1.1 16:28:39 INFO - requests == 1.2.3 16:28:39 INFO - wsgiref == 0.1.2 16:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:40 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 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:40 INFO - 'HOME': '/Users/cltbld', 16:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:40 INFO - 'LOGNAME': 'cltbld', 16:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:40 INFO - 'MOZ_NO_REMOTE': '1', 16:28:40 INFO - 'NO_EM_RESTART': '1', 16:28:40 INFO - 'PAGER': '/bin/cat', 16:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:40 INFO - 'PWD': '/builds/slave/test', 16:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:40 INFO - 'SHELL': '/bin/bash', 16:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:40 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:40 INFO - 'USER': 'cltbld', 16:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:40 INFO - 'XPC_FLAGS': '0x0', 16:28:40 INFO - 'XPC_SERVICE_NAME': '0', 16:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:28:40 INFO - Cleaning up... 16:28:40 INFO - Return code: 0 16:28:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1027f1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102767570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97884db020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, '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.KWoI1V8vjr/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.elweUiRi8u/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:28: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', 'jsonschema'] in /builds/slave/test/build 16:28: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 jsonschema 16:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:40 INFO - 'HOME': '/Users/cltbld', 16:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:40 INFO - 'LOGNAME': 'cltbld', 16:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:40 INFO - 'MOZ_NO_REMOTE': '1', 16:28:40 INFO - 'NO_EM_RESTART': '1', 16:28:40 INFO - 'PAGER': '/bin/cat', 16:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:40 INFO - 'PWD': '/builds/slave/test', 16:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:40 INFO - 'SHELL': '/bin/bash', 16:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:28:40 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:40 INFO - 'USER': 'cltbld', 16:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:40 INFO - 'XPC_FLAGS': '0x0', 16:28:40 INFO - 'XPC_SERVICE_NAME': '0', 16:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:28:40 INFO - Cleaning up... 16:28:40 INFO - Return code: 0 16:28:40 INFO - Running post-action listener: _resource_record_post_action 16:28:40 INFO - Running post-action listener: _start_resource_monitoring 16:28:40 INFO - Starting resource monitoring. 16:28:40 INFO - [mozharness: 2016-10-04 23:28:40.867887Z] Finished create-virtualenv step (success) 16:28:40 INFO - [mozharness: 2016-10-04 23:28:40.868898Z] Running install step. 16:28:40 INFO - Running pre-action listener: _resource_record_pre_action 16:28:40 INFO - Running main action method: install 16:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:41 INFO - Reading from file tmpfile_stdout 16:28:41 INFO - Detecting whether we're running mozinstall >=1.0... 16:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:28:41 INFO - Reading from file tmpfile_stdout 16:28:41 INFO - Output received: 16:28:41 INFO - Usage: mozinstall [options] installer 16:28:41 INFO - Options: 16:28:41 INFO - -h, --help show this help message and exit 16:28:41 INFO - -d DEST, --destination=DEST 16:28:41 INFO - Directory to install application into. [default: 16:28:41 INFO - "/builds/slave/test"] 16:28:41 INFO - --app=APP Application being installed. [default: firefox] 16:28:41 INFO - mkdir: /builds/slave/test/build/application 16:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:29:14 INFO - Reading from file tmpfile_stdout 16:29:14 INFO - Output received: 16:29:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:29:14 INFO - Running post-action listener: _resource_record_post_action 16:29:14 INFO - [mozharness: 2016-10-04 23:29:14.722359Z] Finished install step (success) 16:29:14 INFO - [mozharness: 2016-10-04 23:29:14.722499Z] Running run-tests step. 16:29:14 INFO - Running pre-action listener: _resource_record_pre_action 16:29:14 INFO - Running main action method: run_tests 16:29:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:29:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:29:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:29:14 INFO - 2016-10-04 16:29:14.737 screenresolution[2583:80731] starting screenresolution argv=screenresolution get 16:29:14 INFO - 2016-10-04 16:29:14.739 screenresolution[2583:80731] Display 0: 1600x1200x32@60 16:29:14 INFO - 2016-10-04 16:29:14.745 screenresolution[2584:80733] starting screenresolution argv=screenresolution list 16:29:14 INFO - Available Modes on Display 0 16:29:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:29:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:29:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:29:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:29:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:29:14 INFO - Intel Iris: 16:29:14 INFO - Chipset Model: Intel Iris 16:29:14 INFO - Type: GPU 16:29:14 INFO - Bus: Built-In 16:29:14 INFO - VRAM (Dynamic, Max): 1536 MB 16:29:14 INFO - Vendor: Intel (0x8086) 16:29:14 INFO - Device ID: 0x0a2e 16:29:14 INFO - Revision ID: 0x0009 16:29:14 INFO - Displays: 16:29:14 INFO - Display: 16:29:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:29:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:29:14 INFO - Display Serial Number: 1600x1200 60 16:29:14 INFO - Main Display: Yes 16:29:14 INFO - Mirror: Off 16:29:14 INFO - Online: Yes 16:29:14 INFO - Rotation: Supported 16:29:14 INFO - Return code: 0 16:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:14 INFO - Python 2.7.3 16:29:14 INFO - Return code: 0 16:29:14 INFO - grabbing minidump binary from tooltool 16:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:14 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102605d30>, '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 0x10246bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1025fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:14 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 16:29:14 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 16:29:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:29:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:15 INFO - Return code: 0 16:29:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:29:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:29:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:29:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KWoI1V8vjr/Render', 16:29:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:15 INFO - 'HOME': '/Users/cltbld', 16:29:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:15 INFO - 'LOGNAME': 'cltbld', 16:29:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:15 INFO - 'MOZ_NO_REMOTE': '1', 16:29:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:15 INFO - 'NO_EM_RESTART': '1', 16:29:15 INFO - 'PAGER': '/bin/cat', 16:29:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:15 INFO - 'PWD': '/builds/slave/test', 16:29:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:15 INFO - 'SHELL': '/bin/bash', 16:29:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.elweUiRi8u/Listeners', 16:29:15 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:29:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:15 INFO - 'USER': 'cltbld', 16:29:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:15 INFO - 'XPC_FLAGS': '0x0', 16:29:15 INFO - 'XPC_SERVICE_NAME': '0', 16:29:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:29:15 INFO - mozversion application_buildid: 20161004141800 16:29:15 INFO - mozversion application_changeset: 43c3d294f63cd8e49fca491a686f729cfd66a365 16:29:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:29:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:15 INFO - mozversion application_name: Firefox 16:29:15 INFO - mozversion application_remotingname: firefox-dev 16:29:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:29:15 INFO - mozversion application_vendor: Mozilla 16:29:15 INFO - mozversion application_version: 51.0a2 16:29:15 INFO - mozversion platform_buildid: 20161004141800 16:29:15 INFO - mozversion platform_changeset: 43c3d294f63cd8e49fca491a686f729cfd66a365 16:29:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:29:15 INFO - mozversion platform_version: 51.0a2 16:29:15 INFO - using testdate: 1475623755 16:29:15 INFO - actual date: 1475623755 16:29:15 INFO - starting webserver on 'localhost:58264' 16:29:15 INFO - SUITE-START | Running 2 tests 16:29:15 INFO - TEST-START | dromaeo_css 16:29:15 INFO - operating with platform_type : mac_ 16:29:15 INFO - Initialising browser for dromaeo_css test... 16:29:15 INFO - TEST-INFO | started process 2594 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpPRY7p2/profile http://localhost:58264/getInfo.html) 16:29:17 INFO - PROCESS | 2594 | __metrics Screen width/height:1600/1200 16:29:17 INFO - PROCESS | 2594 | colorDepth:24 16:29:17 INFO - PROCESS | 2594 | Browser inner width/height: 1024/689 16:29:17 INFO - PROCESS | 2594 | __metrics 16:29:18 INFO - PROCESS | 2594 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:29:18 INFO - PROCESS | 2594 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:18 INFO - TEST-INFO | 2594: exit 0 16:29:18 INFO - Browser initialized. 16:29:18 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:18 INFO - TEST-INFO | started process 2596 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpPRY7p2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:30 INFO - PROCESS | 2596 | RSS: Main: 219787264 16:29:30 INFO - PROCESS | 2596 | 16:30:22 INFO - PROCESS | 2596 | 1475623822141 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:32:34 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:58264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58264/tests/dromaeo/cssquery-ext.html) 16:32:36 INFO - PROCESS | 2596 | RSS: Main: 328531968 16:32:36 INFO - PROCESS | 2596 | 16:35:39 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:58264/tests/dromaeo/cssquery-ext.html (next: http://localhost:58264/tests/dromaeo/cssquery-jquery.html) 16:35:39 INFO - PROCESS | 2596 | RSS: Main: 351412224 16:35:39 INFO - PROCESS | 2596 | 16:38:42 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:58264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58264/tests/dromaeo/cssquery-mootools.html) 16:38:42 INFO - PROCESS | 2596 | RSS: Main: 316624896 16:38:42 INFO - PROCESS | 2596 | 16:41:45 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:58264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58264/tests/dromaeo/cssquery-prototype.html) 16:41:45 INFO - PROCESS | 2596 | RSS: Main: 320733184 16:41:45 INFO - PROCESS | 2596 | 16:44:49 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:58264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58264/tests/dromaeo/cssquery-yui.html) 16:44:49 INFO - PROCESS | 2596 | RSS: Main: 308707328 16:44:49 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | Cycle 1(1): loaded http://localhost:58264/tests/dromaeo/cssquery-yui.html (next: http://localhost:58264/tests/dromaeo/cssquery-dojo.html) 16:47:53 INFO - PROCESS | 2596 | RSS: Main: 361025536 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | __start_tp_report 16:47:53 INFO - PROCESS | 2596 | _x_x_mozilla_page_load 16:47:53 INFO - PROCESS | 2596 | _x_x_mozilla_page_load_details 16:47:53 INFO - PROCESS | 2596 | |i|pagename|runs| 16:47:53 INFO - PROCESS | 2596 | |0;dojo.html;2871.4687782760193;3319.4688849784034;3335.8498867550957;3338.2488939988507;3371.6628337166285;5647.548196144309;5671.546276297897;5717.34250561185;5724.742386592603;5735.598508104435;5654.547636189105;5764.682942438164;5770.624909380887;5788.42115788421;5797.246357973468;5265.3155089838265;5267.55225805807;5291.994521041;5303.920441193385;5348.438413966536;5212.5308722214995;5229.764660590283;5236.1098613235845;5330.520253177213;5356.946430535684;5323.307969963918;5326.840194794162;5330.760115794798;5339.866503337428;5346.984073026132;5314.973425132888;5318.1225097858805;5321.068812957737;5331.840044798662;5336.119540275849;5095.312132862054;5210.296609957645;5235.581153507748;5267.578593712494;5280;5752.884942301131;5766.336871259817;5792.68140252286;5856.443637854397;5858.707064646751;6235.00239961604;6241.457632341469;6281.8743625127245;6293;6296.1500197473215;6251.3123556408755;6339.8415039623915;6344.3655634436645;6346.746130154788;6367.681615919232;4856.854294371175;5684.204211410406;5712.0860662293835;5715.485606295453;5758.596898217084;6154.292256390483;6239.625622462667;6242.500599951993;6309.274433440121;6314.463270622048;6151.3541078187045;6216.378362163748;6223.96888015566;6230.158928544679;6265.8746825063245;6120.693965301717;6158.938410615837;6349.904751428732;6365.172527571386;6366.299707032223;6178.536609754196;6222.253329600387;6226.315105338409;6236;6271.122042913996;6257.311695713468;6283.96858015707;6285.2457705075685;6288.339724328971;6293.213348331458;4829.082474329866;4835.734034628059;4892.3884514435695;4958.033183529177;4988.900221995613;4408.4930233023615;4447.933281000787;4455.799489023002;4469.508354081048;4500.639948804088;5833;5840.415958404211;5852.970735146382;5856.765729370863;5857.238558987305;6172.876542469216;6371.585846919936;6373.904391434132;6380.947143721327;6387.584806987531;5702.087665973508;5702.344230413472;5745.195672605839;5754.712264386764;5821.970890145607;5369;5411.648242864201;5416.997855396764;5418.756155972991;5424.105022671215;6269.96865015672;6273.215848018997;6319.368063193552;6322.083297921868;6339.270983836734;6171.814845554641;6227.159333489921;6231.065340198825;6262.46769024638;6294.3076261612105;6323.525735569759;6331.018692102732;6341.714622841891;6342.682865856781;6352;6158.3841615838055;6219.937800622117;6231.470325022424;6236.064590311489;6237.625742455467;6080.635161890301;6180.876382472416;6190.442860142609;6190.845228869134;6275.309715931336;6032.849178770566;6066.545009124422;6090.543209259412;6106.1146133811235;6113.113598528277;6050.45545900871;6051.75938932509;6061.212042434456;6065.3934606539;6098.390160983866;5717.342505611741;5838.211841401527;5887.852803679943;5902.61632993854;5930.169776231417;6089.604175728564;6149.323574406902;6174.289956654862;6186.4741496973265;6211.534134939988;5035.647504674784;5983.192269043623;6003.696119074866;6007.068904319837;6040.2147720797775 16:47:53 INFO - PROCESS | 2596 | |1;ext.html;455.860349127182;469.6313393985722;497.4677095507808;514.7014731455755;528.5216878724756;24537.509249815015;37031.814840925756;40687;42635.57364426351;42702.786486067525;43140.78429607848;43521;43534.12931741363;43542;43570.7821460893;9712.70861874145;9908.702738917844;9916.405015699082;9924.354916930413;9933.503324833766;8953.194212520872;9165.587548560297;9195.908040919605;9198.356115071947;9210.355275130743;12041.157119001673;12282.877171228307;12373.752524949496;12557.058220633444;12592.685182870457;12044.337561434118;12143.696407589792;12192;12232.510699572007;12263.50945962165;8778.47329160246;9019.729408117766;11991.580294689644;12060.216085954473;12067.818982715266;39853.60146398528;40475.988100297436;40647.7967610163;42540.57459425428;42656.36015459771;3374.4094783412806;3457.5505184325875;3548.8048157351336;3700.666939975415;3939.625735555118;29669.258268543243;29777.70222297771;31447.742090316588;31633;32462.675373246202;3226.709596136359;3250.821204833733;3260.250142467246;3311.2218628622254;3365.730741540671;532372;533600;537115;538916;539262.303688483;51917;53492;56311.155332670045;57199;57638.13542796861;62491.06263406052;62721;62953.370466295666;63013;63147.36852631507;16089.436869709503;16221;16529.917350413172;16683.916580417263;16690.16549172561;10862.619808306672;12917.289549074703;13056.673583160307;13165;13174;13974.720505589832;14235.715285694228;14235.85764142366;15913.840861591236;15982.920085399499;6149.723262453201;6435.452986496107;7046.013558101869;7292.270772922771;7355.896615507717;821.7945513621595;878.3587980774071;894.2756367342473;979.3683074416961;1004.7940172264668;29319.120426387242;30125.397492050037;30712;31050.844745776125;31206;883.6377085395086;897.9269772621655;917.8347897378402;958.7219706285239;1096.6381094238882;12933;14712.779308310384;14971.92514037423;15025.924870375797;15343;677380;681427.5571732856;681829;682701;682738;46696.5330346699;46952;53991;54675.453245467834;54762.17856732152;1349.8515163332027;1378.9793153102712;1395.1559306619552;1397.8811800996623;1400.8529104443887;28870.42259154847;29739;29990.70009299879;30652.693473064985;30715.692843071283;55187.724061379435;56636.43363566312;56720.71639641775;59350.109748352945;59365.40634593599;578355;585627;585692;587085;587131;26206.60690089612;26528.469430611665;26548.203553893414;26577;26603.866980664974;46206.537934620224;46934.53065469438;47204.291935620306;47886.28170577374;48050.759746201045;38187.42718859164;38196.04509887275;39198.804005979786;39550.60449395584;40529.1894162121;38256.04359891025;39267.2146557073;39552.80223598864;39967;40571.59428405678;37545.43681844829;37737;38682.03294917537;39124.6087539121;39212.01969950774;33286;34216.65783342135;34325.485117722754;34905.30189396249;35599.28801423905;23702.762972370056;24703.258902232963;25879;26030.479390412464;26695.065672702138 16:47:53 INFO - PROCESS | 2596 | |2;jquery.html;299.8935377940832;363.37862255543024;366.67182871330175;376.70240509997103;396.3539430727913;15104.395824167033;15205.771913421293;16533;21129.049192786322;21661.91690415481;20055.69916451251;20374.388768336936;20959.895200524013;21222.89388553059;21377.67933480999;5380.166074258496;5848.532117430606;6123.265208175003;6127.601705889125;6138.109974053782;5803.361630220672;5899.941000589982;5988.970055149718;6052.122442245872;6058.515318774509;5678.630888992202;5846.123081537761;5848.5321174305955;5860;5913.822585322448;5841.15303281024;5869.413058694139;5891.528677705816;6012.488938440238;6020.939790602104;5225.425203227642;5235.607329450307;5237.47625237477;5460.126379779256;5519.172124181365;12715.173513721578;12833.743325133444;13030.609081727564;24852.25443236706;24891.133165012514;1806.927722891096;2098.569793192392;2153.536989547239;2177.945551361213;2347.213683416058;9872.60509579616;9890.357126786736;9937.5031248438;10384.37693738378;10491.055804977588;1818.627181427804;1830.3502256698814;1844.9907750461161;1886.7547218861598;1891.943241702751;74869.62565187193;95690;104002.98990905618;125334;139117;11288.435578221057;11543;11778.057755379548;11811.291322520676;11896.810318968033;14857.702845943237;14869.256537173098;14875.404983800527;14890.106593604201;14892.776608350883;8428;8492.490450572985;8533.189347012023;8711.695090671796;8780.473171609723;7158.570485770871;8656.956715216384;8686.348523860735;8704.869426958474;8886;4494.9325760113625;4501.68488205829;4547.477040140427;4640.907181856344;4643.303504474288;1864.4406677996817;1925.8748181368167;1929.0933261367136;1931.2275089963846;1935.2645994521993;821.3183058061794;939.3753154152412;951.1867353412871;974.7611835100446;986.2603047714215;21321.78678213229;22355.993980270927;22358.776412235995;22415.32754017382;22436;787.8660627693306;958.8904410297374;979.3780949097375;1003.2626019875386;1032.3341444768232;10965.177611679155;11498.655040348804;11503.521740212482;11552.768944621228;11596.188266821242;589291;609752;626566;639638;640468;91453;138442.3077884604;139766;142206.2889685545;142421.57578424292;900.2033200617501;921.1709461484718;931.0828833598899;933.5332333833084;955.7515046087929;15886.364545418515;18871.339503117324;19293.517662058;20317.898410507853;20533.38399848007;57474;58886.82226355535;59031;59156.70421647864;59577;81775;85067.5746621263;85310;86306.13693863232;88151;7769.456138070281;8041.356691464785;8055.718049868226;8143.5928203590765;8162.387820913336;10270.743231419274;12281;12880.677983050498;13001.219926804422;13415.798763018367;11221.66335009951;11346.319220846775;11694.70763230926;11702.648920532398;11774.293542387484;11021.83467247976;11174.832377514507;11221.60724374643;11248.606298779503;11265.887341126483;11286.548538058385;11601.767964640829;11723.589674361356;11753.706157345792;11930.343831089373;8048.83902321962;8057.919420805952;8249.381296402673;8308;8478.448900821428;10441.373517588969;11102.833457497982;11211.943940280573;11448.198626096426;11601.82597261025 16:47:53 INFO - PROCESS | 2596 | |3;mootools.html;1484.480431848853;1500.7298686236477;1666.2585149608428;1819.3905041810992;1835.9357422490207;8156.714514991976;8382.203690649378;8647.351448641353;9203.63185472581;9210.986791452935;8278.420510564263;8740.825183496327;8953.820923581525;8987.550622468883;9064.501452420114;2408.096963638631;2423.624338227569;2432.963505547418;2439.3047981325326;2443.0960544598524;2396;2425.9514809703796;2449.371168173163;2449.595816690244;2451.166603354859;2052.4560991337307;2114.7039414481983;2156.5255643758346;2333.9766602334016;2403.5072810073893;2041.530447996969;2393.413613664655;2425.1148330859287;2429.769171928664;2430.3924018995253;2388.7611238876148;2420.9757902420924;2424.6726691896542;2429.4533729910627;2434.3914021494625;8259.95870020652;9150.679726209552;9158.26733861296;9174;9209.125133112344;5347.331583552056;5440.483154100354;5503.807366742185;5518.558515318805;5532.917006244909;3551.751377403583;3617.855285788565;3758.248350329945;3763.172102137525;3763.9623603763885;1092.8907109289087;1102.7132945434246;1110.9833352499718;1116.20749268019;1134.512159771298;12126.757464850742;12210.572629957998;12214.26714397139;12221.694457638541;12234.816477752753;4739.312799644033;4815.181419158752;4840.443349014909;4916.680415772963;4945.604351651859;10288.742781430374;10299.3820370778;10305.536250868729;10307;10323;5499.257600223998;5503.752331145108;5507.917381239285;5516;5525.972370138124;4911.803527858917;4953.034158339089;4992.850214493571;5047.621428392885;5055.014272216956;3800;3842.9231415371537;4018.7588744675413;4043.595640435933;4092.0997380576227;1301.9349032548334;1301.9414126364336;1304.0545604436707;1320.9603711888658;1321.662975941148;622.8629701465761;772.7681695491331;844.8943882014748;862.2110768646744;935.9859602105973;5894.941050589439;5933.910991335133;5958.910616340759;6156.507479401637;6191.938080619227;900.6127365232882;916.867054277126;929.8977112517617;951.6336210558846;961.6393852305386;3879.282332768447;4006.939895901564;4021.055052062763;4127;4140.648044916155;10616.416097114577;10893.564257429773;10969.067629251604;11041.944790275997;11053.834192487118;10998.505067271992;11011.669649910515;11012.17408694335;11032.724181895517;11035.503402346914;8372.120927302545;8420.2842758365;8438.113998030241;8447.197516235949;8490.15098490146;5865.912011319749;5868.911966320423;5925.111233315038;6026.3953725891415;6199.543107369855;9894.901050989398;10259.333143345659;10274.921133281197;10288.382697038202;10312.071913527818;10416.635417760343;10523.368597884151;10554.261201715806;10557.31083026712;10588.258821882702;7458.73894413693;7487.737929172671;7718.768436946901;7734;7782.883256751266;8491;8691.782705432415;8700.390972631854;8710.433821801562;8761.956190219009;7460.888086678813;7552.055993000875;7568.5458872467825;7621.12357078943;7715.8071048222;7456.627168641655;7519.285667861544;7572.848543028998;7698.114716807415;7731.458797884319;7123.323284287984;7129.073220481304;7261.3101755333155;7269.818254543678;7277.526960747535;5027.346444962278;5054.570361519312;5102.821401250939;5110.259012443249;5157.638965272395;5095.566876815512;5144.279800827962;5177.249298851721;5249.816256431007;5281.60387970896 16:47:53 INFO - PROCESS | 2596 | |4;prototype.html;297.2449977058272;298.98505074746265;306.193180968149;311.94385010698096;312.39083786616106;5386.326709161355;5409.864753381157;5415.593830462716;5440.401555828856;5463.945360546393;4072.755634661915;4307.858417519352;4878.317035615017;5174.689518628876;5315.946840531594;3939.9212015759667;4111.753294802306;4129.772862492562;4195.307774217258;4219.767912764797;3589.94615080774;4107.747137123191;4120.958790412087;4125.31932231183;4162.1675664867;3431.6445004223315;3606.9639303607023;3732.768186498449;3856.151646637735;3980.4228386883883;3408.812515311657;4083.734557253769;4118.6499147572495;4125.8968525787095;4162.666986641077;2958.4231074940394;3285.7349920280626;3578.9621009907096;3579.8926032219074;3584.8028358440274;4582.541745825424;4957.587087679994;5209.843704688866;5297.894042119136;5322.600804939606;3526.400511912981;4200.789960501963;4275.230458517465;4300.010997470568;4572.611328037121;4182.268103081979;4714.740689262089;4808.374911261549;5587.7485513152005;5652.56939516008;3268.9182770430693;3380.884308178295;3720.3675375186285;3845.788481633509;3863.4932376373235;5629.7185140742795;5692.829215123553;5869.85325366865;5913.970430147821;5922.733476993546;3409.4544872820725;3876.39129761146;3899.8245078971513;3925.8429662813737;3929.390944403622;3982.6614737747036;3987.3221552335594;3988.760674359548;3988.940165897514;4013.91972160561;4315.726860576137;4583.931241031387;4611.2852507861335;4615.5845973862515;4642.303654451859;4616.930746038812;5222.634415590948;5654.575906807006;5678.744456499468;5739.62692424991;1112.3548341961643;1343.899207559437;1356.1252991820418;1357.2738584857252;1357.6559206385805;842.8103676672822;869.1308691308691;872.7905302727299;885.6457417033109;906.9002409734924;4345.348197770297;4419.779011049434;4882.7558622068755;5077.466865979093;5374.27447294618;5782.59521833476;5802.274715660543;5812.738426770721;5814.30228372598;5846.766129354864;4499.820007199675;4640;4977.701337919736;5235.65968212065;5253.474652534716;2631.644727961739;2817.3660926291423;2983.4928062229474;2999.9950016744197;3037.9240518987203;5459.5359394451125;5951.791687290924;5971.19388882504;5981.850453738604;6023.488003519662;5346.705931173823;5562.666240025612;5873.828132808236;5878.913570375587;5886.381929897385;5038.916632923866;5157.32954715892;5951.851203719855;5969.910451343233;5974.372690867396;4861.857463496005;4990.276409920614;5335.812316950032;5376.526797673114;5789.565782566408;5126.666766660155;5517.579100957271;5605.766731319103;5615.915761263666;5619.9719001406365;5946.313285762854;5949.434803693643;5971.492423144082;5972;5991.580589358878;3227.7889645592845;3640.9817950910074;3821.4840996466232;3851.2297540491454;3887.572367039567;4965.453800081916;5235.110031294766;5519.227308176939;5641.9435805641415;5698.914516282342;4185.497740271187;5282.735863206901;5580.9162862557905;5626.718664066862;5636;5014.498550144956;5180;5498.95519851227;5607.299087614048;5659.490645841894;4422.7346359218545;5270.472952704698;5449.727513624223;5468.781248750164;5488.267977774992;5068.391792984866;5121.8463446096675;5574.132665557084;5623.650323922311;5639.941421381249;5476.151196564539;5487.4238204987905;5493.214705220899;5509.3664228614225;5537.363203231519 16:47:53 INFO - PROCESS | 2596 | |5;yui.html;719.3489891648057;796.4106561144755;803.3171803966629;816.0941355095842;826.68999125328;15202.923985380072;16507.422240221596;16583;16586.170691465424;16598.917005414973;15623.062616243005;15638;15876.761848572252;16669.91645543039;16713.415030473934;816.2042009041182;842.1830824100613;844.0841686769832;844.3540691371106;848.7962888906649;646.6378827856415;674.1270055278402;674.7503423733226;675.5946432140726;679.3885503047272;705.932936371044;856.0155820806092;886.7517095213351;889.0842432294746;901.8421776189174;887.4010043220833;889.8976617688984;890.185480285538;890.2566357091804;890.3856339125982;659.3604203922188;659.7361055577759;660.1714847865898;660.5739298152713;660.7852447954386;12362.876371236262;12658.55695050678;12671.176373535784;13018.739625207538;13030.02274829382;12090.910446351825;12617.432215550321;14293.213873236968;14392.856071439257;14589.124652520883;11535.064740663158;11589.536418543332;11920.761584768343;12064.638060858188;12066;3711.1649878777057;3789.80986481258;3803.7717736935874;3874.5544262409903;3945.6251656092627;125826;127197;127469;129302.35348823195;129358.7064129356;10936.617218397318;11115.888841111486;11174.44127793607;11276.097912167006;11307.378094204732;22374.888125559268;22570.661440078413;22756;22801.429964250696;22808.2017129403;8169.060558035783;8250.711225107092;8252;8318.04342500608;8363.540005299767;4299.290617048152;4363.690668790589;4479.3057076153245;4599.678022538457;4608.631309495232;3672.4307732301536;3796.240751849641;3811.352070148026;3814.408766641175;3815.523059617548;675.6351570152062;686.2040033561045;691.872003679321;694.3022262626029;700.3766647683566;541.9674819510842;561.7528287553463;633.6071635585967;663.571996062537;670.5038271678923;9330.58012389444;9466.715998520056;9549.283803714749;9561.378510396802;9565.808683826284;591.8786648736999;597.9880402392015;641.3362170153869;678.2708588267632;700.6986995591842;4166.91666166681;4405.31717583775;4559.110973360163;4614.700044497097;4640.025594625099;100880.49559752154;147380;148682;148686;149612.75580866294;105473;124453.37773311076;127826.36086819506;131482.34258828644;134331.32834335766;108313;108716.45641771899;111595;113774.43112784548;115190;9163;9901.405915645084;10092.899071009197;10233.692989210336;10283.94858025705;48586;49705;59580.40419595748;66471.66764166148;67638.64722705616;93084.53457732667;95218;96291.037089631;98447.58538280464;99241.51137732796;11163.832542512031;13027.674308142372;13263.66840828987;13323;13329.266890320738;14372.209528476034;14519.92740036293;14544.563663090124;15306.234688265766;15984.600384990468;13105.737885242052;13391.99560032982;13930.79103813464;14117.43530258778;14137.575872723835;11476.368799716096;13503.189808611514;13889.513867014606;14599.445097108177;14835;12085.516579336729;13480.258585777876;14409.495667651581;14429.639259018608;14459.421623134956;11110.888891110986;11351.091912646803;11814.291142531476;11896.988755955841;11943.940280298542;11474.426278685865;11522.53909843597;11711.824322634997;11887;11903.226290291102 16:47:53 INFO - PROCESS | 2596 | __end_tp_report 16:47:53 INFO - PROCESS | 2596 | __start_cc_report 16:47:53 INFO - PROCESS | 2596 | _x_x_mozilla_cycle_collect,1198 16:47:53 INFO - PROCESS | 2596 | __end_cc_report 16:47:53 INFO - PROCESS | 2596 | __startTimestamp1475624873402__endTimestamp 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | ------- Summary: start ------- 16:47:53 INFO - PROCESS | 2596 | Number of tests: 6 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | [#0] dojo.html Cycles:165 Average:5766.73 Median:6003.70 stddev:657.09 (10.9%) stddev-sans-first:618.60 16:47:53 INFO - PROCESS | 2596 | Values: 2871.5 3319.5 3335.8 3338.2 3371.7 5647.5 5671.5 5717.3 5724.7 5735.6 5654.5 5764.7 5770.6 5788.4 5797.2 5265.3 5267.6 5292.0 5303.9 5348.4 5212.5 5229.8 5236.1 5330.5 5356.9 5323.3 5326.8 5330.8 5339.9 5347.0 5315.0 5318.1 5321.1 5331.8 5336.1 5095.3 5210.3 5235.6 5267.6 5280.0 5752.9 5766.3 5792.7 5856.4 5858.7 6235.0 6241.5 6281.9 6293.0 6296.2 6251.3 6339.8 6344.4 6346.7 6367.7 4856.9 5684.2 5712.1 5715.5 5758.6 6154.3 6239.6 6242.5 6309.3 6314.5 6151.4 6216.4 6224.0 6230.2 6265.9 6120.7 6158.9 6349.9 6365.2 6366.3 6178.5 6222.3 6226.3 6236.0 6271.1 6257.3 6284.0 6285.2 6288.3 6293.2 4829.1 4835.7 4892.4 4958.0 4988.9 4408.5 4447.9 4455.8 4469.5 4500.6 5833.0 5840.4 5853.0 5856.8 5857.2 6172.9 6371.6 6373.9 6380.9 6387.6 5702.1 5702.3 5745.2 5754.7 5822.0 5369.0 5411.6 5417.0 5418.8 5424.1 6270.0 6273.2 6319.4 6322.1 6339.3 6171.8 6227.2 6231.1 6262.5 6294.3 6323.5 6331.0 6341.7 6342.7 6352.0 6158.4 6219.9 6231.5 6236.1 6237.6 6080.6 6180.9 6190.4 6190.8 6275.3 6032.8 6066.5 6090.5 6106.1 6113.1 6050.5 6051.8 6061.2 6065.4 6098.4 5717.3 5838.2 5887.9 5902.6 5930.2 6089.6 6149.3 6174.3 6186.5 6211.5 5035.6 5983.2 6003.7 6007.1 6040.2 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | [#1] ext.html Cycles:180 Average:72891.59 Median:21603.42 stddev:161525.21 (747.7%) stddev-sans-first:161886.77 16:47:53 INFO - PROCESS | 2596 | Values: 455.9 469.6 497.5 514.7 528.5 24537.5 37031.8 40687.0 42635.6 42702.8 43140.8 43521.0 43534.1 43542.0 43570.8 9712.7 9908.7 9916.4 9924.4 9933.5 8953.2 9165.6 9195.9 9198.4 9210.4 12041.2 12282.9 12373.8 12557.1 12592.7 12044.3 12143.7 12192.0 12232.5 12263.5 8778.5 9019.7 11991.6 12060.2 12067.8 39853.6 40476.0 40647.8 42540.6 42656.4 3374.4 3457.6 3548.8 3700.7 3939.6 29669.3 29777.7 31447.7 31633.0 32462.7 3226.7 3250.8 3260.3 3311.2 3365.7 532372.0 533600.0 537115.0 538916.0 539262.3 51917.0 53492.0 56311.2 57199.0 57638.1 62491.1 62721.0 62953.4 63013.0 63147.4 16089.4 16221.0 16529.9 16683.9 16690.2 10862.6 12917.3 13056.7 13165.0 13174.0 13974.7 14235.7 14235.9 15913.8 15982.9 6149.7 6435.5 7046.0 7292.3 7355.9 821.8 878.4 894.3 979.4 1004.8 29319.1 30125.4 30712.0 31050.8 31206.0 883.6 897.9 917.8 958.7 1096.6 12933.0 14712.8 14971.9 15025.9 15343.0 677380.0 681427.6 681829.0 682701.0 682738.0 46696.5 46952.0 53991.0 54675.5 54762.2 1349.9 1379.0 1395.2 1397.9 1400.9 28870.4 29739.0 29990.7 30652.7 30715.7 55187.7 56636.4 56720.7 59350.1 59365.4 578355.0 585627.0 585692.0 587085.0 587131.0 26206.6 26528.5 26548.2 26577.0 26603.9 46206.5 46934.5 47204.3 47886.3 48050.8 38187.4 38196.0 39198.8 39550.6 40529.2 38256.0 39267.2 39552.8 39967.0 40571.6 37545.4 37737.0 38682.0 39124.6 39212.0 33286.0 34216.7 34325.5 34905.3 35599.3 23702.8 24703.3 25879.0 26030.5 26695.1 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | [#2] jquery.html Cycles:180 Average:35649.42 Median:12595.51 stddev:103640.61 (822.8%) stddev-sans-first:103897.36 16:47:53 INFO - PROCESS | 2596 | Values: 299.9 363.4 366.7 376.7 396.4 15104.4 15205.8 16533.0 21129.0 21661.9 20055.7 20374.4 20959.9 21222.9 21377.7 5380.2 5848.5 6123.3 6127.6 6138.1 5803.4 5899.9 5989.0 6052.1 6058.5 5678.6 5846.1 5848.5 5860.0 5913.8 5841.2 5869.4 5891.5 6012.5 6020.9 5225.4 5235.6 5237.5 5460.1 5519.2 12715.2 12833.7 13030.6 24852.3 24891.1 1806.9 2098.6 2153.5 2177.9 2347.2 9872.6 9890.4 9937.5 10384.4 10491.1 1818.6 1830.4 1845.0 1886.8 1891.9 74869.6 95690.0 104003.0 125334.0 139117.0 11288.4 11543.0 11778.1 11811.3 11896.8 14857.7 14869.3 14875.4 14890.1 14892.8 8428.0 8492.5 8533.2 8711.7 8780.5 7158.6 8657.0 8686.3 8704.9 8886.0 4494.9 4501.7 4547.5 4640.9 4643.3 1864.4 1925.9 1929.1 1931.2 1935.3 821.3 939.4 951.2 974.8 986.3 21321.8 22356.0 22358.8 22415.3 22436.0 787.9 958.9 979.4 1003.3 1032.3 10965.2 11498.7 11503.5 11552.8 11596.2 589291.0 609752.0 626566.0 639638.0 640468.0 91453.0 138442.3 139766.0 142206.3 142421.6 900.2 921.2 931.1 933.5 955.8 15886.4 18871.3 19293.5 20317.9 20533.4 57474.0 58886.8 59031.0 59156.7 59577.0 81775.0 85067.6 85310.0 86306.1 88151.0 7769.5 8041.4 8055.7 8143.6 8162.4 10270.7 12281.0 12880.7 13001.2 13415.8 11221.7 11346.3 11694.7 11702.6 11774.3 11021.8 11174.8 11221.6 11248.6 11265.9 11286.5 11601.8 11723.6 11753.7 11930.3 8048.8 8057.9 8249.4 8308.0 8478.4 10441.4 11102.8 11211.9 11448.2 11601.8 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | [#3] mootools.html Cycles:180 Average:5868.81 Median:4972.94 stddev:3309.39 (66.5%) stddev-sans-first:3302.27 16:47:53 INFO - PROCESS | 2596 | Values: 1484.5 1500.7 1666.3 1819.4 1835.9 8156.7 8382.2 8647.4 9203.6 9211.0 8278.4 8740.8 8953.8 8987.6 9064.5 2408.1 2423.6 2433.0 2439.3 2443.1 2396.0 2426.0 2449.4 2449.6 2451.2 2052.5 2114.7 2156.5 2334.0 2403.5 2041.5 2393.4 2425.1 2429.8 2430.4 2388.8 2421.0 2424.7 2429.5 2434.4 8260.0 9150.7 9158.3 9174.0 9209.1 5347.3 5440.5 5503.8 5518.6 5532.9 3551.8 3617.9 3758.2 3763.2 3764.0 1092.9 1102.7 1111.0 1116.2 1134.5 12126.8 12210.6 12214.3 12221.7 12234.8 4739.3 4815.2 4840.4 4916.7 4945.6 10288.7 10299.4 10305.5 10307.0 10323.0 5499.3 5503.8 5507.9 5516.0 5526.0 4911.8 4953.0 4992.9 5047.6 5055.0 3800.0 3842.9 4018.8 4043.6 4092.1 1301.9 1301.9 1304.1 1321.0 1321.7 622.9 772.8 844.9 862.2 936.0 5894.9 5933.9 5958.9 6156.5 6191.9 900.6 916.9 929.9 951.6 961.6 3879.3 4006.9 4021.1 4127.0 4140.6 10616.4 10893.6 10969.1 11041.9 11053.8 10998.5 11011.7 11012.2 11032.7 11035.5 8372.1 8420.3 8438.1 8447.2 8490.2 5865.9 5868.9 5925.1 6026.4 6199.5 9894.9 10259.3 10274.9 10288.4 10312.1 10416.6 10523.4 10554.3 10557.3 10588.3 7458.7 7487.7 7718.8 7734.0 7782.9 8491.0 8691.8 8700.4 8710.4 8762.0 7460.9 7552.1 7568.5 7621.1 7715.8 7456.6 7519.3 7572.8 7698.1 7731.5 7123.3 7129.1 7261.3 7269.8 7277.5 5027.3 5054.6 5102.8 5110.3 5157.6 5095.6 5144.3 5177.2 5249.8 5281.6 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | [#4] prototype.html Cycles:180 Average:4487.82 Median:5026.71 stddev:1396.88 (27.8%) stddev-sans-first:1364.93 16:47:53 INFO - PROCESS | 2596 | Values: 297.2 299.0 306.2 311.9 312.4 5386.3 5409.9 5415.6 5440.4 5463.9 4072.8 4307.9 4878.3 5174.7 5315.9 3939.9 4111.8 4129.8 4195.3 4219.8 3589.9 4107.7 4121.0 4125.3 4162.2 3431.6 3607.0 3732.8 3856.2 3980.4 3408.8 4083.7 4118.6 4125.9 4162.7 2958.4 3285.7 3579.0 3579.9 3584.8 4582.5 4957.6 5209.8 5297.9 5322.6 3526.4 4200.8 4275.2 4300.0 4572.6 4182.3 4714.7 4808.4 5587.7 5652.6 3268.9 3380.9 3720.4 3845.8 3863.5 5629.7 5692.8 5869.9 5914.0 5922.7 3409.5 3876.4 3899.8 3925.8 3929.4 3982.7 3987.3 3988.8 3988.9 4013.9 4315.7 4583.9 4611.3 4615.6 4642.3 4616.9 5222.6 5654.6 5678.7 5739.6 1112.4 1343.9 1356.1 1357.3 1357.7 842.8 869.1 872.8 885.6 906.9 4345.3 4419.8 4882.8 5077.5 5374.3 5782.6 5802.3 5812.7 5814.3 5846.8 4499.8 4640.0 4977.7 5235.7 5253.5 2631.6 2817.4 2983.5 3000.0 3037.9 5459.5 5951.8 5971.2 5981.9 6023.5 5346.7 5562.7 5873.8 5878.9 5886.4 5038.9 5157.3 5951.9 5969.9 5974.4 4861.9 4990.3 5335.8 5376.5 5789.6 5126.7 5517.6 5605.8 5615.9 5620.0 5946.3 5949.4 5971.5 5972.0 5991.6 3227.8 3641.0 3821.5 3851.2 3887.6 4965.5 5235.1 5519.2 5641.9 5698.9 4185.5 5282.7 5580.9 5626.7 5636.0 5014.5 5180.0 5499.0 5607.3 5659.5 4422.7 5270.5 5449.7 5468.8 5488.3 5068.4 5121.8 5574.1 5623.7 5639.9 5476.2 5487.4 5493.2 5509.4 5537.4 16:47:53 INFO - PROCESS | 2596 | 16:47:53 INFO - PROCESS | 2596 | [#5] yui.html Cycles:180 Average:25153.55 Median:22778.71 stddev:40028.21 (175.7%) stddev-sans-first:40098.46 16:47:53 INFO - PROCESS | 2596 | Values: 719.3 796.4 803.3 816.1 826.7 15202.9 16507.4 16583.0 16586.2 16598.9 15623.1 15638.0 15876.8 16669.9 16713.4 816.2 842.2 844.1 844.4 848.8 646.6 674.1 674.8 675.6 679.4 705.9 856.0 886.8 889.1 901.8 887.4 889.9 890.2 890.3 890.4 659.4 659.7 660.2 660.6 660.8 12362.9 12658.6 12671.2 13018.7 13030.0 12090.9 12617.4 14293.2 14392.9 14589.1 11535.1 11589.5 11920.8 12064.6 12066.0 3711.2 3789.8 3803.8 3874.6 3945.6 125826.0 127197.0 127469.0 129302.4 129358.7 10936.6 11115.9 11174.4 11276.1 11307.4 22374.9 22570.7 22756.0 22801.4 22808.2 8169.1 8250.7 8252.0 8318.0 8363.5 4299.3 4363.7 4479.3 4599.7 4608.6 3672.4 3796.2 3811.4 3814.4 3815.5 675.6 686.2 691.9 694.3 700.4 542.0 561.8 633.6 663.6 670.5 9330.6 9466.7 9549.3 9561.4 9565.8 591.9 598.0 641.3 678.3 700.7 4166.9 4405.3 4559.1 4614.7 4640.0 100880.5 147380.0 148682.0 148686.0 149612.8 105473.0 124453.4 127826.4 131482.3 134331.3 108313.0 108716.5 111595.0 113774.4 115190.0 9163.0 9901.4 10092.9 10233.7 10283.9 48586.0 49705.0 59580.4 66471.7 67638.6 93084.5 95218.0 96291.0 98447.6 99241.5 11163.8 13027.7 13263.7 13323.0 13329.3 14372.2 14519.9 14544.6 15306.2 15984.6 13105.7 13392.0 13930.8 14117.4 14137.6 11476.4 13503.2 13889.5 14599.4 14835.0 12085.5 13480.3 14409.5 14429.6 14459.4 11110.9 11351.1 11814.3 11897.0 11943.9 11474.4 11522.5 11711.8 11887.0 11903.2 16:47:53 INFO - PROCESS | 2596 | -------- Summary: end -------- 16:47:53 INFO - PROCESS | 2596 | 16:47:54 INFO - TEST-INFO | 2596: exit 0 16:47:54 INFO - TEST-OK | dromaeo_css | took 1118893ms 16:47:54 INFO - TEST-START | kraken 16:47:54 INFO - operating with platform_type : mac_ 16:47:54 INFO - Initialising browser for kraken test... 16:47:54 INFO - TEST-INFO | started process 2599 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmprkZwPg/profile http://localhost:58264/getInfo.html) 16:47:56 INFO - PROCESS | 2599 | __metrics Screen width/height:1600/1200 16:47:56 INFO - PROCESS | 2599 | colorDepth:24 16:47:56 INFO - PROCESS | 2599 | Browser inner width/height: 1024/689 16:47:56 INFO - PROCESS | 2599 | __metrics 16:47:56 INFO - PROCESS | 2599 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:47:56 INFO - PROCESS | 2599 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:47:57 INFO - TEST-INFO | 2599: exit 0 16:47:57 INFO - Browser initialized. 16:47:57 INFO - Running cycle 1/1 for kraken test... 16:47:57 INFO - TEST-INFO | started process 2600 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmprkZwPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:09 INFO - PROCESS | 2600 | RSS: Main: 219693056 16:48:09 INFO - PROCESS | 2600 | 16:48:12 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58264/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:13 INFO - PROCESS | 2600 | RSS: Main: 269422592 16:48:13 INFO - PROCESS | 2600 | 16:48:16 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58264/tests/kraken/driver.html?testName=audio-dft) 16:48:16 INFO - PROCESS | 2600 | RSS: Main: 279760896 16:48:16 INFO - PROCESS | 2600 | 16:48:19 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58264/tests/kraken/driver.html?testName=audio-fft) 16:48:20 INFO - PROCESS | 2600 | RSS: Main: 377085952 16:48:20 INFO - PROCESS | 2600 | 16:48:22 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58264/tests/kraken/driver.html?testName=audio-oscillator) 16:48:23 INFO - PROCESS | 2600 | RSS: Main: 279973888 16:48:23 INFO - PROCESS | 2600 | 16:48:25 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:25 INFO - PROCESS | 2600 | RSS: Main: 280780800 16:48:25 INFO - PROCESS | 2600 | 16:48:28 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58264/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:29 INFO - PROCESS | 2600 | RSS: Main: 317333504 16:48:29 INFO - PROCESS | 2600 | 16:48:32 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58264/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:32 INFO - PROCESS | 2600 | RSS: Main: 319025152 16:48:32 INFO - PROCESS | 2600 | 16:48:35 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58264/tests/kraken/driver.html?testName=json-parse-financial) 16:48:36 INFO - PROCESS | 2600 | RSS: Main: 315662336 16:48:36 INFO - PROCESS | 2600 | 16:48:37 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:48:38 INFO - PROCESS | 2600 | RSS: Main: 288698368 16:48:38 INFO - PROCESS | 2600 | 16:48:40 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:48:40 INFO - PROCESS | 2600 | RSS: Main: 294768640 16:48:40 INFO - PROCESS | 2600 | 16:48:43 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:48:43 INFO - PROCESS | 2600 | RSS: Main: 307560448 16:48:43 INFO - PROCESS | 2600 | 16:48:46 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:48:47 INFO - PROCESS | 2600 | RSS: Main: 311173120 16:48:47 INFO - PROCESS | 2600 | 16:48:50 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:48:50 INFO - PROCESS | 2600 | RSS: Main: 311644160 16:48:50 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | Cycle 1(1): loaded http://localhost:58264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58264/tests/kraken/driver.html?testName=ai-astar) 16:48:52 INFO - PROCESS | 2600 | RSS: Main: 355454976 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | __start_tp_report 16:48:52 INFO - PROCESS | 2600 | _x_x_mozilla_page_load 16:48:52 INFO - PROCESS | 2600 | _x_x_mozilla_page_load_details 16:48:52 INFO - PROCESS | 2600 | |i|pagename|runs| 16:48:52 INFO - PROCESS | 2600 | |0;ai-astar;115;113;114;113;114;113;113;112;113;114 16:48:52 INFO - PROCESS | 2600 | |1;audio-beat-detection;147;108;110;143;109;110;114;130;174;109 16:48:52 INFO - PROCESS | 2600 | |2;audio-dft;184;186;184;187;183;184;184;188;184;186 16:48:52 INFO - PROCESS | 2600 | |3;audio-fft;81;59;60;91;63;59;59;59;82;58 16:48:52 INFO - PROCESS | 2600 | |4;audio-oscillator;86;72;97;68;68;69;92;67;69;90 16:48:52 INFO - PROCESS | 2600 | |5;imaging-gaussian-blur;90;87;90;126;90;87;90;88;90;86 16:48:52 INFO - PROCESS | 2600 | |6;imaging-darkroom;98;98;107;157;97;97;99;98;97;97 16:48:52 INFO - PROCESS | 2600 | |7;imaging-desaturate;84;85;86;83;83;83;85;84;84;86 16:48:52 INFO - PROCESS | 2600 | |8;json-parse-financial;57;52;52;53;55;58;57;57;56;57 16:48:52 INFO - PROCESS | 2600 | |9;json-stringify-tinderbox;65;73;78;72;73;71;71;74;73;73 16:48:52 INFO - PROCESS | 2600 | |10;stanford-crypto-aes;86;83;83;86;87;86;86;89;90;92 16:48:52 INFO - PROCESS | 2600 | |11;stanford-crypto-ccm;152;152;151;140;136;136;140;140;234;134 16:48:52 INFO - PROCESS | 2600 | |12;stanford-crypto-pbkdf2;162;163;163;165;167;163;165;163;166;164 16:48:52 INFO - PROCESS | 2600 | |13;stanford-crypto-sha256-iterative;67;67;66;66;67;66;66;67;67;72 16:48:52 INFO - PROCESS | 2600 | __end_tp_report 16:48:52 INFO - PROCESS | 2600 | __start_cc_report 16:48:52 INFO - PROCESS | 2600 | _x_x_mozilla_cycle_collect,2087 16:48:52 INFO - PROCESS | 2600 | __end_cc_report 16:48:52 INFO - PROCESS | 2600 | __startTimestamp1475624932979__endTimestamp 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | ------- Summary: start ------- 16:48:52 INFO - PROCESS | 2600 | Number of tests: 14 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:0.84 (0.7%) stddev-sans-first:0.67 16:48:52 INFO - PROCESS | 2600 | Values: 115.0 113.0 114.0 113.0 114.0 113.0 113.0 112.0 113.0 114.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:122.00 stddev:22.62 (18.5%) stddev-sans-first:22.60 16:48:52 INFO - PROCESS | 2600 | Values: 147.0 108.0 110.0 143.0 109.0 110.0 114.0 130.0 174.0 109.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.00 stddev:1.63 (0.9%) stddev-sans-first:1.69 16:48:52 INFO - PROCESS | 2600 | Values: 184.0 186.0 184.0 187.0 183.0 184.0 184.0 188.0 184.0 186.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#3] audio-fft Cycles:10 Average:67.10 Median:61.50 stddev:12.47 (20.3%) stddev-sans-first:12.17 16:48:52 INFO - PROCESS | 2600 | Values: 81.0 59.0 60.0 91.0 63.0 59.0 59.0 59.0 82.0 58.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.00 stddev:11.94 (15.1%) stddev-sans-first:12.29 16:48:52 INFO - PROCESS | 2600 | Values: 86.0 72.0 97.0 68.0 68.0 69.0 92.0 67.0 69.0 90.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:90.00 stddev:11.91 (13.2%) stddev-sans-first:12.60 16:48:52 INFO - PROCESS | 2600 | Values: 90.0 87.0 90.0 126.0 90.0 87.0 90.0 88.0 90.0 86.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#6] imaging-darkroom Cycles:10 Average:104.50 Median:97.50 stddev:18.69 (19.2%) stddev-sans-first:19.68 16:48:52 INFO - PROCESS | 2600 | Values: 98.0 98.0 107.0 157.0 97.0 97.0 99.0 98.0 97.0 97.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:1.16 (1.4%) stddev-sans-first:1.22 16:48:52 INFO - PROCESS | 2600 | Values: 84.0 85.0 86.0 83.0 83.0 83.0 85.0 84.0 84.0 86.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.00 stddev:2.27 (4.0%) stddev-sans-first:2.33 16:48:52 INFO - PROCESS | 2600 | Values: 57.0 52.0 52.0 53.0 55.0 58.0 57.0 57.0 56.0 57.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:73.00 stddev:3.23 (4.4%) stddev-sans-first:2.09 16:48:52 INFO - PROCESS | 2600 | Values: 65.0 73.0 78.0 72.0 73.0 71.0 71.0 74.0 73.0 73.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:2.86 (3.3%) stddev-sans-first:3.02 16:48:52 INFO - PROCESS | 2600 | Values: 86.0 83.0 83.0 86.0 87.0 86.0 86.0 89.0 90.0 92.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:145.50 stddev:29.80 (20.5%) stddev-sans-first:31.60 16:48:52 INFO - PROCESS | 2600 | Values: 152.0 152.0 151.0 140.0 136.0 136.0 140.0 140.0 234.0 134.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:1.60 (1.0%) stddev-sans-first:1.50 16:48:52 INFO - PROCESS | 2600 | Values: 162.0 163.0 163.0 165.0 167.0 163.0 165.0 163.0 166.0 164.0 16:48:52 INFO - PROCESS | 2600 | 16:48:52 INFO - PROCESS | 2600 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.90 16:48:52 INFO - PROCESS | 2600 | Values: 67.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 72.0 16:48:52 INFO - PROCESS | 2600 | -------- Summary: end -------- 16:48:52 INFO - PROCESS | 2600 | 16:48:53 INFO - TEST-INFO | 2600: exit 0 16:48:54 INFO - TEST-OK | kraken | took 59784ms 16:48:54 INFO - SUITE-END | took 1178s 16:48:54 INFO - Completed test suite (00:19:38) 16:48:54 INFO - javascript benchmark 16:48:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2871.4687782760193, 3319.4688849784034, 3335.8498867550957, 3338.2488939988507, 3371.6628337166285, 5647.548196144309, 5671.546276297897, 5717.34250561185, 5724.742386592603, 5735.598508104435, 5654.547636189105, 5764.682942438164, 5770.624909380887, 5788.42115788421, 5797.246357973468, 5265.3155089838265, 5267.55225805807, 5291.994521041, 5303.920441193385, 5348.438413966536, 5212.5308722214995, 5229.764660590283, 5236.1098613235845, 5330.520253177213, 5356.946430535684, 5323.307969963918, 5326.840194794162, 5330.760115794798, 5339.866503337428, 5346.984073026132, 5314.973425132888, 5318.1225097858805, 5321.068812957737, 5331.840044798662, 5336.119540275849, 5095.312132862054, 5210.296609957645, 5235.581153507748, 5267.578593712494, 5280.0, 5752.884942301131, 5766.336871259817, 5792.68140252286, 5856.443637854397, 5858.707064646751, 6235.00239961604, 6241.457632341469, 6281.8743625127245, 6293.0, 6296.1500197473215, 6251.3123556408755, 6339.8415039623915, 6344.3655634436645, 6346.746130154788, 6367.681615919232, 4856.854294371175, 5684.204211410406, 5712.0860662293835, 5715.485606295453, 5758.596898217084, 6154.292256390483, 6239.625622462667, 6242.500599951993, 6309.274433440121, 6314.463270622048, 6151.3541078187045, 6216.378362163748, 6223.96888015566, 6230.158928544679, 6265.8746825063245, 6120.693965301717, 6158.938410615837, 6349.904751428732, 6365.172527571386, 6366.299707032223, 6178.536609754196, 6222.253329600387, 6226.315105338409, 6236.0, 6271.122042913996, 6257.311695713468, 6283.96858015707, 6285.2457705075685, 6288.339724328971, 6293.213348331458, 4829.082474329866, 4835.734034628059, 4892.3884514435695, 4958.033183529177, 4988.900221995613, 4408.4930233023615, 4447.933281000787, 4455.799489023002, 4469.508354081048, 4500.639948804088, 5833.0, 5840.415958404211, 5852.970735146382, 5856.765729370863, 5857.238558987305, 6172.876542469216, 6371.585846919936, 6373.904391434132, 6380.947143721327, 6387.584806987531, 5702.087665973508, 5702.344230413472, 5745.195672605839, 5754.712264386764, 5821.970890145607, 5369.0, 5411.648242864201, 5416.997855396764, 5418.756155972991, 5424.105022671215, 6269.96865015672, 6273.215848018997, 6319.368063193552, 6322.083297921868, 6339.270983836734, 6171.814845554641, 6227.159333489921, 6231.065340198825, 6262.46769024638, 6294.3076261612105, 6323.525735569759, 6331.018692102732, 6341.714622841891, 6342.682865856781, 6352.0, 6158.3841615838055, 6219.937800622117, 6231.470325022424, 6236.064590311489, 6237.625742455467, 6080.635161890301, 6180.876382472416, 6190.442860142609, 6190.845228869134, 6275.309715931336, 6032.849178770566, 6066.545009124422, 6090.543209259412, 6106.1146133811235, 6113.113598528277, 6050.45545900871, 6051.75938932509, 6061.212042434456, 6065.3934606539, 6098.390160983866, 5717.342505611741, 5838.211841401527, 5887.852803679943, 5902.61632993854, 5930.169776231417, 6089.604175728564, 6149.323574406902, 6174.289956654862, 6186.4741496973265, 6211.534134939988, 5035.647504674784, 5983.192269043623, 6003.696119074866, 6007.068904319837, 6040.2147720797775], "value": 5722.612504701357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.860349127182, 469.6313393985722, 497.4677095507808, 514.7014731455755, 528.5216878724756, 24537.509249815015, 37031.814840925756, 40687.0, 42635.57364426351, 42702.786486067525, 43140.78429607848, 43521.0, 43534.12931741363, 43542.0, 43570.7821460893, 9712.70861874145, 9908.702738917844, 9916.405015699082, 9924.354916930413, 9933.503324833766, 8953.194212520872, 9165.587548560297, 9195.908040919605, 9198.356115071947, 9210.355275130743, 12041.157119001673, 12282.877171228307, 12373.752524949496, 12557.058220633444, 12592.685182870457, 12044.337561434118, 12143.696407589792, 12192.0, 12232.510699572007, 12263.50945962165, 8778.47329160246, 9019.729408117766, 11991.580294689644, 12060.216085954473, 12067.818982715266, 39853.60146398528, 40475.988100297436, 40647.7967610163, 42540.57459425428, 42656.36015459771, 3374.4094783412806, 3457.5505184325875, 3548.8048157351336, 3700.666939975415, 3939.625735555118, 29669.258268543243, 29777.70222297771, 31447.742090316588, 31633.0, 32462.675373246202, 3226.709596136359, 3250.821204833733, 3260.250142467246, 3311.2218628622254, 3365.730741540671, 532372.0, 533600.0, 537115.0, 538916.0, 539262.303688483, 51917.0, 53492.0, 56311.155332670045, 57199.0, 57638.13542796861, 62491.06263406052, 62721.0, 62953.370466295666, 63013.0, 63147.36852631507, 16089.436869709503, 16221.0, 16529.917350413172, 16683.916580417263, 16690.16549172561, 10862.619808306672, 12917.289549074703, 13056.673583160307, 13165.0, 13174.0, 13974.720505589832, 14235.715285694228, 14235.85764142366, 15913.840861591236, 15982.920085399499, 6149.723262453201, 6435.452986496107, 7046.013558101869, 7292.270772922771, 7355.896615507717, 821.7945513621595, 878.3587980774071, 894.2756367342473, 979.3683074416961, 1004.7940172264668, 29319.120426387242, 30125.397492050037, 30712.0, 31050.844745776125, 31206.0, 883.6377085395086, 897.9269772621655, 917.8347897378402, 958.7219706285239, 1096.6381094238882, 12933.0, 14712.779308310384, 14971.92514037423, 15025.924870375797, 15343.0, 677380.0, 681427.5571732856, 681829.0, 682701.0, 682738.0, 46696.5330346699, 46952.0, 53991.0, 54675.453245467834, 54762.17856732152, 1349.8515163332027, 1378.9793153102712, 1395.1559306619552, 1397.8811800996623, 1400.8529104443887, 28870.42259154847, 29739.0, 29990.70009299879, 30652.693473064985, 30715.692843071283, 55187.724061379435, 56636.43363566312, 56720.71639641775, 59350.109748352945, 59365.40634593599, 578355.0, 585627.0, 585692.0, 587085.0, 587131.0, 26206.60690089612, 26528.469430611665, 26548.203553893414, 26577.0, 26603.866980664974, 46206.537934620224, 46934.53065469438, 47204.291935620306, 47886.28170577374, 48050.759746201045, 38187.42718859164, 38196.04509887275, 39198.804005979786, 39550.60449395584, 40529.1894162121, 38256.04359891025, 39267.2146557073, 39552.80223598864, 39967.0, 40571.59428405678, 37545.43681844829, 37737.0, 38682.03294917537, 39124.6087539121, 39212.01969950774, 33286.0, 34216.65783342135, 34325.485117722754, 34905.30189396249, 35599.28801423905, 23702.762972370056, 24703.258902232963, 25879.0, 26030.479390412464, 26695.065672702138], "value": 20134.338465905723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8935377940832, 363.37862255543024, 366.67182871330175, 376.70240509997103, 396.3539430727913, 15104.395824167033, 15205.771913421293, 16533.0, 21129.049192786322, 21661.91690415481, 20055.69916451251, 20374.388768336936, 20959.895200524013, 21222.89388553059, 21377.67933480999, 5380.166074258496, 5848.532117430606, 6123.265208175003, 6127.601705889125, 6138.109974053782, 5803.361630220672, 5899.941000589982, 5988.970055149718, 6052.122442245872, 6058.515318774509, 5678.630888992202, 5846.123081537761, 5848.5321174305955, 5860.0, 5913.822585322448, 5841.15303281024, 5869.413058694139, 5891.528677705816, 6012.488938440238, 6020.939790602104, 5225.425203227642, 5235.607329450307, 5237.47625237477, 5460.126379779256, 5519.172124181365, 12715.173513721578, 12833.743325133444, 13030.609081727564, 24852.25443236706, 24891.133165012514, 1806.927722891096, 2098.569793192392, 2153.536989547239, 2177.945551361213, 2347.213683416058, 9872.60509579616, 9890.357126786736, 9937.5031248438, 10384.37693738378, 10491.055804977588, 1818.627181427804, 1830.3502256698814, 1844.9907750461161, 1886.7547218861598, 1891.943241702751, 74869.62565187193, 95690.0, 104002.98990905618, 125334.0, 139117.0, 11288.435578221057, 11543.0, 11778.057755379548, 11811.291322520676, 11896.810318968033, 14857.702845943237, 14869.256537173098, 14875.404983800527, 14890.106593604201, 14892.776608350883, 8428.0, 8492.490450572985, 8533.189347012023, 8711.695090671796, 8780.473171609723, 7158.570485770871, 8656.956715216384, 8686.348523860735, 8704.869426958474, 8886.0, 4494.9325760113625, 4501.68488205829, 4547.477040140427, 4640.907181856344, 4643.303504474288, 1864.4406677996817, 1925.8748181368167, 1929.0933261367136, 1931.2275089963846, 1935.2645994521993, 821.3183058061794, 939.3753154152412, 951.1867353412871, 974.7611835100446, 986.2603047714215, 21321.78678213229, 22355.993980270927, 22358.776412235995, 22415.32754017382, 22436.0, 787.8660627693306, 958.8904410297374, 979.3780949097375, 1003.2626019875386, 1032.3341444768232, 10965.177611679155, 11498.655040348804, 11503.521740212482, 11552.768944621228, 11596.188266821242, 589291.0, 609752.0, 626566.0, 639638.0, 640468.0, 91453.0, 138442.3077884604, 139766.0, 142206.2889685545, 142421.57578424292, 900.2033200617501, 921.1709461484718, 931.0828833598899, 933.5332333833084, 955.7515046087929, 15886.364545418515, 18871.339503117324, 19293.517662058, 20317.898410507853, 20533.38399848007, 57474.0, 58886.82226355535, 59031.0, 59156.70421647864, 59577.0, 81775.0, 85067.5746621263, 85310.0, 86306.13693863232, 88151.0, 7769.456138070281, 8041.356691464785, 8055.718049868226, 8143.5928203590765, 8162.387820913336, 10270.743231419274, 12281.0, 12880.677983050498, 13001.219926804422, 13415.798763018367, 11221.66335009951, 11346.319220846775, 11694.70763230926, 11702.648920532398, 11774.293542387484, 11021.83467247976, 11174.832377514507, 11221.60724374643, 11248.606298779503, 11265.887341126483, 11286.548538058385, 11601.767964640829, 11723.589674361356, 11753.706157345792, 11930.343831089373, 8048.83902321962, 8057.919420805952, 8249.381296402673, 8308.0, 8478.448900821428, 10441.373517588969, 11102.833457497982, 11211.943940280573, 11448.198626096426, 11601.82597261025], "value": 9508.563749237346, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.480431848853, 1500.7298686236477, 1666.2585149608428, 1819.3905041810992, 1835.9357422490207, 8156.714514991976, 8382.203690649378, 8647.351448641353, 9203.63185472581, 9210.986791452935, 8278.420510564263, 8740.825183496327, 8953.820923581525, 8987.550622468883, 9064.501452420114, 2408.096963638631, 2423.624338227569, 2432.963505547418, 2439.3047981325326, 2443.0960544598524, 2396.0, 2425.9514809703796, 2449.371168173163, 2449.595816690244, 2451.166603354859, 2052.4560991337307, 2114.7039414481983, 2156.5255643758346, 2333.9766602334016, 2403.5072810073893, 2041.530447996969, 2393.413613664655, 2425.1148330859287, 2429.769171928664, 2430.3924018995253, 2388.7611238876148, 2420.9757902420924, 2424.6726691896542, 2429.4533729910627, 2434.3914021494625, 8259.95870020652, 9150.679726209552, 9158.26733861296, 9174.0, 9209.125133112344, 5347.331583552056, 5440.483154100354, 5503.807366742185, 5518.558515318805, 5532.917006244909, 3551.751377403583, 3617.855285788565, 3758.248350329945, 3763.172102137525, 3763.9623603763885, 1092.8907109289087, 1102.7132945434246, 1110.9833352499718, 1116.20749268019, 1134.512159771298, 12126.757464850742, 12210.572629957998, 12214.26714397139, 12221.694457638541, 12234.816477752753, 4739.312799644033, 4815.181419158752, 4840.443349014909, 4916.680415772963, 4945.604351651859, 10288.742781430374, 10299.3820370778, 10305.536250868729, 10307.0, 10323.0, 5499.257600223998, 5503.752331145108, 5507.917381239285, 5516.0, 5525.972370138124, 4911.803527858917, 4953.034158339089, 4992.850214493571, 5047.621428392885, 5055.014272216956, 3800.0, 3842.9231415371537, 4018.7588744675413, 4043.595640435933, 4092.0997380576227, 1301.9349032548334, 1301.9414126364336, 1304.0545604436707, 1320.9603711888658, 1321.662975941148, 622.8629701465761, 772.7681695491331, 844.8943882014748, 862.2110768646744, 935.9859602105973, 5894.941050589439, 5933.910991335133, 5958.910616340759, 6156.507479401637, 6191.938080619227, 900.6127365232882, 916.867054277126, 929.8977112517617, 951.6336210558846, 961.6393852305386, 3879.282332768447, 4006.939895901564, 4021.055052062763, 4127.0, 4140.648044916155, 10616.416097114577, 10893.564257429773, 10969.067629251604, 11041.944790275997, 11053.834192487118, 10998.505067271992, 11011.669649910515, 11012.17408694335, 11032.724181895517, 11035.503402346914, 8372.120927302545, 8420.2842758365, 8438.113998030241, 8447.197516235949, 8490.15098490146, 5865.912011319749, 5868.911966320423, 5925.111233315038, 6026.3953725891415, 6199.543107369855, 9894.901050989398, 10259.333143345659, 10274.921133281197, 10288.382697038202, 10312.071913527818, 10416.635417760343, 10523.368597884151, 10554.261201715806, 10557.31083026712, 10588.258821882702, 7458.73894413693, 7487.737929172671, 7718.768436946901, 7734.0, 7782.883256751266, 8491.0, 8691.782705432415, 8700.390972631854, 8710.433821801562, 8761.956190219009, 7460.888086678813, 7552.055993000875, 7568.5458872467825, 7621.12357078943, 7715.8071048222, 7456.627168641655, 7519.285667861544, 7572.848543028998, 7698.114716807415, 7731.458797884319, 7123.323284287984, 7129.073220481304, 7261.3101755333155, 7269.818254543678, 7277.526960747535, 5027.346444962278, 5054.570361519312, 5102.821401250939, 5110.259012443249, 5157.638965272395, 5095.566876815512, 5144.279800827962, 5177.249298851721, 5249.816256431007, 5281.60387970896], "value": 4689.277829122711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.2449977058272, 298.98505074746265, 306.193180968149, 311.94385010698096, 312.39083786616106, 5386.326709161355, 5409.864753381157, 5415.593830462716, 5440.401555828856, 5463.945360546393, 4072.755634661915, 4307.858417519352, 4878.317035615017, 5174.689518628876, 5315.946840531594, 3939.9212015759667, 4111.753294802306, 4129.772862492562, 4195.307774217258, 4219.767912764797, 3589.94615080774, 4107.747137123191, 4120.958790412087, 4125.31932231183, 4162.1675664867, 3431.6445004223315, 3606.9639303607023, 3732.768186498449, 3856.151646637735, 3980.4228386883883, 3408.812515311657, 4083.734557253769, 4118.6499147572495, 4125.8968525787095, 4162.666986641077, 2958.4231074940394, 3285.7349920280626, 3578.9621009907096, 3579.8926032219074, 3584.8028358440274, 4582.541745825424, 4957.587087679994, 5209.843704688866, 5297.894042119136, 5322.600804939606, 3526.400511912981, 4200.789960501963, 4275.230458517465, 4300.010997470568, 4572.611328037121, 4182.268103081979, 4714.740689262089, 4808.374911261549, 5587.7485513152005, 5652.56939516008, 3268.9182770430693, 3380.884308178295, 3720.3675375186285, 3845.788481633509, 3863.4932376373235, 5629.7185140742795, 5692.829215123553, 5869.85325366865, 5913.970430147821, 5922.733476993546, 3409.4544872820725, 3876.39129761146, 3899.8245078971513, 3925.8429662813737, 3929.390944403622, 3982.6614737747036, 3987.3221552335594, 3988.760674359548, 3988.940165897514, 4013.91972160561, 4315.726860576137, 4583.931241031387, 4611.2852507861335, 4615.5845973862515, 4642.303654451859, 4616.930746038812, 5222.634415590948, 5654.575906807006, 5678.744456499468, 5739.62692424991, 1112.3548341961643, 1343.899207559437, 1356.1252991820418, 1357.2738584857252, 1357.6559206385805, 842.8103676672822, 869.1308691308691, 872.7905302727299, 885.6457417033109, 906.9002409734924, 4345.348197770297, 4419.779011049434, 4882.7558622068755, 5077.466865979093, 5374.27447294618, 5782.59521833476, 5802.274715660543, 5812.738426770721, 5814.30228372598, 5846.766129354864, 4499.820007199675, 4640.0, 4977.701337919736, 5235.65968212065, 5253.474652534716, 2631.644727961739, 2817.3660926291423, 2983.4928062229474, 2999.9950016744197, 3037.9240518987203, 5459.5359394451125, 5951.791687290924, 5971.19388882504, 5981.850453738604, 6023.488003519662, 5346.705931173823, 5562.666240025612, 5873.828132808236, 5878.913570375587, 5886.381929897385, 5038.916632923866, 5157.32954715892, 5951.851203719855, 5969.910451343233, 5974.372690867396, 4861.857463496005, 4990.276409920614, 5335.812316950032, 5376.526797673114, 5789.565782566408, 5126.666766660155, 5517.579100957271, 5605.766731319103, 5615.915761263666, 5619.9719001406365, 5946.313285762854, 5949.434803693643, 5971.492423144082, 5972.0, 5991.580589358878, 3227.7889645592845, 3640.9817950910074, 3821.4840996466232, 3851.2297540491454, 3887.572367039567, 4965.453800081916, 5235.110031294766, 5519.227308176939, 5641.9435805641415, 5698.914516282342, 4185.497740271187, 5282.735863206901, 5580.9162862557905, 5626.718664066862, 5636.0, 5014.498550144956, 5180.0, 5498.95519851227, 5607.299087614048, 5659.490645841894, 4422.7346359218545, 5270.472952704698, 5449.727513624223, 5468.781248750164, 5488.267977774992, 5068.391792984866, 5121.8463446096675, 5574.132665557084, 5623.650323922311, 5639.941421381249, 5476.151196564539, 5487.4238204987905, 5493.214705220899, 5509.3664228614225, 5537.363203231519], "value": 4045.611043036026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.3489891648057, 796.4106561144755, 803.3171803966629, 816.0941355095842, 826.68999125328, 15202.923985380072, 16507.422240221596, 16583.0, 16586.170691465424, 16598.917005414973, 15623.062616243005, 15638.0, 15876.761848572252, 16669.91645543039, 16713.415030473934, 816.2042009041182, 842.1830824100613, 844.0841686769832, 844.3540691371106, 848.7962888906649, 646.6378827856415, 674.1270055278402, 674.7503423733226, 675.5946432140726, 679.3885503047272, 705.932936371044, 856.0155820806092, 886.7517095213351, 889.0842432294746, 901.8421776189174, 887.4010043220833, 889.8976617688984, 890.185480285538, 890.2566357091804, 890.3856339125982, 659.3604203922188, 659.7361055577759, 660.1714847865898, 660.5739298152713, 660.7852447954386, 12362.876371236262, 12658.55695050678, 12671.176373535784, 13018.739625207538, 13030.02274829382, 12090.910446351825, 12617.432215550321, 14293.213873236968, 14392.856071439257, 14589.124652520883, 11535.064740663158, 11589.536418543332, 11920.761584768343, 12064.638060858188, 12066.0, 3711.1649878777057, 3789.80986481258, 3803.7717736935874, 3874.5544262409903, 3945.6251656092627, 125826.0, 127197.0, 127469.0, 129302.35348823195, 129358.7064129356, 10936.617218397318, 11115.888841111486, 11174.44127793607, 11276.097912167006, 11307.378094204732, 22374.888125559268, 22570.661440078413, 22756.0, 22801.429964250696, 22808.2017129403, 8169.060558035783, 8250.711225107092, 8252.0, 8318.04342500608, 8363.540005299767, 4299.290617048152, 4363.690668790589, 4479.3057076153245, 4599.678022538457, 4608.631309495232, 3672.4307732301536, 3796.240751849641, 3811.352070148026, 3814.408766641175, 3815.523059617548, 675.6351570152062, 686.2040033561045, 691.872003679321, 694.3022262626029, 700.3766647683566, 541.9674819510842, 561.7528287553463, 633.6071635585967, 663.571996062537, 670.5038271678923, 9330.58012389444, 9466.715998520056, 9549.283803714749, 9561.378510396802, 9565.808683826284, 591.8786648736999, 597.9880402392015, 641.3362170153869, 678.2708588267632, 700.6986995591842, 4166.91666166681, 4405.31717583775, 4559.110973360163, 4614.700044497097, 4640.025594625099, 100880.49559752154, 147380.0, 148682.0, 148686.0, 149612.75580866294, 105473.0, 124453.37773311076, 127826.36086819506, 131482.34258828644, 134331.32834335766, 108313.0, 108716.45641771899, 111595.0, 113774.43112784548, 115190.0, 9163.0, 9901.405915645084, 10092.899071009197, 10233.692989210336, 10283.94858025705, 48586.0, 49705.0, 59580.40419595748, 66471.66764166148, 67638.64722705616, 93084.53457732667, 95218.0, 96291.037089631, 98447.58538280464, 99241.51137732796, 11163.832542512031, 13027.674308142372, 13263.66840828987, 13323.0, 13329.266890320738, 14372.209528476034, 14519.92740036293, 14544.563663090124, 15306.234688265766, 15984.600384990468, 13105.737885242052, 13391.99560032982, 13930.79103813464, 14117.43530258778, 14137.575872723835, 11476.368799716096, 13503.189808611514, 13889.513867014606, 14599.445097108177, 14835.0, 12085.516579336729, 13480.258585777876, 14409.495667651581, 14429.639259018608, 14459.421623134956, 11110.888891110986, 11351.091912646803, 11814.291142531476, 11896.988755955841, 11943.940280298542, 11474.426278685865, 11522.53909843597, 11711.824322634997, 11887.0, 11903.226290291102], "value": 7865.0209805432905, "unit": "score"}], "name": "dromaeo_css", "value": 7394.584110218433, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 112.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 108.0, 110.0, 143.0, 109.0, 110.0, 114.0, 130.0, 174.0, 109.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 187.0, 183.0, 184.0, 184.0, 188.0, 184.0, 186.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 91.0, 63.0, 59.0, 59.0, 59.0, 82.0, 58.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 97.0, 68.0, 68.0, 69.0, 92.0, 67.0, 69.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 126.0, 90.0, 87.0, 90.0, 88.0, 90.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 107.0, 157.0, 97.0, 97.0, 99.0, 98.0, 97.0, 97.0], "value": 104.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 83.0, 83.0, 83.0, 85.0, 84.0, 84.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 52.0, 53.0, 55.0, 58.0, 57.0, 57.0, 56.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 78.0, 72.0, 73.0, 71.0, 71.0, 74.0, 73.0, 73.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 86.0, 87.0, 86.0, 86.0, 89.0, 90.0, 92.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 140.0, 136.0, 136.0, 140.0, 140.0, 234.0, 134.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 165.0, 167.0, 163.0, 165.0, 163.0, 166.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 72.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1447.0999999999997, "alertThreshold": 2.0}]} 16:48:54 INFO - Return code: 0 16:48:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:48:54 INFO - # TBPL SUCCESS # 16:48:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:48:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:48:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:48:54 INFO - 2016-10-04 16:48:54.282 screenresolution[2604:82774] starting screenresolution argv=screenresolution get 16:48:54 INFO - 2016-10-04 16:48:54.285 screenresolution[2604:82774] Display 0: 1600x1200x32@60 16:48:54 INFO - 2016-10-04 16:48:54.291 screenresolution[2605:82777] starting screenresolution argv=screenresolution list 16:48:54 INFO - Available Modes on Display 0 16:48:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:48:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:48:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:48:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:48:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:48:54 INFO - Intel Iris: 16:48:54 INFO - Chipset Model: Intel Iris 16:48:54 INFO - Type: GPU 16:48:54 INFO - Bus: Built-In 16:48:54 INFO - VRAM (Dynamic, Max): 1536 MB 16:48:54 INFO - Vendor: Intel (0x8086) 16:48:54 INFO - Device ID: 0x0a2e 16:48:54 INFO - Revision ID: 0x0009 16:48:54 INFO - Displays: 16:48:54 INFO - Display: 16:48:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:48:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:48:54 INFO - Display Serial Number: 1600x1200 60 16:48:54 INFO - Main Display: Yes 16:48:54 INFO - Mirror: Off 16:48:54 INFO - Online: Yes 16:48:54 INFO - Rotation: Supported 16:48:54 INFO - Return code: 0 16:48:54 INFO - Running post-action listener: _resource_record_post_action 16:48:54 INFO - [mozharness: 2016-10-04 23:48:54.532675Z] Finished run-tests step (success) 16:48:54 INFO - Running post-run listener: _resource_record_post_run 16:48:54 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 999424; Write bytes: 660665344; Read time: 7; Write time: 1826 16:48:54 INFO - TinderboxPrint: CPU usage
53.4% 16:48:54 INFO - TinderboxPrint: I/O read bytes / time
999,424 / 7 16:48:54 INFO - TinderboxPrint: I/O write bytes / time
660,665,344 / 1,826 16:48:54 INFO - TinderboxPrint: CPU idle
2,264.0 (46.6%) 16:48:54 INFO - TinderboxPrint: CPU system
974.8 (20.1%) 16:48:54 INFO - TinderboxPrint: CPU user
1,615.0 (33.3%) 16:48:54 INFO - TinderboxPrint: Swap in / out
363,286,528 / 0 16:48:54 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 354800128; Write bytes: 355010048; Read time: 27474; Write time: 619 16:48:54 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 999424; Write bytes: 295472640; Read time: 7; Write time: 1177 16:48:55 INFO - Running post-run listener: _upload_blobber_files 16:48:55 INFO - Blob upload gear active. 16:48:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:48:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:48:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:56 INFO - (blobuploader) - INFO - Done attempting. 16:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:48:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:57 INFO - (blobuploader) - INFO - Done attempting. 16:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:59 INFO - (blobuploader) - INFO - Done attempting. 16:48:59 INFO - (blobuploader) - INFO - Iteration through files over. 16:48:59 INFO - Return code: 0 16:48:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:48:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:48:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06450ef630321e1e76179bc80d98af6ddbd8fc7f58bf04adce9af36dd28f64db075f1b3257777c4542ec36d7f22fb96a37e9beef19eb8cad76f0e87c62abeecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/636a65fc3c34746aed5660d2708e6f07b06d1649ebd05fc78566567fca29921a7d67ebfbf33ec82fa7a418d287d1874d2ad97e8d566a5fd432d453fd876184a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bfbfc2a08fc7aa59e29f4daaacbe8aa510b2685e1914162676c8eee72c9a16baca36a4a21ff00d2b251779c62aa9fe8677583f0c5dc161128dc17839cc73853"} 16:48:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:48:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:48:59 INFO - Contents: 16:48:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06450ef630321e1e76179bc80d98af6ddbd8fc7f58bf04adce9af36dd28f64db075f1b3257777c4542ec36d7f22fb96a37e9beef19eb8cad76f0e87c62abeecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/636a65fc3c34746aed5660d2708e6f07b06d1649ebd05fc78566567fca29921a7d67ebfbf33ec82fa7a418d287d1874d2ad97e8d566a5fd432d453fd876184a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bfbfc2a08fc7aa59e29f4daaacbe8aa510b2685e1914162676c8eee72c9a16baca36a4a21ff00d2b251779c62aa9fe8677583f0c5dc161128dc17839cc73853"} 16:48:59 INFO - Running post-run listener: copy_logs_to_upload_dir 16:48:59 INFO - Copying logs to upload dir... 16:48:59 INFO - mkdir: /builds/slave/test/build/upload/logs 16:48:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.156993 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 16:48:59.841705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:59.845824) ========= 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.KWoI1V8vjr/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.elweUiRi8u/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06450ef630321e1e76179bc80d98af6ddbd8fc7f58bf04adce9af36dd28f64db075f1b3257777c4542ec36d7f22fb96a37e9beef19eb8cad76f0e87c62abeecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/636a65fc3c34746aed5660d2708e6f07b06d1649ebd05fc78566567fca29921a7d67ebfbf33ec82fa7a418d287d1874d2ad97e8d566a5fd432d453fd876184a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bfbfc2a08fc7aa59e29f4daaacbe8aa510b2685e1914162676c8eee72c9a16baca36a4a21ff00d2b251779c62aa9fe8677583f0c5dc161128dc17839cc73853"} build_url:https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06450ef630321e1e76179bc80d98af6ddbd8fc7f58bf04adce9af36dd28f64db075f1b3257777c4542ec36d7f22fb96a37e9beef19eb8cad76f0e87c62abeecb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/636a65fc3c34746aed5660d2708e6f07b06d1649ebd05fc78566567fca29921a7d67ebfbf33ec82fa7a418d287d1874d2ad97e8d566a5fd432d453fd876184a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bfbfc2a08fc7aa59e29f4daaacbe8aa510b2685e1914162676c8eee72c9a16baca36a4a21ff00d2b251779c62aa9fe8677583f0c5dc161128dc17839cc73853"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:59.885715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:59.886284) ========= 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.KWoI1V8vjr/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.elweUiRi8u/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005400 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:59.938395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 16:48:59.938887) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 16:48:59.939389) ========= ========= Total master_lag: 0.19 =========