builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0129 starttime: 1486741063.13 results: success (0) buildid: 20170210051622 builduid: 21e6f00c3e234c359030193442b0bd20 revision: dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.126826) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.127280) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.127572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.154245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.154625) ========= 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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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-02-10 07:37:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-02-10 07:37:43 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123361 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.302041) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.302387) ========= 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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.035977 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:43.362135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-10 07:37:43.362524) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac --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 dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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-02-10 07:37:43,465 truncating revision to first 12 chars 2017-02-10 07:37:43,465 Setting DEBUG logging. 2017-02-10 07:37:43,465 attempt 1/10 2017-02-10 07:37:43,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dd8a1f27c391?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 07:37:45,196 unpacking tar archive at: mozilla-beta-dd8a1f27c391/testing/mozharness/ program finished with exit code 0 elapsedTime=1.976776 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-10 07:37:45.522123) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:45.522474) ========= script_repo_revision: dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:45.522901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:45.523221) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 07:37:45.549328) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-10 07:37:45.549780) ========= /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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:37:45 INFO - MultiFileLogger online at 20170210 07:37:45 in /builds/slave/test 07:37:45 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 07:37:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:45 INFO - {'append_to_log': False, 07:37:45 INFO - 'base_work_dir': '/builds/slave/test', 07:37:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:37:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:45 INFO - 'branch': 'Mozilla-Beta', 07:37:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:45 INFO - 'config_files': ('talos/mac_config.py',), 07:37:45 INFO - 'default_actions': ('clobber', 07:37:45 INFO - 'read-buildbot-config', 07:37:45 INFO - 'download-and-extract', 07:37:45 INFO - 'populate-webroot', 07:37:45 INFO - 'create-virtualenv', 07:37:45 INFO - 'install', 07:37:45 INFO - 'run-tests'), 07:37:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:45 INFO - 'download_minidump_stackwalk': True, 07:37:45 INFO - 'download_symbols': 'ondemand', 07:37:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:45 INFO - 'installer_path': 'installer.exe', 07:37:45 INFO - 'log_level': 'info', 07:37:45 INFO - 'log_name': 'talos', 07:37:45 INFO - 'log_to_console': True, 07:37:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:37:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:37:45 INFO - 'opt_config_files': (), 07:37:45 INFO - 'pip_index': False, 07:37:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:45 INFO - 'cmd': ('bash', 07:37:45 INFO - '-c', 07:37:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:45 INFO - 'enabled': True, 07:37:45 INFO - 'halt_on_failure': False, 07:37:45 INFO - 'name': 'check_screen_resolution'},), 07:37:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:45 INFO - 'cmd': ('bash', 07:37:45 INFO - '-c', 07:37:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:45 INFO - 'enabled': True, 07:37:45 INFO - 'halt_on_failure': False, 07:37:45 INFO - 'name': 'check_screen_resolution'},), 07:37:45 INFO - 'run_cmd_checks_enabled': True, 07:37:45 INFO - 'sps_profile': False, 07:37:45 INFO - 'sps_profile_interval': 0, 07:37:45 INFO - 'suite': 'dromaeojs', 07:37:45 INFO - 'system_bits': '32', 07:37:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:45 INFO - 'title': 't-yosemite-r7-0129', 07:37:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:45 INFO - 'use_talos_json': True, 07:37:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:45 INFO - 'work_dir': 'build'} 07:37:45 INFO - [mozharness: 2017-02-10 15:37:45.765682Z] Running clobber step. 07:37:45 INFO - Running pre-action listener: _resource_record_pre_action 07:37:45 INFO - Running main action method: clobber 07:37:45 INFO - rmtree: /builds/slave/test/build 07:37:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:48 INFO - Running post-action listener: _resource_record_post_action 07:37:48 INFO - [mozharness: 2017-02-10 15:37:48.378358Z] Finished clobber step (success) 07:37:48 INFO - [mozharness: 2017-02-10 15:37:48.378583Z] Running read-buildbot-config step. 07:37:48 INFO - Running pre-action listener: _resource_record_pre_action 07:37:48 INFO - Running main action method: read_buildbot_config 07:37:48 INFO - Using buildbot properties: 07:37:48 INFO - { 07:37:48 INFO - "project": "", 07:37:48 INFO - "product": "firefox", 07:37:48 INFO - "script_repo_revision": "production", 07:37:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:37:48 INFO - "repository": "", 07:37:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:37:48 INFO - "buildid": "20170210051622", 07:37:48 INFO - "pgo_build": "False", 07:37:48 INFO - "basedir": "/builds/slave/test", 07:37:48 INFO - "buildnumber": 23, 07:37:48 INFO - "slavename": "t-yosemite-r7-0129", 07:37:48 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:37:48 INFO - "platform": "yosemite_r7", 07:37:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:37:48 INFO - "branch": "mozilla-beta", 07:37:48 INFO - "repo_path": "releases/mozilla-beta", 07:37:48 INFO - "revision": "dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac", 07:37:48 INFO - "stage_platform": "macosx64", 07:37:48 INFO - "builduid": "21e6f00c3e234c359030193442b0bd20", 07:37:48 INFO - "slavebuilddir": "test" 07:37:48 INFO - } 07:37:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 07:37:48 INFO - Running post-action listener: _resource_record_post_action 07:37:48 INFO - [mozharness: 2017-02-10 15:37:48.384094Z] Finished read-buildbot-config step (success) 07:37:48 INFO - [mozharness: 2017-02-10 15:37:48.384275Z] Running download-and-extract step. 07:37:48 INFO - Running pre-action listener: _resource_record_pre_action 07:37:48 INFO - Running main action method: download_and_extract 07:37:48 INFO - mkdir: /builds/slave/test/build/tests 07:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:48 INFO - trying https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 07:37:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:37:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 07:37:49 INFO - Downloaded 1165 bytes. 07:37:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:37:49 INFO - Using the following test package requirements: 07:37:49 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:37:49 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 07:37:49 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 07:37:49 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:37:49 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 07:37:49 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:37:49 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 07:37:49 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 07:37:49 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 07:37:49 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:37:49 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 07:37:49 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 07:37:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:37:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:37:49 INFO - Fetch https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:37:49 INFO - Http code: 200 07:37:49 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 07:37:49 INFO - x-amz-cf-id: pC-fGVCf2u_3PmKjzIleheeAV-RwOMuiANxWhU7FXoxA4ojUSvH_8w== 07:37:49 INFO - x-amz-version-id: XHqTQA.M1QAVsKH28wKxFZK44_s6bA8D 07:37:50 INFO - Expected file size: 16093691 07:37:50 INFO - Obtained file size: 16093691 07:37:57 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:37:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:37:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:37:57 INFO - Fetch https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:37:58 INFO - Http code: 200 07:37:58 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 07:37:58 INFO - x-amz-cf-id: 62xh-DFCHXpTVaSiOkSuf7H-k9s70LMR7-ZoZJlraJLuuT2lSfZzOA== 07:37:58 INFO - x-amz-version-id: XHqTQA.M1QAVsKH28wKxFZK44_s6bA8D 07:37:58 INFO - Expected file size: 16093691 07:37:58 INFO - Obtained file size: 16093691 07:38:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 07:38:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 07:38:04 INFO - Fetch https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 07:38:06 INFO - Http code: 200 07:38:06 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 07:38:06 INFO - x-amz-cf-id: 4d5dfVlU6-ySVvbguJjcfwhF5wOoee4J6LjD9ilGl4rZ8qg5B254PQ== 07:38:06 INFO - x-amz-version-id: iW1pz0ipKluLhyRnZ.e4vfwJKZIP_cXu 07:38:07 INFO - Expected file size: 14403005 07:38:07 INFO - Obtained file size: 14403005 07:38: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')]} 07:38:07 INFO - trying https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:38:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 07:38:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 07:38:10 INFO - Downloaded 82153811 bytes. 07:38:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:38:10 INFO - mkdir: /builds/slave/test/properties 07:38:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:10 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:10 INFO - Contents: 07:38:10 INFO - build_url:https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:38:11 INFO - Running post-action listener: _resource_record_post_action 07:38:11 INFO - Running post-action listener: set_extra_try_arguments 07:38:11 INFO - [mozharness: 2017-02-10 15:38:11.280722Z] Finished download-and-extract step (success) 07:38:11 INFO - [mozharness: 2017-02-10 15:38:11.280888Z] Running populate-webroot step. 07:38:11 INFO - Running pre-action listener: _resource_record_pre_action 07:38:11 INFO - Running main action method: populate_webroot 07:38:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:11 INFO - '--tppagecycles', 07:38:11 INFO - '7'], 07:38:11 INFO - 'tests': ['tsvgm']}}, 07:38:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['damp', 'tps']}, 07:38:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'tests': ['damp', 'tps']}, 07:38:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['dromaeo_dom']}, 07:38:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['basic_compositor_video']}, 07:38:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:38:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['a11yr', 07:38:11 INFO - 'ts_paint', 07:38:11 INFO - 'tpaint', 07:38:11 INFO - 'sessionrestore', 07:38:11 INFO - 'sessionrestore_no_auto_restore', 07:38:11 INFO - 'tabpaint']}, 07:38:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:11 INFO - 'ts_paint', 07:38:11 INFO - 'tpaint', 07:38:11 INFO - 'sessionrestore', 07:38:11 INFO - 'sessionrestore_no_auto_restore', 07:38:11 INFO - 'tabpaint']}, 07:38:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:11 INFO - 'ts_paint', 07:38:11 INFO - 'tpaint', 07:38:11 INFO - 'sessionrestore', 07:38:11 INFO - 'sessionrestore_no_auto_restore', 07:38:11 INFO - 'tabpaint']}, 07:38:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:11 INFO - 'ts_paint', 07:38:11 INFO - 'tpaint', 07:38:11 INFO - 'sessionrestore', 07:38:11 INFO - 'sessionrestore_no_auto_restore', 07:38:11 INFO - 'tabpaint']}, 07:38:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['a11yr', 07:38:11 INFO - 'ts_paint', 07:38:11 INFO - 'tpaint', 07:38:11 INFO - 'sessionrestore', 07:38:11 INFO - 'sessionrestore_no_auto_restore', 07:38:11 INFO - 'tabpaint']}, 07:38:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['a11yr', 07:38:11 INFO - 'ts_paint', 07:38:11 INFO - 'tpaint', 07:38:11 INFO - 'sessionrestore', 07:38:11 INFO - 'sessionrestore_no_auto_restore', 07:38:11 INFO - 'tabpaint']}, 07:38:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['tsvgx', 07:38:11 INFO - 'tsvgr_opacity', 07:38:11 INFO - 'tart', 07:38:11 INFO - 'tscrollx', 07:38:11 INFO - 'cart']}, 07:38:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:11 INFO - 'tsvgr_opacity', 07:38:11 INFO - 'tart', 07:38:11 INFO - 'tscrollx', 07:38:11 INFO - 'cart']}, 07:38:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'talos_options': ['--disable-e10s'], 07:38:11 INFO - 'tests': ['tp5o']}, 07:38:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'tests': ['tp5o']}, 07:38:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'talos_options': ['--disable-e10s', 07:38:11 INFO - '--xperf_path', 07:38:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:11 INFO - 'tests': ['tp5n']}, 07:38:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:11 INFO - 'talos_options': ['--xperf_path', 07:38:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:11 INFO - 'tests': ['tp5n']}}, 07:38:11 INFO - 'talos.zip': {'path': '', 07:38:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:11 INFO - Running post-action listener: _resource_record_post_action 07:38:11 INFO - [mozharness: 2017-02-10 15:38:11.299699Z] Finished populate-webroot step (success) 07:38:11 INFO - [mozharness: 2017-02-10 15:38:11.299835Z] Running create-virtualenv step. 07:38:11 INFO - Running pre-action listener: _resource_record_pre_action 07:38:11 INFO - Running main action method: create_virtualenv 07:38:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:11 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 07:38:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:11 INFO - Using real prefix '/tools/python27' 07:38:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:15 INFO - Installing pip.................done. 07:38:15 INFO - Return code: 0 07:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:15 INFO - Reading from file tmpfile_stdout 07:38:15 INFO - Output received: 07:38:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:38:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:15 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')]} 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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')]} 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:15 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 07:38:15 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 07:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:15 INFO - 'HOME': '/Users/cltbld', 07:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PAGER': '/bin/cat', 07:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:15 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - 'XPC_FLAGS': '0x0', 07:38:15 INFO - 'XPC_SERVICE_NAME': '0', 07:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:15 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 07:38:15 INFO - Cleaning up... 07:38:15 INFO - Return code: 0 07:38:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:15 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')]} 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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')]} 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:15 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:15 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 07:38:15 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 07:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:15 INFO - 'HOME': '/Users/cltbld', 07:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PAGER': '/bin/cat', 07:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:15 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - 'XPC_FLAGS': '0x0', 07:38:15 INFO - 'XPC_SERVICE_NAME': '0', 07:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:15 INFO - Downloading/unpacking psutil>=3.1.1 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:19 INFO - Installing collected packages: psutil 07:38:19 INFO - Running setup.py install for psutil 07:38:19 INFO - building 'psutil._psutil_osx' extension 07:38:19 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 07:38:19 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 07:38:20 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 07:38:20 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 07:38:20 INFO - building 'psutil._psutil_posix' extension 07:38:20 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 07:38:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:38:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:38:20 INFO - ^ 07:38:20 INFO - 1 warning generated. 07:38:20 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 07:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:20 INFO - Successfully installed psutil 07:38:20 INFO - Cleaning up... 07:38:20 INFO - Return code: 0 07:38:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:20 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')]} 07:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:20 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')]} 07:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:20 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:20 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 07:38:20 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 07:38:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:20 INFO - 'HOME': '/Users/cltbld', 07:38:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:20 INFO - 'LOGNAME': 'cltbld', 07:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:20 INFO - 'MOZ_NO_REMOTE': '1', 07:38:20 INFO - 'NO_EM_RESTART': '1', 07:38:20 INFO - 'PAGER': '/bin/cat', 07:38:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:20 INFO - 'PWD': '/builds/slave/test', 07:38:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:20 INFO - 'SHELL': '/bin/bash', 07:38:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:20 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:20 INFO - 'USER': 'cltbld', 07:38:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:20 INFO - 'XPC_FLAGS': '0x0', 07:38:20 INFO - 'XPC_SERVICE_NAME': '0', 07:38:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:20 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 07:38:20 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 07:38:20 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 07:38:20 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 07:38:20 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 07:38:20 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 07:38:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:23 INFO - Installing collected packages: mozsystemmonitor 07:38:23 INFO - Running setup.py install for mozsystemmonitor 07:38:23 INFO - Successfully installed mozsystemmonitor 07:38:23 INFO - Cleaning up... 07:38:23 INFO - Return code: 0 07:38:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:23 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:23 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 07:38:23 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 07:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:23 INFO - 'HOME': '/Users/cltbld', 07:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:23 INFO - 'LOGNAME': 'cltbld', 07:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:23 INFO - 'MOZ_NO_REMOTE': '1', 07:38:23 INFO - 'NO_EM_RESTART': '1', 07:38:23 INFO - 'PAGER': '/bin/cat', 07:38:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:23 INFO - 'PWD': '/builds/slave/test', 07:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:23 INFO - 'SHELL': '/bin/bash', 07:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:23 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:23 INFO - 'USER': 'cltbld', 07:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:23 INFO - 'XPC_FLAGS': '0x0', 07:38:23 INFO - 'XPC_SERVICE_NAME': '0', 07:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 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 07:38:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:27 INFO - warning: no files found matching '*.txt' 07:38:27 INFO - no previously-included directories found matching 'build' 07:38:27 INFO - no previously-included directories found matching 'dist' 07:38:27 INFO - no previously-included directories found matching '.git*' 07:38:27 INFO - Installing collected packages: jsonschema, functools32 07:38:27 INFO - Running setup.py install for functools32 07:38:27 INFO - warning: no files found matching '*.txt' 07:38:27 INFO - no previously-included directories found matching 'build' 07:38:27 INFO - no previously-included directories found matching 'dist' 07:38:27 INFO - no previously-included directories found matching '.git*' 07:38:27 INFO - Successfully installed jsonschema functools32 07:38:27 INFO - Cleaning up... 07:38:27 INFO - Return code: 0 07:38:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:38:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:27 INFO - 'HOME': '/Users/cltbld', 07:38:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:27 INFO - 'LOGNAME': 'cltbld', 07:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:27 INFO - 'MOZ_NO_REMOTE': '1', 07:38:27 INFO - 'NO_EM_RESTART': '1', 07:38:27 INFO - 'PAGER': '/bin/cat', 07:38:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:27 INFO - 'PWD': '/builds/slave/test', 07:38:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:27 INFO - 'SHELL': '/bin/bash', 07:38:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:27 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:27 INFO - 'USER': 'cltbld', 07:38:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:27 INFO - 'XPC_FLAGS': '0x0', 07:38:27 INFO - 'XPC_SERVICE_NAME': '0', 07:38:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:27 INFO - Cleaning up... 07:38:27 INFO - Return code: 0 07:38:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:27 INFO - 'HOME': '/Users/cltbld', 07:38:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:27 INFO - 'LOGNAME': 'cltbld', 07:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:27 INFO - 'MOZ_NO_REMOTE': '1', 07:38:27 INFO - 'NO_EM_RESTART': '1', 07:38:27 INFO - 'PAGER': '/bin/cat', 07:38:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:27 INFO - 'PWD': '/builds/slave/test', 07:38:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:27 INFO - 'SHELL': '/bin/bash', 07:38:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:27 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:27 INFO - 'USER': 'cltbld', 07:38:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:27 INFO - 'XPC_FLAGS': '0x0', 07:38:27 INFO - 'XPC_SERVICE_NAME': '0', 07:38:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 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 07:38:31 INFO - Downloading docopt-0.6.1.tar.gz 07:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:31 INFO - Running setup.py install for blobuploader 07:38:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:31 INFO - Running setup.py install for requests 07:38:32 INFO - Running setup.py install for docopt 07:38:32 INFO - Successfully installed blobuploader requests docopt 07:38:32 INFO - Cleaning up... 07:38:32 INFO - Return code: 0 07:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:32 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:32 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 07:38:32 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 07:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:32 INFO - 'HOME': '/Users/cltbld', 07:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:32 INFO - 'LOGNAME': 'cltbld', 07:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:32 INFO - 'MOZ_NO_REMOTE': '1', 07:38:32 INFO - 'NO_EM_RESTART': '1', 07:38:32 INFO - 'PAGER': '/bin/cat', 07:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:32 INFO - 'PWD': '/builds/slave/test', 07:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:32 INFO - 'SHELL': '/bin/bash', 07:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:32 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:32 INFO - 'USER': 'cltbld', 07:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:32 INFO - 'XPC_FLAGS': '0x0', 07:38:32 INFO - 'XPC_SERVICE_NAME': '0', 07:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-DvoMk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-hVmBjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-w8KH2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-sxAMky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-zV3dCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-jVhycv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-iKvG65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-SUQw0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-AcDjYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:33 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-pc9WCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Ab5HPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-K8rBJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-egbap6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-uz_33s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-EIavW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-nzQe_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:34 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Pm7ozF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:34 INFO - Running setup.py install for manifestparser 07:38:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:34 INFO - Running setup.py install for mozcrash 07:38:35 INFO - Running setup.py install for mozdebug 07:38:35 INFO - Running setup.py install for mozdevice 07:38:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozfile 07:38:35 INFO - Running setup.py install for mozhttpd 07:38:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozinfo 07:38:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozInstall 07:38:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:35 INFO - Running setup.py install for mozleak 07:38:36 INFO - Running setup.py install for mozlog 07:38:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:36 INFO - Running setup.py install for moznetwork 07:38:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:36 INFO - Running setup.py install for mozprocess 07:38:36 INFO - Running setup.py install for mozprofile 07:38:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:36 INFO - Running setup.py install for mozrunner 07:38:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:36 INFO - Running setup.py install for mozscreenshot 07:38:37 INFO - Running setup.py install for moztest 07:38:37 INFO - Running setup.py install for mozversion 07:38:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:37 INFO - Cleaning up... 07:38:37 INFO - Return code: 0 07:38:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:37 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')]} 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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')]} 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:37 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 07:38:37 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 07:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:37 INFO - 'HOME': '/Users/cltbld', 07:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:37 INFO - 'LOGNAME': 'cltbld', 07:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:37 INFO - 'MOZ_NO_REMOTE': '1', 07:38:37 INFO - 'NO_EM_RESTART': '1', 07:38:37 INFO - 'PAGER': '/bin/cat', 07:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:37 INFO - 'PWD': '/builds/slave/test', 07:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:37 INFO - 'SHELL': '/bin/bash', 07:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:37 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:37 INFO - 'USER': 'cltbld', 07:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:37 INFO - 'XPC_FLAGS': '0x0', 07:38:37 INFO - 'XPC_SERVICE_NAME': '0', 07:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:37 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-RtfLrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:37 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-XO3S4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:37 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-PnG2Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:37 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)) 07:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:37 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-zuVMcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-wshPAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-1Mgke4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-geUSx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-_tEMkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Y3nSKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Mhn2Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Ai1h4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Hi2jJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:38 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-xaibHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:38 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)) 07:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:39 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-nP4nHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 07:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:39 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-lrrXtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:39 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)) 07:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:39 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-6ydwsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 07:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:39 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-h53s5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:39 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)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:39 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)) 07:38:39 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)) 07:38:39 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)) 07:38:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:39 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 07:38:39 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 07:38:39 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 07:38:39 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 07:38:39 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 07:38:39 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 07:38:42 INFO - Downloading blessings-1.6.tar.gz 07:38:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:42 INFO - Installing collected packages: blessings 07:38:42 INFO - Running setup.py install for blessings 07:38:42 INFO - Successfully installed blessings 07:38:42 INFO - Cleaning up... 07:38:42 INFO - Return code: 0 07:38:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:43 INFO - Reading from file tmpfile_stdout 07:38:43 INFO - Current package versions: 07:38:43 INFO - blessings == 1.6 07:38:43 INFO - blobuploader == 1.2.4 07:38:43 INFO - docopt == 0.6.1 07:38:43 INFO - functools32 == 3.2.3-2 07:38:43 INFO - jsonschema == 2.5.1 07:38:43 INFO - manifestparser == 1.1 07:38:43 INFO - mozInstall == 1.12 07:38:43 INFO - mozcrash == 1.0 07:38:43 INFO - mozdebug == 0.1 07:38:43 INFO - mozdevice == 0.48 07:38:43 INFO - mozfile == 1.2 07:38:43 INFO - mozhttpd == 0.7 07:38:43 INFO - mozinfo == 0.9 07:38:43 INFO - mozleak == 0.1 07:38:43 INFO - mozlog == 3.4 07:38:43 INFO - moznetwork == 0.27 07:38:43 INFO - mozprocess == 0.23 07:38:43 INFO - mozprofile == 0.28 07:38:43 INFO - mozrunner == 6.13 07:38:43 INFO - mozscreenshot == 0.1 07:38:43 INFO - mozsystemmonitor == 0.3 07:38:43 INFO - moztest == 0.8 07:38:43 INFO - mozversion == 1.4 07:38:43 INFO - psutil == 3.1.1 07:38:43 INFO - requests == 1.2.3 07:38:43 INFO - wsgiref == 0.1.2 07:38:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:43 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 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:43 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 07:38:43 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 07:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:43 INFO - 'HOME': '/Users/cltbld', 07:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:43 INFO - 'LOGNAME': 'cltbld', 07:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:43 INFO - 'MOZ_NO_REMOTE': '1', 07:38:43 INFO - 'NO_EM_RESTART': '1', 07:38:43 INFO - 'PAGER': '/bin/cat', 07:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:43 INFO - 'PWD': '/builds/slave/test', 07:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:43 INFO - 'SHELL': '/bin/bash', 07:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:43 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:43 INFO - 'USER': 'cltbld', 07:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:43 INFO - 'XPC_FLAGS': '0x0', 07:38:43 INFO - 'XPC_SERVICE_NAME': '0', 07:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 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)) 07:38:43 INFO - Cleaning up... 07:38:43 INFO - Return code: 0 07:38:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101731490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea59b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, '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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 07:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:43 INFO - 'HOME': '/Users/cltbld', 07:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:43 INFO - 'LOGNAME': 'cltbld', 07:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:43 INFO - 'MOZ_NO_REMOTE': '1', 07:38:43 INFO - 'NO_EM_RESTART': '1', 07:38:43 INFO - 'PAGER': '/bin/cat', 07:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:43 INFO - 'PWD': '/builds/slave/test', 07:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:43 INFO - 'SHELL': '/bin/bash', 07:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:38:43 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:43 INFO - 'USER': 'cltbld', 07:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:43 INFO - 'XPC_FLAGS': '0x0', 07:38:43 INFO - 'XPC_SERVICE_NAME': '0', 07:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:44 INFO - Cleaning up... 07:38:44 INFO - Return code: 0 07:38:44 INFO - Running post-action listener: _resource_record_post_action 07:38:44 INFO - Running post-action listener: _start_resource_monitoring 07:38:44 INFO - Starting resource monitoring. 07:38:44 INFO - [mozharness: 2017-02-10 15:38:44.059100Z] Finished create-virtualenv step (success) 07:38:44 INFO - [mozharness: 2017-02-10 15:38:44.060147Z] Running install step. 07:38:44 INFO - Running pre-action listener: _resource_record_pre_action 07:38:44 INFO - Running main action method: install 07:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:44 INFO - Reading from file tmpfile_stdout 07:38:44 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:44 INFO - Reading from file tmpfile_stdout 07:38:44 INFO - Output received: 07:38:44 INFO - Usage: mozinstall [options] installer 07:38:44 INFO - Options: 07:38:44 INFO - -h, --help show this help message and exit 07:38:44 INFO - -d DEST, --destination=DEST 07:38:44 INFO - Directory to install application into. [default: 07:38:44 INFO - "/builds/slave/test"] 07:38:44 INFO - --app=APP Application being installed. [default: firefox] 07:38:44 INFO - mkdir: /builds/slave/test/build/application 07:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:39:05 INFO - Reading from file tmpfile_stdout 07:39:05 INFO - Output received: 07:39:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:39:05 INFO - Running post-action listener: _resource_record_post_action 07:39:05 INFO - [mozharness: 2017-02-10 15:39:05.550558Z] Finished install step (success) 07:39:05 INFO - [mozharness: 2017-02-10 15:39:05.550693Z] Running run-tests step. 07:39:05 INFO - Running pre-action listener: _resource_record_pre_action 07:39:05 INFO - Running main action method: run_tests 07:39:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:39:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:39:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:39:05 INFO - 2017-02-10 07:39:05.565 screenresolution[1623:7330] starting screenresolution argv=screenresolution get 07:39:05 INFO - 2017-02-10 07:39:05.567 screenresolution[1623:7330] Display 0: 1600x1200x32@60 07:39:05 INFO - 2017-02-10 07:39:05.573 screenresolution[1624:7332] starting screenresolution argv=screenresolution list 07:39:05 INFO - Available Modes on Display 0 07:39:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:39:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:39:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:39:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:39:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:39:05 INFO - Intel Iris: 07:39:05 INFO - Chipset Model: Intel Iris 07:39:05 INFO - Type: GPU 07:39:05 INFO - Bus: Built-In 07:39:05 INFO - VRAM (Dynamic, Max): 1536 MB 07:39:05 INFO - Vendor: Intel (0x8086) 07:39:05 INFO - Device ID: 0x0a2e 07:39:05 INFO - Revision ID: 0x0009 07:39:05 INFO - Displays: 07:39:05 INFO - Display: 07:39:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:39:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:39:05 INFO - Display Serial Number: 1600x1200 60 07:39:05 INFO - Main Display: Yes 07:39:05 INFO - Mirror: Off 07:39:05 INFO - Online: Yes 07:39:05 INFO - Rotation: Supported 07:39:05 INFO - Return code: 0 07:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:05 INFO - Python 2.7.3 07:39:05 INFO - Return code: 0 07:39:05 INFO - grabbing minidump binary from tooltool 07:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:39:05 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 0x101545d30>, '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 0x1013abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10153db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:05 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 07:39:05 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 07:39:05 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 07:39:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:05 INFO - Return code: 0 07:39:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:39:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:39:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:05 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/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 07:39:05 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/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --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 07:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJgnuQZ8TY/Render', 07:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:05 INFO - 'HOME': '/Users/cltbld', 07:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:05 INFO - 'LOGNAME': 'cltbld', 07:39:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:05 INFO - 'MOZ_NO_REMOTE': '1', 07:39:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:05 INFO - 'NO_EM_RESTART': '1', 07:39:05 INFO - 'PAGER': '/bin/cat', 07:39:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:05 INFO - 'PWD': '/builds/slave/test', 07:39:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:05 INFO - 'SHELL': '/bin/bash', 07:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f1mCKmCJRu/Listeners', 07:39:05 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 07:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:05 INFO - 'USER': 'cltbld', 07:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:05 INFO - 'XPC_FLAGS': '0x0', 07:39:05 INFO - 'XPC_SERVICE_NAME': '0', 07:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:05 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/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 07:39:06 INFO - mozversion application_buildid: 20170210051622 07:39:06 INFO - mozversion application_changeset: dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac 07:39:06 INFO - mozversion application_display_name: Firefox 07:39:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:06 INFO - mozversion application_name: Firefox 07:39:06 INFO - mozversion application_remotingname: firefox 07:39:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:39:06 INFO - mozversion application_vendor: Mozilla 07:39:06 INFO - mozversion application_version: 52.0 07:39:06 INFO - mozversion platform_buildid: 20170210051622 07:39:06 INFO - mozversion platform_changeset: dd8a1f27c391b0669bd6890f7efe3c9efd35e7ac 07:39:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:39:06 INFO - mozversion platform_version: 52.0 07:39:06 INFO - using testdate: 1486741146 07:39:06 INFO - actual date: 1486741146 07:39:06 INFO - starting webserver on 'localhost:49243' 07:39:06 INFO - SUITE-START | Running 2 tests 07:39:06 INFO - TEST-START | dromaeo_css 07:39:06 INFO - operating with platform_type : mac_ 07:39:06 INFO - Initialising browser for dromaeo_css test... 07:39:06 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmptipGM7/profile http://localhost:49243/getInfo.html) 07:39:08 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 07:39:08 INFO - PROCESS | 1634 | colorDepth:24 07:39:08 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 07:39:08 INFO - PROCESS | 1634 | __metrics 07:39:08 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:39:08 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:39:09 INFO - TEST-INFO | 1634: exit 0 07:39:09 INFO - Browser initialized. 07:39:09 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:09 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmptipGM7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:21 INFO - PROCESS | 1637 | RSS: Main: 168022016 07:39:21 INFO - PROCESS | 1637 | 07:42:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:42:26 INFO - PROCESS | 1637 | RSS: Main: 316977152 07:42:26 INFO - PROCESS | 1637 | 07:45:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:45:30 INFO - PROCESS | 1637 | RSS: Main: 298491904 07:45:30 INFO - PROCESS | 1637 | 07:48:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:48:33 INFO - PROCESS | 1637 | RSS: Main: 272285696 07:48:33 INFO - PROCESS | 1637 | 07:51:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:51:35 INFO - PROCESS | 1637 | RSS: Main: 283398144 07:51:35 INFO - PROCESS | 1637 | 07:54:39 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 07:54:39 INFO - PROCESS | 1637 | RSS: Main: 257163264 07:54:39 INFO - PROCESS | 1637 | 07:57:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 07:57:43 INFO - PROCESS | 1637 | RSS: Main: 304726016 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | __start_tp_report 07:57:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 07:57:43 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 07:57:43 INFO - PROCESS | 1637 | |i|pagename|runs| 07:57:43 INFO - PROCESS | 1637 | |0;dojo.html;3557.8576856925724;3575.6960658344037;3578.320119177357;3594.8741794037214;3641.5812181599126;5946.464818166364;5958.761649534019;5984.072468767348;6000.609960352574;6016.669083200428;5972.820815375546;5999.610025348349;6010.609310394832;6037.245344331958;6060.878782424349;4381.671374646899;5205.687658740488;5274.789008439668;5295.20571914214;5344.599155063366;5255.343082114736;5315.468453154673;5411.648242864221;5427.9185812212845;5438.809641662542;4691.671582989192;5294.814681486148;5372.328458942632;5382.004329199091;5391.676499410048;5074.112030394703;5376.838694839161;5397.892042159174;5416.539594134503;5421.159720243369;5245.213218017328;5340.813071542478;5346.732663366855;5349.786008559653;5413.729313534347;5861.9741545229845;5871.324797648283;5901.203337549418;5905.936931352355;5928.555358348141;4875.463698993108;6187.535934804908;6219.720112594944;6241.438270555672;6248.4064013918605;6382.648954307511;6408.743650253984;6410.391012853772;6421.2615549211505;6429.967850160766;5919.171316015804;5975.701214939236;6054.182685337511;6113.938860611382;6153.907691384633;6487.318831522716;6569.67151642416;6581.967090164519;6582.736690532421;6591.472682185414;6245.250569931637;6256.562040657202;6259.217597800275;6267.968660156761;6276.372362763778;6151.96924015377;6201.96899015502;6218.129461875341;6334.081558174131;6370.522210834206;5159.819406320761;6256.936320825471;6259.217597800275;6260.686965651699;6266.122742816009;6154.630722156685;6223.875522489525;6232.3144454110015;6235.314115447297;6282.811515654537;5000.924986125211;5110.233464980209;5170.276161337416;5174.948250517522;5194.35070616173;4611.008633143891;4618.976905115453;4625.838095666635;4642.86071417858;4657.99853031593;6060.818175454743;6079.179310792986;6079.635221886701;6085.908711369245;6114.480269177081;5539;5961.880762384815;6245;6260.749570017239;6263.968680156661;6065.393460653988;6079.513638908877;6089.117078023662;6092.299385570627;6104.786332478342;5577.27495425592;5587.8603034923635;5598.552115830724;5611.915821262684;5614.6631202128;6532.8366790830605;6665.866682666319;6671.699773510204;6678.398944094957;6697.129373181455;6421.389967953224;6426.4537514311805;6435.646039467874;6436.67816609177;6491.188601424822;6435.4529864962005;6456.806295811133;6653;6672.866542669217;6683.43190828785;5138.280640710378;6187.381261873777;6229.283632382334;6269.780557680459;6325.430711236011;6419;6423.03654451836;6431.967840160956;6459.773907913201;6461.06314584392;5182.585393168612;6098.542609304409;6225.221847269091;6233.470155036873;6249.25008998923;5080.49195080489;6111.956402836337;6139.369480960641;6157.138000679998;6193.102000209854;6199.814005579839;6214.161088253209;6217.906731399123;6219.813405597839;6230.909590821679;6093.878122437615;6208.503319734501;6213.844653883689;6234;6240.500759939285;4806.375171227718;5992.43071908168;6138.693065346625;6150.692465376803;6162.044883043135 07:57:43 INFO - PROCESS | 1637 | |1;ext.html;465.34386515013824;507.70806786098;541.8509909774812;544.1484077418841;549.6701978812711;30314.090577282688;38289.85130446088;39500;39680.801595992016;41570.58429415705;41527;41853.79073104638;41978.37032444508;42003;42066.78966605163;7311.926880731205;9446.291528135383;9603.32776705631;9634.132928036475;9643.758906027335;8796.516191609458;11343.092552595772;11563.768724625503;11586.478608462598;11823.7635247295;11606.535738570446;11658.475368608391;11663.650090497298;11667.008304294146;11668.766624667502;11517.884821151807;11569.595064172714;11579.768404631945;11591.420428978518;11602.419879006058;11521.251118677259;11604.361760103191;11611.941940290244;11633.185677002613;11641;39134.60865391367;39343.21313573741;39358.606413935784;39361;39369.606303937166;3268.2319654881085;3390.423627983249;3793.1585358547804;3902.2975864344407;3923.038855480397;28951.131466056053;29394;29486.41027179466;30373.088807335593;31256.531152032738;3241.4003409369343;3248.675132486756;3334.9666503334897;3378.2905589826164;3413.7951722896705;488252;490976;491054;492190;493216.5339173281;58768.53078673068;59296.11055834166;59350;59394;59403;61766.382336176066;62045.75908481805;62071;62077;62081.68959155175;16259.83740162607;16376.590585235464;16408.26162822676;16473.83526164723;16555.751663725056;11639.301641901513;12057.336846473352;12059;12573.245605263714;12888.871111288767;11724;14309.35607897647;14318.427262909367;16659.009698826016;20790.48023799387;8172.468789528662;8337.374696897758;8374.53940033304;8398.454100483448;8402.151526664124;822.4201937633953;871.4292138649195;970.9126178643955;1062.5643486170634;1084.2464487181492;29586.260343491584;30046.699533004827;30047.849760751495;30061.699383006326;30846.383072338427;1010.0959641121156;1043.2697112021615;1068.4924660786064;1078.4392116099584;1143.634037108134;15469.767953480481;15484.30320635574;15549.766753498707;15736.134512601917;15792.448900657495;646787.7660611761;651415;651801;652722;654457.7277113583;57921.55196120131;58425;58437.5390615238;58506.707466462394;58671.70664146652;1252.555342853274;1292.7608392447428;1344.2002008804745;1367.9658008549666;1399.3912647998154;29074.854625726737;31335.05994820159;31472;32095.679043209268;32173.873914412885;48708;55325;59625.70187149037;59763.1035534476;59825.10262346156;637512;643168;644128;644152.7792361008;644346;36719.63280367269;37197.6280237205;37279.81360093182;39802.40296395614;43622.781886090364;43437.782811085744;45064;46252.53747462482;47382.76308618435;47910.20897910181;34577.654223457444;37976.430353544165;38060.42909356306;39179;40305.1938961225;35599.64400355963;37767.92276424823;38672.552656443746;39010.2197956045;39243.60756392399;37322.253554928204;38213.61786382212;38290;38675.806620966716;38860.6113938857;33705.494417583264;34556.82721586376;35143.82428087945;35235.94292171239;35434;23723.288301350985;24567.877160614797;25396.984120634967;25619;25671.614925776503 07:57:43 INFO - PROCESS | 1637 | |2;jquery.html;372.9421939599362;378.6327262555322;385.9980700096499;391.237087679026;406.1065655557772;18539.814601853977;19961.401157965283;20953.580928381423;21206.787932120675;21232.2568710095;19420.320288789895;19660.508487287825;20080.196792128332;20257.088431020602;20439.59120817583;5735.455131762496;5741.569382296324;6021.367756385582;6032.819015429523;6086.117512960618;5947.791827286046;6042.546808989321;6052.515798736113;6055.061465472859;6078.331383547807;5758.683272420015;6009.5192384609345;6046.244219472566;6087.573869829113;6158.322584515722;5874;5998.520118390518;6024.337322894522;6039.1243269725865;6044.848878778022;5876;5939.07944268639;5939.67331796751;5940.6435613863305;5942.197803296586;12140.028797696252;12307.93846030773;24207.878960605085;24547.754522454725;25135.120270790434;2119.9152033918626;2211.6682497625325;2264.3207037888733;2696.3528753099313;2754.325190328362;9940.66394397316;9975.351602145838;9999.600015999351;10469.162467002621;10519.94740026295;1857.229249861306;1950.4051264364364;1961.6665166921514;1968.2619017868299;1978.3075923426686;120544.39727801393;123657.38171309086;126002.73997260001;128137;130822.03766943504;11306.886931130748;11593.188476806712;11613.245139066103;11622.244554103956;11784.234024788362;14884.181370024753;14905.031172973722;14906.925465372604;14927.40290388394;14936.925315373353;6686.899696504556;8583.207284159247;8637.0499245083;8781.121887811296;8836.690715824916;6837.35045170708;8560.443571167854;8594.785130371665;8639.395242332976;8674.655428408607;4513.819447222074;4586.518415566385;4607.539246075433;4624.907501849944;4741.739204343725;1648.250046228963;1887.4337698690338;1949.0741897598527;1961.3233434465087;1962.685970244754;840.3949156607233;875.3391189651772;920.0661328751323;945.9006804285451;957.0190554681507;19630.073985203016;20849.79150208509;21064.368068957956;21109.472263193544;21340.93295335258;894.0242065036342;903.7347713201439;921.3412410126791;925.6809047107845;992.573193526776;8528.829423411496;9753.902460975441;10391.428471434143;11124.888751112547;11207.327560346404;600559;605475;617244;622012;623424;69340.65329673319;118637;120894;122894;124650;928.9396189247813;942.3309450290234;963.2149797914677;981.9459929703935;982.9754256143653;17505.474835754947;17782.733259001383;18561;18586.69094998545;18774.53063673419;52499;54151.18773218484;54160.45839541712;54204.457955419944;55001.72499137479;55791.44208557862;57602;73929;75757;76155;7701.229877012254;7880.960595196987;7921.841563168589;8273.379496537664;8274.793130171553;9511.762205944906;12353.135280530636;12481.188722732993;12569.874301257236;12907.741845163231;10516.474176291307;10721.946390267998;10727.785444290914;10970.122390208604;11192.440377981231;10716.35701857891;10733.516991735234;10972.945135274273;11112.333260004425;11206.607768728056;10919.563217471212;11128.443577820915;11175.497102630563;11179.66461006171;11357.261777984404;8069.87895181561;8144.511329320259;8202.302804261704;8275.420720549504;8443.197896199852;9802.460864652512;9891.752706182404;9919.355241909252;10138.746531336776;10618.256722029384 07:57:43 INFO - PROCESS | 1637 | |3;mootools.html;1242.173954320377;1471.632091977006;1484.0279616850962;1667.1830802906572;1849.694800357941;6806.557573757708;7358.300961408664;7899.052113746351;8422.36832237583;8451.57742112895;8310.626021829017;8379.497230166178;8397.91602083979;8415.242628163463;8426.91573084269;2356.422676444269;2405.9518809623796;2408.8434251773665;2410.216679579135;2417.0452671194867;2382.821288403368;2424.6847909771705;2426.805855531562;2426.842255253403;2429.757024297565;2361.527694461106;2361.9409514762096;2387.55830171418;2389.223502361731;2393.2461274698503;2327.4995875886766;2335.976640233593;2358.858468491896;2368.9813380246487;2371.5256948610177;2363.1847012780563;2377.6314671225987;2401.0635852017726;2401.7117945846435;2405.434722840131;8303.377246706521;8386.245237928615;8392.622331995075;8393.916060839374;8422.536760478171;5038.269450929632;5039.395272567279;5194.168932970744;5195.610329225286;5212.765425555859;3555.235624340779;3635.9636403636155;3646.6171052039417;3653.8173091345325;3659.2132691471197;1034.6947650443137;1068.1027936533271;1088.4938503595865;1093.2565855218527;1098.2531878322736;10816;10877;10901.509432075576;10902.96421839916;10920.781584368347;4374.737515749065;4492.618127459137;4533.546645335506;4539.614132798749;4546.204414227497;8660.783480412914;8661.350398719995;8669.00306464752;8678.609462574199;8689.17452841979;5016.598672106223;5086.643934924594;5091.414487334004;5110.9488905110475;5126.974365128151;4052.65552428041;4189.853355132555;4761.381020467386;4797.832075877328;4806.990531988322;3683.650053244937;3697.6487233712755;3766.114962983697;3802.08749900022;3802.1065049713297;981.9312648114707;1144.8168293073068;1153.3080151908787;1155.641751057175;1166.1836714300025;876.2332958661171;878.5519385113511;885.172363839799;903.2277402820625;915.2677857713802;5147.408048074444;5167.689938603696;5399.811006614828;5563.944360556424;5601.683604352974;375.9906002349963;418.6044188242143;434.42655694482977;440.10219152928306;450.27056169005766;3615.837287322077;3656.524651795303;3772.1135533149686;3779.5464544254864;3781.4516895050065;9170.358074934691;9401.764955876159;9950;10078.949605251926;10106.646267380607;8308.750737477885;10031.99680031991;10033.548490317953;10038.297319187586;10043.69868903934;7501.437392195608;7802.98561187042;7886.171951945078;7895.01312335958;7900.170482099412;4455.866324010285;5242.16125419931;5359.973200133974;5380.623356365017;5466.617336786387;9123.817523649623;9263.861042084509;9326.487043212417;9342.392744471588;9343.065693430603;9444.95277523608;9511.381760185566;9578.952105239428;9632.75918102053;9642.035796420301;7009.2990700929495;7020.227774944854;7168.784936451915;7283.963580182065;7372.299631534996;7981.800454988672;8019.6391162398995;8063.35493160534;8071.394645401501;8077.5961201940845;7191.280871912767;7240.312170343809;7250.238724934017;7299.5620262784405;7370.262973702587;7030.507864449644;7089.716411343488;7094.042304289062;7098.964505177441;7162.997180394645;6692.1969363674725;6807.455403567604;6814.591124532544;6823.55646882951;6828.317168283132;4691.671582989158;4767.404074490689;4773.403324584427;4790.592799612072;4812.35033270504;4766.165920963748;4826.251930950708;4827.372441582572;4921.384826896638;4964.578010869117 07:57:43 INFO - PROCESS | 1637 | |4;prototype.html;303.6583843176428;310.2414596312017;318.2632206442086;323.0051441559994;324.9447593909035;5212.322398088253;5330.307060082188;5333.733313334337;5390.1106317457625;5408.889244174431;5255.605829562779;5279.4984476474765;5281.788728450857;5286.259923610688;5298.36419629645;3306.041248038066;3548.7338449616254;3926.8232929518167;4066.4103704962763;4090.89772755682;3871.748336358142;3981.9004524886964;4097.282975479294;4099.856505022325;4110.0752330725645;3694.667479926806;3809.466674665549;3976.369688427745;3984.780837053961;4061.918761624766;3280.721138703213;3943.526776786804;4009.3184158692948;4021.5777343378963;4041.757494550307;2829.2361062513005;3201.191326900317;3438.054535002869;3550.230819960435;3558.733095017858;4567.657425693086;5128.230765385185;5245.737713114329;5255.109689670666;5320.5900436384;4064.4512990746166;4391.9020244938765;4628.375169352128;4651.813927442899;4655.394798676184;4975.601951843843;5369.516743493065;5384.569234461273;5542.861428464321;5649.802256921029;3187.553742476055;3792.412176112707;3910.6284902934176;3944.3294639911283;3944.408338749182;4431.689781715281;5282.781231882618;5627.971860140714;5788.247527821356;5840.984860223216;3321.6014078310272;3606.062423769839;3872.651461368434;3962.405639154092;3969.186316805048;3493.615702272748;3664.4320130379833;3773.207826208586;4060.7563546187325;4070.75575465473;3598.7300952428673;3736.4208547675153;4525.117602067631;4562.5665561771575;4628.5371462853445;4647.419072615923;5427.638977044998;5568.19033814004;5575.898053281202;5592.412796656374;1233.0382301804607;1245.769532636465;1266.512392728806;1272.6754677557165;1330.1952318846959;780.3406121827047;834.0783434305006;890.8530092534788;918.5774543709969;938.6714649872627;4549.203889319356;4566.086782643484;4888.413390393175;4901.583365413909;4907.852764417074;4535.63714902807;5440.646357986719;5446.183072539072;5450.264214331015;5454.53636440899;4401.261501706808;4943.9258411123865;4944.208926571803;4967.751612419437;5284.9471505284455;2652.58884872845;2837.758790502789;2865.0231340375076;2877.309445733009;2884.298264024194;5079.2888995539915;5673.943260567424;5727.856803579861;5738.364566098642;5750.38357547315;5282.603804714662;5469.890602188014;5842.844863773515;5919.4968427684125;5932.309291851801;5990.5622650563555;6003.907987386587;6009.519238460913;6009.8532012910955;6012.849678758066;4761.761911904322;5001.749912504288;5618.2415373924;5768.836686242659;5773.220615216892;4904.166291730486;5625.324961004706;5687.971560142173;5709.857253568694;5722.370539240597;4875.634327425386;5732.885342293047;5769.8557536061935;5900.645961242168;5904.61619994699;3866.737958294429;4012.839486420627;4014.9397759034223;4024;4033.435319055276;4201.159768046464;5303.43548653156;5432.755526001419;5694.715264236855;5707.5433965281845;5518.888428121076;5544.889102218014;5551.583631227593;5570.91643625354;5580.414056524007;5264.394594621514;5275.366955965155;5463.590230732791;5534.972325138509;5548.583856210719;4687.039156972744;5124.590032797293;5385.757640906247;5391.379991300893;5471.343438787371;5540.22436858832;5553.945040335102;5567.415421380859;5571.247881535941;5577.776888924398;4533.682642215013;5360.865978350573;5489.780408783764;5497.972510137423;5528 07:57:43 INFO - PROCESS | 1637 | |5;yui.html;712.7077898061794;794.6463823598501;795.5624406576378;803.437593684421;808.8665370213915;14299.285035748224;15283.159426231552;15382.230888455588;16351.509454716377;16960.83039169608;15231.162286074261;15603;15873;15888.602784930383;15908.045517268973;807.5639154856385;841.3479553346144;843.9957800211021;844.3498506150261;844.4595458906305;666.8799616069106;689.3623398356525;852.4885068958606;855.5850412549909;856.2379482260761;739.9593022383767;854.8247609240091;881.0616693221698;881.2553392383426;883.2801266967433;664.445188267797;846.6697987784769;846.8814365988767;847.7287268074218;847.8389106069858;628.6416742456802;629.0972454527767;629.3674856768918;630.483003936772;630.4893036640336;11790.233634813796;14033.859661403358;14352.56942291733;14415.495457659037;14417;13043.543475978295;13085.738285234338;13113.737725245537;13196.6700832479;13203.735925281537;12116.697082572919;12422.689432764162;12537.623871283784;12672.619821405373;12690.492380304777;3744.756590821588;3768;3871.1096447816876;4451.132029254297;4454.443194600675;80829.19170808276;82218.58890705567;82954.58522707348;83479.74780378299;84097.15902841015;10562.20783441245;10623.946880265548;10640.042396184226;10825.458727063615;10858.67423977282;20481.078351474218;20605.587888242153;20616.69074963877;20656.07047682858;20914;7543.358814500829;7754.612269386508;7963.203679631991;8154.266116049584;8182.4681395709085;3606.711463082947;4440.7335559866515;4452.844150454784;4468.865934021985;4544.454665440102;2966;3109.4092122496654;3118.1113382685826;3134.717875391226;3138.3880143371825;660.904168895517;693.3032302535919;697.6267696782197;702.8664553734774;704.7533363322796;585.3356440440131;597.6910565860751;609.7469550136732;629.329763801559;650.9544331896816;7794.259545343183;9150.954245228864;9360.251179905592;9519.333646644807;9579.521023948775;564.5483613109578;614.9262088549402;618.913352130702;626.6803929995735;639.4724352409281;4547.840825571089;4576.771161441915;4589.632829373642;4591.449026116888;4596.149712303235;107558;107773;109519.45240273747;110915.44542277398;112048;93723.53138234265;96284.51857740666;97025;97426;98321;82497.58751206326;85143.57428212943;87637.56181219181;87661;88308;8598.828023439371;8924.732258032269;8931.464112153291;8984.505852177932;9117.90882091197;48555;55080.449195507535;55736.885262295335;56334.43665563292;56356.154657680985;51828.48171518387;60837.78324433575;63442.68278658577;72356;72649.63675181591;12332.260064396165;12347.814782778087;12394;12475.251484910934;12688.6827829305;13503.729925401634;14387.920905932306;14518.927405362905;14774.926125369304;15249.542513724606;11252.66242012741;12781.8082728761;13071.803922941353;13716.493841706313;14325.283735813377;13501.729965400833;13581.728365432438;13589.456421743414;13628.727425451634;13676.521321753691;12910.612681619567;12918.935405322913;13105;13227.603171904859;13339.466421343037;8795.944486661641;10473.633422830164;10592.89407105919;10830.458477076272;11099.833502497631;11392.202545822045;11399.373034482851;11409.201355905006;11591.826122608;11703.180777345504 07:57:43 INFO - PROCESS | 1637 | __end_tp_report 07:57:43 INFO - PROCESS | 1637 | __start_cc_report 07:57:43 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1448 07:57:43 INFO - PROCESS | 1637 | __end_cc_report 07:57:43 INFO - PROCESS | 1637 | __startTimestamp1486742263098__endTimestamp 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | ------- Summary: start ------- 07:57:43 INFO - PROCESS | 1637 | Number of tests: 6 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5864.60 Median:6104.79 stddev:660.55 (10.8%) stddev-sans-first:637.31 07:57:43 INFO - PROCESS | 1637 | Values: 3557.9 3575.7 3578.3 3594.9 3641.6 5946.5 5958.8 5984.1 6000.6 6016.7 5972.8 5999.6 6010.6 6037.2 6060.9 4381.7 5205.7 5274.8 5295.2 5344.6 5255.3 5315.5 5411.6 5427.9 5438.8 4691.7 5294.8 5372.3 5382.0 5391.7 5074.1 5376.8 5397.9 5416.5 5421.2 5245.2 5340.8 5346.7 5349.8 5413.7 5862.0 5871.3 5901.2 5905.9 5928.6 4875.5 6187.5 6219.7 6241.4 6248.4 6382.6 6408.7 6410.4 6421.3 6430.0 5919.2 5975.7 6054.2 6113.9 6153.9 6487.3 6569.7 6582.0 6582.7 6591.5 6245.3 6256.6 6259.2 6268.0 6276.4 6152.0 6202.0 6218.1 6334.1 6370.5 5159.8 6256.9 6259.2 6260.7 6266.1 6154.6 6223.9 6232.3 6235.3 6282.8 5000.9 5110.2 5170.3 5174.9 5194.4 4611.0 4619.0 4625.8 4642.9 4658.0 6060.8 6079.2 6079.6 6085.9 6114.5 5539.0 5961.9 6245.0 6260.7 6264.0 6065.4 6079.5 6089.1 6092.3 6104.8 5577.3 5587.9 5598.6 5611.9 5614.7 6532.8 6665.9 6671.7 6678.4 6697.1 6421.4 6426.5 6435.6 6436.7 6491.2 6435.5 6456.8 6653.0 6672.9 6683.4 5138.3 6187.4 6229.3 6269.8 6325.4 6419.0 6423.0 6432.0 6459.8 6461.1 5182.6 6098.5 6225.2 6233.5 6249.3 5080.5 6112.0 6139.4 6157.1 6193.1 6199.8 6214.2 6217.9 6219.8 6230.9 6093.9 6208.5 6213.8 6234.0 6240.5 4806.4 5992.4 6138.7 6150.7 6162.0 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:72914.95 Median:20780.54 stddev:160324.92 (771.5%) stddev-sans-first:160682.39 07:57:43 INFO - PROCESS | 1637 | Values: 465.3 507.7 541.9 544.1 549.7 30314.1 38289.9 39500.0 39680.8 41570.6 41527.0 41853.8 41978.4 42003.0 42066.8 7311.9 9446.3 9603.3 9634.1 9643.8 8796.5 11343.1 11563.8 11586.5 11823.8 11606.5 11658.5 11663.7 11667.0 11668.8 11517.9 11569.6 11579.8 11591.4 11602.4 11521.3 11604.4 11611.9 11633.2 11641.0 39134.6 39343.2 39358.6 39361.0 39369.6 3268.2 3390.4 3793.2 3902.3 3923.0 28951.1 29394.0 29486.4 30373.1 31256.5 3241.4 3248.7 3335.0 3378.3 3413.8 488252.0 490976.0 491054.0 492190.0 493216.5 58768.5 59296.1 59350.0 59394.0 59403.0 61766.4 62045.8 62071.0 62077.0 62081.7 16259.8 16376.6 16408.3 16473.8 16555.8 11639.3 12057.3 12059.0 12573.2 12888.9 11724.0 14309.4 14318.4 16659.0 20790.5 8172.5 8337.4 8374.5 8398.5 8402.2 822.4 871.4 970.9 1062.6 1084.2 29586.3 30046.7 30047.8 30061.7 30846.4 1010.1 1043.3 1068.5 1078.4 1143.6 15469.8 15484.3 15549.8 15736.1 15792.4 646787.8 651415.0 651801.0 652722.0 654457.7 57921.6 58425.0 58437.5 58506.7 58671.7 1252.6 1292.8 1344.2 1368.0 1399.4 29074.9 31335.1 31472.0 32095.7 32173.9 48708.0 55325.0 59625.7 59763.1 59825.1 637512.0 643168.0 644128.0 644152.8 644346.0 36719.6 37197.6 37279.8 39802.4 43622.8 43437.8 45064.0 46252.5 47382.8 47910.2 34577.7 37976.4 38060.4 39179.0 40305.2 35599.6 37767.9 38672.6 39010.2 39243.6 37322.3 38213.6 38290.0 38675.8 38860.6 33705.5 34556.8 35143.8 35235.9 35434.0 23723.3 24567.9 25397.0 25619.0 25671.6 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:34731.69 Median:4550.17 stddev:102111.79 (2244.1%) stddev-sans-first:102365.64 07:57:43 INFO - PROCESS | 1637 | Values: 372.9 378.6 386.0 391.2 406.1 18539.8 19961.4 20953.6 21206.8 21232.3 19420.3 19660.5 20080.2 20257.1 20439.6 5735.5 5741.6 6021.4 6032.8 6086.1 5947.8 6042.5 6052.5 6055.1 6078.3 5758.7 6009.5 6046.2 6087.6 6158.3 5874.0 5998.5 6024.3 6039.1 6044.8 5876.0 5939.1 5939.7 5940.6 5942.2 12140.0 12307.9 24207.9 24547.8 25135.1 2119.9 2211.7 2264.3 2696.4 2754.3 9940.7 9975.4 9999.6 10469.2 10519.9 1857.2 1950.4 1961.7 1968.3 1978.3 120544.4 123657.4 126002.7 128137.0 130822.0 11306.9 11593.2 11613.2 11622.2 11784.2 14884.2 14905.0 14906.9 14927.4 14936.9 6686.9 8583.2 8637.0 8781.1 8836.7 6837.4 8560.4 8594.8 8639.4 8674.7 4513.8 4586.5 4607.5 4624.9 4741.7 1648.3 1887.4 1949.1 1961.3 1962.7 840.4 875.3 920.1 945.9 957.0 19630.1 20849.8 21064.4 21109.5 21340.9 894.0 903.7 921.3 925.7 992.6 8528.8 9753.9 10391.4 11124.9 11207.3 600559.0 605475.0 617244.0 622012.0 623424.0 69340.7 118637.0 120894.0 122894.0 124650.0 928.9 942.3 963.2 981.9 983.0 17505.5 17782.7 18561.0 18586.7 18774.5 52499.0 54151.2 54160.5 54204.5 55001.7 55791.4 57602.0 73929.0 75757.0 76155.0 7701.2 7881.0 7921.8 8273.4 8274.8 9511.8 12353.1 12481.2 12569.9 12907.7 10516.5 10721.9 10727.8 10970.1 11192.4 10716.4 10733.5 10972.9 11112.3 11206.6 10919.6 11128.4 11175.5 11179.7 11357.3 8069.9 8144.5 8202.3 8275.4 8443.2 9802.5 9891.8 9919.4 10138.7 10618.3 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5391.00 Median:4990.59 stddev:2957.09 (59.3%) stddev-sans-first:2948.94 07:57:43 INFO - PROCESS | 1637 | Values: 1242.2 1471.6 1484.0 1667.2 1849.7 6806.6 7358.3 7899.1 8422.4 8451.6 8310.6 8379.5 8397.9 8415.2 8426.9 2356.4 2406.0 2408.8 2410.2 2417.0 2382.8 2424.7 2426.8 2426.8 2429.8 2361.5 2361.9 2387.6 2389.2 2393.2 2327.5 2336.0 2358.9 2369.0 2371.5 2363.2 2377.6 2401.1 2401.7 2405.4 8303.4 8386.2 8392.6 8393.9 8422.5 5038.3 5039.4 5194.2 5195.6 5212.8 3555.2 3636.0 3646.6 3653.8 3659.2 1034.7 1068.1 1088.5 1093.3 1098.3 10816.0 10877.0 10901.5 10903.0 10920.8 4374.7 4492.6 4533.5 4539.6 4546.2 8660.8 8661.4 8669.0 8678.6 8689.2 5016.6 5086.6 5091.4 5110.9 5127.0 4052.7 4189.9 4761.4 4797.8 4807.0 3683.7 3697.6 3766.1 3802.1 3802.1 981.9 1144.8 1153.3 1155.6 1166.2 876.2 878.6 885.2 903.2 915.3 5147.4 5167.7 5399.8 5563.9 5601.7 376.0 418.6 434.4 440.1 450.3 3615.8 3656.5 3772.1 3779.5 3781.5 9170.4 9401.8 9950.0 10078.9 10106.6 8308.8 10032.0 10033.5 10038.3 10043.7 7501.4 7803.0 7886.2 7895.0 7900.2 4455.9 5242.2 5360.0 5380.6 5466.6 9123.8 9263.9 9326.5 9342.4 9343.1 9445.0 9511.4 9579.0 9632.8 9642.0 7009.3 7020.2 7168.8 7284.0 7372.3 7981.8 8019.6 8063.4 8071.4 8077.6 7191.3 7240.3 7250.2 7299.6 7370.3 7030.5 7089.7 7094.0 7099.0 7163.0 6692.2 6807.5 6814.6 6823.6 6828.3 4691.7 4767.4 4773.4 4790.6 4812.4 4766.2 4826.3 4827.4 4921.4 4964.6 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4475.20 Median:5040.52 stddev:1388.05 (27.5%) stddev-sans-first:1356.17 07:57:43 INFO - PROCESS | 1637 | Values: 303.7 310.2 318.3 323.0 324.9 5212.3 5330.3 5333.7 5390.1 5408.9 5255.6 5279.5 5281.8 5286.3 5298.4 3306.0 3548.7 3926.8 4066.4 4090.9 3871.7 3981.9 4097.3 4099.9 4110.1 3694.7 3809.5 3976.4 3984.8 4061.9 3280.7 3943.5 4009.3 4021.6 4041.8 2829.2 3201.2 3438.1 3550.2 3558.7 4567.7 5128.2 5245.7 5255.1 5320.6 4064.5 4391.9 4628.4 4651.8 4655.4 4975.6 5369.5 5384.6 5542.9 5649.8 3187.6 3792.4 3910.6 3944.3 3944.4 4431.7 5282.8 5628.0 5788.2 5841.0 3321.6 3606.1 3872.7 3962.4 3969.2 3493.6 3664.4 3773.2 4060.8 4070.8 3598.7 3736.4 4525.1 4562.6 4628.5 4647.4 5427.6 5568.2 5575.9 5592.4 1233.0 1245.8 1266.5 1272.7 1330.2 780.3 834.1 890.9 918.6 938.7 4549.2 4566.1 4888.4 4901.6 4907.9 4535.6 5440.6 5446.2 5450.3 5454.5 4401.3 4943.9 4944.2 4967.8 5284.9 2652.6 2837.8 2865.0 2877.3 2884.3 5079.3 5673.9 5727.9 5738.4 5750.4 5282.6 5469.9 5842.8 5919.5 5932.3 5990.6 6003.9 6009.5 6009.9 6012.8 4761.8 5001.7 5618.2 5768.8 5773.2 4904.2 5625.3 5688.0 5709.9 5722.4 4875.6 5732.9 5769.9 5900.6 5904.6 3866.7 4012.8 4014.9 4024.0 4033.4 4201.2 5303.4 5432.8 5694.7 5707.5 5518.9 5544.9 5551.6 5570.9 5580.4 5264.4 5275.4 5463.6 5535.0 5548.6 4687.0 5124.6 5385.8 5391.4 5471.3 5540.2 5553.9 5567.4 5571.2 5577.8 4533.7 5360.9 5489.8 5498.0 5528.0 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20359.07 Median:4583.20 stddev:29347.90 (640.3%) stddev-sans-first:29393.15 07:57:43 INFO - PROCESS | 1637 | Values: 712.7 794.6 795.6 803.4 808.9 14299.3 15283.2 15382.2 16351.5 16960.8 15231.2 15603.0 15873.0 15888.6 15908.0 807.6 841.3 844.0 844.3 844.5 666.9 689.4 852.5 855.6 856.2 740.0 854.8 881.1 881.3 883.3 664.4 846.7 846.9 847.7 847.8 628.6 629.1 629.4 630.5 630.5 11790.2 14033.9 14352.6 14415.5 14417.0 13043.5 13085.7 13113.7 13196.7 13203.7 12116.7 12422.7 12537.6 12672.6 12690.5 3744.8 3768.0 3871.1 4451.1 4454.4 80829.2 82218.6 82954.6 83479.7 84097.2 10562.2 10623.9 10640.0 10825.5 10858.7 20481.1 20605.6 20616.7 20656.1 20914.0 7543.4 7754.6 7963.2 8154.3 8182.5 3606.7 4440.7 4452.8 4468.9 4544.5 2966.0 3109.4 3118.1 3134.7 3138.4 660.9 693.3 697.6 702.9 704.8 585.3 597.7 609.7 629.3 651.0 7794.3 9151.0 9360.3 9519.3 9579.5 564.5 614.9 618.9 626.7 639.5 4547.8 4576.8 4589.6 4591.4 4596.1 107558.0 107773.0 109519.5 110915.4 112048.0 93723.5 96284.5 97025.0 97426.0 98321.0 82497.6 85143.6 87637.6 87661.0 88308.0 8598.8 8924.7 8931.5 8984.5 9117.9 48555.0 55080.4 55736.9 56334.4 56356.2 51828.5 60837.8 63442.7 72356.0 72649.6 12332.3 12347.8 12394.0 12475.3 12688.7 13503.7 14387.9 14518.9 14774.9 15249.5 11252.7 12781.8 13071.8 13716.5 14325.3 13501.7 13581.7 13589.5 13628.7 13676.5 12910.6 12918.9 13105.0 13227.6 13339.5 8795.9 10473.6 10592.9 10830.5 11099.8 11392.2 11399.4 11409.2 11591.8 11703.2 07:57:43 INFO - PROCESS | 1637 | -------- Summary: end -------- 07:57:43 INFO - PROCESS | 1637 | 07:57:43 INFO - TEST-INFO | 1637: exit 0 07:57:43 INFO - TEST-OK | dromaeo_css | took 1117568ms 07:57:43 INFO - TEST-START | kraken 07:57:43 INFO - operating with platform_type : mac_ 07:57:43 INFO - Initialising browser for kraken test... 07:57:43 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpEF2lAC/profile http://localhost:49243/getInfo.html) 07:57:46 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 07:57:46 INFO - PROCESS | 1649 | colorDepth:24 07:57:46 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 07:57:46 INFO - PROCESS | 1649 | __metrics 07:57:46 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:46 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:46 INFO - TEST-INFO | 1649: exit 0 07:57:46 INFO - Browser initialized. 07:57:46 INFO - Running cycle 1/1 for kraken test... 07:57:46 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpEF2lAC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:59 INFO - PROCESS | 1651 | RSS: Main: 167792640 07:57:59 INFO - PROCESS | 1651 | 07:58:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:02 INFO - PROCESS | 1651 | RSS: Main: 218062848 07:58:02 INFO - PROCESS | 1651 | 07:58:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 07:58:06 INFO - PROCESS | 1651 | RSS: Main: 232128512 07:58:06 INFO - PROCESS | 1651 | 07:58:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 07:58:10 INFO - PROCESS | 1651 | RSS: Main: 329416704 07:58:10 INFO - PROCESS | 1651 | 07:58:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 07:58:12 INFO - PROCESS | 1651 | RSS: Main: 232792064 07:58:12 INFO - PROCESS | 1651 | 07:58:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:15 INFO - PROCESS | 1651 | RSS: Main: 233992192 07:58:15 INFO - PROCESS | 1651 | 07:58:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:18 INFO - PROCESS | 1651 | RSS: Main: 275402752 07:58:18 INFO - PROCESS | 1651 | 07:58:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:22 INFO - PROCESS | 1651 | RSS: Main: 274452480 07:58:22 INFO - PROCESS | 1651 | 07:58:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 07:58:25 INFO - PROCESS | 1651 | RSS: Main: 271736832 07:58:25 INFO - PROCESS | 1651 | 07:58:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:27 INFO - PROCESS | 1651 | RSS: Main: 246652928 07:58:27 INFO - PROCESS | 1651 | 07:58:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:30 INFO - PROCESS | 1651 | RSS: Main: 250548224 07:58:30 INFO - PROCESS | 1651 | 07:58:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:32 INFO - PROCESS | 1651 | RSS: Main: 252088320 07:58:32 INFO - PROCESS | 1651 | 07:58:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:36 INFO - PROCESS | 1651 | RSS: Main: 270331904 07:58:36 INFO - PROCESS | 1651 | 07:58:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:39 INFO - PROCESS | 1651 | RSS: Main: 264192000 07:58:39 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 07:58:41 INFO - PROCESS | 1651 | RSS: Main: 308056064 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | __start_tp_report 07:58:41 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 07:58:41 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 07:58:41 INFO - PROCESS | 1651 | |i|pagename|runs| 07:58:41 INFO - PROCESS | 1651 | |0;ai-astar;101;112;113;110;114;113;108;107;114;113 07:58:41 INFO - PROCESS | 1651 | |1;audio-beat-detection;150;132;141;156;111;133;137;90;176;138 07:58:41 INFO - PROCESS | 1651 | |2;audio-dft;182;179;182;180;181;181;180;180;180;182 07:58:41 INFO - PROCESS | 1651 | |3;audio-fft;81;59;58;87;59;58;58;59;81;57 07:58:41 INFO - PROCESS | 1651 | |4;audio-oscillator;88;69;92;69;68;67;88;67;68;91 07:58:41 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;85;84;108;83;85;82;85;84;86;83 07:58:41 INFO - PROCESS | 1651 | |6;imaging-darkroom;97;92;93;94;96;92;92;93;108;149 07:58:41 INFO - PROCESS | 1651 | |7;imaging-desaturate;78;83;78;82;79;94;139;125;82;81 07:58:41 INFO - PROCESS | 1651 | |8;json-parse-financial;55;55;54;53;58;58;57;56;57;58 07:58:41 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;63;64;76;76;71;68;66;67;68;68 07:58:41 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;82;84;83;82;83;83;82;83;82;81 07:58:41 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;149;148;135;133;136;138;140;143;187;138 07:58:41 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;161;216;227;163;161;160;160;161;162;224 07:58:41 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;68;66;66;67;65;66;65;64 07:58:41 INFO - PROCESS | 1651 | __end_tp_report 07:58:41 INFO - PROCESS | 1651 | __start_cc_report 07:58:41 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1905 07:58:41 INFO - PROCESS | 1651 | __end_cc_report 07:58:41 INFO - PROCESS | 1651 | __startTimestamp1486742321872__endTimestamp 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | ------- Summary: start ------- 07:58:41 INFO - PROCESS | 1651 | Number of tests: 14 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:110.50 Median:113.00 stddev:4.14 (3.7%) stddev-sans-first:2.60 07:58:41 INFO - PROCESS | 1651 | Values: 101.0 112.0 113.0 110.0 114.0 113.0 108.0 107.0 114.0 113.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:145.50 stddev:23.55 (16.2%) stddev-sans-first:24.46 07:58:41 INFO - PROCESS | 1651 | Values: 150.0 132.0 141.0 156.0 111.0 133.0 137.0 90.0 176.0 138.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:180.70 Median:181.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 07:58:41 INFO - PROCESS | 1651 | Values: 182.0 179.0 182.0 180.0 181.0 181.0 180.0 180.0 180.0 182.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:65.70 Median:59.00 stddev:12.07 (20.4%) stddev-sans-first:11.46 07:58:41 INFO - PROCESS | 1651 | Values: 81.0 59.0 58.0 87.0 59.0 58.0 58.0 59.0 81.0 57.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.50 stddev:11.31 (14.4%) stddev-sans-first:11.24 07:58:41 INFO - PROCESS | 1651 | Values: 88.0 69.0 92.0 69.0 68.0 67.0 88.0 67.0 68.0 91.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:84.50 stddev:7.65 (9.1%) stddev-sans-first:8.09 07:58:41 INFO - PROCESS | 1651 | Values: 85.0 84.0 108.0 83.0 85.0 82.0 85.0 84.0 86.0 83.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:93.00 stddev:17.68 (19.0%) stddev-sans-first:18.70 07:58:41 INFO - PROCESS | 1651 | Values: 97.0 92.0 93.0 94.0 96.0 92.0 92.0 93.0 108.0 149.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:81.50 stddev:21.77 (26.7%) stddev-sans-first:22.48 07:58:41 INFO - PROCESS | 1651 | Values: 78.0 83.0 78.0 82.0 79.0 94.0 139.0 125.0 82.0 81.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:57.00 stddev:1.79 (3.1%) stddev-sans-first:1.86 07:58:41 INFO - PROCESS | 1651 | Values: 55.0 55.0 54.0 53.0 58.0 58.0 57.0 56.0 57.0 58.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:4.45 (6.5%) stddev-sans-first:4.21 07:58:41 INFO - PROCESS | 1651 | Values: 63.0 64.0 76.0 76.0 71.0 68.0 66.0 67.0 68.0 68.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 07:58:41 INFO - PROCESS | 1651 | Values: 82.0 84.0 83.0 82.0 83.0 83.0 82.0 83.0 82.0 81.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:141.50 stddev:15.78 (11.1%) stddev-sans-first:16.66 07:58:41 INFO - PROCESS | 1651 | Values: 149.0 148.0 135.0 133.0 136.0 138.0 140.0 143.0 187.0 138.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:162.50 stddev:29.69 (18.3%) stddev-sans-first:30.73 07:58:41 INFO - PROCESS | 1651 | Values: 161.0 216.0 227.0 163.0 161.0 160.0 160.0 161.0 162.0 224.0 07:58:41 INFO - PROCESS | 1651 | 07:58:41 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 07:58:41 INFO - PROCESS | 1651 | Values: 66.0 66.0 68.0 66.0 66.0 67.0 65.0 66.0 65.0 64.0 07:58:41 INFO - PROCESS | 1651 | -------- Summary: end -------- 07:58:41 INFO - PROCESS | 1651 | 07:58:42 INFO - TEST-INFO | 1651: exit 0 07:58:42 INFO - TEST-OK | kraken | took 59206ms 07:58:42 INFO - SUITE-END | took 1176s 07:58:43 INFO - Completed test suite (00:19:36) 07:58:43 INFO - javascript benchmark 07:58:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3557.8576856925724, 3575.6960658344037, 3578.320119177357, 3594.8741794037214, 3641.5812181599126, 5946.464818166364, 5958.761649534019, 5984.072468767348, 6000.609960352574, 6016.669083200428, 5972.820815375546, 5999.610025348349, 6010.609310394832, 6037.245344331958, 6060.878782424349, 4381.671374646899, 5205.687658740488, 5274.789008439668, 5295.20571914214, 5344.599155063366, 5255.343082114736, 5315.468453154673, 5411.648242864221, 5427.9185812212845, 5438.809641662542, 4691.671582989192, 5294.814681486148, 5372.328458942632, 5382.004329199091, 5391.676499410048, 5074.112030394703, 5376.838694839161, 5397.892042159174, 5416.539594134503, 5421.159720243369, 5245.213218017328, 5340.813071542478, 5346.732663366855, 5349.786008559653, 5413.729313534347, 5861.9741545229845, 5871.324797648283, 5901.203337549418, 5905.936931352355, 5928.555358348141, 4875.463698993108, 6187.535934804908, 6219.720112594944, 6241.438270555672, 6248.4064013918605, 6382.648954307511, 6408.743650253984, 6410.391012853772, 6421.2615549211505, 6429.967850160766, 5919.171316015804, 5975.701214939236, 6054.182685337511, 6113.938860611382, 6153.907691384633, 6487.318831522716, 6569.67151642416, 6581.967090164519, 6582.736690532421, 6591.472682185414, 6245.250569931637, 6256.562040657202, 6259.217597800275, 6267.968660156761, 6276.372362763778, 6151.96924015377, 6201.96899015502, 6218.129461875341, 6334.081558174131, 6370.522210834206, 5159.819406320761, 6256.936320825471, 6259.217597800275, 6260.686965651699, 6266.122742816009, 6154.630722156685, 6223.875522489525, 6232.3144454110015, 6235.314115447297, 6282.811515654537, 5000.924986125211, 5110.233464980209, 5170.276161337416, 5174.948250517522, 5194.35070616173, 4611.008633143891, 4618.976905115453, 4625.838095666635, 4642.86071417858, 4657.99853031593, 6060.818175454743, 6079.179310792986, 6079.635221886701, 6085.908711369245, 6114.480269177081, 5539.0, 5961.880762384815, 6245.0, 6260.749570017239, 6263.968680156661, 6065.393460653988, 6079.513638908877, 6089.117078023662, 6092.299385570627, 6104.786332478342, 5577.27495425592, 5587.8603034923635, 5598.552115830724, 5611.915821262684, 5614.6631202128, 6532.8366790830605, 6665.866682666319, 6671.699773510204, 6678.398944094957, 6697.129373181455, 6421.389967953224, 6426.4537514311805, 6435.646039467874, 6436.67816609177, 6491.188601424822, 6435.4529864962005, 6456.806295811133, 6653.0, 6672.866542669217, 6683.43190828785, 5138.280640710378, 6187.381261873777, 6229.283632382334, 6269.780557680459, 6325.430711236011, 6419.0, 6423.03654451836, 6431.967840160956, 6459.773907913201, 6461.06314584392, 5182.585393168612, 6098.542609304409, 6225.221847269091, 6233.470155036873, 6249.25008998923, 5080.49195080489, 6111.956402836337, 6139.369480960641, 6157.138000679998, 6193.102000209854, 6199.814005579839, 6214.161088253209, 6217.906731399123, 6219.813405597839, 6230.909590821679, 6093.878122437615, 6208.503319734501, 6213.844653883689, 6234.0, 6240.500759939285, 4806.375171227718, 5992.43071908168, 6138.693065346625, 6150.692465376803, 6162.044883043135], "value": 5826.550096894368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.34386515013824, 507.70806786098, 541.8509909774812, 544.1484077418841, 549.6701978812711, 30314.090577282688, 38289.85130446088, 39500.0, 39680.801595992016, 41570.58429415705, 41527.0, 41853.79073104638, 41978.37032444508, 42003.0, 42066.78966605163, 7311.926880731205, 9446.291528135383, 9603.32776705631, 9634.132928036475, 9643.758906027335, 8796.516191609458, 11343.092552595772, 11563.768724625503, 11586.478608462598, 11823.7635247295, 11606.535738570446, 11658.475368608391, 11663.650090497298, 11667.008304294146, 11668.766624667502, 11517.884821151807, 11569.595064172714, 11579.768404631945, 11591.420428978518, 11602.419879006058, 11521.251118677259, 11604.361760103191, 11611.941940290244, 11633.185677002613, 11641.0, 39134.60865391367, 39343.21313573741, 39358.606413935784, 39361.0, 39369.606303937166, 3268.2319654881085, 3390.423627983249, 3793.1585358547804, 3902.2975864344407, 3923.038855480397, 28951.131466056053, 29394.0, 29486.41027179466, 30373.088807335593, 31256.531152032738, 3241.4003409369343, 3248.675132486756, 3334.9666503334897, 3378.2905589826164, 3413.7951722896705, 488252.0, 490976.0, 491054.0, 492190.0, 493216.5339173281, 58768.53078673068, 59296.11055834166, 59350.0, 59394.0, 59403.0, 61766.382336176066, 62045.75908481805, 62071.0, 62077.0, 62081.68959155175, 16259.83740162607, 16376.590585235464, 16408.26162822676, 16473.83526164723, 16555.751663725056, 11639.301641901513, 12057.336846473352, 12059.0, 12573.245605263714, 12888.871111288767, 11724.0, 14309.35607897647, 14318.427262909367, 16659.009698826016, 20790.48023799387, 8172.468789528662, 8337.374696897758, 8374.53940033304, 8398.454100483448, 8402.151526664124, 822.4201937633953, 871.4292138649195, 970.9126178643955, 1062.5643486170634, 1084.2464487181492, 29586.260343491584, 30046.699533004827, 30047.849760751495, 30061.699383006326, 30846.383072338427, 1010.0959641121156, 1043.2697112021615, 1068.4924660786064, 1078.4392116099584, 1143.634037108134, 15469.767953480481, 15484.30320635574, 15549.766753498707, 15736.134512601917, 15792.448900657495, 646787.7660611761, 651415.0, 651801.0, 652722.0, 654457.7277113583, 57921.55196120131, 58425.0, 58437.5390615238, 58506.707466462394, 58671.70664146652, 1252.555342853274, 1292.7608392447428, 1344.2002008804745, 1367.9658008549666, 1399.3912647998154, 29074.854625726737, 31335.05994820159, 31472.0, 32095.679043209268, 32173.873914412885, 48708.0, 55325.0, 59625.70187149037, 59763.1035534476, 59825.10262346156, 637512.0, 643168.0, 644128.0, 644152.7792361008, 644346.0, 36719.63280367269, 37197.6280237205, 37279.81360093182, 39802.40296395614, 43622.781886090364, 43437.782811085744, 45064.0, 46252.53747462482, 47382.76308618435, 47910.20897910181, 34577.654223457444, 37976.430353544165, 38060.42909356306, 39179.0, 40305.1938961225, 35599.64400355963, 37767.92276424823, 38672.552656443746, 39010.2197956045, 39243.60756392399, 37322.253554928204, 38213.61786382212, 38290.0, 38675.806620966716, 38860.6113938857, 33705.494417583264, 34556.82721586376, 35143.82428087945, 35235.94292171239, 35434.0, 23723.288301350985, 24567.877160614797, 25396.984120634967, 25619.0, 25671.614925776503], "value": 20633.61182676862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.9421939599362, 378.6327262555322, 385.9980700096499, 391.237087679026, 406.1065655557772, 18539.814601853977, 19961.401157965283, 20953.580928381423, 21206.787932120675, 21232.2568710095, 19420.320288789895, 19660.508487287825, 20080.196792128332, 20257.088431020602, 20439.59120817583, 5735.455131762496, 5741.569382296324, 6021.367756385582, 6032.819015429523, 6086.117512960618, 5947.791827286046, 6042.546808989321, 6052.515798736113, 6055.061465472859, 6078.331383547807, 5758.683272420015, 6009.5192384609345, 6046.244219472566, 6087.573869829113, 6158.322584515722, 5874.0, 5998.520118390518, 6024.337322894522, 6039.1243269725865, 6044.848878778022, 5876.0, 5939.07944268639, 5939.67331796751, 5940.6435613863305, 5942.197803296586, 12140.028797696252, 12307.93846030773, 24207.878960605085, 24547.754522454725, 25135.120270790434, 2119.9152033918626, 2211.6682497625325, 2264.3207037888733, 2696.3528753099313, 2754.325190328362, 9940.66394397316, 9975.351602145838, 9999.600015999351, 10469.162467002621, 10519.94740026295, 1857.229249861306, 1950.4051264364364, 1961.6665166921514, 1968.2619017868299, 1978.3075923426686, 120544.39727801393, 123657.38171309086, 126002.73997260001, 128137.0, 130822.03766943504, 11306.886931130748, 11593.188476806712, 11613.245139066103, 11622.244554103956, 11784.234024788362, 14884.181370024753, 14905.031172973722, 14906.925465372604, 14927.40290388394, 14936.925315373353, 6686.899696504556, 8583.207284159247, 8637.0499245083, 8781.121887811296, 8836.690715824916, 6837.35045170708, 8560.443571167854, 8594.785130371665, 8639.395242332976, 8674.655428408607, 4513.819447222074, 4586.518415566385, 4607.539246075433, 4624.907501849944, 4741.739204343725, 1648.250046228963, 1887.4337698690338, 1949.0741897598527, 1961.3233434465087, 1962.685970244754, 840.3949156607233, 875.3391189651772, 920.0661328751323, 945.9006804285451, 957.0190554681507, 19630.073985203016, 20849.79150208509, 21064.368068957956, 21109.472263193544, 21340.93295335258, 894.0242065036342, 903.7347713201439, 921.3412410126791, 925.6809047107845, 992.573193526776, 8528.829423411496, 9753.902460975441, 10391.428471434143, 11124.888751112547, 11207.327560346404, 600559.0, 605475.0, 617244.0, 622012.0, 623424.0, 69340.65329673319, 118637.0, 120894.0, 122894.0, 124650.0, 928.9396189247813, 942.3309450290234, 963.2149797914677, 981.9459929703935, 982.9754256143653, 17505.474835754947, 17782.733259001383, 18561.0, 18586.69094998545, 18774.53063673419, 52499.0, 54151.18773218484, 54160.45839541712, 54204.457955419944, 55001.72499137479, 55791.44208557862, 57602.0, 73929.0, 75757.0, 76155.0, 7701.229877012254, 7880.960595196987, 7921.841563168589, 8273.379496537664, 8274.793130171553, 9511.762205944906, 12353.135280530636, 12481.188722732993, 12569.874301257236, 12907.741845163231, 10516.474176291307, 10721.946390267998, 10727.785444290914, 10970.122390208604, 11192.440377981231, 10716.35701857891, 10733.516991735234, 10972.945135274273, 11112.333260004425, 11206.607768728056, 10919.563217471212, 11128.443577820915, 11175.497102630563, 11179.66461006171, 11357.261777984404, 8069.87895181561, 8144.511329320259, 8202.302804261704, 8275.420720549504, 8443.197896199852, 9802.460864652512, 9891.752706182404, 9919.355241909252, 10138.746531336776, 10618.256722029384], "value": 9429.754841067012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.173954320377, 1471.632091977006, 1484.0279616850962, 1667.1830802906572, 1849.694800357941, 6806.557573757708, 7358.300961408664, 7899.052113746351, 8422.36832237583, 8451.57742112895, 8310.626021829017, 8379.497230166178, 8397.91602083979, 8415.242628163463, 8426.91573084269, 2356.422676444269, 2405.9518809623796, 2408.8434251773665, 2410.216679579135, 2417.0452671194867, 2382.821288403368, 2424.6847909771705, 2426.805855531562, 2426.842255253403, 2429.757024297565, 2361.527694461106, 2361.9409514762096, 2387.55830171418, 2389.223502361731, 2393.2461274698503, 2327.4995875886766, 2335.976640233593, 2358.858468491896, 2368.9813380246487, 2371.5256948610177, 2363.1847012780563, 2377.6314671225987, 2401.0635852017726, 2401.7117945846435, 2405.434722840131, 8303.377246706521, 8386.245237928615, 8392.622331995075, 8393.916060839374, 8422.536760478171, 5038.269450929632, 5039.395272567279, 5194.168932970744, 5195.610329225286, 5212.765425555859, 3555.235624340779, 3635.9636403636155, 3646.6171052039417, 3653.8173091345325, 3659.2132691471197, 1034.6947650443137, 1068.1027936533271, 1088.4938503595865, 1093.2565855218527, 1098.2531878322736, 10816.0, 10877.0, 10901.509432075576, 10902.96421839916, 10920.781584368347, 4374.737515749065, 4492.618127459137, 4533.546645335506, 4539.614132798749, 4546.204414227497, 8660.783480412914, 8661.350398719995, 8669.00306464752, 8678.609462574199, 8689.17452841979, 5016.598672106223, 5086.643934924594, 5091.414487334004, 5110.9488905110475, 5126.974365128151, 4052.65552428041, 4189.853355132555, 4761.381020467386, 4797.832075877328, 4806.990531988322, 3683.650053244937, 3697.6487233712755, 3766.114962983697, 3802.08749900022, 3802.1065049713297, 981.9312648114707, 1144.8168293073068, 1153.3080151908787, 1155.641751057175, 1166.1836714300025, 876.2332958661171, 878.5519385113511, 885.172363839799, 903.2277402820625, 915.2677857713802, 5147.408048074444, 5167.689938603696, 5399.811006614828, 5563.944360556424, 5601.683604352974, 375.9906002349963, 418.6044188242143, 434.42655694482977, 440.10219152928306, 450.27056169005766, 3615.837287322077, 3656.524651795303, 3772.1135533149686, 3779.5464544254864, 3781.4516895050065, 9170.358074934691, 9401.764955876159, 9950.0, 10078.949605251926, 10106.646267380607, 8308.750737477885, 10031.99680031991, 10033.548490317953, 10038.297319187586, 10043.69868903934, 7501.437392195608, 7802.98561187042, 7886.171951945078, 7895.01312335958, 7900.170482099412, 4455.866324010285, 5242.16125419931, 5359.973200133974, 5380.623356365017, 5466.617336786387, 9123.817523649623, 9263.861042084509, 9326.487043212417, 9342.392744471588, 9343.065693430603, 9444.95277523608, 9511.381760185566, 9578.952105239428, 9632.75918102053, 9642.035796420301, 7009.2990700929495, 7020.227774944854, 7168.784936451915, 7283.963580182065, 7372.299631534996, 7981.800454988672, 8019.6391162398995, 8063.35493160534, 8071.394645401501, 8077.5961201940845, 7191.280871912767, 7240.312170343809, 7250.238724934017, 7299.5620262784405, 7370.262973702587, 7030.507864449644, 7089.716411343488, 7094.042304289062, 7098.964505177441, 7162.997180394645, 6692.1969363674725, 6807.455403567604, 6814.591124532544, 6823.55646882951, 6828.317168283132, 4691.671582989158, 4767.404074490689, 4773.403324584427, 4790.592799612072, 4812.35033270504, 4766.165920963748, 4826.251930950708, 4827.372441582572, 4921.384826896638, 4964.578010869117], "value": 4302.0573736772285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.6583843176428, 310.2414596312017, 318.2632206442086, 323.0051441559994, 324.9447593909035, 5212.322398088253, 5330.307060082188, 5333.733313334337, 5390.1106317457625, 5408.889244174431, 5255.605829562779, 5279.4984476474765, 5281.788728450857, 5286.259923610688, 5298.36419629645, 3306.041248038066, 3548.7338449616254, 3926.8232929518167, 4066.4103704962763, 4090.89772755682, 3871.748336358142, 3981.9004524886964, 4097.282975479294, 4099.856505022325, 4110.0752330725645, 3694.667479926806, 3809.466674665549, 3976.369688427745, 3984.780837053961, 4061.918761624766, 3280.721138703213, 3943.526776786804, 4009.3184158692948, 4021.5777343378963, 4041.757494550307, 2829.2361062513005, 3201.191326900317, 3438.054535002869, 3550.230819960435, 3558.733095017858, 4567.657425693086, 5128.230765385185, 5245.737713114329, 5255.109689670666, 5320.5900436384, 4064.4512990746166, 4391.9020244938765, 4628.375169352128, 4651.813927442899, 4655.394798676184, 4975.601951843843, 5369.516743493065, 5384.569234461273, 5542.861428464321, 5649.802256921029, 3187.553742476055, 3792.412176112707, 3910.6284902934176, 3944.3294639911283, 3944.408338749182, 4431.689781715281, 5282.781231882618, 5627.971860140714, 5788.247527821356, 5840.984860223216, 3321.6014078310272, 3606.062423769839, 3872.651461368434, 3962.405639154092, 3969.186316805048, 3493.615702272748, 3664.4320130379833, 3773.207826208586, 4060.7563546187325, 4070.75575465473, 3598.7300952428673, 3736.4208547675153, 4525.117602067631, 4562.5665561771575, 4628.5371462853445, 4647.419072615923, 5427.638977044998, 5568.19033814004, 5575.898053281202, 5592.412796656374, 1233.0382301804607, 1245.769532636465, 1266.512392728806, 1272.6754677557165, 1330.1952318846959, 780.3406121827047, 834.0783434305006, 890.8530092534788, 918.5774543709969, 938.6714649872627, 4549.203889319356, 4566.086782643484, 4888.413390393175, 4901.583365413909, 4907.852764417074, 4535.63714902807, 5440.646357986719, 5446.183072539072, 5450.264214331015, 5454.53636440899, 4401.261501706808, 4943.9258411123865, 4944.208926571803, 4967.751612419437, 5284.9471505284455, 2652.58884872845, 2837.758790502789, 2865.0231340375076, 2877.309445733009, 2884.298264024194, 5079.2888995539915, 5673.943260567424, 5727.856803579861, 5738.364566098642, 5750.38357547315, 5282.603804714662, 5469.890602188014, 5842.844863773515, 5919.4968427684125, 5932.309291851801, 5990.5622650563555, 6003.907987386587, 6009.519238460913, 6009.8532012910955, 6012.849678758066, 4761.761911904322, 5001.749912504288, 5618.2415373924, 5768.836686242659, 5773.220615216892, 4904.166291730486, 5625.324961004706, 5687.971560142173, 5709.857253568694, 5722.370539240597, 4875.634327425386, 5732.885342293047, 5769.8557536061935, 5900.645961242168, 5904.61619994699, 3866.737958294429, 4012.839486420627, 4014.9397759034223, 4024.0, 4033.435319055276, 4201.159768046464, 5303.43548653156, 5432.755526001419, 5694.715264236855, 5707.5433965281845, 5518.888428121076, 5544.889102218014, 5551.583631227593, 5570.91643625354, 5580.414056524007, 5264.394594621514, 5275.366955965155, 5463.590230732791, 5534.972325138509, 5548.583856210719, 4687.039156972744, 5124.590032797293, 5385.757640906247, 5391.379991300893, 5471.343438787371, 5540.22436858832, 5553.945040335102, 5567.415421380859, 5571.247881535941, 5577.776888924398, 4533.682642215013, 5360.865978350573, 5489.780408783764, 5497.972510137423, 5528.0], "value": 4036.608909858569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.7077898061794, 794.6463823598501, 795.5624406576378, 803.437593684421, 808.8665370213915, 14299.285035748224, 15283.159426231552, 15382.230888455588, 16351.509454716377, 16960.83039169608, 15231.162286074261, 15603.0, 15873.0, 15888.602784930383, 15908.045517268973, 807.5639154856385, 841.3479553346144, 843.9957800211021, 844.3498506150261, 844.4595458906305, 666.8799616069106, 689.3623398356525, 852.4885068958606, 855.5850412549909, 856.2379482260761, 739.9593022383767, 854.8247609240091, 881.0616693221698, 881.2553392383426, 883.2801266967433, 664.445188267797, 846.6697987784769, 846.8814365988767, 847.7287268074218, 847.8389106069858, 628.6416742456802, 629.0972454527767, 629.3674856768918, 630.483003936772, 630.4893036640336, 11790.233634813796, 14033.859661403358, 14352.56942291733, 14415.495457659037, 14417.0, 13043.543475978295, 13085.738285234338, 13113.737725245537, 13196.6700832479, 13203.735925281537, 12116.697082572919, 12422.689432764162, 12537.623871283784, 12672.619821405373, 12690.492380304777, 3744.756590821588, 3768.0, 3871.1096447816876, 4451.132029254297, 4454.443194600675, 80829.19170808276, 82218.58890705567, 82954.58522707348, 83479.74780378299, 84097.15902841015, 10562.20783441245, 10623.946880265548, 10640.042396184226, 10825.458727063615, 10858.67423977282, 20481.078351474218, 20605.587888242153, 20616.69074963877, 20656.07047682858, 20914.0, 7543.358814500829, 7754.612269386508, 7963.203679631991, 8154.266116049584, 8182.4681395709085, 3606.711463082947, 4440.7335559866515, 4452.844150454784, 4468.865934021985, 4544.454665440102, 2966.0, 3109.4092122496654, 3118.1113382685826, 3134.717875391226, 3138.3880143371825, 660.904168895517, 693.3032302535919, 697.6267696782197, 702.8664553734774, 704.7533363322796, 585.3356440440131, 597.6910565860751, 609.7469550136732, 629.329763801559, 650.9544331896816, 7794.259545343183, 9150.954245228864, 9360.251179905592, 9519.333646644807, 9579.521023948775, 564.5483613109578, 614.9262088549402, 618.913352130702, 626.6803929995735, 639.4724352409281, 4547.840825571089, 4576.771161441915, 4589.632829373642, 4591.449026116888, 4596.149712303235, 107558.0, 107773.0, 109519.45240273747, 110915.44542277398, 112048.0, 93723.53138234265, 96284.51857740666, 97025.0, 97426.0, 98321.0, 82497.58751206326, 85143.57428212943, 87637.56181219181, 87661.0, 88308.0, 8598.828023439371, 8924.732258032269, 8931.464112153291, 8984.505852177932, 9117.90882091197, 48555.0, 55080.449195507535, 55736.885262295335, 56334.43665563292, 56356.154657680985, 51828.48171518387, 60837.78324433575, 63442.68278658577, 72356.0, 72649.63675181591, 12332.260064396165, 12347.814782778087, 12394.0, 12475.251484910934, 12688.6827829305, 13503.729925401634, 14387.920905932306, 14518.927405362905, 14774.926125369304, 15249.542513724606, 11252.66242012741, 12781.8082728761, 13071.803922941353, 13716.493841706313, 14325.283735813377, 13501.729965400833, 13581.728365432438, 13589.456421743414, 13628.727425451634, 13676.521321753691, 12910.612681619567, 12918.935405322913, 13105.0, 13227.603171904859, 13339.466421343037, 8795.944486661641, 10473.633422830164, 10592.89407105919, 10830.458477076272, 11099.833502497631, 11392.202545822045, 11399.373034482851, 11409.201355905006, 11591.826122608, 11703.180777345504], "value": 7345.145456596741, "unit": "score"}], "name": "dromaeo_css", "value": 7244.999182972498, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 113.0, 110.0, 114.0, 113.0, 108.0, 107.0, 114.0, 113.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 141.0, 156.0, 111.0, 133.0, 137.0, 90.0, 176.0, 138.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 182.0, 180.0, 181.0, 181.0, 180.0, 180.0, 180.0, 182.0], "value": 180.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 87.0, 59.0, 58.0, 58.0, 59.0, 81.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 92.0, 69.0, 68.0, 67.0, 88.0, 67.0, 68.0, 91.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 108.0, 83.0, 85.0, 82.0, 85.0, 84.0, 86.0, 83.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 93.0, 94.0, 96.0, 92.0, 92.0, 93.0, 108.0, 149.0], "value": 100.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 78.0, 82.0, 79.0, 94.0, 139.0, 125.0, 82.0, 81.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 58.0, 58.0, 57.0, 56.0, 57.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 76.0, 76.0, 71.0, 68.0, 66.0, 67.0, 68.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 82.0, 83.0, 83.0, 82.0, 83.0, 82.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 135.0, 133.0, 136.0, 138.0, 140.0, 143.0, 187.0, 138.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 216.0, 227.0, 163.0, 161.0, 160.0, 160.0, 161.0, 162.0, 224.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 66.0, 66.0, 67.0, 65.0, 66.0, 65.0, 64.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1446.6000000000001, "alertThreshold": 2.0}]} 07:58:43 INFO - Return code: 0 07:58:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:43 INFO - # TBPL SUCCESS # 07:58:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:43 INFO - 2017-02-10 07:58:43.232 screenresolution[1655:9794] starting screenresolution argv=screenresolution get 07:58:43 INFO - 2017-02-10 07:58:43.236 screenresolution[1655:9794] Display 0: 1600x1200x32@60 07:58:43 INFO - 2017-02-10 07:58:43.242 screenresolution[1656:9797] starting screenresolution argv=screenresolution list 07:58:43 INFO - Available Modes on Display 0 07:58:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:43 INFO - Intel Iris: 07:58:43 INFO - Chipset Model: Intel Iris 07:58:43 INFO - Type: GPU 07:58:43 INFO - Bus: Built-In 07:58:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:43 INFO - Vendor: Intel (0x8086) 07:58:43 INFO - Device ID: 0x0a2e 07:58:43 INFO - Revision ID: 0x0009 07:58:43 INFO - Displays: 07:58:43 INFO - Display: 07:58:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:43 INFO - Display Serial Number: 1600x1200 60 07:58:43 INFO - Main Display: Yes 07:58:43 INFO - Mirror: Off 07:58:43 INFO - Online: Yes 07:58:43 INFO - Rotation: Supported 07:58:43 INFO - Return code: 0 07:58:43 INFO - Running post-action listener: _resource_record_post_action 07:58:43 INFO - [mozharness: 2017-02-10 15:58:43.483076Z] Finished run-tests step (success) 07:58:43 INFO - Running post-run listener: _resource_record_post_run 07:58:43 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 39097344; Write bytes: 496547840; Read time: 378; Write time: 1685 07:58:43 INFO - TinderboxPrint: CPU usage
53.0% 07:58:43 INFO - TinderboxPrint: I/O read bytes / time
39,097,344 / 378 07:58:43 INFO - TinderboxPrint: I/O write bytes / time
496,547,840 / 1,685 07:58:43 INFO - TinderboxPrint: CPU idle
2,251.2 (47.0%) 07:58:43 INFO - TinderboxPrint: CPU system
951.3 (19.8%) 07:58:43 INFO - TinderboxPrint: CPU user
1,591.0 (33.2%) 07:58:43 INFO - TinderboxPrint: Swap in / out
230,547,456 / 0 07:58:43 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187044352; Write bytes: 187828224; Read time: 16844; Write time: 417 07:58:43 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37135360; Write bytes: 301789184; Read time: 357; Write time: 1242 07:58:43 INFO - Running post-run listener: _upload_blobber_files 07:58:43 INFO - Blob upload gear active. 07:58:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:43 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 07:58:43 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'] 07:58:43 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 07:58:44 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:45 INFO - (blobuploader) - INFO - Done attempting. 07:58:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:46 INFO - (blobuploader) - INFO - Done attempting. 07:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:49 INFO - (blobuploader) - INFO - Done attempting. 07:58:49 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:49 INFO - Return code: 0 07:58:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cce6431faceac268b65403a362b417ecffec2347c316d4a57a96defbea5db985dea8f666ecbe1068faf0e56e5237827e0aac3ac3cf1c01794bc3e2296bdc660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d83c42a8f8ab1288e3fd61fa04aaeba241156546e0fb5b297d2ee5a3486252b9906c2f808d9eb44c3b4f0dc2e5c869a772a8e1fbbc6407ac562948470248727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762e76669e5d3c0ed508905ab521559f16b6b5a9d06138c96a7df7c10f0e45ff177465ef5725d53dfef650a63dfbaa0f51553d35e042a39fc60bbc27d2fd64dc"} 07:58:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:49 INFO - Contents: 07:58:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cce6431faceac268b65403a362b417ecffec2347c316d4a57a96defbea5db985dea8f666ecbe1068faf0e56e5237827e0aac3ac3cf1c01794bc3e2296bdc660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d83c42a8f8ab1288e3fd61fa04aaeba241156546e0fb5b297d2ee5a3486252b9906c2f808d9eb44c3b4f0dc2e5c869a772a8e1fbbc6407ac562948470248727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762e76669e5d3c0ed508905ab521559f16b6b5a9d06138c96a7df7c10f0e45ff177465ef5725d53dfef650a63dfbaa0f51553d35e042a39fc60bbc27d2fd64dc"} 07:58:49 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:49 INFO - Copying logs to upload dir... 07:58:49 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.565483 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-10 07:58:49.358557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 07:58:49.361729) ========= 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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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/3cce6431faceac268b65403a362b417ecffec2347c316d4a57a96defbea5db985dea8f666ecbe1068faf0e56e5237827e0aac3ac3cf1c01794bc3e2296bdc660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d83c42a8f8ab1288e3fd61fa04aaeba241156546e0fb5b297d2ee5a3486252b9906c2f808d9eb44c3b4f0dc2e5c869a772a8e1fbbc6407ac562948470248727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762e76669e5d3c0ed508905ab521559f16b6b5a9d06138c96a7df7c10f0e45ff177465ef5725d53dfef650a63dfbaa0f51553d35e042a39fc60bbc27d2fd64dc"} build_url:https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/TVbiBc0vR0GdvaKZKMtrlA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cce6431faceac268b65403a362b417ecffec2347c316d4a57a96defbea5db985dea8f666ecbe1068faf0e56e5237827e0aac3ac3cf1c01794bc3e2296bdc660", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3d83c42a8f8ab1288e3fd61fa04aaeba241156546e0fb5b297d2ee5a3486252b9906c2f808d9eb44c3b4f0dc2e5c869a772a8e1fbbc6407ac562948470248727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/762e76669e5d3c0ed508905ab521559f16b6b5a9d06138c96a7df7c10f0e45ff177465ef5725d53dfef650a63dfbaa0f51553d35e042a39fc60bbc27d2fd64dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 07:58:49.396441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 07:58:49.396813) ========= 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.wJgnuQZ8TY/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.f1mCKmCJRu/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005139 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 07:58:49.444925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 07:58:49.445210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 07:58:49.445518) ========= ========= Total master_lag: 0.54 =========