builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0074 starttime: 1483956061.71 results: success (0) buildid: 20170108234508 builduid: 3dde137a6d7e4844ab13acc3af2e39be revision: 6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:01.705879) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:01.706701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:01.706977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:01.764186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:01.764566) ========= 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.rgCiup2I8r/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.x93XVjCHu1/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 --2017-01-09 02:01:01-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-01-09 02:01:02 (46.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.535879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:02.323892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:02.324171) ========= 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.rgCiup2I8r/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.x93XVjCHu1/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.027495 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:02.374149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 02:01:02.374507) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rgCiup2I8r/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.x93XVjCHu1/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 2017-01-09 02:01:02,468 truncating revision to first 12 chars 2017-01-09 02:01:02,468 Setting DEBUG logging. 2017-01-09 02:01:02,468 attempt 1/10 2017-01-09 02:01:02,469 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6dc2ca24bd0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 02:01:03,838 unpacking tar archive at: mozilla-beta-6dc2ca24bd0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.674130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 02:01:04.072794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:04.073109) ========= script_repo_revision: 6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:04.073503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:04.073768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 02:01:04.093782) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-09 02:01:04.094161) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rgCiup2I8r/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.x93XVjCHu1/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:04 INFO - MultiFileLogger online at 20170109 02:01:04 in /builds/slave/test 02:01:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:01:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:04 INFO - {'append_to_log': False, 02:01:04 INFO - 'base_work_dir': '/builds/slave/test', 02:01:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:01:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:04 INFO - 'branch': 'Mozilla-Beta', 02:01:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:04 INFO - 'config_files': ('talos/mac_config.py',), 02:01:04 INFO - 'default_actions': ('clobber', 02:01:04 INFO - 'read-buildbot-config', 02:01:04 INFO - 'download-and-extract', 02:01:04 INFO - 'populate-webroot', 02:01:04 INFO - 'create-virtualenv', 02:01:04 INFO - 'install', 02:01:04 INFO - 'run-tests'), 02:01:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:04 INFO - 'download_minidump_stackwalk': True, 02:01:04 INFO - 'download_symbols': 'ondemand', 02:01:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:04 INFO - 'installer_path': 'installer.exe', 02:01:04 INFO - 'log_level': 'info', 02:01:04 INFO - 'log_name': 'talos', 02:01:04 INFO - 'log_to_console': True, 02:01:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:04 INFO - 'opt_config_files': (), 02:01:04 INFO - 'pip_index': False, 02:01:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:04 INFO - 'cmd': ('bash', 02:01:04 INFO - '-c', 02:01:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:04 INFO - 'enabled': True, 02:01:04 INFO - 'halt_on_failure': False, 02:01:04 INFO - 'name': 'check_screen_resolution'},), 02:01:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:04 INFO - 'cmd': ('bash', 02:01:04 INFO - '-c', 02:01:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:04 INFO - 'enabled': True, 02:01:04 INFO - 'halt_on_failure': False, 02:01:04 INFO - 'name': 'check_screen_resolution'},), 02:01:04 INFO - 'run_cmd_checks_enabled': True, 02:01:04 INFO - 'sps_profile': False, 02:01:04 INFO - 'sps_profile_interval': 0, 02:01:04 INFO - 'suite': 'dromaeojs', 02:01:04 INFO - 'system_bits': '32', 02:01:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:04 INFO - 'title': 't-yosemite-r7-0074', 02:01:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:04 INFO - 'use_talos_json': True, 02:01:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:04 INFO - 'work_dir': 'build'} 02:01:04 INFO - [mozharness: 2017-01-09 10:01:04.294991Z] Running clobber step. 02:01:04 INFO - Running pre-action listener: _resource_record_pre_action 02:01:04 INFO - Running main action method: clobber 02:01:04 INFO - rmtree: /builds/slave/test/build 02:01:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:07 INFO - Running post-action listener: _resource_record_post_action 02:01:07 INFO - [mozharness: 2017-01-09 10:01:07.212222Z] Finished clobber step (success) 02:01:07 INFO - [mozharness: 2017-01-09 10:01:07.212382Z] Running read-buildbot-config step. 02:01:07 INFO - Running pre-action listener: _resource_record_pre_action 02:01:07 INFO - Running main action method: read_buildbot_config 02:01:07 INFO - Using buildbot properties: 02:01:07 INFO - { 02:01:07 INFO - "project": "", 02:01:07 INFO - "product": "firefox", 02:01:07 INFO - "script_repo_revision": "production", 02:01:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:01:07 INFO - "repository": "", 02:01:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:01:07 INFO - "buildid": "20170108234508", 02:01:07 INFO - "pgo_build": "False", 02:01:07 INFO - "basedir": "/builds/slave/test", 02:01:07 INFO - "buildnumber": 4, 02:01:07 INFO - "slavename": "t-yosemite-r7-0074", 02:01:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:01:07 INFO - "platform": "yosemite_r7", 02:01:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:01:07 INFO - "branch": "mozilla-beta", 02:01:07 INFO - "repo_path": "releases/mozilla-beta", 02:01:07 INFO - "revision": "6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333", 02:01:07 INFO - "stage_platform": "macosx64", 02:01:07 INFO - "builduid": "3dde137a6d7e4844ab13acc3af2e39be", 02:01:07 INFO - "slavebuilddir": "test" 02:01:07 INFO - } 02:01:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 02:01:07 INFO - Running post-action listener: _resource_record_post_action 02:01:07 INFO - [mozharness: 2017-01-09 10:01:07.215815Z] Finished read-buildbot-config step (success) 02:01:07 INFO - [mozharness: 2017-01-09 10:01:07.215900Z] Running download-and-extract step. 02:01:07 INFO - Running pre-action listener: _resource_record_pre_action 02:01:07 INFO - Running main action method: download_and_extract 02:01:07 INFO - mkdir: /builds/slave/test/build/tests 02:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:07 INFO - trying https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 02:01:07 INFO - Downloading https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 02:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 02:01:08 INFO - Downloaded 1165 bytes. 02:01:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 02:01:08 INFO - Using the following test package requirements: 02:01:08 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 02:01:08 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 02:01:08 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 02:01:08 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:01:08 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 02:01:08 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 02:01:08 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 02:01:08 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 02:01:08 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 02:01:08 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:01:08 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 02:01:08 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 02:01:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 02:01:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 02:01:08 INFO - Fetch https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 02:01:09 INFO - Expected file size: 16234531 02:01:16 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 02:01:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 02:01:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 02:01:16 INFO - Fetch https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 02:01:17 INFO - Expected file size: 16234531 02:01:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 02:01:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 02:01:23 INFO - Fetch https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 02:01:24 INFO - Expected file size: 14414089 02:01: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')]} 02:01:24 INFO - trying https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:01:24 INFO - Downloading https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 02:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 02:01:27 INFO - Downloaded 86143263 bytes. 02:01:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:01:27 INFO - mkdir: /builds/slave/test/properties 02:01:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:27 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:27 INFO - Contents: 02:01:27 INFO - build_url:https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:01:27 INFO - Running post-action listener: _resource_record_post_action 02:01:27 INFO - Running post-action listener: set_extra_try_arguments 02:01:27 INFO - [mozharness: 2017-01-09 10:01:27.881410Z] Finished download-and-extract step (success) 02:01:27 INFO - [mozharness: 2017-01-09 10:01:27.881557Z] Running populate-webroot step. 02:01:27 INFO - Running pre-action listener: _resource_record_pre_action 02:01:27 INFO - Running main action method: populate_webroot 02:01:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:27 INFO - '--tppagecycles', 02:01:27 INFO - '7'], 02:01:27 INFO - 'tests': ['tsvgm']}}, 02:01:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:01:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:01:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['damp', 'tps']}, 02:01:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'tests': ['damp', 'tps']}, 02:01:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['dromaeo_dom']}, 02:01:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:01:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['basic_compositor_video']}, 02:01:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:01:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['a11yr', 02:01:27 INFO - 'ts_paint', 02:01:27 INFO - 'tpaint', 02:01:27 INFO - 'sessionrestore', 02:01:27 INFO - 'sessionrestore_no_auto_restore', 02:01:27 INFO - 'tabpaint']}, 02:01:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:01:27 INFO - 'ts_paint', 02:01:27 INFO - 'tpaint', 02:01:27 INFO - 'sessionrestore', 02:01:27 INFO - 'sessionrestore_no_auto_restore', 02:01:27 INFO - 'tabpaint']}, 02:01:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:01:27 INFO - 'ts_paint', 02:01:27 INFO - 'tpaint', 02:01:27 INFO - 'sessionrestore', 02:01:27 INFO - 'sessionrestore_no_auto_restore', 02:01:27 INFO - 'tabpaint']}, 02:01:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:01:27 INFO - 'ts_paint', 02:01:27 INFO - 'tpaint', 02:01:27 INFO - 'sessionrestore', 02:01:27 INFO - 'sessionrestore_no_auto_restore', 02:01:27 INFO - 'tabpaint']}, 02:01:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['a11yr', 02:01:27 INFO - 'ts_paint', 02:01:27 INFO - 'tpaint', 02:01:27 INFO - 'sessionrestore', 02:01:27 INFO - 'sessionrestore_no_auto_restore', 02:01:27 INFO - 'tabpaint']}, 02:01:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['a11yr', 02:01:27 INFO - 'ts_paint', 02:01:27 INFO - 'tpaint', 02:01:27 INFO - 'sessionrestore', 02:01:27 INFO - 'sessionrestore_no_auto_restore', 02:01:27 INFO - 'tabpaint']}, 02:01:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['tsvgx', 02:01:27 INFO - 'tsvgr_opacity', 02:01:27 INFO - 'tart', 02:01:27 INFO - 'tscrollx', 02:01:27 INFO - 'cart']}, 02:01:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:01:27 INFO - 'tsvgr_opacity', 02:01:27 INFO - 'tart', 02:01:27 INFO - 'tscrollx', 02:01:27 INFO - 'cart']}, 02:01:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'talos_options': ['--disable-e10s'], 02:01:27 INFO - 'tests': ['tp5o']}, 02:01:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'tests': ['tp5o']}, 02:01:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'talos_options': ['--disable-e10s', 02:01:27 INFO - '--xperf_path', 02:01:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:27 INFO - 'tests': ['tp5n']}, 02:01:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:27 INFO - 'talos_options': ['--xperf_path', 02:01:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:27 INFO - 'tests': ['tp5n']}}, 02:01:27 INFO - 'talos.zip': {'path': '', 02:01:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:27 INFO - Running post-action listener: _resource_record_post_action 02:01:27 INFO - [mozharness: 2017-01-09 10:01:27.900622Z] Finished populate-webroot step (success) 02:01:27 INFO - [mozharness: 2017-01-09 10:01:27.900754Z] Running create-virtualenv step. 02:01:27 INFO - Running pre-action listener: _resource_record_pre_action 02:01:27 INFO - Running main action method: create_virtualenv 02:01:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:27 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 02:01:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:28 INFO - Using real prefix '/tools/python27' 02:01:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:31 INFO - Installing pip.................done. 02:01:31 INFO - Return code: 0 02:01:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:31 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')]} 02:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:31 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')]} 02:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:31 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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:31 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 02:01:31 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 02:01:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:31 INFO - 'HOME': '/Users/cltbld', 02:01:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:31 INFO - 'LOGNAME': 'cltbld', 02:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:31 INFO - 'MOZ_NO_REMOTE': '1', 02:01:31 INFO - 'NO_EM_RESTART': '1', 02:01:31 INFO - 'PAGER': '/bin/cat', 02:01:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:31 INFO - 'PWD': '/builds/slave/test', 02:01:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:31 INFO - 'SHELL': '/bin/bash', 02:01:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:31 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:31 INFO - 'USER': 'cltbld', 02:01:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:31 INFO - 'XPC_FLAGS': '0x0', 02:01:31 INFO - 'XPC_SERVICE_NAME': '0', 02:01:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:31 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 02:01:31 INFO - Cleaning up... 02:01:31 INFO - Return code: 0 02:01:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:01:31 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')]} 02:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:31 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')]} 02:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:31 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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:31 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 02:01:31 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 02:01:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:31 INFO - 'HOME': '/Users/cltbld', 02:01:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:31 INFO - 'LOGNAME': 'cltbld', 02:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:31 INFO - 'MOZ_NO_REMOTE': '1', 02:01:31 INFO - 'NO_EM_RESTART': '1', 02:01:31 INFO - 'PAGER': '/bin/cat', 02:01:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:31 INFO - 'PWD': '/builds/slave/test', 02:01:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:31 INFO - 'SHELL': '/bin/bash', 02:01:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:31 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:31 INFO - 'USER': 'cltbld', 02:01:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:31 INFO - 'XPC_FLAGS': '0x0', 02:01:31 INFO - 'XPC_SERVICE_NAME': '0', 02:01:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:32 INFO - Downloading/unpacking psutil>=3.1.1 02:01:32 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 02:01:32 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 02:01:32 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 02:01:32 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 02:01:32 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 02:01:32 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 02:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:35 INFO - Installing collected packages: psutil 02:01:35 INFO - Running setup.py install for psutil 02:01:35 INFO - building 'psutil._psutil_osx' extension 02:01:35 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 02:01:36 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 02:01:36 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 02:01:36 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 02:01:36 INFO - building 'psutil._psutil_posix' extension 02:01:36 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 02:01:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:01:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:01:36 INFO - ^ 02:01:36 INFO - 1 warning generated. 02:01:36 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 02:01:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:36 INFO - Successfully installed psutil 02:01:36 INFO - Cleaning up... 02:01:36 INFO - Return code: 0 02:01:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:01:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:36 INFO - 'HOME': '/Users/cltbld', 02:01:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:36 INFO - 'LOGNAME': 'cltbld', 02:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:36 INFO - 'MOZ_NO_REMOTE': '1', 02:01:36 INFO - 'NO_EM_RESTART': '1', 02:01:36 INFO - 'PAGER': '/bin/cat', 02:01:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:36 INFO - 'PWD': '/builds/slave/test', 02:01:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:36 INFO - 'SHELL': '/bin/bash', 02:01:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:36 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:36 INFO - 'USER': 'cltbld', 02:01:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:36 INFO - 'XPC_FLAGS': '0x0', 02:01:36 INFO - 'XPC_SERVICE_NAME': '0', 02:01:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:01:37 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 02:01:37 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 02:01:37 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 02:01:37 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 02:01:37 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 02:01:37 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 02:01:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:01:40 INFO - Installing collected packages: mozsystemmonitor 02:01:40 INFO - Running setup.py install for mozsystemmonitor 02:01:41 INFO - Successfully installed mozsystemmonitor 02:01:41 INFO - Cleaning up... 02:01:41 INFO - Return code: 0 02:01:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:41 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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:41 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 02:01:41 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 02:01:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:41 INFO - 'HOME': '/Users/cltbld', 02:01:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:41 INFO - 'LOGNAME': 'cltbld', 02:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:41 INFO - 'MOZ_NO_REMOTE': '1', 02:01:41 INFO - 'NO_EM_RESTART': '1', 02:01:41 INFO - 'PAGER': '/bin/cat', 02:01:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:41 INFO - 'PWD': '/builds/slave/test', 02:01:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:41 INFO - 'SHELL': '/bin/bash', 02:01:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:41 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:41 INFO - 'USER': 'cltbld', 02:01:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:41 INFO - 'XPC_FLAGS': '0x0', 02:01:41 INFO - 'XPC_SERVICE_NAME': '0', 02:01:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:41 INFO - Downloading/unpacking jsonschema==2.5.1 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:01:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:01:45 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 02:01:45 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 02:01:45 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 02:01:45 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 02:01:45 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 02:01:45 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 02:01:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:01:45 INFO - warning: no files found matching '*.txt' 02:01:45 INFO - no previously-included directories found matching 'build' 02:01:45 INFO - no previously-included directories found matching 'dist' 02:01:45 INFO - no previously-included directories found matching '.git*' 02:01:45 INFO - Installing collected packages: jsonschema, functools32 02:01:45 INFO - Running setup.py install for functools32 02:01:45 INFO - warning: no files found matching '*.txt' 02:01:45 INFO - no previously-included directories found matching 'build' 02:01:45 INFO - no previously-included directories found matching 'dist' 02:01:45 INFO - no previously-included directories found matching '.git*' 02:01:45 INFO - Successfully installed jsonschema functools32 02:01:45 INFO - Cleaning up... 02:01:46 INFO - Return code: 0 02:01:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:46 INFO - 'HOME': '/Users/cltbld', 02:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:46 INFO - 'LOGNAME': 'cltbld', 02:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:46 INFO - 'MOZ_NO_REMOTE': '1', 02:01:46 INFO - 'NO_EM_RESTART': '1', 02:01:46 INFO - 'PAGER': '/bin/cat', 02:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:46 INFO - 'PWD': '/builds/slave/test', 02:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:46 INFO - 'SHELL': '/bin/bash', 02:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:46 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:46 INFO - 'USER': 'cltbld', 02:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:46 INFO - 'XPC_FLAGS': '0x0', 02:01:46 INFO - 'XPC_SERVICE_NAME': '0', 02:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:01:46 INFO - Cleaning up... 02:01:46 INFO - Return code: 0 02:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:46 INFO - 'HOME': '/Users/cltbld', 02:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:46 INFO - 'LOGNAME': 'cltbld', 02:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:46 INFO - 'MOZ_NO_REMOTE': '1', 02:01:46 INFO - 'NO_EM_RESTART': '1', 02:01:46 INFO - 'PAGER': '/bin/cat', 02:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:46 INFO - 'PWD': '/builds/slave/test', 02:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:46 INFO - 'SHELL': '/bin/bash', 02:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:46 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:46 INFO - 'USER': 'cltbld', 02:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:46 INFO - 'XPC_FLAGS': '0x0', 02:01:46 INFO - 'XPC_SERVICE_NAME': '0', 02:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01:51 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 02:01:51 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 02:01:51 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 02:01:51 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 02:01:51 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 02:01:51 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 02:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:54 INFO - Downloading docopt-0.6.1.tar.gz 02:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:54 INFO - Running setup.py install for blobuploader 02:01:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:54 INFO - Running setup.py install for requests 02:01:55 INFO - Running setup.py install for docopt 02:01:55 INFO - Successfully installed blobuploader requests docopt 02:01:55 INFO - Cleaning up... 02:01:55 INFO - Return code: 0 02:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:55 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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:01:55 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 02:01:55 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 02:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:55 INFO - 'HOME': '/Users/cltbld', 02:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:55 INFO - 'LOGNAME': 'cltbld', 02:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:55 INFO - 'MOZ_NO_REMOTE': '1', 02:01:55 INFO - 'NO_EM_RESTART': '1', 02:01:55 INFO - 'PAGER': '/bin/cat', 02:01:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:55 INFO - 'PWD': '/builds/slave/test', 02:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:55 INFO - 'SHELL': '/bin/bash', 02:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:01:55 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:55 INFO - 'USER': 'cltbld', 02:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:55 INFO - 'XPC_FLAGS': '0x0', 02:01:55 INFO - 'XPC_SERVICE_NAME': '0', 02:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:55 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-zDWEwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:55 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-IjOBUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:55 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-4mgCra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Q4juO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-jbl5cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Wd87KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-KxFFty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XktNFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6Gke0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-SlmK23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-DS3t1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-42wbZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:56 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Jl33pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:57 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-B5F1hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:57 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-C4aaJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:57 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-VNK8aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:57 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ddNAOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:57 INFO - Running setup.py install for manifestparser 02:01:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:57 INFO - Running setup.py install for mozcrash 02:01:57 INFO - Running setup.py install for mozdebug 02:01:57 INFO - Running setup.py install for mozdevice 02:01:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozfile 02:01:58 INFO - Running setup.py install for mozhttpd 02:01:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozinfo 02:01:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozInstall 02:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for mozleak 02:01:58 INFO - Running setup.py install for mozlog 02:01:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:58 INFO - Running setup.py install for moznetwork 02:01:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:59 INFO - Running setup.py install for mozprocess 02:01:59 INFO - Running setup.py install for mozprofile 02:01:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:59 INFO - Running setup.py install for mozrunner 02:01:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:59 INFO - Running setup.py install for mozscreenshot 02:01:59 INFO - Running setup.py install for moztest 02:01:59 INFO - Running setup.py install for mozversion 02:02:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:00 INFO - Cleaning up... 02:02:00 INFO - Return code: 0 02:02:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:00 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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:02:00 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 02:02:00 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 02:02:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:02:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:00 INFO - 'HOME': '/Users/cltbld', 02:02:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:00 INFO - 'LOGNAME': 'cltbld', 02:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:00 INFO - 'MOZ_NO_REMOTE': '1', 02:02:00 INFO - 'NO_EM_RESTART': '1', 02:02:00 INFO - 'PAGER': '/bin/cat', 02:02:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:00 INFO - 'PWD': '/builds/slave/test', 02:02:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:00 INFO - 'SHELL': '/bin/bash', 02:02:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:02:00 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:02:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:00 INFO - 'USER': 'cltbld', 02:02:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:00 INFO - 'XPC_FLAGS': '0x0', 02:02:00 INFO - 'XPC_SERVICE_NAME': '0', 02:02:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-NdjSXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-vg9d2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-vBavaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-dWLKsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-5PCuWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-W4jcSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:00 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)) 02:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:00 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-qDoZxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Mfdx8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-7_krH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-c0cFhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-TCssuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-AbADUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-uuZnfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Kf0FA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-PQKlEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:01 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)) 02:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:01 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-jvv27O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:02 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)) 02:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:02 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-INvAkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:02 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)) 02:02:02 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)) 02:02:02 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)) 02:02:02 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)) 02:02:02 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)) 02:02:02 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)) 02:02:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:06 INFO - Downloading blessings-1.6.tar.gz 02:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:06 INFO - Installing collected packages: blessings 02:02:06 INFO - Running setup.py install for blessings 02:02:06 INFO - Successfully installed blessings 02:02:06 INFO - Cleaning up... 02:02:06 INFO - Return code: 0 02:02:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:07 INFO - Reading from file tmpfile_stdout 02:02:07 INFO - Current package versions: 02:02:07 INFO - blessings == 1.6 02:02:07 INFO - blobuploader == 1.2.4 02:02:07 INFO - docopt == 0.6.1 02:02:07 INFO - functools32 == 3.2.3-2 02:02:07 INFO - jsonschema == 2.5.1 02:02:07 INFO - manifestparser == 1.1 02:02:07 INFO - mozInstall == 1.12 02:02:07 INFO - mozcrash == 0.17 02:02:07 INFO - mozdebug == 0.1 02:02:07 INFO - mozdevice == 0.48 02:02:07 INFO - mozfile == 1.2 02:02:07 INFO - mozhttpd == 0.7 02:02:07 INFO - mozinfo == 0.9 02:02:07 INFO - mozleak == 0.1 02:02:07 INFO - mozlog == 3.4 02:02:07 INFO - moznetwork == 0.27 02:02:07 INFO - mozprocess == 0.23 02:02:07 INFO - mozprofile == 0.28 02:02:07 INFO - mozrunner == 6.12 02:02:07 INFO - mozscreenshot == 0.1 02:02:07 INFO - mozsystemmonitor == 0.3 02:02:07 INFO - moztest == 0.7 02:02:07 INFO - mozversion == 1.4 02:02:07 INFO - psutil == 3.1.1 02:02:07 INFO - requests == 1.2.3 02:02:07 INFO - wsgiref == 0.1.2 02:02:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:07 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 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:02:07 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 02:02:07 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 02:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:07 INFO - 'HOME': '/Users/cltbld', 02:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:07 INFO - 'LOGNAME': 'cltbld', 02:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:07 INFO - 'MOZ_NO_REMOTE': '1', 02:02:07 INFO - 'NO_EM_RESTART': '1', 02:02:07 INFO - 'PAGER': '/bin/cat', 02:02:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:07 INFO - 'PWD': '/builds/slave/test', 02:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:07 INFO - 'SHELL': '/bin/bash', 02:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:02:07 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:07 INFO - 'USER': 'cltbld', 02:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:07 INFO - 'XPC_FLAGS': '0x0', 02:02:07 INFO - 'XPC_SERVICE_NAME': '0', 02:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 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)) 02:02:07 INFO - Cleaning up... 02:02:07 INFO - Return code: 0 02:02:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbf2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db68570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd300c64190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, '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.rgCiup2I8r/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.x93XVjCHu1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 02:02:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:02:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:02:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:07 INFO - 'HOME': '/Users/cltbld', 02:02:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:07 INFO - 'LOGNAME': 'cltbld', 02:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:07 INFO - 'MOZ_NO_REMOTE': '1', 02:02:07 INFO - 'NO_EM_RESTART': '1', 02:02:07 INFO - 'PAGER': '/bin/cat', 02:02:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:07 INFO - 'PWD': '/builds/slave/test', 02:02:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:07 INFO - 'SHELL': '/bin/bash', 02:02:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:02:07 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:02:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:07 INFO - 'USER': 'cltbld', 02:02:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:07 INFO - 'XPC_FLAGS': '0x0', 02:02:07 INFO - 'XPC_SERVICE_NAME': '0', 02:02:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:02:07 INFO - Cleaning up... 02:02:07 INFO - Return code: 0 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - Running post-action listener: _start_resource_monitoring 02:02:07 INFO - Starting resource monitoring. 02:02:07 INFO - [mozharness: 2017-01-09 10:02:07.786810Z] Finished create-virtualenv step (success) 02:02:07 INFO - [mozharness: 2017-01-09 10:02:07.787772Z] Running install step. 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: install 02:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:08 INFO - Reading from file tmpfile_stdout 02:02:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:08 INFO - Reading from file tmpfile_stdout 02:02:08 INFO - Output received: 02:02:08 INFO - Usage: mozinstall [options] installer 02:02:08 INFO - Options: 02:02:08 INFO - -h, --help show this help message and exit 02:02:08 INFO - -d DEST, --destination=DEST 02:02:08 INFO - Directory to install application into. [default: 02:02:08 INFO - "/builds/slave/test"] 02:02:08 INFO - --app=APP Application being installed. [default: firefox] 02:02:08 INFO - mkdir: /builds/slave/test/build/application 02:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 02:02:29 INFO - Reading from file tmpfile_stdout 02:02:29 INFO - Output received: 02:02:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:02:29 INFO - Running post-action listener: _resource_record_post_action 02:02:29 INFO - [mozharness: 2017-01-09 10:02:29.956000Z] Finished install step (success) 02:02:29 INFO - [mozharness: 2017-01-09 10:02:29.956160Z] Running run-tests step. 02:02:29 INFO - Running pre-action listener: _resource_record_pre_action 02:02:29 INFO - Running main action method: run_tests 02:02:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:29 INFO - 2017-01-09 02:02:29.970 screenresolution[1622:8179] starting screenresolution argv=screenresolution get 02:02:29 INFO - 2017-01-09 02:02:29.973 screenresolution[1622:8179] Display 0: 1600x1200x32@60 02:02:29 INFO - 2017-01-09 02:02:29.978 screenresolution[1623:8182] starting screenresolution argv=screenresolution list 02:02:29 INFO - Available Modes on Display 0 02:02:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:30 INFO - Intel Iris: 02:02:30 INFO - Chipset Model: Intel Iris 02:02:30 INFO - Type: GPU 02:02:30 INFO - Bus: Built-In 02:02:30 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:30 INFO - Vendor: Intel (0x8086) 02:02:30 INFO - Device ID: 0x0a2e 02:02:30 INFO - Revision ID: 0x0009 02:02:30 INFO - Displays: 02:02:30 INFO - Display: 02:02:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:30 INFO - Display Serial Number: 1600x1200 60 02:02:30 INFO - Main Display: Yes 02:02:30 INFO - Mirror: Off 02:02:30 INFO - Online: Yes 02:02:30 INFO - Rotation: Supported 02:02:30 INFO - Return code: 0 02:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:30 INFO - Python 2.7.3 02:02:30 INFO - Return code: 0 02:02:30 INFO - grabbing minidump binary from tooltool 02:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:02:30 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 0x10da06d30>, '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 0x10d86cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9feb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:30 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 02:02:30 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 02:02:30 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 02:02:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:30 INFO - Return code: 0 02:02:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:02:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:02:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 02:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --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 02:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rgCiup2I8r/Render', 02:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:30 INFO - 'HOME': '/Users/cltbld', 02:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:30 INFO - 'LOGNAME': 'cltbld', 02:02:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:30 INFO - 'MOZ_NO_REMOTE': '1', 02:02:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:30 INFO - 'NO_EM_RESTART': '1', 02:02:30 INFO - 'PAGER': '/bin/cat', 02:02:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:30 INFO - 'PWD': '/builds/slave/test', 02:02:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:30 INFO - 'SHELL': '/bin/bash', 02:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x93XVjCHu1/Listeners', 02:02:30 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 02:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:30 INFO - 'USER': 'cltbld', 02:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:30 INFO - 'XPC_FLAGS': '0x0', 02:02:30 INFO - 'XPC_SERVICE_NAME': '0', 02:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 02:02:30 INFO - mozversion application_buildid: 20170108234508 02:02:30 INFO - mozversion application_changeset: 6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333 02:02:30 INFO - mozversion application_display_name: Firefox 02:02:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:30 INFO - mozversion application_name: Firefox 02:02:30 INFO - mozversion application_remotingname: firefox 02:02:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:02:30 INFO - mozversion application_vendor: Mozilla 02:02:30 INFO - mozversion application_version: 51.0 02:02:30 INFO - mozversion platform_buildid: 20170108234508 02:02:30 INFO - mozversion platform_changeset: 6dc2ca24bd0bcb88992ae72e4fb8285ea8e24333 02:02:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:02:30 INFO - mozversion platform_version: 51.0 02:02:30 INFO - using testdate: 1483956150 02:02:30 INFO - actual date: 1483956150 02:02:30 INFO - starting webserver on 'localhost:49235' 02:02:30 INFO - SUITE-START | Running 2 tests 02:02:30 INFO - TEST-START | dromaeo_css 02:02:30 INFO - operating with platform_type : mac_ 02:02:30 INFO - Initialising browser for dromaeo_css test... 02:02:30 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpdCA3ZE/profile http://localhost:49235/getInfo.html) 02:02:32 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 02:02:32 INFO - PROCESS | 1633 | colorDepth:24 02:02:32 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 02:02:32 INFO - PROCESS | 1633 | __metrics 02:02:33 INFO - PROCESS | 1633 | 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" 02:02:33 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:02:33 INFO - TEST-INFO | 1633: exit 0 02:02:33 INFO - Browser initialized. 02:02:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:02:33 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpdCA3ZE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:02:45 INFO - PROCESS | 1637 | RSS: Main: 169070592 02:02:45 INFO - PROCESS | 1637 | 02:03:37 INFO - PROCESS | 1637 | 1483956217351 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] 02:05:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 02:05:48 INFO - PROCESS | 1637 | RSS: Main: 269742080 02:05:48 INFO - PROCESS | 1637 | 02:08:51 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 02:08:51 INFO - PROCESS | 1637 | RSS: Main: 299380736 02:08:51 INFO - PROCESS | 1637 | 02:11:54 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 02:11:54 INFO - PROCESS | 1637 | RSS: Main: 297541632 02:11:54 INFO - PROCESS | 1637 | 02:14:56 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 02:14:57 INFO - PROCESS | 1637 | RSS: Main: 256917504 02:14:57 INFO - PROCESS | 1637 | 02:18:00 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 02:18:01 INFO - PROCESS | 1637 | RSS: Main: 259485696 02:18:01 INFO - PROCESS | 1637 | 02:21:03 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 02:21:04 INFO - PROCESS | 1637 | RSS: Main: 415125504 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | __start_tp_report 02:21:04 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 02:21:04 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 02:21:04 INFO - PROCESS | 1637 | |i|pagename|runs| 02:21:04 INFO - PROCESS | 1637 | |0;dojo.html;3475.9304813903723;3478.5825700915884;3504.123969007748;3511.4381698928178;3554.9111272218192;5625.943740562593;5683.0622947213715;5691.203231547576;5707.086866101425;5707.086866101425;5702.77188912443;5763.855903602412;5789.45000224978;5791.623544469607;5800.274965629296;4364.2798938175165;5176.223566465042;5221.112410890139;5230.1108811501945;5275.60432967529;5144.511271429208;5145.151050076752;5151.871203219912;5307.73461326934;5323.973380133094;5206.297149884774;5214.009338225744;5246.606504512158;5269.525742683158;5282.656627319231;5246.50158234969;5249.921251181236;5294.947050529484;5303.60222983274;5303.992241474146;5080.212567052075;5171.741412929338;5243.056249875021;5253.369595648508;5258.6581872178185;5633.295838020247;5651.604387692863;5677.063284558043;5682.261306030189;5690.260266165414;6184.196054512884;6284.5600807943465;6290.276618188921;6310.652914089723;6316.936830631681;6133.080037994292;6203.162573052626;6224.09750586167;6228;6256.217972753406;4683.7423941682855;5151.201563757623;5702.486776190121;5728.083506638918;5804.970975145097;6210.875782484325;6226.439620434183;6239.875202496016;6242.406971337716;6249.468795152463;5980.671063091571;6142.600730952474;6153.4154255345675;6172.166757487771;6178.5366097542865;6149.2313460817395;6169.691515424211;6207.379262073847;6214.8135555933395;6255.311915689271;6169.136320915076;6218;6224.875502489925;6234.784217077627;6241.812745617639;6166.1983942087245;6245.75016999324;6250.656213908188;6252;6257.74969001244;4855.44162421319;4870.318155458239;4878.048780487771;4917.901641967141;4991.301217829507;3826.655600995868;4521.299198624219;4527.1172121436;4575.862724118282;4579.358889755437;5796.536277097822;5806.042003069446;5816.621919575214;5820.272465941757;5871.6183448075735;6117.602355846945;6198.876022479615;6208.534359923024;6224.875502489925;6257.155284036688;5756.683382413924;5830.416958304136;5861.912071318934;5865.120231965239;5868.941310586925;5413.918791218135;5414.945850541444;5418.701971391612;5424.593155513352;5433.809816656398;5332.33345831771;6355.364463553793;6362.045693146065;6366.236051673829;6380.936190638127;6097.878042439038;6168.9691551541955;6175.938240617536;6186.257649082139;6221.4089661482085;6244.968775156277;6307.43233109004;6312.779052733316;6331.588446750947;6332.3034466207755;6138.447539721446;6169.753209871735;6187.690615469299;6213.440790328711;6230.314665386894;6133.785317513865;6135.630783975068;6172.907406388818;6262.436380725757;6286.245650521967;6066.787662431793;6092.695365231632;6121.265448146251;6136.73353236607;6152.538559608137;6036.245469316335;6058.0610005449225;6109.004786498273;6111.236095488064;6119.510439164767;5718.228039214653;5874.295084589706;5920.79277225295;5925.259342582177;5958.165856779968;5942.168096466585;6005.279366476051;6037.09443583466;6044.486218671462;6126.578745377254;5950.404959504015;5953.58324917269;5953.791617293374;5969.194158788508;5994.490468310242 02:21:04 INFO - PROCESS | 1637 | |1;ext.html;434.67182277380573;519.9116150254456;532.1113740054109;537.7338217582297;556.3435146527096;30215.697843021564;32915;34855.651443485556;42600.78699606506;44279.335809962875;36591.45112823303;46284.07431851361;46325.841853953665;46388;46515;9953;10142.18862490999;10147.289689721685;10149.797004059952;10151.137153341975;9283.442993420382;9550.665726699566;9958.203343732484;12164.14850960433;12440.751184976296;12436.19164754288;12512.186707864004;12514.874851251461;12516;12526.373681315943;12402.193857399285;12481.50073997039;12503.062270329761;12513.249205047727;12545.811812822814;12317.50729970809;12366.938165309206;12367.072469564819;12379.62861114168;12380.195287306386;42953.35569966453;43119.13761724779;43214.35178472326;43277.61973091479;43373.56626433727;3395.6604339565847;3508.6491350864962;3672.412414013745;3899.7465164764485;3970.8808735737975;32347.676523234935;32637.51043734346;32655.346893062007;32990.01029969105;33338.66661333404;3285.671432856719;3311.437055700537;3400.5409269748516;3420.452727563578;3424.708899743525;532911;533503.332483339;533940;534148;534400;65252;65918.38571299963;65931;65990.34009659938;66064;36753.448698269545;37383.81308093442;37450.62549374526;38656.22687546234;38727;17599.824001760073;17777.377791777224;17785.021823799816;17785.555361116076;17808.46574602738;12316.876831231752;13367.532136375376;13479.663008424868;13479.865201348057;13488.93255533716;17214.139293035547;17797.555061123574;19799;20318.390448286576;20940;8070.556119413489;8158.632861521246;8169.63236654352;8217.712380066789;8231.588420578948;903.75146834621;1042.3433237060756;1049.7742985258205;1086.9891301087046;1115.7210697325668;30995.915142969887;31247.843760781507;31351.686483134876;31897.202569935936;32110.357792844014;1109.7614012987085;1114.0307932099126;1119.7256672115384;1155.5955415604471;1217.713837248246;16080.839191608167;16379.83620163783;16520.75218871718;16584.66830663404;16721.080340581386;753830;1034331;1055514.722426383;1061473;1061879;63739.36260637334;64398.35601643923;64482.355176447636;64489.677551611945;64650.676746615965;1290.2000759529153;1328.063715080885;1414.4837134445854;1440.3734375546671;1459.8905082118672;27567;33028;33034.66965330316;33890.3221935555;34596.481052783725;60372;61153.694231528556;61203;61206.38793612007;61477.38522614895;687108;693697;695172;695745;696694;28376.43247135087;29212.123636290944;29240.415191696473;38716.6128338713;46246.53753462557;48475.5152448471;48643;49146.75426622844;49159.26261106015;50174;39292.80353598214;39495.802520987214;40430;40835.79582102071;41896;39910.60089399069;40257.79226623206;41080.38379424371;41635.959101022716;41830;38959.415608765325;39685.00787480336;40060.1987960245;40082;40438.79780601078;34267;35376.11559711028;35919.64080359267;35982.64017359793;36069.819650901576;25947.481050379265;26073;26189;26207;26846.120771546586 02:21:04 INFO - PROCESS | 1637 | |2;jquery.html;380.6060727147402;387.42854289922366;390.13390273592614;397.95025621797265;417.3364350682414;14980.700385992273;20573;21481.57036859262;21868.343949681515;21890.452738681543;15644.452444164457;16242.269097890594;19866.503337416572;20814.687779683318;21105;5894.6168499047535;6214.533909956749;6223.719932603021;6232.158658581079;6260.749570017194;5900.970495147519;6066.454019138277;6157.938420615781;6187.07193920911;6241.531885108612;6182.505399568046;6184.752609895599;6184.84537886552;6187.81436556904;6188.133661287423;5878.294604647427;6078.72645730941;6135.570510064297;6139.539534534905;6144.5084393248435;5333.546648534879;5358.490943360374;5359.785608575652;5365.382980957201;5367.087595108841;25636.949044076617;25858.6121208182;26266.86866565674;27137.45725085507;27548;2108.110536060965;2145.95708085839;2192.967105493419;2297.873616951067;2339.2163625185585;9708.854367184498;10696.946515267451;11108.444577771079;11170.888291117066;16650.916745416194;1796.2814874050355;1870.9438716838517;1881.990590047041;1990.6018796240664;2018.576099019193;115804;121930;124118;127370;135645;11341.943290283496;11608.723040465542;11631.76736465266;11635.127365447624;11857.525698971944;15174.393024278905;15270.847291527165;15275.61810954735;15277.541673749805;15282.541523754082;7990.081140668781;8418.410711250277;8447.408681392366;8631.568421578895;8977.955110224537;8819.823603528022;8880.200781929658;8957.417767845069;9048.457092574467;9064.456132632064;4509.34614480905;4666.789994450258;4667.556582124693;4672.462666793363;4715.41057367829;1711.9743203851951;1834.6330733853283;1845.966258895023;1846.8614853885745;1980.7127966444784;895.7984453497911;909.8862642169729;946;961.240619910277;964.9710508684751;20560.58878822445;21646;21726.89136554307;21797.891010544845;21919.67120493194;822.4078663362369;910.6949172027313;960.7598100474881;966.5940305071887;1011.3224139826334;9261.16649501548;10842.945785271024;11585.304881707125;11589;11596.652100437;633357;637276;648883;656788;657158;128205;129494.35252823676;139490.3025484866;144220;144856;998.9950050249702;1014.3660212367271;1038.6416686243083;1050.0916707048348;1050.8161071812556;13940.200726924484;19388.224471021;20414;20456.590868182255;20565.97170141517;54311.72844135754;56198.7190064047;56638.433615664966;56872.43127568837;57580;79748.60125699334;81892.59053704693;84682.15317846989;85602;87849;8147.429679922348;8219.424640275123;8343.24806662696;8558.443701159405;8672.78318042054;11973.640790776291;12980.15628984113;13253.271070091238;13387;13613.047086703835;11156.776864462827;11349.48927298257;11359.375234362189;11424.771504569695;11713.41432928333;10394.58421663125;11411.942940285246;11511.424428778695;11771.823422648838;11808.409579521162;8309.584520773817;11127.276727012719;11492.48283827213;11654.650360489199;12102.36618056551;7387.891816227394;8293.253607175384;8500.61747221389;8622.482651040958;8675.175858293453;8145.714899978472;11069.446527673745;11362.54549818031;11533.423328833693;11926.582569610022 02:21:04 INFO - PROCESS | 1637 | |3;mootools.html;1554.4404014554761;1588.52344296711;1775.1213149491005;1910.7038409046602;1920.6446807340642;8934.195922366986;9463.43219406836;9484.66803661872;9490.952545237264;9498.240140788721;8305.83388332233;8524.659013639463;8976.237019853304;9208.861867071999;9238.722838314861;2433.4038160650575;2469.0370755405315;2470.505898820234;2472.5425796227664;2475.393528585499;2423.103451722865;2478.9752102478924;2486.7264600893886;2487.3035550046015;2491.215267190838;2443.9144629937955;2456.0298682020593;2478.10788116278;2482.1932871816643;2484.714257860342;2424.1273141668985;2441.2066078524463;2453.619688948207;2463.9014439422403;2467.1858286765323;2041.285550057468;2427.720812106613;2447.889844956981;2452.583060879637;2453.5338285725657;9330.673426430043;9355.812883742286;9442.763930901714;9470.52647367629;9479;5510.448955104497;5690.4025077367105;5691.914621280643;5694.4590263924865;5709.429057094258;3554.8400321985573;3711.1278849470355;3768.7173461990187;3784.6972242220554;3785.4511095890944;1112.9777404451947;1116.7989761842864;1138.4137169357787;1156.8553930758655;1159.843421138144;12588.18176818513;12622.558210462681;12624.87375126237;12625.936870315682;12639.925606323473;4858.198397264412;4878.43897951733;4911.287863259879;4984.3021976923255;5042.722650254272;10593.735156621146;10602.893971060344;10623.628173013907;10628.681139565826;10636.946815265874;5656.066748986454;5656.85857853557;5658.264425624642;5658.971705141448;5663.716814159276;4580.496145424001;4586.862394128115;5078.898422031539;5107.540321371094;5147.639665223398;4113.650339721157;4136.793160342031;4236.915261694749;4239.448871646666;4249.3413520904305;1306.6145487081333;1340.6648337915522;1343.43575698207;1350.7636163671318;1357.633438971472;901.6708901251127;912.9154187341428;936.1481052242426;958.4680502321139;984.6159997600942;5954.791582294685;5982.0727787193055;6226.688665566703;6245.18812554365;6272.623642581369;449.99775001124783;450.2593234129838;452.19509273493236;458.96557758168274;476.05978193069103;3667.8166091695307;3952.446657467957;3957.2085582883537;4020.43713880057;4082.22437736835;10007.349522281029;11115.722106947229;11268.54925802975;11273.267237629529;11330;11047.944760276147;11209;11216.607418740305;11227.38249396291;11228.529723460826;8345.123762005023;8530.10433904431;8550.102239264788;8551.828963420698;8582;4735.313379560013;5044.697318160922;5694.402087780889;5840.620359676607;6021.2473440819895;10068.446235456828;10154.492275386054;10331.483425828528;10378.014088661565;10472.10987066108;10252.179825614083;10508.106810921157;10626.36241825493;10685.984831441001;10696.786064278827;7690.461667683208;7719.961400192963;7772.45592808498;7801.531908085533;7887.290143887078;8548;8613.31093512505;8619.65521379163;8626.56867156627;8646;7610.657520411484;7706.807329816799;7758.224177582197;7868.84262314762;7912.248336408032;6438.227412710505;7681.539107653559;7686.846263074595;7708.807279818049;7827.9823622930935;7131.393831524379;7269.672864720995;7279.053723015974;7279.417646588155;7290.4896657233485;4985.6011519077665;4994.375703037121;5098.643094983316;5214.97392513035;5254;5097;5142.97428512855;5215.504527069922;5238.371395432572;5292.470752924677 02:21:04 INFO - PROCESS | 1637 | |4;prototype.html;253.56133888373117;292.33493801601355;293.92064142681477;302.1524623431276;315.99052028439155;4769.165396055694;5230.34620672416;5484.698341591211;5586.385497595261;5665.575081868866;4298.419713338699;4754.7860346284415;5165.328507294056;5332.733363331838;5387.24578559002;4185.748855068706;4191.266528357541;4213.325867861143;4231.428757117788;4253.914921701564;3860.652541271285;4045.6763458923215;4117.114820313632;4211.789410529461;4212.031232816454;4095.8361665533344;4132.690048246379;4138.586141385852;4167.291560434718;4170.562090980449;4094.447249621293;4117.402976568411;4117.5882411758885;4131.483564554431;4134.7312424692445;3611.458281257806;3624.4019736743408;3627.963720362789;3631.9273614527824;3643.4716966039778;4480.775961201927;4961.585948004801;5222.92165617516;5246.396664383568;5343.732813359316;4088.7955602220068;4610.492845786961;4739.440702020905;4844.903101937976;4915.557599816034;4778.665493415462;4787.305840653121;5634.3520495143175;5646.774129034834;5762.3373312069225;3846.480725102131;3991.201759648082;4008.4187792770176;4024.0342317843506;4049.5950404959563;5242.161254199348;5564.443555644443;5927.644341339534;5937.851553711149;5951.851203719898;3720.2373513430225;3803.0682482791894;4089.4479245301504;4097.057676734308;4099.811054794076;3435.587729472479;3745.8127093645207;3793.5447746270625;3978.7520051170995;4020.115574573589;4667.696599721007;4672.766361681903;4712.622990160848;4717.268823332389;4739.928901066418;4972.980538989498;5137.915357290963;5786.42135786418;5793.681347525927;5867.237259156368;1146.7247860513417;1294.7345794112184;1294.7505657041002;1338.5448947357945;1352.384664977433;790.7627711686471;895.6520436742791;924.9815003700023;930.9906900931039;937.2923442800778;5387.272718183073;5393.1370980642905;5398;5411.810586629528;5412.296401467784;5660.462256085665;5846.941530584725;5900.468957793819;5906.232189815297;5922.496587790086;5334.3865455473115;5370.62405631602;5370.865728356823;5423.810166644227;5424.728763561806;2354.4349356154744;2444.350063707026;2456.8084479027657;2565.230430870731;2601.9219423417326;4409.4267745193565;4686.797634866447;4849.769106211183;4919.754012299442;5131.640785145079;4413.477350314137;4506.755136301857;4979.92931519725;5075.578837925387;5098.337216161949;4738.73936933465;4955.430125535538;4971.45314015458;4986.775595098156;5017.37282839645;3940.7044471665313;4492.73043617384;4806.567408933212;4862.41651001882;4930.704157750546;4180.581941805916;4405.31717583775;4819.759012049453;4919.532644398776;4934.457209707001;4922.424824056267;4955.40535135786;4997.201007637175;5045.5459008689395;5075.822346218012;3120.7971481853606;3142.74858011354;3382.20518178223;3395.3718562066097;3396.5244865719314;4861.51384861511;4862.90274194507;4882.779305173706;4896.902061958812;4900.509949005071;3873.469979358081;4286.657067434536;4478.9543110685045;4627.190241707621;4743.83396581118;3850.5186851643543;4399.6040356368085;4721.952780472288;4726.534774220003;4731.2859405368;4199.811008504564;4543.6365090792;5085.847424577269;5503.504684578407;5603.907238088534;5722.62802917809;5735.139729040678;5737.91393129095;5760.913586296125;5764.971175144097;4786.473487916257;5193.428722840409;5276.445973172915;5628.634138780966;5658.17956396312 02:21:04 INFO - PROCESS | 1637 | |5;yui.html;747.7532414303283;767.3822572828873;775.8836174573813;808.4704518540358;877.4340550345028;14003.299835008234;15820.288087036082;15863.444779432722;16872.325106995722;16982.83017169828;12940.676483087927;14958.40166393343;15339;15343.156126413043;15464.072155670669;711.5268346549539;886.6231851463135;896.5338024227398;899.4153800029967;899.5052721003455;726.4624178108188;875.9737207883774;901.143913282381;903.0743487924897;908.0148039377284;938.5307346326837;940.952952352383;941.1388579449796;944.2351695126935;945.8392073347547;932.1144912333276;934.2525979216667;937.0301737701446;937.2782957123011;937.7093101138669;705.2031204738613;705.587231469591;706.6572712234562;707.1514182980444;708.982275443118;15501.612459688598;15523.45667901618;15553.766693499607;15555.533333999998;15559.29983150761;13779.173249604955;14929.850701492955;15105.773413398807;15199.62000949974;15390.615234619225;13190.274534900576;13738.244396558186;13802.240876751775;13804.861951380459;13865;4638.489766125724;4662.930056049162;4741.881452963669;4788.856334309976;4901.5588597026435;113414.43292783566;119282;119757;122201;123511;10331.32846364984;10402.167826573856;11231;11235.887641123647;11268.38023908693;21089.472763181042;21105.894470527855;21158.47103822386;21263.68104478434;21297.68053479199;7370.447216458787;7879.921200787919;8349.66601335952;8380.706675266336;8650.480971141751;4509.864704058883;4584.5186255442695;4588.403507543998;4654.837080702159;4746.905061898743;3682.5949145593963;3839.673627741673;3841.9807900960877;3846.211526637033;3851.306764782366;685.2154283345542;690.1304356510833;699.0981633692581;705.1150805738868;708.242180866468;596.5347029317139;602.7197353230769;646.5861848417017;681.3186813186813;707.4729326651677;8473.788155296166;9537.952310238543;9651.276154288316;9657;9794.16749576294;570.6946783470823;597.623497196772;610.8289678889918;649.8245473722069;681.3595220492721;4169.97915010423;4353.847615333448;4629.930551041737;4698.459677137173;4749.905001899942;98363;152021;154059;168005.1599742018;175575;138348;150774;151293.73059404118;152247;157047;123253;125132.37433812773;126379.36810316074;126415;126892.36553817173;8730.301575873787;9076.137766912132;9140.451572905647;9216.447013179231;9238.491882946502;69640.30359696542;71008.64495677488;71134;71575.92636110567;72102.91845622424;76265;94699.05300946902;95767.52116239653;101456.49271753593;102414;11887.108466865193;11988.400579971141;12022.579209727617;12173.69565760863;12381.62855114348;13048.673783155496;13394.866051339752;13810.58568242914;15449.613759656098;15662.295196715948;13732.519361822287;13912.095713778572;14410;14425.49510767118;15650.686986260438;13928.72142557123;13945.790813137608;14477.420903163755;14912.403503859725;15063.246837657854;13496.86503134956;14393.85606143967;14431.78352324737;14777.630559236106;15184;9869.062439068277;11161.44192790341;11371.48828302745;11619.767604648028;12185.207961482476;10244.948775256076;10911.618093367011;11778.175527712978;11889.881101188877;12130.575429859913 02:21:04 INFO - PROCESS | 1637 | __end_tp_report 02:21:04 INFO - PROCESS | 1637 | __start_cc_report 02:21:04 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1278 02:21:04 INFO - PROCESS | 1637 | __end_cc_report 02:21:04 INFO - PROCESS | 1637 | __startTimestamp1483957264249__endTimestamp 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | ------- Summary: start ------- 02:21:04 INFO - PROCESS | 1637 | Number of tests: 6 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5733.81 Median:5953.58 stddev:632.63 (10.6%) stddev-sans-first:609.27 02:21:04 INFO - PROCESS | 1637 | Values: 3475.9 3478.6 3504.1 3511.4 3554.9 5625.9 5683.1 5691.2 5707.1 5707.1 5702.8 5763.9 5789.5 5791.6 5800.3 4364.3 5176.2 5221.1 5230.1 5275.6 5144.5 5145.2 5151.9 5307.7 5324.0 5206.3 5214.0 5246.6 5269.5 5282.7 5246.5 5249.9 5294.9 5303.6 5304.0 5080.2 5171.7 5243.1 5253.4 5258.7 5633.3 5651.6 5677.1 5682.3 5690.3 6184.2 6284.6 6290.3 6310.7 6316.9 6133.1 6203.2 6224.1 6228.0 6256.2 4683.7 5151.2 5702.5 5728.1 5805.0 6210.9 6226.4 6239.9 6242.4 6249.5 5980.7 6142.6 6153.4 6172.2 6178.5 6149.2 6169.7 6207.4 6214.8 6255.3 6169.1 6218.0 6224.9 6234.8 6241.8 6166.2 6245.8 6250.7 6252.0 6257.7 4855.4 4870.3 4878.0 4917.9 4991.3 3826.7 4521.3 4527.1 4575.9 4579.4 5796.5 5806.0 5816.6 5820.3 5871.6 6117.6 6198.9 6208.5 6224.9 6257.2 5756.7 5830.4 5861.9 5865.1 5868.9 5413.9 5414.9 5418.7 5424.6 5433.8 5332.3 6355.4 6362.0 6366.2 6380.9 6097.9 6169.0 6175.9 6186.3 6221.4 6245.0 6307.4 6312.8 6331.6 6332.3 6138.4 6169.8 6187.7 6213.4 6230.3 6133.8 6135.6 6172.9 6262.4 6286.2 6066.8 6092.7 6121.3 6136.7 6152.5 6036.2 6058.1 6109.0 6111.2 6119.5 5718.2 5874.3 5920.8 5925.3 5958.2 5942.2 6005.3 6037.1 6044.5 6126.6 5950.4 5953.6 5953.8 5969.2 5994.5 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:85605.10 Median:34726.07 stddev:207272.49 (596.9%) stddev-sans-first:207755.29 02:21:04 INFO - PROCESS | 1637 | Values: 434.7 519.9 532.1 537.7 556.3 30215.7 32915.0 34855.7 42600.8 44279.3 36591.5 46284.1 46325.8 46388.0 46515.0 9953.0 10142.2 10147.3 10149.8 10151.1 9283.4 9550.7 9958.2 12164.1 12440.8 12436.2 12512.2 12514.9 12516.0 12526.4 12402.2 12481.5 12503.1 12513.2 12545.8 12317.5 12366.9 12367.1 12379.6 12380.2 42953.4 43119.1 43214.4 43277.6 43373.6 3395.7 3508.6 3672.4 3899.7 3970.9 32347.7 32637.5 32655.3 32990.0 33338.7 3285.7 3311.4 3400.5 3420.5 3424.7 532911.0 533503.3 533940.0 534148.0 534400.0 65252.0 65918.4 65931.0 65990.3 66064.0 36753.4 37383.8 37450.6 38656.2 38727.0 17599.8 17777.4 17785.0 17785.6 17808.5 12316.9 13367.5 13479.7 13479.9 13488.9 17214.1 17797.6 19799.0 20318.4 20940.0 8070.6 8158.6 8169.6 8217.7 8231.6 903.8 1042.3 1049.8 1087.0 1115.7 30995.9 31247.8 31351.7 31897.2 32110.4 1109.8 1114.0 1119.7 1155.6 1217.7 16080.8 16379.8 16520.8 16584.7 16721.1 753830.0 1034331.0 1055514.7 1061473.0 1061879.0 63739.4 64398.4 64482.4 64489.7 64650.7 1290.2 1328.1 1414.5 1440.4 1459.9 27567.0 33028.0 33034.7 33890.3 34596.5 60372.0 61153.7 61203.0 61206.4 61477.4 687108.0 693697.0 695172.0 695745.0 696694.0 28376.4 29212.1 29240.4 38716.6 46246.5 48475.5 48643.0 49146.8 49159.3 50174.0 39292.8 39495.8 40430.0 40835.8 41896.0 39910.6 40257.8 41080.4 41636.0 41830.0 38959.4 39685.0 40060.2 40082.0 40438.8 34267.0 35376.1 35919.6 35982.6 36069.8 25947.5 26073.0 26189.0 26207.0 26846.1 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:37229.98 Median:13988.08 stddev:107965.45 (771.8%) stddev-sans-first:108232.86 02:21:04 INFO - PROCESS | 1637 | Values: 380.6 387.4 390.1 398.0 417.3 14980.7 20573.0 21481.6 21868.3 21890.5 15644.5 16242.3 19866.5 20814.7 21105.0 5894.6 6214.5 6223.7 6232.2 6260.7 5901.0 6066.5 6157.9 6187.1 6241.5 6182.5 6184.8 6184.8 6187.8 6188.1 5878.3 6078.7 6135.6 6139.5 6144.5 5333.5 5358.5 5359.8 5365.4 5367.1 25636.9 25858.6 26266.9 27137.5 27548.0 2108.1 2146.0 2193.0 2297.9 2339.2 9708.9 10696.9 11108.4 11170.9 16650.9 1796.3 1870.9 1882.0 1990.6 2018.6 115804.0 121930.0 124118.0 127370.0 135645.0 11341.9 11608.7 11631.8 11635.1 11857.5 15174.4 15270.8 15275.6 15277.5 15282.5 7990.1 8418.4 8447.4 8631.6 8978.0 8819.8 8880.2 8957.4 9048.5 9064.5 4509.3 4666.8 4667.6 4672.5 4715.4 1712.0 1834.6 1846.0 1846.9 1980.7 895.8 909.9 946.0 961.2 965.0 20560.6 21646.0 21726.9 21797.9 21919.7 822.4 910.7 960.8 966.6 1011.3 9261.2 10842.9 11585.3 11589.0 11596.7 633357.0 637276.0 648883.0 656788.0 657158.0 128205.0 129494.4 139490.3 144220.0 144856.0 999.0 1014.4 1038.6 1050.1 1050.8 13940.2 19388.2 20414.0 20456.6 20566.0 54311.7 56198.7 56638.4 56872.4 57580.0 79748.6 81892.6 84682.2 85602.0 87849.0 8147.4 8219.4 8343.2 8558.4 8672.8 11973.6 12980.2 13253.3 13387.0 13613.0 11156.8 11349.5 11359.4 11424.8 11713.4 10394.6 11411.9 11511.4 11771.8 11808.4 8309.6 11127.3 11492.5 11654.7 12102.4 7387.9 8293.3 8500.6 8622.5 8675.2 8145.7 11069.4 11362.5 11533.4 11926.6 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5945.70 Median:4661.09 stddev:3390.55 (72.7%) stddev-sans-first:3384.00 02:21:04 INFO - PROCESS | 1637 | Values: 1554.4 1588.5 1775.1 1910.7 1920.6 8934.2 9463.4 9484.7 9491.0 9498.2 8305.8 8524.7 8976.2 9208.9 9238.7 2433.4 2469.0 2470.5 2472.5 2475.4 2423.1 2479.0 2486.7 2487.3 2491.2 2443.9 2456.0 2478.1 2482.2 2484.7 2424.1 2441.2 2453.6 2463.9 2467.2 2041.3 2427.7 2447.9 2452.6 2453.5 9330.7 9355.8 9442.8 9470.5 9479.0 5510.4 5690.4 5691.9 5694.5 5709.4 3554.8 3711.1 3768.7 3784.7 3785.5 1113.0 1116.8 1138.4 1156.9 1159.8 12588.2 12622.6 12624.9 12625.9 12639.9 4858.2 4878.4 4911.3 4984.3 5042.7 10593.7 10602.9 10623.6 10628.7 10636.9 5656.1 5656.9 5658.3 5659.0 5663.7 4580.5 4586.9 5078.9 5107.5 5147.6 4113.7 4136.8 4236.9 4239.4 4249.3 1306.6 1340.7 1343.4 1350.8 1357.6 901.7 912.9 936.1 958.5 984.6 5954.8 5982.1 6226.7 6245.2 6272.6 450.0 450.3 452.2 459.0 476.1 3667.8 3952.4 3957.2 4020.4 4082.2 10007.3 11115.7 11268.5 11273.3 11330.0 11047.9 11209.0 11216.6 11227.4 11228.5 8345.1 8530.1 8550.1 8551.8 8582.0 4735.3 5044.7 5694.4 5840.6 6021.2 10068.4 10154.5 10331.5 10378.0 10472.1 10252.2 10508.1 10626.4 10686.0 10696.8 7690.5 7720.0 7772.5 7801.5 7887.3 8548.0 8613.3 8619.7 8626.6 8646.0 7610.7 7706.8 7758.2 7868.8 7912.2 6438.2 7681.5 7686.8 7708.8 7828.0 7131.4 7269.7 7279.1 7279.4 7290.5 4985.6 4994.4 5098.6 5215.0 5254.0 5097.0 5143.0 5215.5 5238.4 5292.5 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4353.12 Median:4749.31 stddev:1308.70 (27.6%) stddev-sans-first:1275.68 02:21:04 INFO - PROCESS | 1637 | Values: 253.6 292.3 293.9 302.2 316.0 4769.2 5230.3 5484.7 5586.4 5665.6 4298.4 4754.8 5165.3 5332.7 5387.2 4185.7 4191.3 4213.3 4231.4 4253.9 3860.7 4045.7 4117.1 4211.8 4212.0 4095.8 4132.7 4138.6 4167.3 4170.6 4094.4 4117.4 4117.6 4131.5 4134.7 3611.5 3624.4 3628.0 3631.9 3643.5 4480.8 4961.6 5222.9 5246.4 5343.7 4088.8 4610.5 4739.4 4844.9 4915.6 4778.7 4787.3 5634.4 5646.8 5762.3 3846.5 3991.2 4008.4 4024.0 4049.6 5242.2 5564.4 5927.6 5937.9 5951.9 3720.2 3803.1 4089.4 4097.1 4099.8 3435.6 3745.8 3793.5 3978.8 4020.1 4667.7 4672.8 4712.6 4717.3 4739.9 4973.0 5137.9 5786.4 5793.7 5867.2 1146.7 1294.7 1294.8 1338.5 1352.4 790.8 895.7 925.0 931.0 937.3 5387.3 5393.1 5398.0 5411.8 5412.3 5660.5 5846.9 5900.5 5906.2 5922.5 5334.4 5370.6 5370.9 5423.8 5424.7 2354.4 2444.4 2456.8 2565.2 2601.9 4409.4 4686.8 4849.8 4919.8 5131.6 4413.5 4506.8 4979.9 5075.6 5098.3 4738.7 4955.4 4971.5 4986.8 5017.4 3940.7 4492.7 4806.6 4862.4 4930.7 4180.6 4405.3 4819.8 4919.5 4934.5 4922.4 4955.4 4997.2 5045.5 5075.8 3120.8 3142.7 3382.2 3395.4 3396.5 4861.5 4862.9 4882.8 4896.9 4900.5 3873.5 4286.7 4479.0 4627.2 4743.8 3850.5 4399.6 4722.0 4726.5 4731.3 4199.8 4543.6 5085.8 5503.5 5603.9 5722.6 5735.1 5737.9 5760.9 5765.0 4786.5 5193.4 5276.4 5628.6 5658.2 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:26684.44 Median:3761.13 stddev:43376.70 (1153.3%) stddev-sans-first:43454.67 02:21:04 INFO - PROCESS | 1637 | Values: 747.8 767.4 775.9 808.5 877.4 14003.3 15820.3 15863.4 16872.3 16982.8 12940.7 14958.4 15339.0 15343.2 15464.1 711.5 886.6 896.5 899.4 899.5 726.5 876.0 901.1 903.1 908.0 938.5 941.0 941.1 944.2 945.8 932.1 934.3 937.0 937.3 937.7 705.2 705.6 706.7 707.2 709.0 15501.6 15523.5 15553.8 15555.5 15559.3 13779.2 14929.9 15105.8 15199.6 15390.6 13190.3 13738.2 13802.2 13804.9 13865.0 4638.5 4662.9 4741.9 4788.9 4901.6 113414.4 119282.0 119757.0 122201.0 123511.0 10331.3 10402.2 11231.0 11235.9 11268.4 21089.5 21105.9 21158.5 21263.7 21297.7 7370.4 7879.9 8349.7 8380.7 8650.5 4509.9 4584.5 4588.4 4654.8 4746.9 3682.6 3839.7 3842.0 3846.2 3851.3 685.2 690.1 699.1 705.1 708.2 596.5 602.7 646.6 681.3 707.5 8473.8 9538.0 9651.3 9657.0 9794.2 570.7 597.6 610.8 649.8 681.4 4170.0 4353.8 4629.9 4698.5 4749.9 98363.0 152021.0 154059.0 168005.2 175575.0 138348.0 150774.0 151293.7 152247.0 157047.0 123253.0 125132.4 126379.4 126415.0 126892.4 8730.3 9076.1 9140.5 9216.4 9238.5 69640.3 71008.6 71134.0 71575.9 72102.9 76265.0 94699.1 95767.5 101456.5 102414.0 11887.1 11988.4 12022.6 12173.7 12381.6 13048.7 13394.9 13810.6 15449.6 15662.3 13732.5 13912.1 14410.0 14425.5 15650.7 13928.7 13945.8 14477.4 14912.4 15063.2 13496.9 14393.9 14431.8 14777.6 15184.0 9869.1 11161.4 11371.5 11619.8 12185.2 10244.9 10911.6 11778.2 11889.9 12130.6 02:21:04 INFO - PROCESS | 1637 | -------- Summary: end -------- 02:21:04 INFO - PROCESS | 1637 | 02:21:04 INFO - TEST-INFO | 1637: exit 0 02:21:04 INFO - TEST-OK | dromaeo_css | took 1114263ms 02:21:04 INFO - TEST-START | kraken 02:21:04 INFO - operating with platform_type : mac_ 02:21:04 INFO - Initialising browser for kraken test... 02:21:04 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp2qemst/profile http://localhost:49235/getInfo.html) 02:21:06 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 02:21:06 INFO - PROCESS | 1644 | colorDepth:24 02:21:06 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 02:21:06 INFO - PROCESS | 1644 | __metrics 02:21:06 INFO - PROCESS | 1644 | 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" 02:21:06 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:07 INFO - TEST-INFO | 1644: exit 0 02:21:07 INFO - Browser initialized. 02:21:07 INFO - Running cycle 1/1 for kraken test... 02:21:07 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp2qemst/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:19 INFO - PROCESS | 1646 | RSS: Main: 169332736 02:21:19 INFO - PROCESS | 1646 | 02:21:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:23 INFO - PROCESS | 1646 | RSS: Main: 218497024 02:21:23 INFO - PROCESS | 1646 | 02:21:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 02:21:26 INFO - PROCESS | 1646 | RSS: Main: 232140800 02:21:26 INFO - PROCESS | 1646 | 02:21:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 02:21:30 INFO - PROCESS | 1646 | RSS: Main: 329719808 02:21:30 INFO - PROCESS | 1646 | 02:21:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 02:21:32 INFO - PROCESS | 1646 | RSS: Main: 229539840 02:21:32 INFO - PROCESS | 1646 | 02:21:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:21:35 INFO - PROCESS | 1646 | RSS: Main: 230965248 02:21:35 INFO - PROCESS | 1646 | 02:21:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 02:21:38 INFO - PROCESS | 1646 | RSS: Main: 266194944 02:21:38 INFO - PROCESS | 1646 | 02:21:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 02:21:42 INFO - PROCESS | 1646 | RSS: Main: 268492800 02:21:42 INFO - PROCESS | 1646 | 02:21:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 02:21:45 INFO - PROCESS | 1646 | RSS: Main: 265371648 02:21:45 INFO - PROCESS | 1646 | 02:21:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:21:47 INFO - PROCESS | 1646 | RSS: Main: 244293632 02:21:47 INFO - PROCESS | 1646 | 02:21:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:21:50 INFO - PROCESS | 1646 | RSS: Main: 246464512 02:21:50 INFO - PROCESS | 1646 | 02:21:52 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:21:52 INFO - PROCESS | 1646 | RSS: Main: 251088896 02:21:52 INFO - PROCESS | 1646 | 02:21:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:21:56 INFO - PROCESS | 1646 | RSS: Main: 267075584 02:21:56 INFO - PROCESS | 1646 | 02:21:59 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:21:59 INFO - PROCESS | 1646 | RSS: Main: 261120000 02:21:59 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 02:22:01 INFO - PROCESS | 1646 | RSS: Main: 304951296 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | __start_tp_report 02:22:01 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 02:22:01 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 02:22:01 INFO - PROCESS | 1646 | |i|pagename|runs| 02:22:01 INFO - PROCESS | 1646 | |0;ai-astar;114;115;113;112;113;114;112;113;114;114 02:22:01 INFO - PROCESS | 1646 | |1;audio-beat-detection;140;107;108;140;105;103;107;107;132;106 02:22:01 INFO - PROCESS | 1646 | |2;audio-dft;183;185;182;185;193;226;253;196;183;185 02:22:01 INFO - PROCESS | 1646 | |3;audio-fft;82;59;57;85;62;58;56;65;108;82 02:22:01 INFO - PROCESS | 1646 | |4;audio-oscillator;84;70;92;75;97;100;76;85;100;122 02:22:01 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;116;130;89;87;90;84;90;87;90;86 02:22:01 INFO - PROCESS | 1646 | |6;imaging-darkroom;94;92;94;94;93;94;94;94;94;93 02:22:01 INFO - PROCESS | 1646 | |7;imaging-desaturate;85;83;86;85;84;84;86;82;86;85 02:22:01 INFO - PROCESS | 1646 | |8;json-parse-financial;52;54;51;54;55;57;56;56;55;57 02:22:01 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;62;69;72;71;71;67;66;69;68;68 02:22:01 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;81;83;80;84;81;79;80;80;81;85 02:22:01 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;135;135;132;133;131;132;155;150;172;134 02:22:01 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;161;159;160;156;203;219;164;160;161;160 02:22:01 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;66;65;65;65;66;79;76;84;84;64 02:22:01 INFO - PROCESS | 1646 | __end_tp_report 02:22:01 INFO - PROCESS | 1646 | __start_cc_report 02:22:01 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1881 02:22:01 INFO - PROCESS | 1646 | __end_cc_report 02:22:01 INFO - PROCESS | 1646 | __startTimestamp1483957321986__endTimestamp 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | ------- Summary: start ------- 02:22:01 INFO - PROCESS | 1646 | Number of tests: 14 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 02:22:01 INFO - PROCESS | 1646 | Values: 114.0 115.0 113.0 112.0 113.0 114.0 112.0 113.0 114.0 114.0 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:107.50 stddev:15.28 (14.2%) stddev-sans-first:13.40 02:22:01 INFO - PROCESS | 1646 | Values: 140.0 107.0 108.0 140.0 105.0 103.0 107.0 107.0 132.0 106.0 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:197.10 Median:189.00 stddev:23.67 (12.5%) stddev-sans-first:24.55 02:22:01 INFO - PROCESS | 1646 | Values: 183.0 185.0 182.0 185.0 193.0 226.0 253.0 196.0 183.0 185.0 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:71.40 Median:63.50 stddev:17.18 (27.1%) stddev-sans-first:17.79 02:22:01 INFO - PROCESS | 1646 | Values: 82.0 59.0 57.0 85.0 62.0 58.0 56.0 65.0 108.0 82.0 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:80.00 stddev:15.49 (19.4%) stddev-sans-first:16.27 02:22:01 INFO - PROCESS | 1646 | Values: 84.0 70.0 92.0 75.0 97.0 100.0 76.0 85.0 100.0 122.0 02:22:01 INFO - PROCESS | 1646 | 02:22:01 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:88.00 stddev:15.30 (17.4%) stddev-sans-first:14.20 02:22:02 INFO - PROCESS | 1646 | Values: 116.0 130.0 89.0 87.0 90.0 84.0 90.0 87.0 90.0 86.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 02:22:02 INFO - PROCESS | 1646 | Values: 94.0 92.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 02:22:02 INFO - PROCESS | 1646 | Values: 85.0 83.0 86.0 85.0 84.0 84.0 86.0 82.0 86.0 85.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:2.00 (3.6%) stddev-sans-first:1.87 02:22:02 INFO - PROCESS | 1646 | Values: 52.0 54.0 51.0 54.0 55.0 57.0 56.0 56.0 55.0 57.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:2.91 (4.2%) stddev-sans-first:2.00 02:22:02 INFO - PROCESS | 1646 | Values: 62.0 69.0 72.0 71.0 71.0 67.0 66.0 69.0 68.0 68.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:1.96 (2.4%) stddev-sans-first:2.07 02:22:02 INFO - PROCESS | 1646 | Values: 81.0 83.0 80.0 84.0 81.0 79.0 80.0 80.0 81.0 85.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:135.00 stddev:13.68 (10.1%) stddev-sans-first:14.34 02:22:02 INFO - PROCESS | 1646 | Values: 135.0 135.0 132.0 133.0 131.0 132.0 155.0 150.0 172.0 134.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:161.00 stddev:21.87 (13.6%) stddev-sans-first:22.93 02:22:02 INFO - PROCESS | 1646 | Values: 161.0 159.0 160.0 156.0 203.0 219.0 164.0 160.0 161.0 160.0 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:8.38 (11.8%) stddev-sans-first:8.66 02:22:02 INFO - PROCESS | 1646 | Values: 66.0 65.0 65.0 65.0 66.0 79.0 76.0 84.0 84.0 64.0 02:22:02 INFO - PROCESS | 1646 | -------- Summary: end -------- 02:22:02 INFO - PROCESS | 1646 | 02:22:02 INFO - TEST-INFO | 1646: exit 0 02:22:02 INFO - TEST-OK | kraken | took 57988ms 02:22:02 INFO - SUITE-END | took 1172s 02:22:03 INFO - Completed test suite (00:19:32) 02:22:03 INFO - javascript benchmark 02:22:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.9304813903723, 3478.5825700915884, 3504.123969007748, 3511.4381698928178, 3554.9111272218192, 5625.943740562593, 5683.0622947213715, 5691.203231547576, 5707.086866101425, 5707.086866101425, 5702.77188912443, 5763.855903602412, 5789.45000224978, 5791.623544469607, 5800.274965629296, 4364.2798938175165, 5176.223566465042, 5221.112410890139, 5230.1108811501945, 5275.60432967529, 5144.511271429208, 5145.151050076752, 5151.871203219912, 5307.73461326934, 5323.973380133094, 5206.297149884774, 5214.009338225744, 5246.606504512158, 5269.525742683158, 5282.656627319231, 5246.50158234969, 5249.921251181236, 5294.947050529484, 5303.60222983274, 5303.992241474146, 5080.212567052075, 5171.741412929338, 5243.056249875021, 5253.369595648508, 5258.6581872178185, 5633.295838020247, 5651.604387692863, 5677.063284558043, 5682.261306030189, 5690.260266165414, 6184.196054512884, 6284.5600807943465, 6290.276618188921, 6310.652914089723, 6316.936830631681, 6133.080037994292, 6203.162573052626, 6224.09750586167, 6228.0, 6256.217972753406, 4683.7423941682855, 5151.201563757623, 5702.486776190121, 5728.083506638918, 5804.970975145097, 6210.875782484325, 6226.439620434183, 6239.875202496016, 6242.406971337716, 6249.468795152463, 5980.671063091571, 6142.600730952474, 6153.4154255345675, 6172.166757487771, 6178.5366097542865, 6149.2313460817395, 6169.691515424211, 6207.379262073847, 6214.8135555933395, 6255.311915689271, 6169.136320915076, 6218.0, 6224.875502489925, 6234.784217077627, 6241.812745617639, 6166.1983942087245, 6245.75016999324, 6250.656213908188, 6252.0, 6257.74969001244, 4855.44162421319, 4870.318155458239, 4878.048780487771, 4917.901641967141, 4991.301217829507, 3826.655600995868, 4521.299198624219, 4527.1172121436, 4575.862724118282, 4579.358889755437, 5796.536277097822, 5806.042003069446, 5816.621919575214, 5820.272465941757, 5871.6183448075735, 6117.602355846945, 6198.876022479615, 6208.534359923024, 6224.875502489925, 6257.155284036688, 5756.683382413924, 5830.416958304136, 5861.912071318934, 5865.120231965239, 5868.941310586925, 5413.918791218135, 5414.945850541444, 5418.701971391612, 5424.593155513352, 5433.809816656398, 5332.33345831771, 6355.364463553793, 6362.045693146065, 6366.236051673829, 6380.936190638127, 6097.878042439038, 6168.9691551541955, 6175.938240617536, 6186.257649082139, 6221.4089661482085, 6244.968775156277, 6307.43233109004, 6312.779052733316, 6331.588446750947, 6332.3034466207755, 6138.447539721446, 6169.753209871735, 6187.690615469299, 6213.440790328711, 6230.314665386894, 6133.785317513865, 6135.630783975068, 6172.907406388818, 6262.436380725757, 6286.245650521967, 6066.787662431793, 6092.695365231632, 6121.265448146251, 6136.73353236607, 6152.538559608137, 6036.245469316335, 6058.0610005449225, 6109.004786498273, 6111.236095488064, 6119.510439164767, 5718.228039214653, 5874.295084589706, 5920.79277225295, 5925.259342582177, 5958.165856779968, 5942.168096466585, 6005.279366476051, 6037.09443583466, 6044.486218671462, 6126.578745377254, 5950.404959504015, 5953.58324917269, 5953.791617293374, 5969.194158788508, 5994.490468310242], "value": 5695.139362513834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.67182277380573, 519.9116150254456, 532.1113740054109, 537.7338217582297, 556.3435146527096, 30215.697843021564, 32915.0, 34855.651443485556, 42600.78699606506, 44279.335809962875, 36591.45112823303, 46284.07431851361, 46325.841853953665, 46388.0, 46515.0, 9953.0, 10142.18862490999, 10147.289689721685, 10149.797004059952, 10151.137153341975, 9283.442993420382, 9550.665726699566, 9958.203343732484, 12164.14850960433, 12440.751184976296, 12436.19164754288, 12512.186707864004, 12514.874851251461, 12516.0, 12526.373681315943, 12402.193857399285, 12481.50073997039, 12503.062270329761, 12513.249205047727, 12545.811812822814, 12317.50729970809, 12366.938165309206, 12367.072469564819, 12379.62861114168, 12380.195287306386, 42953.35569966453, 43119.13761724779, 43214.35178472326, 43277.61973091479, 43373.56626433727, 3395.6604339565847, 3508.6491350864962, 3672.412414013745, 3899.7465164764485, 3970.8808735737975, 32347.676523234935, 32637.51043734346, 32655.346893062007, 32990.01029969105, 33338.66661333404, 3285.671432856719, 3311.437055700537, 3400.5409269748516, 3420.452727563578, 3424.708899743525, 532911.0, 533503.332483339, 533940.0, 534148.0, 534400.0, 65252.0, 65918.38571299963, 65931.0, 65990.34009659938, 66064.0, 36753.448698269545, 37383.81308093442, 37450.62549374526, 38656.22687546234, 38727.0, 17599.824001760073, 17777.377791777224, 17785.021823799816, 17785.555361116076, 17808.46574602738, 12316.876831231752, 13367.532136375376, 13479.663008424868, 13479.865201348057, 13488.93255533716, 17214.139293035547, 17797.555061123574, 19799.0, 20318.390448286576, 20940.0, 8070.556119413489, 8158.632861521246, 8169.63236654352, 8217.712380066789, 8231.588420578948, 903.75146834621, 1042.3433237060756, 1049.7742985258205, 1086.9891301087046, 1115.7210697325668, 30995.915142969887, 31247.843760781507, 31351.686483134876, 31897.202569935936, 32110.357792844014, 1109.7614012987085, 1114.0307932099126, 1119.7256672115384, 1155.5955415604471, 1217.713837248246, 16080.839191608167, 16379.83620163783, 16520.75218871718, 16584.66830663404, 16721.080340581386, 753830.0, 1034331.0, 1055514.722426383, 1061473.0, 1061879.0, 63739.36260637334, 64398.35601643923, 64482.355176447636, 64489.677551611945, 64650.676746615965, 1290.2000759529153, 1328.063715080885, 1414.4837134445854, 1440.3734375546671, 1459.8905082118672, 27567.0, 33028.0, 33034.66965330316, 33890.3221935555, 34596.481052783725, 60372.0, 61153.694231528556, 61203.0, 61206.38793612007, 61477.38522614895, 687108.0, 693697.0, 695172.0, 695745.0, 696694.0, 28376.43247135087, 29212.123636290944, 29240.415191696473, 38716.6128338713, 46246.53753462557, 48475.5152448471, 48643.0, 49146.75426622844, 49159.26261106015, 50174.0, 39292.80353598214, 39495.802520987214, 40430.0, 40835.79582102071, 41896.0, 39910.60089399069, 40257.79226623206, 41080.38379424371, 41635.959101022716, 41830.0, 38959.415608765325, 39685.00787480336, 40060.1987960245, 40082.0, 40438.79780601078, 34267.0, 35376.11559711028, 35919.64080359267, 35982.64017359793, 36069.819650901576, 25947.481050379265, 26073.0, 26189.0, 26207.0, 26846.120771546586], "value": 21649.04230866602, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.6060727147402, 387.42854289922366, 390.13390273592614, 397.95025621797265, 417.3364350682414, 14980.700385992273, 20573.0, 21481.57036859262, 21868.343949681515, 21890.452738681543, 15644.452444164457, 16242.269097890594, 19866.503337416572, 20814.687779683318, 21105.0, 5894.6168499047535, 6214.533909956749, 6223.719932603021, 6232.158658581079, 6260.749570017194, 5900.970495147519, 6066.454019138277, 6157.938420615781, 6187.07193920911, 6241.531885108612, 6182.505399568046, 6184.752609895599, 6184.84537886552, 6187.81436556904, 6188.133661287423, 5878.294604647427, 6078.72645730941, 6135.570510064297, 6139.539534534905, 6144.5084393248435, 5333.546648534879, 5358.490943360374, 5359.785608575652, 5365.382980957201, 5367.087595108841, 25636.949044076617, 25858.6121208182, 26266.86866565674, 27137.45725085507, 27548.0, 2108.110536060965, 2145.95708085839, 2192.967105493419, 2297.873616951067, 2339.2163625185585, 9708.854367184498, 10696.946515267451, 11108.444577771079, 11170.888291117066, 16650.916745416194, 1796.2814874050355, 1870.9438716838517, 1881.990590047041, 1990.6018796240664, 2018.576099019193, 115804.0, 121930.0, 124118.0, 127370.0, 135645.0, 11341.943290283496, 11608.723040465542, 11631.76736465266, 11635.127365447624, 11857.525698971944, 15174.393024278905, 15270.847291527165, 15275.61810954735, 15277.541673749805, 15282.541523754082, 7990.081140668781, 8418.410711250277, 8447.408681392366, 8631.568421578895, 8977.955110224537, 8819.823603528022, 8880.200781929658, 8957.417767845069, 9048.457092574467, 9064.456132632064, 4509.34614480905, 4666.789994450258, 4667.556582124693, 4672.462666793363, 4715.41057367829, 1711.9743203851951, 1834.6330733853283, 1845.966258895023, 1846.8614853885745, 1980.7127966444784, 895.7984453497911, 909.8862642169729, 946.0, 961.240619910277, 964.9710508684751, 20560.58878822445, 21646.0, 21726.89136554307, 21797.891010544845, 21919.67120493194, 822.4078663362369, 910.6949172027313, 960.7598100474881, 966.5940305071887, 1011.3224139826334, 9261.16649501548, 10842.945785271024, 11585.304881707125, 11589.0, 11596.652100437, 633357.0, 637276.0, 648883.0, 656788.0, 657158.0, 128205.0, 129494.35252823676, 139490.3025484866, 144220.0, 144856.0, 998.9950050249702, 1014.3660212367271, 1038.6416686243083, 1050.0916707048348, 1050.8161071812556, 13940.200726924484, 19388.224471021, 20414.0, 20456.590868182255, 20565.97170141517, 54311.72844135754, 56198.7190064047, 56638.433615664966, 56872.43127568837, 57580.0, 79748.60125699334, 81892.59053704693, 84682.15317846989, 85602.0, 87849.0, 8147.429679922348, 8219.424640275123, 8343.24806662696, 8558.443701159405, 8672.78318042054, 11973.640790776291, 12980.15628984113, 13253.271070091238, 13387.0, 13613.047086703835, 11156.776864462827, 11349.48927298257, 11359.375234362189, 11424.771504569695, 11713.41432928333, 10394.58421663125, 11411.942940285246, 11511.424428778695, 11771.823422648838, 11808.409579521162, 8309.584520773817, 11127.276727012719, 11492.48283827213, 11654.650360489199, 12102.36618056551, 7387.891816227394, 8293.253607175384, 8500.61747221389, 8622.482651040958, 8675.175858293453, 8145.714899978472, 11069.446527673745, 11362.54549818031, 11533.423328833693, 11926.582569610022], "value": 9817.488033312777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.4404014554761, 1588.52344296711, 1775.1213149491005, 1910.7038409046602, 1920.6446807340642, 8934.195922366986, 9463.43219406836, 9484.66803661872, 9490.952545237264, 9498.240140788721, 8305.83388332233, 8524.659013639463, 8976.237019853304, 9208.861867071999, 9238.722838314861, 2433.4038160650575, 2469.0370755405315, 2470.505898820234, 2472.5425796227664, 2475.393528585499, 2423.103451722865, 2478.9752102478924, 2486.7264600893886, 2487.3035550046015, 2491.215267190838, 2443.9144629937955, 2456.0298682020593, 2478.10788116278, 2482.1932871816643, 2484.714257860342, 2424.1273141668985, 2441.2066078524463, 2453.619688948207, 2463.9014439422403, 2467.1858286765323, 2041.285550057468, 2427.720812106613, 2447.889844956981, 2452.583060879637, 2453.5338285725657, 9330.673426430043, 9355.812883742286, 9442.763930901714, 9470.52647367629, 9479.0, 5510.448955104497, 5690.4025077367105, 5691.914621280643, 5694.4590263924865, 5709.429057094258, 3554.8400321985573, 3711.1278849470355, 3768.7173461990187, 3784.6972242220554, 3785.4511095890944, 1112.9777404451947, 1116.7989761842864, 1138.4137169357787, 1156.8553930758655, 1159.843421138144, 12588.18176818513, 12622.558210462681, 12624.87375126237, 12625.936870315682, 12639.925606323473, 4858.198397264412, 4878.43897951733, 4911.287863259879, 4984.3021976923255, 5042.722650254272, 10593.735156621146, 10602.893971060344, 10623.628173013907, 10628.681139565826, 10636.946815265874, 5656.066748986454, 5656.85857853557, 5658.264425624642, 5658.971705141448, 5663.716814159276, 4580.496145424001, 4586.862394128115, 5078.898422031539, 5107.540321371094, 5147.639665223398, 4113.650339721157, 4136.793160342031, 4236.915261694749, 4239.448871646666, 4249.3413520904305, 1306.6145487081333, 1340.6648337915522, 1343.43575698207, 1350.7636163671318, 1357.633438971472, 901.6708901251127, 912.9154187341428, 936.1481052242426, 958.4680502321139, 984.6159997600942, 5954.791582294685, 5982.0727787193055, 6226.688665566703, 6245.18812554365, 6272.623642581369, 449.99775001124783, 450.2593234129838, 452.19509273493236, 458.96557758168274, 476.05978193069103, 3667.8166091695307, 3952.446657467957, 3957.2085582883537, 4020.43713880057, 4082.22437736835, 10007.349522281029, 11115.722106947229, 11268.54925802975, 11273.267237629529, 11330.0, 11047.944760276147, 11209.0, 11216.607418740305, 11227.38249396291, 11228.529723460826, 8345.123762005023, 8530.10433904431, 8550.102239264788, 8551.828963420698, 8582.0, 4735.313379560013, 5044.697318160922, 5694.402087780889, 5840.620359676607, 6021.2473440819895, 10068.446235456828, 10154.492275386054, 10331.483425828528, 10378.014088661565, 10472.10987066108, 10252.179825614083, 10508.106810921157, 10626.36241825493, 10685.984831441001, 10696.786064278827, 7690.461667683208, 7719.961400192963, 7772.45592808498, 7801.531908085533, 7887.290143887078, 8548.0, 8613.31093512505, 8619.65521379163, 8626.56867156627, 8646.0, 7610.657520411484, 7706.807329816799, 7758.224177582197, 7868.84262314762, 7912.248336408032, 6438.227412710505, 7681.539107653559, 7686.846263074595, 7708.807279818049, 7827.9823622930935, 7131.393831524379, 7269.672864720995, 7279.053723015974, 7279.417646588155, 7290.4896657233485, 4985.6011519077665, 4994.375703037121, 5098.643094983316, 5214.97392513035, 5254.0, 5097.0, 5142.97428512855, 5215.504527069922, 5238.371395432572, 5292.470752924677], "value": 4687.295914278986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.56133888373117, 292.33493801601355, 293.92064142681477, 302.1524623431276, 315.99052028439155, 4769.165396055694, 5230.34620672416, 5484.698341591211, 5586.385497595261, 5665.575081868866, 4298.419713338699, 4754.7860346284415, 5165.328507294056, 5332.733363331838, 5387.24578559002, 4185.748855068706, 4191.266528357541, 4213.325867861143, 4231.428757117788, 4253.914921701564, 3860.652541271285, 4045.6763458923215, 4117.114820313632, 4211.789410529461, 4212.031232816454, 4095.8361665533344, 4132.690048246379, 4138.586141385852, 4167.291560434718, 4170.562090980449, 4094.447249621293, 4117.402976568411, 4117.5882411758885, 4131.483564554431, 4134.7312424692445, 3611.458281257806, 3624.4019736743408, 3627.963720362789, 3631.9273614527824, 3643.4716966039778, 4480.775961201927, 4961.585948004801, 5222.92165617516, 5246.396664383568, 5343.732813359316, 4088.7955602220068, 4610.492845786961, 4739.440702020905, 4844.903101937976, 4915.557599816034, 4778.665493415462, 4787.305840653121, 5634.3520495143175, 5646.774129034834, 5762.3373312069225, 3846.480725102131, 3991.201759648082, 4008.4187792770176, 4024.0342317843506, 4049.5950404959563, 5242.161254199348, 5564.443555644443, 5927.644341339534, 5937.851553711149, 5951.851203719898, 3720.2373513430225, 3803.0682482791894, 4089.4479245301504, 4097.057676734308, 4099.811054794076, 3435.587729472479, 3745.8127093645207, 3793.5447746270625, 3978.7520051170995, 4020.115574573589, 4667.696599721007, 4672.766361681903, 4712.622990160848, 4717.268823332389, 4739.928901066418, 4972.980538989498, 5137.915357290963, 5786.42135786418, 5793.681347525927, 5867.237259156368, 1146.7247860513417, 1294.7345794112184, 1294.7505657041002, 1338.5448947357945, 1352.384664977433, 790.7627711686471, 895.6520436742791, 924.9815003700023, 930.9906900931039, 937.2923442800778, 5387.272718183073, 5393.1370980642905, 5398.0, 5411.810586629528, 5412.296401467784, 5660.462256085665, 5846.941530584725, 5900.468957793819, 5906.232189815297, 5922.496587790086, 5334.3865455473115, 5370.62405631602, 5370.865728356823, 5423.810166644227, 5424.728763561806, 2354.4349356154744, 2444.350063707026, 2456.8084479027657, 2565.230430870731, 2601.9219423417326, 4409.4267745193565, 4686.797634866447, 4849.769106211183, 4919.754012299442, 5131.640785145079, 4413.477350314137, 4506.755136301857, 4979.92931519725, 5075.578837925387, 5098.337216161949, 4738.73936933465, 4955.430125535538, 4971.45314015458, 4986.775595098156, 5017.37282839645, 3940.7044471665313, 4492.73043617384, 4806.567408933212, 4862.41651001882, 4930.704157750546, 4180.581941805916, 4405.31717583775, 4819.759012049453, 4919.532644398776, 4934.457209707001, 4922.424824056267, 4955.40535135786, 4997.201007637175, 5045.5459008689395, 5075.822346218012, 3120.7971481853606, 3142.74858011354, 3382.20518178223, 3395.3718562066097, 3396.5244865719314, 4861.51384861511, 4862.90274194507, 4882.779305173706, 4896.902061958812, 4900.509949005071, 3873.469979358081, 4286.657067434536, 4478.9543110685045, 4627.190241707621, 4743.83396581118, 3850.5186851643543, 4399.6040356368085, 4721.952780472288, 4726.534774220003, 4731.2859405368, 4199.811008504564, 4543.6365090792, 5085.847424577269, 5503.504684578407, 5603.907238088534, 5722.62802917809, 5735.139729040678, 5737.91393129095, 5760.913586296125, 5764.971175144097, 4786.473487916257, 5193.428722840409, 5276.445973172915, 5628.634138780966, 5658.17956396312], "value": 3936.0117161995986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.7532414303283, 767.3822572828873, 775.8836174573813, 808.4704518540358, 877.4340550345028, 14003.299835008234, 15820.288087036082, 15863.444779432722, 16872.325106995722, 16982.83017169828, 12940.676483087927, 14958.40166393343, 15339.0, 15343.156126413043, 15464.072155670669, 711.5268346549539, 886.6231851463135, 896.5338024227398, 899.4153800029967, 899.5052721003455, 726.4624178108188, 875.9737207883774, 901.143913282381, 903.0743487924897, 908.0148039377284, 938.5307346326837, 940.952952352383, 941.1388579449796, 944.2351695126935, 945.8392073347547, 932.1144912333276, 934.2525979216667, 937.0301737701446, 937.2782957123011, 937.7093101138669, 705.2031204738613, 705.587231469591, 706.6572712234562, 707.1514182980444, 708.982275443118, 15501.612459688598, 15523.45667901618, 15553.766693499607, 15555.533333999998, 15559.29983150761, 13779.173249604955, 14929.850701492955, 15105.773413398807, 15199.62000949974, 15390.615234619225, 13190.274534900576, 13738.244396558186, 13802.240876751775, 13804.861951380459, 13865.0, 4638.489766125724, 4662.930056049162, 4741.881452963669, 4788.856334309976, 4901.5588597026435, 113414.43292783566, 119282.0, 119757.0, 122201.0, 123511.0, 10331.32846364984, 10402.167826573856, 11231.0, 11235.887641123647, 11268.38023908693, 21089.472763181042, 21105.894470527855, 21158.47103822386, 21263.68104478434, 21297.68053479199, 7370.447216458787, 7879.921200787919, 8349.66601335952, 8380.706675266336, 8650.480971141751, 4509.864704058883, 4584.5186255442695, 4588.403507543998, 4654.837080702159, 4746.905061898743, 3682.5949145593963, 3839.673627741673, 3841.9807900960877, 3846.211526637033, 3851.306764782366, 685.2154283345542, 690.1304356510833, 699.0981633692581, 705.1150805738868, 708.242180866468, 596.5347029317139, 602.7197353230769, 646.5861848417017, 681.3186813186813, 707.4729326651677, 8473.788155296166, 9537.952310238543, 9651.276154288316, 9657.0, 9794.16749576294, 570.6946783470823, 597.623497196772, 610.8289678889918, 649.8245473722069, 681.3595220492721, 4169.97915010423, 4353.847615333448, 4629.930551041737, 4698.459677137173, 4749.905001899942, 98363.0, 152021.0, 154059.0, 168005.1599742018, 175575.0, 138348.0, 150774.0, 151293.73059404118, 152247.0, 157047.0, 123253.0, 125132.37433812773, 126379.36810316074, 126415.0, 126892.36553817173, 8730.301575873787, 9076.137766912132, 9140.451572905647, 9216.447013179231, 9238.491882946502, 69640.30359696542, 71008.64495677488, 71134.0, 71575.92636110567, 72102.91845622424, 76265.0, 94699.05300946902, 95767.52116239653, 101456.49271753593, 102414.0, 11887.108466865193, 11988.400579971141, 12022.579209727617, 12173.69565760863, 12381.62855114348, 13048.673783155496, 13394.866051339752, 13810.58568242914, 15449.613759656098, 15662.295196715948, 13732.519361822287, 13912.095713778572, 14410.0, 14425.49510767118, 15650.686986260438, 13928.72142557123, 13945.790813137608, 14477.420903163755, 14912.403503859725, 15063.246837657854, 13496.86503134956, 14393.85606143967, 14431.78352324737, 14777.630559236106, 15184.0, 9869.062439068277, 11161.44192790341, 11371.48828302745, 11619.767604648028, 12185.207961482476, 10244.948775256076, 10911.618093367011, 11778.175527712978, 11889.881101188877, 12130.575429859913], "value": 8174.851278158482, "unit": "score"}], "name": "dromaeo_css", "value": 7531.973611459348, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 112.0, 113.0, 114.0, 112.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 108.0, 140.0, 105.0, 103.0, 107.0, 107.0, 132.0, 106.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 185.0, 193.0, 226.0, 253.0, 196.0, 183.0, 185.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 57.0, 85.0, 62.0, 58.0, 56.0, 65.0, 108.0, 82.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 92.0, 75.0, 97.0, 100.0, 76.0, 85.0, 100.0, 122.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 130.0, 89.0, 87.0, 90.0, 84.0, 90.0, 87.0, 90.0, 86.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 86.0, 85.0, 84.0, 84.0, 86.0, 82.0, 86.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 51.0, 54.0, 55.0, 57.0, 56.0, 56.0, 55.0, 57.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 72.0, 71.0, 71.0, 67.0, 66.0, 69.0, 68.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 80.0, 84.0, 81.0, 79.0, 80.0, 80.0, 81.0, 85.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 132.0, 133.0, 131.0, 132.0, 155.0, 150.0, 172.0, 134.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 156.0, 203.0, 219.0, 164.0, 160.0, 161.0, 160.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 79.0, 76.0, 84.0, 84.0, 64.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1447.6000000000001, "alertThreshold": 2.0}]} 02:22:03 INFO - Return code: 0 02:22:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:22:03 INFO - # TBPL SUCCESS # 02:22:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:03 INFO - 2017-01-09 02:22:03.292 screenresolution[1650:10610] starting screenresolution argv=screenresolution get 02:22:03 INFO - 2017-01-09 02:22:03.294 screenresolution[1650:10610] Display 0: 1600x1200x32@60 02:22:03 INFO - 2017-01-09 02:22:03.300 screenresolution[1651:10613] starting screenresolution argv=screenresolution list 02:22:03 INFO - Available Modes on Display 0 02:22:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:03 INFO - Intel Iris: 02:22:03 INFO - Chipset Model: Intel Iris 02:22:03 INFO - Type: GPU 02:22:03 INFO - Bus: Built-In 02:22:03 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:03 INFO - Vendor: Intel (0x8086) 02:22:03 INFO - Device ID: 0x0a2e 02:22:03 INFO - Revision ID: 0x0009 02:22:03 INFO - Displays: 02:22:03 INFO - Display: 02:22:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:03 INFO - Display Serial Number: 1600x1200 60 02:22:03 INFO - Main Display: Yes 02:22:03 INFO - Mirror: Off 02:22:03 INFO - Online: Yes 02:22:03 INFO - Rotation: Supported 02:22:03 INFO - Return code: 0 02:22:03 INFO - Running post-action listener: _resource_record_post_action 02:22:03 INFO - [mozharness: 2017-01-09 10:22:03.537345Z] Finished run-tests step (success) 02:22:03 INFO - Running post-run listener: _resource_record_post_run 02:22:03 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 33680384; Write bytes: 496929280; Read time: 318; Write time: 2035 02:22:03 INFO - TinderboxPrint: CPU usage
53.6% 02:22:03 INFO - TinderboxPrint: I/O read bytes / time
33,680,384 / 318 02:22:03 INFO - TinderboxPrint: I/O write bytes / time
496,929,280 / 2,035 02:22:03 INFO - TinderboxPrint: CPU idle
2,219.9 (46.4%) 02:22:03 INFO - TinderboxPrint: CPU system
955.4 (20.0%) 02:22:03 INFO - TinderboxPrint: CPU user
1,606.5 (33.6%) 02:22:03 INFO - TinderboxPrint: Swap in / out
225,755,136 / 0 02:22:03 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196350464; Write bytes: 196075520; Read time: 17803; Write time: 506 02:22:03 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29375488; Write bytes: 299366912; Read time: 283; Write time: 1522 02:22:04 INFO - Running post-run listener: _upload_blobber_files 02:22:04 INFO - Blob upload gear active. 02:22:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:22:05 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:08 INFO - (blobuploader) - INFO - Done attempting. 02:22:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:22:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:22:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:11 INFO - (blobuploader) - INFO - Done attempting. 02:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:22:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:16 INFO - (blobuploader) - INFO - Done attempting. 02:22:16 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:16 INFO - Return code: 0 02:22:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47a43e2fed2e8a45b1226cef90eb5d8aed490e9bb801b396ba8f519b5cfc6faa23ae6669eee78485485f5aea4666138da2b49be745a1d91f170ac3a78cfd13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/872f6e3e6cf0cc5ea722a6ebb4c486e2623915894574172f3b56473c6c7538cbc960a0818a4f095057c028ffe9c69fc3bea47c4757c1d2a2689464988d772413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be7fa26ebebd33265c1b95f02440882318390bc0658dd63aa9ea55676aeffea102ae5916fbb3f86a4f4b202a0766a7af1a291e0d8b9df0486a3b0043d4da03cd"} 02:22:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:16 INFO - Contents: 02:22:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47a43e2fed2e8a45b1226cef90eb5d8aed490e9bb801b396ba8f519b5cfc6faa23ae6669eee78485485f5aea4666138da2b49be745a1d91f170ac3a78cfd13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/872f6e3e6cf0cc5ea722a6ebb4c486e2623915894574172f3b56473c6c7538cbc960a0818a4f095057c028ffe9c69fc3bea47c4757c1d2a2689464988d772413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be7fa26ebebd33265c1b95f02440882318390bc0658dd63aa9ea55676aeffea102ae5916fbb3f86a4f4b202a0766a7af1a291e0d8b9df0486a3b0043d4da03cd"} 02:22:16 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:16 INFO - Copying logs to upload dir... 02:22:16 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.671587 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-09 02:22:16.805735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:16.808917) ========= 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.rgCiup2I8r/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.x93XVjCHu1/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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-Beta/sha512/47a43e2fed2e8a45b1226cef90eb5d8aed490e9bb801b396ba8f519b5cfc6faa23ae6669eee78485485f5aea4666138da2b49be745a1d91f170ac3a78cfd13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/872f6e3e6cf0cc5ea722a6ebb4c486e2623915894574172f3b56473c6c7538cbc960a0818a4f095057c028ffe9c69fc3bea47c4757c1d2a2689464988d772413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be7fa26ebebd33265c1b95f02440882318390bc0658dd63aa9ea55676aeffea102ae5916fbb3f86a4f4b202a0766a7af1a291e0d8b9df0486a3b0043d4da03cd"} build_url:https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011036 build_url: 'https://queue.taskcluster.net/v1/task/BM66iUg1QtS1N6TBrikWtQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47a43e2fed2e8a45b1226cef90eb5d8aed490e9bb801b396ba8f519b5cfc6faa23ae6669eee78485485f5aea4666138da2b49be745a1d91f170ac3a78cfd13fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/872f6e3e6cf0cc5ea722a6ebb4c486e2623915894574172f3b56473c6c7538cbc960a0818a4f095057c028ffe9c69fc3bea47c4757c1d2a2689464988d772413", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be7fa26ebebd33265c1b95f02440882318390bc0658dd63aa9ea55676aeffea102ae5916fbb3f86a4f4b202a0766a7af1a291e0d8b9df0486a3b0043d4da03cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:16.843540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:16.843865) ========= 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.rgCiup2I8r/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.x93XVjCHu1/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 02:22:16.892139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:22:16.892475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 02:22:16.892783) ========= ========= Total master_lag: 0.18 =========