builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0109 starttime: 1484780458.86 results: success (0) buildid: 20170118123627 builduid: d5373cf167444fe8b2680f95a336b94a revision: 20159d1481827415258184fb689253639f93d705 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:58.863883) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:58.864412) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:58.864705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:58.891487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:58.891908) ========= 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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-18 15:00:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.9M=0.001s 2017-01-18 15:00:59 (14.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:59.042866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:59.043174) ========= 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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.026615 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:00:59.091469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 15:00:59.091891) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20159d1481827415258184fb689253639f93d705 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20159d1481827415258184fb689253639f93d705 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mQ6W1qQzmy/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.ekstFFBhgm/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-18 15:00:59,182 truncating revision to first 12 chars 2017-01-18 15:00:59,182 Setting DEBUG logging. 2017-01-18 15:00:59,183 attempt 1/10 2017-01-18 15:00:59,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/20159d148182?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 15:01:01,408 unpacking tar archive at: mozilla-aurora-20159d148182/testing/mozharness/ program finished with exit code 0 elapsedTime=2.477514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-18 15:01:01.593365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 15:01:01.594568) ========= script_repo_revision: 20159d1481827415258184fb689253639f93d705 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 15:01:01.594956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 15:01:01.595224) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 15:01:01.615624) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-18 15:01:01.616084) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mQ6W1qQzmy/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.ekstFFBhgm/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:01:01 INFO - MultiFileLogger online at 20170118 15:01:01 in /builds/slave/test 15:01:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:01:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:01 INFO - {'append_to_log': False, 15:01:01 INFO - 'base_work_dir': '/builds/slave/test', 15:01:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:01:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:01 INFO - 'branch': 'Mozilla-Aurora', 15:01:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:01 INFO - 'config_files': ('talos/mac_config.py',), 15:01:01 INFO - 'default_actions': ('clobber', 15:01:01 INFO - 'read-buildbot-config', 15:01:01 INFO - 'download-and-extract', 15:01:01 INFO - 'populate-webroot', 15:01:01 INFO - 'create-virtualenv', 15:01:01 INFO - 'install', 15:01:01 INFO - 'run-tests'), 15:01:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:01 INFO - 'download_minidump_stackwalk': True, 15:01:01 INFO - 'download_symbols': 'ondemand', 15:01:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:01 INFO - 'installer_path': 'installer.exe', 15:01:01 INFO - 'log_level': 'info', 15:01:01 INFO - 'log_name': 'talos', 15:01:01 INFO - 'log_to_console': True, 15:01:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:01:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:01:01 INFO - 'opt_config_files': (), 15:01:01 INFO - 'pip_index': False, 15:01:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:01:01 INFO - 'cmd': ('bash', 15:01:01 INFO - '-c', 15:01:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:01:01 INFO - 'enabled': True, 15:01:01 INFO - 'halt_on_failure': False, 15:01:01 INFO - 'name': 'check_screen_resolution'},), 15:01:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:01:01 INFO - 'cmd': ('bash', 15:01:01 INFO - '-c', 15:01:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:01:01 INFO - 'enabled': True, 15:01:01 INFO - 'halt_on_failure': False, 15:01:01 INFO - 'name': 'check_screen_resolution'},), 15:01:01 INFO - 'run_cmd_checks_enabled': True, 15:01:01 INFO - 'sps_profile': False, 15:01:01 INFO - 'sps_profile_interval': 0, 15:01:01 INFO - 'suite': 'dromaeojs', 15:01:01 INFO - 'system_bits': '32', 15:01:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:01 INFO - 'title': 't-yosemite-r7-0109', 15:01:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:01 INFO - 'use_talos_json': True, 15:01:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:01 INFO - 'work_dir': 'build'} 15:01:01 INFO - [mozharness: 2017-01-18 23:01:01.815770Z] Running clobber step. 15:01:01 INFO - Running pre-action listener: _resource_record_pre_action 15:01:01 INFO - Running main action method: clobber 15:01:01 INFO - rmtree: /builds/slave/test/build 15:01:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:04 INFO - Running post-action listener: _resource_record_post_action 15:01:04 INFO - [mozharness: 2017-01-18 23:01:04.376935Z] Finished clobber step (success) 15:01:04 INFO - [mozharness: 2017-01-18 23:01:04.377057Z] Running read-buildbot-config step. 15:01:04 INFO - Running pre-action listener: _resource_record_pre_action 15:01:04 INFO - Running main action method: read_buildbot_config 15:01:04 INFO - Using buildbot properties: 15:01:04 INFO - { 15:01:04 INFO - "project": "", 15:01:04 INFO - "product": "firefox", 15:01:04 INFO - "script_repo_revision": "production", 15:01:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:01:04 INFO - "repository": "", 15:01:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:01:04 INFO - "buildid": "20170118123627", 15:01:04 INFO - "pgo_build": "False", 15:01:04 INFO - "basedir": "/builds/slave/test", 15:01:04 INFO - "buildnumber": 92, 15:01:04 INFO - "slavename": "t-yosemite-r7-0109", 15:01:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:01:04 INFO - "platform": "yosemite_r7", 15:01:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:01:04 INFO - "branch": "mozilla-aurora", 15:01:04 INFO - "repo_path": "releases/mozilla-aurora", 15:01:04 INFO - "revision": "20159d1481827415258184fb689253639f93d705", 15:01:04 INFO - "stage_platform": "macosx64", 15:01:04 INFO - "builduid": "d5373cf167444fe8b2680f95a336b94a", 15:01:04 INFO - "slavebuilddir": "test" 15:01:04 INFO - } 15:01:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 15:01:04 INFO - Running post-action listener: _resource_record_post_action 15:01:04 INFO - [mozharness: 2017-01-18 23:01:04.380571Z] Finished read-buildbot-config step (success) 15:01:04 INFO - [mozharness: 2017-01-18 23:01:04.380691Z] Running download-and-extract step. 15:01:04 INFO - Running pre-action listener: _resource_record_pre_action 15:01:04 INFO - Running main action method: download_and_extract 15:01:04 INFO - mkdir: /builds/slave/test/build/tests 15:01:04 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')]} 15:01:04 INFO - trying https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 15:01:04 INFO - Downloading https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 15:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 15:01:05 INFO - Downloaded 1199 bytes. 15:01:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 15:01:05 INFO - Using the following test package requirements: 15:01:05 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 15:01:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 15:01:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 15:01:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'jsshell-mac.zip'], 15:01:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 15:01:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 15:01:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 15:01:05 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 15:01:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 15:01:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:01:05 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 15:01:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:01:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 15:01:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:01:05 INFO - Fetch https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 15:01:06 INFO - Http code: 200 15:01:06 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 15:01:06 INFO - x-amz-cf-id: PqvUgZsp6JIrcti2kJpZ1liyhJKh4v80lDnRymVZvNgfjKR6TcZ__A== 15:01:06 INFO - x-amz-version-id: HdZaxWRNnAHWMwrD2NOIvNUMsBefOijh 15:01:06 INFO - Expected file size: 16276139 15:01:06 INFO - Obtained file size: 16276139 15:01:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:01:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 15:01:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:01:12 INFO - Fetch https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 15:01:13 INFO - Http code: 200 15:01:13 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 15:01:13 INFO - x-amz-cf-id: GSSfgBOtlW-hR1ivYfqp_HPifVlGuqYjjSydb21Ie0SrDBy-rjPtyA== 15:01:13 INFO - x-amz-version-id: HdZaxWRNnAHWMwrD2NOIvNUMsBefOijh 15:01:13 INFO - Expected file size: 16276139 15:01:13 INFO - Obtained file size: 16276139 15:01:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 15:01:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:01:20 INFO - Fetch https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 15:01:21 INFO - Http code: 200 15:01:21 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 15:01:21 INFO - x-amz-cf-id: qZ1bdXH_uW9NHGmSZdgxYG9dhUyGCSb9PNW6pet8lZsXiSEP8gRONQ== 15:01:21 INFO - x-amz-version-id: _ReuASDMR6AIFMyHlnhz7WhekqfE1Xqu 15:01:21 INFO - Expected file size: 14409038 15:01:21 INFO - Obtained file size: 14409038 15:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:21 INFO - trying https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 15:01:21 INFO - Downloading https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 15:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 15:01:24 INFO - Downloaded 110010778 bytes. 15:01:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 15:01:24 INFO - mkdir: /builds/slave/test/properties 15:01:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:24 INFO - Contents: 15:01:24 INFO - build_url:https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 15:01:25 INFO - Running post-action listener: _resource_record_post_action 15:01:25 INFO - Running post-action listener: set_extra_try_arguments 15:01:25 INFO - [mozharness: 2017-01-18 23:01:25.252952Z] Finished download-and-extract step (success) 15:01:25 INFO - [mozharness: 2017-01-18 23:01:25.253093Z] Running populate-webroot step. 15:01:25 INFO - Running pre-action listener: _resource_record_pre_action 15:01:25 INFO - Running main action method: populate_webroot 15:01:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:25 INFO - '--tppagecycles', 15:01:25 INFO - '7'], 15:01:25 INFO - 'tests': ['tsvgm']}}, 15:01:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['damp', 'tps']}, 15:01:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'tests': ['damp', 'tps']}, 15:01:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['dromaeo_dom']}, 15:01:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['basic_compositor_video']}, 15:01:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:01:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['a11yr', 15:01:25 INFO - 'ts_paint', 15:01:25 INFO - 'tpaint', 15:01:25 INFO - 'sessionrestore', 15:01:25 INFO - 'sessionrestore_no_auto_restore', 15:01:25 INFO - 'tabpaint']}, 15:01:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:25 INFO - 'ts_paint', 15:01:25 INFO - 'tpaint', 15:01:25 INFO - 'sessionrestore', 15:01:25 INFO - 'sessionrestore_no_auto_restore', 15:01:25 INFO - 'tabpaint']}, 15:01:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:25 INFO - 'ts_paint', 15:01:25 INFO - 'tpaint', 15:01:25 INFO - 'sessionrestore', 15:01:25 INFO - 'sessionrestore_no_auto_restore', 15:01:25 INFO - 'tabpaint']}, 15:01:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:25 INFO - 'ts_paint', 15:01:25 INFO - 'tpaint', 15:01:25 INFO - 'sessionrestore', 15:01:25 INFO - 'sessionrestore_no_auto_restore', 15:01:25 INFO - 'tabpaint']}, 15:01:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['a11yr', 15:01:25 INFO - 'ts_paint', 15:01:25 INFO - 'tpaint', 15:01:25 INFO - 'sessionrestore', 15:01:25 INFO - 'sessionrestore_no_auto_restore', 15:01:25 INFO - 'tabpaint']}, 15:01:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['a11yr', 15:01:25 INFO - 'ts_paint', 15:01:25 INFO - 'tpaint', 15:01:25 INFO - 'sessionrestore', 15:01:25 INFO - 'sessionrestore_no_auto_restore', 15:01:25 INFO - 'tabpaint']}, 15:01:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['tsvgx', 15:01:25 INFO - 'tsvgr_opacity', 15:01:25 INFO - 'tart', 15:01:25 INFO - 'tscrollx', 15:01:25 INFO - 'cart']}, 15:01:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:25 INFO - 'tsvgr_opacity', 15:01:25 INFO - 'tart', 15:01:25 INFO - 'tscrollx', 15:01:25 INFO - 'cart']}, 15:01:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'talos_options': ['--disable-e10s'], 15:01:25 INFO - 'tests': ['tp5o']}, 15:01:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'tests': ['tp5o']}, 15:01:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'talos_options': ['--disable-e10s', 15:01:25 INFO - '--xperf_path', 15:01:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:25 INFO - 'tests': ['tp5n']}, 15:01:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:25 INFO - 'talos_options': ['--xperf_path', 15:01:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:25 INFO - 'tests': ['tp5n']}}, 15:01:25 INFO - 'talos.zip': {'path': '', 15:01:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:25 INFO - Running post-action listener: _resource_record_post_action 15:01:25 INFO - [mozharness: 2017-01-18 23:01:25.271625Z] Finished populate-webroot step (success) 15:01:25 INFO - [mozharness: 2017-01-18 23:01:25.271732Z] Running create-virtualenv step. 15:01:25 INFO - Running pre-action listener: _resource_record_pre_action 15:01:25 INFO - Running main action method: create_virtualenv 15:01:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:01:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:25 INFO - Using real prefix '/tools/python27' 15:01:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:28 INFO - Installing pip.................done. 15:01:28 INFO - Return code: 0 15:01:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:29 INFO - Reading from file tmpfile_stdout 15:01:29 INFO - Output received: 15:01:29 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) 15:01:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:29 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:29 INFO - 'HOME': '/Users/cltbld', 15:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:29 INFO - 'LOGNAME': 'cltbld', 15:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:29 INFO - 'MOZ_NO_REMOTE': '1', 15:01:29 INFO - 'NO_EM_RESTART': '1', 15:01:29 INFO - 'PAGER': '/bin/cat', 15:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:29 INFO - 'PWD': '/builds/slave/test', 15:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:29 INFO - 'SHELL': '/bin/bash', 15:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:29 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:29 INFO - 'USER': 'cltbld', 15:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:29 INFO - 'XPC_FLAGS': '0x0', 15:01:29 INFO - 'XPC_SERVICE_NAME': '0', 15:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:01:29 INFO - Cleaning up... 15:01:29 INFO - Return code: 0 15:01:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:29 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:29 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 15:01:29 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 15:01:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:29 INFO - 'HOME': '/Users/cltbld', 15:01:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:29 INFO - 'LOGNAME': 'cltbld', 15:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:29 INFO - 'MOZ_NO_REMOTE': '1', 15:01:29 INFO - 'NO_EM_RESTART': '1', 15:01:29 INFO - 'PAGER': '/bin/cat', 15:01:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:29 INFO - 'PWD': '/builds/slave/test', 15:01:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:29 INFO - 'SHELL': '/bin/bash', 15:01:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:29 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:29 INFO - 'USER': 'cltbld', 15:01:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:29 INFO - 'XPC_FLAGS': '0x0', 15:01:29 INFO - 'XPC_SERVICE_NAME': '0', 15:01:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:29 INFO - Downloading/unpacking psutil>=3.1.1 15:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:33 INFO - Installing collected packages: psutil 15:01:33 INFO - Running setup.py install for psutil 15:01:33 INFO - building 'psutil._psutil_osx' extension 15:01:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:01:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:01:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:01:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:01:34 INFO - building 'psutil._psutil_posix' extension 15:01:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:01:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:01:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:01:34 INFO - ^ 15:01:34 INFO - 1 warning generated. 15:01:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:34 INFO - Successfully installed psutil 15:01:34 INFO - Cleaning up... 15:01:34 INFO - Return code: 0 15:01:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:34 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:34 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 15:01:34 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 15:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:34 INFO - 'HOME': '/Users/cltbld', 15:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:34 INFO - 'LOGNAME': 'cltbld', 15:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:34 INFO - 'MOZ_NO_REMOTE': '1', 15:01:34 INFO - 'NO_EM_RESTART': '1', 15:01:34 INFO - 'PAGER': '/bin/cat', 15:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:34 INFO - 'PWD': '/builds/slave/test', 15:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:34 INFO - 'SHELL': '/bin/bash', 15:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:34 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:34 INFO - 'USER': 'cltbld', 15:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:34 INFO - 'XPC_FLAGS': '0x0', 15:01:34 INFO - 'XPC_SERVICE_NAME': '0', 15:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:37 INFO - Installing collected packages: mozsystemmonitor 15:01:37 INFO - Running setup.py install for mozsystemmonitor 15:01:37 INFO - Successfully installed mozsystemmonitor 15:01:37 INFO - Cleaning up... 15:01:37 INFO - Return code: 0 15:01:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:37 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:37 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 15:01:37 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 15:01:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:37 INFO - 'HOME': '/Users/cltbld', 15:01:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:37 INFO - 'LOGNAME': 'cltbld', 15:01:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:37 INFO - 'MOZ_NO_REMOTE': '1', 15:01:37 INFO - 'NO_EM_RESTART': '1', 15:01:37 INFO - 'PAGER': '/bin/cat', 15:01:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:37 INFO - 'PWD': '/builds/slave/test', 15:01:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:37 INFO - 'SHELL': '/bin/bash', 15:01:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:37 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:37 INFO - 'USER': 'cltbld', 15:01:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:37 INFO - 'XPC_FLAGS': '0x0', 15:01:37 INFO - 'XPC_SERVICE_NAME': '0', 15:01:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:38 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:41 INFO - warning: no files found matching '*.txt' 15:01:41 INFO - no previously-included directories found matching 'build' 15:01:41 INFO - no previously-included directories found matching 'dist' 15:01:41 INFO - no previously-included directories found matching '.git*' 15:01:41 INFO - Installing collected packages: jsonschema, functools32 15:01:41 INFO - Running setup.py install for functools32 15:01:41 INFO - warning: no files found matching '*.txt' 15:01:41 INFO - no previously-included directories found matching 'build' 15:01:41 INFO - no previously-included directories found matching 'dist' 15:01:41 INFO - no previously-included directories found matching '.git*' 15:01:41 INFO - Successfully installed jsonschema functools32 15:01:41 INFO - Cleaning up... 15:01:41 INFO - Return code: 0 15:01:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:01:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:41 INFO - 'HOME': '/Users/cltbld', 15:01:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:41 INFO - 'LOGNAME': 'cltbld', 15:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:41 INFO - 'MOZ_NO_REMOTE': '1', 15:01:41 INFO - 'NO_EM_RESTART': '1', 15:01:41 INFO - 'PAGER': '/bin/cat', 15:01:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:41 INFO - 'PWD': '/builds/slave/test', 15:01:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:41 INFO - 'SHELL': '/bin/bash', 15:01:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:41 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:41 INFO - 'USER': 'cltbld', 15:01:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:41 INFO - 'XPC_FLAGS': '0x0', 15:01:41 INFO - 'XPC_SERVICE_NAME': '0', 15:01:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:41 INFO - Cleaning up... 15:01:41 INFO - Return code: 0 15:01:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:01:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:41 INFO - 'HOME': '/Users/cltbld', 15:01:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:41 INFO - 'LOGNAME': 'cltbld', 15:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:41 INFO - 'MOZ_NO_REMOTE': '1', 15:01:41 INFO - 'NO_EM_RESTART': '1', 15:01:41 INFO - 'PAGER': '/bin/cat', 15:01:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:41 INFO - 'PWD': '/builds/slave/test', 15:01:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:41 INFO - 'SHELL': '/bin/bash', 15:01:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:41 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:41 INFO - 'USER': 'cltbld', 15:01:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:41 INFO - 'XPC_FLAGS': '0x0', 15:01:41 INFO - 'XPC_SERVICE_NAME': '0', 15:01:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:41 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - Downloading docopt-0.6.1.tar.gz 15:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:46 INFO - Running setup.py install for blobuploader 15:01:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:46 INFO - Running setup.py install for requests 15:01:46 INFO - Running setup.py install for docopt 15:01:46 INFO - Successfully installed blobuploader requests docopt 15:01:46 INFO - Cleaning up... 15:01:46 INFO - Return code: 0 15:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:46 INFO - 'HOME': '/Users/cltbld', 15:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:46 INFO - 'LOGNAME': 'cltbld', 15:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:46 INFO - 'MOZ_NO_REMOTE': '1', 15:01:46 INFO - 'NO_EM_RESTART': '1', 15:01:46 INFO - 'PAGER': '/bin/cat', 15:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:46 INFO - 'PWD': '/builds/slave/test', 15:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:46 INFO - 'SHELL': '/bin/bash', 15:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:46 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:46 INFO - 'USER': 'cltbld', 15:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:46 INFO - 'XPC_FLAGS': '0x0', 15:01:46 INFO - 'XPC_SERVICE_NAME': '0', 15:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-TvP0yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-hUGkC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-9aanIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-SPpHZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-eDLkkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-kszwrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-DE1nZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:47 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Uut7OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ybiEvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-FEwGsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-TnA3hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-1LMI78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-3HBmxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-P9DWyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-BCQlae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ivqbiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:48 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-wySZjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:48 INFO - Running setup.py install for manifestparser 15:01:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:49 INFO - Running setup.py install for mozcrash 15:01:49 INFO - Running setup.py install for mozdebug 15:01:49 INFO - Running setup.py install for mozdevice 15:01:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:49 INFO - Running setup.py install for mozfile 15:01:49 INFO - Running setup.py install for mozhttpd 15:01:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:49 INFO - Running setup.py install for mozinfo 15:01:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:49 INFO - Running setup.py install for mozInstall 15:01:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozleak 15:01:50 INFO - Running setup.py install for mozlog 15:01:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for moznetwork 15:01:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozprocess 15:01:50 INFO - Running setup.py install for mozprofile 15:01:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozrunner 15:01:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozscreenshot 15:01:51 INFO - Running setup.py install for moztest 15:01:51 INFO - Running setup.py install for mozversion 15:01:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:51 INFO - Cleaning up... 15:01:51 INFO - Return code: 0 15:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:51 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')]} 15:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:51 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')]} 15:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:51 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:51 INFO - 'HOME': '/Users/cltbld', 15:01:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:51 INFO - 'LOGNAME': 'cltbld', 15:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:51 INFO - 'MOZ_NO_REMOTE': '1', 15:01:51 INFO - 'NO_EM_RESTART': '1', 15:01:51 INFO - 'PAGER': '/bin/cat', 15:01:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:51 INFO - 'PWD': '/builds/slave/test', 15:01:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:51 INFO - 'SHELL': '/bin/bash', 15:01:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:51 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:51 INFO - 'USER': 'cltbld', 15:01:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:51 INFO - 'XPC_FLAGS': '0x0', 15:01:51 INFO - 'XPC_SERVICE_NAME': '0', 15:01:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-JHbUwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:51 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-7XYLCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:52 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)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vQjxZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-_GxZ92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-dtHoZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-r_SPml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Bq12iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-88bx3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Y2f4Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-6bmKm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:52 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)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:52 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-slfXmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-jZsge1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-35_C4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-9ZxWZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-k2x3tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-okxnjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:53 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)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-NNVJSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:01:53 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)) 15:01:53 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)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:56 INFO - Downloading blessings-1.6.tar.gz 15:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:56 INFO - Installing collected packages: blessings 15:01:56 INFO - Running setup.py install for blessings 15:01:56 INFO - Successfully installed blessings 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:56 INFO - Reading from file tmpfile_stdout 15:01:56 INFO - Current package versions: 15:01:56 INFO - blessings == 1.6 15:01:56 INFO - blobuploader == 1.2.4 15:01:56 INFO - docopt == 0.6.1 15:01:56 INFO - functools32 == 3.2.3-2 15:01:56 INFO - jsonschema == 2.5.1 15:01:56 INFO - manifestparser == 1.1 15:01:56 INFO - mozInstall == 1.12 15:01:56 INFO - mozcrash == 1.0 15:01:56 INFO - mozdebug == 0.1 15:01:56 INFO - mozdevice == 0.48 15:01:56 INFO - mozfile == 1.2 15:01:56 INFO - mozhttpd == 0.7 15:01:56 INFO - mozinfo == 0.9 15:01:56 INFO - mozleak == 0.1 15:01:56 INFO - mozlog == 3.4 15:01:56 INFO - moznetwork == 0.27 15:01:56 INFO - mozprocess == 0.23 15:01:56 INFO - mozprofile == 0.28 15:01:56 INFO - mozrunner == 6.13 15:01:56 INFO - mozscreenshot == 0.1 15:01:56 INFO - mozsystemmonitor == 0.3 15:01:56 INFO - moztest == 0.8 15:01:56 INFO - mozversion == 1.4 15:01:56 INFO - psutil == 3.1.1 15:01:56 INFO - requests == 1.2.3 15:01:56 INFO - wsgiref == 0.1.2 15:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:56 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')]} 15:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:57 INFO - 'HOME': '/Users/cltbld', 15:01:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PAGER': '/bin/cat', 15:01:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test', 15:01:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:57 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - 'XPC_FLAGS': '0x0', 15:01:57 INFO - 'XPC_SERVICE_NAME': '0', 15:01:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:57 INFO - Cleaning up... 15:01:57 INFO - Return code: 0 15:01:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:57 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')]} 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:58 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 0x105e0c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d82570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd45858dad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, '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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:58 INFO - 'HOME': '/Users/cltbld', 15:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:58 INFO - 'LOGNAME': 'cltbld', 15:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:58 INFO - 'MOZ_NO_REMOTE': '1', 15:01:58 INFO - 'NO_EM_RESTART': '1', 15:01:58 INFO - 'PAGER': '/bin/cat', 15:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:58 INFO - 'PWD': '/builds/slave/test', 15:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:58 INFO - 'SHELL': '/bin/bash', 15:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:01:58 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:58 INFO - 'USER': 'cltbld', 15:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:58 INFO - 'XPC_FLAGS': '0x0', 15:01:58 INFO - 'XPC_SERVICE_NAME': '0', 15:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:58 INFO - Cleaning up... 15:01:58 INFO - Return code: 0 15:01:58 INFO - Running post-action listener: _resource_record_post_action 15:01:58 INFO - Running post-action listener: _start_resource_monitoring 15:01:58 INFO - Starting resource monitoring. 15:01:58 INFO - [mozharness: 2017-01-18 23:01:58.552735Z] Finished create-virtualenv step (success) 15:01:58 INFO - [mozharness: 2017-01-18 23:01:58.553780Z] Running install step. 15:01:58 INFO - Running pre-action listener: _resource_record_pre_action 15:01:58 INFO - Running main action method: install 15:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:58 INFO - Reading from file tmpfile_stdout 15:01:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:58 INFO - Reading from file tmpfile_stdout 15:01:58 INFO - Output received: 15:01:58 INFO - Usage: mozinstall [options] installer 15:01:58 INFO - Options: 15:01:58 INFO - -h, --help show this help message and exit 15:01:58 INFO - -d DEST, --destination=DEST 15:01:58 INFO - Directory to install application into. [default: 15:01:58 INFO - "/builds/slave/test"] 15:01:58 INFO - --app=APP Application being installed. [default: firefox] 15:01:58 INFO - mkdir: /builds/slave/test/build/application 15:01:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:02:30 INFO - Reading from file tmpfile_stdout 15:02:30 INFO - Output received: 15:02:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:02:30 INFO - Running post-action listener: _resource_record_post_action 15:02:30 INFO - [mozharness: 2017-01-18 23:02:30.482166Z] Finished install step (success) 15:02:30 INFO - [mozharness: 2017-01-18 23:02:30.482332Z] Running run-tests step. 15:02:30 INFO - Running pre-action listener: _resource_record_pre_action 15:02:30 INFO - Running main action method: run_tests 15:02:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:02:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:02:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:02:30 INFO - 2017-01-18 15:02:30.496 screenresolution[1625:7480] starting screenresolution argv=screenresolution get 15:02:30 INFO - 2017-01-18 15:02:30.499 screenresolution[1625:7480] Display 0: 1600x1200x32@60 15:02:30 INFO - 2017-01-18 15:02:30.505 screenresolution[1626:7482] starting screenresolution argv=screenresolution list 15:02:30 INFO - Available Modes on Display 0 15:02:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:02:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:02:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:02:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:02:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:02:30 INFO - Intel Iris: 15:02:30 INFO - Chipset Model: Intel Iris 15:02:30 INFO - Type: GPU 15:02:30 INFO - Bus: Built-In 15:02:30 INFO - VRAM (Dynamic, Max): 1536 MB 15:02:30 INFO - Vendor: Intel (0x8086) 15:02:30 INFO - Device ID: 0x0a2e 15:02:30 INFO - Revision ID: 0x0009 15:02:30 INFO - Displays: 15:02:30 INFO - Display: 15:02:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:02:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:02:30 INFO - Display Serial Number: 1600x1200 60 15:02:30 INFO - Main Display: Yes 15:02:30 INFO - Mirror: Off 15:02:30 INFO - Online: Yes 15:02:30 INFO - Rotation: Supported 15:02:30 INFO - Return code: 0 15:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:30 INFO - Python 2.7.3 15:02:30 INFO - Return code: 0 15:02:30 INFO - grabbing minidump binary from tooltool 15:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c20d30>, '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 0x105a86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c18b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:02:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:02:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:02:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:30 INFO - Return code: 0 15:02:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:02:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:02:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--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 15:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --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 15:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mQ6W1qQzmy/Render', 15:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:02:30 INFO - 'HOME': '/Users/cltbld', 15:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:02:30 INFO - 'LOGNAME': 'cltbld', 15:02:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:30 INFO - 'MOZ_NO_REMOTE': '1', 15:02:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:30 INFO - 'NO_EM_RESTART': '1', 15:02:30 INFO - 'PAGER': '/bin/cat', 15:02:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:30 INFO - 'PWD': '/builds/slave/test', 15:02:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:02:30 INFO - 'SHELL': '/bin/bash', 15:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ekstFFBhgm/Listeners', 15:02:30 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:02:30 INFO - 'USER': 'cltbld', 15:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:30 INFO - 'XPC_FLAGS': '0x0', 15:02:30 INFO - 'XPC_SERVICE_NAME': '0', 15:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:02:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--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 15:02:31 INFO - mozversion application_buildid: 20170118123627 15:02:31 INFO - mozversion application_changeset: 20159d1481827415258184fb689253639f93d705 15:02:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:02:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:31 INFO - mozversion application_name: Firefox 15:02:31 INFO - mozversion application_remotingname: firefox-dev 15:02:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:31 INFO - mozversion application_vendor: Mozilla 15:02:31 INFO - mozversion application_version: 52.0a2 15:02:31 INFO - mozversion platform_buildid: 20170118123627 15:02:31 INFO - mozversion platform_changeset: 20159d1481827415258184fb689253639f93d705 15:02:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:02:31 INFO - mozversion platform_version: 52.0a2 15:02:31 INFO - using testdate: 1484780551 15:02:31 INFO - actual date: 1484780551 15:02:31 INFO - starting webserver on 'localhost:49247' 15:02:31 INFO - SUITE-START | Running 2 tests 15:02:31 INFO - TEST-START | dromaeo_css 15:02:31 INFO - operating with platform_type : mac_ 15:02:31 INFO - Initialising browser for dromaeo_css test... 15:02:31 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpUVCVKY/profile http://localhost:49247/getInfo.html) 15:02:33 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 15:02:33 INFO - PROCESS | 1636 | colorDepth:24 15:02:33 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 15:02:33 INFO - PROCESS | 1636 | __metrics 15:02:33 INFO - PROCESS | 1636 | 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" 15:02:33 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:34 INFO - TEST-INFO | 1636: exit 0 15:02:34 INFO - Browser initialized. 15:02:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:34 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpUVCVKY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:46 INFO - PROCESS | 1638 | RSS: Main: 221843456 15:02:46 INFO - PROCESS | 1638 | 15:05:51 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 15:05:52 INFO - PROCESS | 1638 | RSS: Main: 370167808 15:05:52 INFO - PROCESS | 1638 | 15:08:55 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 15:08:56 INFO - PROCESS | 1638 | RSS: Main: 348327936 15:08:56 INFO - PROCESS | 1638 | 15:11:58 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 15:11:59 INFO - PROCESS | 1638 | RSS: Main: 312811520 15:11:59 INFO - PROCESS | 1638 | 15:15:01 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 15:15:02 INFO - PROCESS | 1638 | RSS: Main: 312651776 15:15:02 INFO - PROCESS | 1638 | 15:18:05 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 15:18:06 INFO - PROCESS | 1638 | RSS: Main: 306937856 15:18:06 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 15:21:09 INFO - PROCESS | 1638 | RSS: Main: 428048384 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | __start_tp_report 15:21:09 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 15:21:09 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 15:21:09 INFO - PROCESS | 1638 | |i|pagename|runs| 15:21:09 INFO - PROCESS | 1638 | |0;dojo.html;3265.036814139829;3321.9335613287726;3323.900282991511;3353.2287573858025;3370.2585431205143;5674.631148975319;5731.656100633965;5739.598228124033;5753.856153596163;5786.508146807516;5560.082586373253;5597.356304025028;5620.831375058745;5621.690807005613;5637.182608521762;5140.023395554833;5161.9741901290445;5164.9483505164935;5168.741562921858;5210.114280572312;5142.794288228485;5161.406438259592;5169;5252.737363131828;5268.394134674504;5200.063988482072;5267.26258323835;5271.630985830974;5294.258803767476;5296.708681022542;5268.894622107556;5289.973550132225;5294.947050529484;5296;5311.707856067915;4350.390945267665;5138.665986710889;5279.973600132013;5291.417944026154;5297.6821390716295;5604.887902241932;5651.463111004448;5658.405867383906;5680.914786278209;5766.192733017381;6188.1027251048345;6224.408681175281;6230.096635987757;6235.594686345418;6264.812055638338;6357.523185761041;6357.809265722036;6359.20509936258;6360.2367715873925;6381.585196962183;5698.487136157766;5732.6847023413275;5766.163906233573;5874.060150375962;5889.146073819272;6280.5603607747935;6310.05349197624;6333.904991425133;6334.714937827809;6339.366063393623;6202.534809889276;6205.937940620626;6207.937920620826;6209;6216.378362163748;6123.170895756613;6188.535859810442;6191.318954914956;6275.937240627535;6304.936950630527;6208.255009398901;6261.436470717657;6285.9057114143325;6289.55973081889;6290.370962903673;6220.7511699531515;6222.937770622236;6293.2762732285455;6303.936960630427;6308.400701933309;4874.36633237684;4914.70511769295;4957.132501812169;4988.002399520038;4996.200607902791;4393.494748103945;4406.6474682026;4414.1171765647;4420.756858372756;4461.442319710036;5842.912356314659;5848.2689663792025;5848.795292164754;5884.941150588525;5905.025670764362;6176.907346389808;6189.597676151036;6298.275698294663;6307.211598550181;6323.051542268697;5549.861253468695;5598.300212473441;5641.605087643908;5781.075027995501;5836.737346819404;5451.727413629303;5503.091989821634;5509.641873278224;5514.007478653881;5544.805931792368;6395.968020159869;6401.775937842153;6402.679866006774;6424.261209960728;6428.292887782433;6137.447629713347;6178.258608966953;6231.750729970931;6313.43179113882;6313.46335561464;5135.897282054263;5365.490278423544;6310.1796766420075;6380.234371875405;6405.967970160119;6222.439980401786;6231.40801623845;6239.469645080219;6249.468795152463;6251.6874156292915;5087.9456435648735;6072.8785424292155;6121.392004143408;6134.987697083657;6295.370462953668;5877.23595932526;6015.218021657157;6032.517398608188;6100.75596976116;6143.56995010345;6139.706800529493;6160.969195153995;6172.22847144107;6190.597611155261;6200.100985357189;5932.614380065282;5972.910406343995;5989.341172470938;6020.54845886569;6085.6348619083;5968.253968253968;6055.636661800306;6061.757529698939;6184.319724830175;6206.441420272197;5040.5967522597375;5973.49225315853;6012.518998480024;6032.75868965254;6104.20645316106 15:21:09 INFO - PROCESS | 1638 | |1;ext.html;464.59812262393035;479.486948964608;482.79239926831457;489.7257535779961;519.2185760430551;29659.70340296599;30290.39419211617;38697.22605547887;40020.39969400461;40111.197776044464;39338.40992385116;41313.79343103288;41390.58609413912;41429.37855932156;41593.792031039804;9245.306602004843;9403.153716165543;9416;9419.340646154771;9455.243580513577;8359.373047021467;8545.572721363938;9293.628254869796;11027.44862756859;11308.943455282753;11230;11277.266977646426;11299.209055366087;11306.604268850591;11327.773444531105;11237.550497980072;11306.378149201832;11308.717282067932;11331.660050198425;11373.488193031333;8248.175182481704;8470.915290847075;10951.178661600412;11278.436078196057;11283.943580282128;39980.600193997976;40128.79935600333;40196.39705404421;40222.195556089006;40225.396619050734;3199.4560924642865;3289.703926646613;3405.914852128692;3576.4635304704243;3610.2238018825815;28830.855845720846;29838.40323193524;29879.701202987908;30297;30320.393592128035;3105.642851072133;3169.0968074098773;3205.1987003249187;3218.855151518187;3248.642649308574;481942;484572;485096;485132;485171.57414213056;58304.83390332254;58735;58822;58900.82198356009;58982.70508647429;60327.69836150791;60418.697906510184;60451.69774151101;60597.69701151554;60692.78614427687;15730.213489325717;15956.361745530048;15967.840321596635;15986.520404387888;15989.60025999336;11136.66590002285;12457.314847683283;12461.127721059438;12464.189827661174;12482.563110291278;14134.15195088298;14436.855631443761;14463.421463141356;14497.347619357155;15840.76238856418;6094.268687757409;6665.400113989765;6708.664566771642;6715.429188518933;6779.72881084751;847.9321654267644;999.7500624843789;1002.2082554781641;1015.410881969715;1026.3636545341787;28771.856140719163;28779.280517986797;29425.11724648264;29462;29594.852025739732;955.9474228917337;970.3304719743354;1052.736815796051;1071.7802850415646;1090.9345439273668;14582.125072495684;15019.774703379459;15057.774133388008;15429.922850385676;15451.072935623899;576714;635150;636638;638490.8075459686;638988;48319;49069;49104.50895491071;54873;56206.156907646415;1328.5018118205674;1360.4014233737123;1368.5620601407454;1372.670559065797;1375.3467103125936;29094.854525727234;29951.550726738682;30294;30313;30824.69175308308;49841.252381213584;50238.497615023385;50239;50262.497375025785;50378;503707;504500;506554;506790;506831;25830;38748;38972;39011;39056;34947.825260873535;44635.33047004363;45094.42169524051;45560.8609784758;45797.626071217914;36592.81703591465;36846.63153368432;36884;37340.25319493649;38312;31077.844610776803;37092.81453592715;37378.626213737516;37652.623473764914;38400.231995359376;36089.458658120675;36128.518850093875;36964.26071478609;37318;37358.439623405124;31038.482126925628;32163.839180803945;33781.15547111243;33959.4906076414;34346;20129.6980545289;23907.402314942265;24969.12608058709;25356.449362091145;25397.236399850615 15:21:09 INFO - PROCESS | 1638 | |2;jquery.html;349.5892326516343;373.1752826253979;374.44768965775467;382.7129652760429;401.3918912847037;12463.813042804366;14605.634859128528;15368.61578460539;18852;19147.617047659038;19116.33092841751;19220.636388632003;19905.800941990576;20022.699659505084;20070.197192112297;5840.561957853157;6105.419985101408;6113.633182009072;6115.205023346981;6116.694165291718;4972.701637901738;6014.8797024059495;6067.211262535864;6067.696615169224;6071.3625069367745;5707.486326230638;5996.790112346069;6011.098335249704;6021.608595441304;6027;5867.002609556385;5915.171875937351;5944.851378715523;5948.940510594882;5949.315828679714;5012.473690262543;5092.363454568179;5137.33214682089;5197.506236907488;5201.505856943584;24011.27966161018;24040.639390409156;24184.51630967371;24261.393465163335;24497.63253551198;2223.5330580578097;2282.6461898405773;2298.9425264368356;2461.2247142150163;2954.5125054366217;15132.848671513255;15207.61980950474;15445.922770386189;15624.531264062096;15629.687406251925;1757.139001889078;1779.217144456435;1796.8203179682057;1838.8528917686554;1888.688366419539;114118.42940785243;119466;124573;125745.22764317085;125883;10359.22305827066;10425.270231083903;10819.513121909533;10860.927152317881;11022.921519038007;13629.386677599532;13655;13667.316634168252;13673.111247768864;13690;8176.591170441454;8431.494110353398;8505.277051450572;8574.185452382013;8641.956790216009;8423.199796019368;8450.704225352083;8471.872921906177;8580.65677372898;8655.17775811297;6422.4862011039;6426.35736426363;6536.150300460909;6586.73653053882;6654.401103900575;1663.8169801321844;1769.646070785848;1774.751534785131;1785.0628420079563;1860.6929856573784;672.5258692621787;869.7651634058768;900.819836032796;941.0589410589411;945.6264775413673;20450.79549204489;20931.953402329822;21447.356579302646;21625.24311649085;21811.345659630235;944.4097439100562;950.9381890177116;954.4082668745423;991.4943378876825;1042.2860340666668;11145.328200769787;11529.077673786078;11575.016123629417;11583.536658533565;11597.826032609517;488382;544407;577511;596042;596410;62792.372076279564;74088;111571;113442;114384;958.0898146760605;977.2768151567931;998.4458625462938;1001.5893483671659;1001.9899801001897;18467.414561961068;18648.627027459646;18742.96913669761;18787.248510059446;18855.811441885406;48832.51167488422;49109.2633610489;50545.41828696809;50623.24065138952;51024;68503.65748171427;69223.96164057644;70199;71530;72442.91335629864;6043.54673399488;6900.896486552806;7169.247229041084;7271.745488908075;7475.02824632816;9053.818923621358;12264.38678066111;12279.570215042431;12366.876331236572;12550.309732964775;10491.632792852213;10560.366378017343;10598.04617584421;10628.84056739134;10900;10394.168466522811;10500.684979450629;10609.9469502652;10744.73138171552;10973.945130274298;10299.330543514647;10617.469126543796;10686.114749017877;10686.625968091079;10856.674299771019;6848.14398200225;7064.717411303491;7085.256048114874;7301.342879140902;7321.267873212636;8726.69456569017;9228.538573071186;10027.448490333101;10443.68668939933;10780 15:21:09 INFO - PROCESS | 1638 | |3;mootools.html;1268.467243757622;1438.762604170312;1557.3147814961417;1791.4804706635077;1803.8556915446766;8092.109867914532;8400.033996090451;8400.789980250489;8401.117882622328;8403.033651130121;5795.304563452381;6805.387515123638;7726.497777644449;7772.378209743221;8078.313343365806;1883.8869667819974;2347.882605869708;2351.670766092748;2356.5404746074523;2357.834951553392;2328.0687724910085;2351.235848349285;2353.352827972304;2371.5494056129364;2372.4543355028354;1944.7277381166648;2307.5846347657416;2310.4570425949887;2340.67230587717;2341.882905854709;2290.061074959267;2315.1086831569796;2316.976830231693;2318.4783423729696;2319.907203711858;2314.7916687498205;2346.085026839534;2346.3195673254736;2349.5066036132434;2349.565330413879;8431.704890328809;8521.44610600309;8525.701600444017;8528.488290702515;8529.74410767678;5113.437521872591;5262.236975638511;5267;5271.604629652753;5272.947270527284;3250.9349813003846;3342;3509.5613048368955;3564.108972756811;3566.32239874423;1035.5702383510834;1053.2048303530785;1069.5080263078994;1084.0297933349686;1084.046039485248;10861.728456788565;10945.671629851116;11084.833727494093;11100;11105.555777768961;4514.210013247734;4595.655325850575;4692.859214223578;4696.319033740157;4769.260764581495;9537.189338906272;9545.427274363561;9549.188318992963;9552.188064014637;9553.761155971017;5229.921551176735;5231.633785635046;5236.24074509194;5238.083335416287;5247.396549396792;4016.7188296819527;4179.749215047107;4765;4778.402699662543;4792.353032340659;3825.2158307547443;3837.7505462144873;3886.8250928708276;3921.3725803871243;3924.50943632046;1161.4076820821442;1232.8520577530753;1259.6724851538484;1262.1921969939247;1272.3638180909545;757.2541047068632;861.7199410191713;884.6903583745637;896.8699538567001;909.7543663211028;5182.689038657692;5499.1476321170285;5639.830805075854;5653.265075540154;5977.043673012384;430.834128860391;439.50555624921964;443.24869346457444;443.81803460581006;444.46442037344923;3866.5940076292145;3870.9225815483533;3906.374980003186;3995.961050126988;4009.1981603679383;9785.168260697777;9984.251181161442;10140.594376224868;10335.37987720724;10347.63783267582;10092.091711745978;10249.282550221413;10254.846177307347;10271.7432064199;10281.897181028244;7559.433042521723;7842.725504607311;7847.960760196277;7941.9999999998845;7962.960185199153;4851.51484851512;5704.629199102045;5774.1916131740745;5949.672767997802;6089.878202436015;8418.747437576883;8914.420562663665;9078.273738101068;9442.669506567237;9568.856467153137;9600.519974001412;9753.366031207948;9756.60973561078;9756.804863902824;9769.80460390774;6603.075569420381;6856.6228857413325;6857.348551887562;7127.037849890198;7257.020302259339;7668.923310766821;7826.726064587712;7970.641321140679;8066.23370779775;8067;6995.370416662321;7138;7269.636518173965;7327.303906128909;7386.593737344498;6719.664016799043;6859.211190713132;6985.685644145924;7008.369246767816;7082.893756593552;6715.764948226789;6736.393724564813;6830.863382732218;6832.829179270558;6837.9316206839285;4223.7751052195745;4822.9758851205515;4869.245266983623;4876.122297986397;4915.483874193301;4843.249296358929;4866.732329721758;4963.950360496493;5031.295618613471;5055.6713813602 15:21:09 INFO - PROCESS | 1638 | |4;prototype.html;250.04358329390084;301.38818199055925;306.5738623313594;311.80356375483444;315.147525942326;4771.8807029824275;5216.269722238885;5278.7360631968395;5288.947110528894;5371.435999220084;4786.353842231298;4973.975130124353;5062.367204099488;5134.922976155361;5298.761555729991;4018.5981401859726;4056.6066021047577;4069.511658600957;4076.084240407004;4109.21924834282;4040.4141399497057;4053.3717273822604;4081.3673880548413;4096.631303182713;4114.156597897439;3752.587215406303;3990.2817492851277;4023.396490526415;4061.3298805697023;4065.918681626366;3275.5577996970583;3960.6731744865506;3965.3060714375156;3997.660198883113;4014.3376342903384;3470.2538954124984;3475.7566970312087;3478.7390945679176;3479.9652003480146;3482.547268855058;4248.660107191417;5162.432132465426;5164.767585458626;5171.974140129275;5181.870453238662;3836.865709700175;4083.2445997490263;4254.298040823261;4367.279398899178;4589.862304130881;4991.725455099968;5537.501624853742;5556.611037227396;5568.693721845297;5690.772369105231;3009.9849500752575;3791.9431208531896;3804.2201348723447;3812.7331086823933;3823;5603.915941260884;5763.452472015152;5771.6725153214575;5797.608573942266;5809.302883653989;3212.8754935772295;3748.606396328401;3826.559945606235;3838.596947320491;3845.3270677631303;3511.964880351215;3883.417487376916;3929.410588411761;3931.2334094851803;3939.6060393960374;3966.5438474575217;4282.6359759420175;4297.978510107492;4572.199865023607;4595.862124136282;4540.705898818821;5542.584306176972;5564.165375193753;5584.492187109539;5594.300712410949;1050.9316894401838;1251.5807204586565;1257.8427696537933;1265.8354413926315;1270.5489551209373;742.2021327073418;792.6155814429997;811.4806523824757;834.3325339728193;844.8774927635582;4313.935290970638;4524.977375113103;4531.796069176829;4798.2082956312515;4943.714634195135;4634.490206077328;5148.716820574904;5303.814366497154;5306.681599104066;5346.652467589594;4288.764117973541;4308.858152589566;4651.837185698552;4729.432468103781;4816.903661926812;2362.5629258587214;2482.416632091457;2490.5517006938926;2509.4855554611627;2791.9441611167663;4929.852104436873;5072.898542029138;5311.7344132793205;5550.500454959073;5565.387807341189;4739.3838800955655;4834.734089625104;5063.822766203165;5337;5501.807436739695;4708.670393072452;4953.678010929278;5172.456892026434;5516.668999859941;5569.944300556943;4143.97928010358;4947.356843610308;5351.839444816662;5374;5418.970395624819;4816.735079570657;4857.417109946829;4887.731174785421;5273.393559740525;5307.283516725192;4687.6795985987155;4905.950940490692;4913;5121.79512819498;5504.91742623869;3352.6479719630065;3496.9334353022573;3556.8221588919932;3583.3337498063524;3611.5124458197806;4794.448638406628;4975.4278258000795;5265.842024739264;5285.788568457218;5307.761150748149;4610.040732688661;5014.671112155209;5166.948330516647;5221.791128354823;5257.526822585833;4369.798305466023;4533.501314855297;5086.982603479245;5121.590272778243;5202.947970520247;3960.9603903961743;4941.308216849716;5070.949290507047;5248.448912864094;5485.588580856372;4933.29801218579;5112.590992720648;5470.580886945659;5493.176023596492;5619.213310136666;4806.759662016955;5304.9204261936875;5463.235147079492;5503.807366742305;5518.310211223597 15:21:09 INFO - PROCESS | 1638 | |5;yui.html;636.519427831987;722.4220623501197;775.8266660729217;776.1501156233921;783.3028604541955;14341.569752907417;14659.780103298446;14661.120332780027;15631.374745010186;16494.75257871133;14783.408663653468;14883.553493395188;15180.240987950587;15203.847961520381;15225.543233703007;793.183021487867;819.9467034642759;820.2003047029159;821.2772759971217;821.4742564758559;644.6937704590329;665.7636539028648;669.7923643670454;818.3289702443998;823.9382046346548;823.4770920465518;847.3390755210945;847.5211505499404;848.440029580477;850.612971098152;834.929031032363;835.6197929941862;835.7075023741703;835.7325655790149;835.9874601880977;499.45060433523196;509.2971699055317;624.0327492386782;624.6501958903029;627.1251604012423;13752.31238438074;14290;14324.283785810669;14627.414903403851;14656.193909334983;11508.96419322265;13064.86935130646;13142.802857957138;13469.528566500125;13632.659183520393;11358.488868000877;11410.657680269605;11465.426728663533;11563.826542601868;11625.24435911663;3574.982125089358;3582.1940063485767;3608.639136086397;3691.8523259069607;3737.906552336186;88049.54797462703;90516;92882.53558732163;93492.06507934969;94299.0570094304;10093.192544596415;10127.898721012696;10342.844857327145;10371.962803719718;10490.636217291856;20120.39638810838;20408.38774836757;20456.488587785127;20485;20499.8975005124;7484.401247900264;7531.171571127281;7552.169261381244;7581.317681408589;7631.732889348847;4088.509378874554;4116.629503344653;4175.62419382257;4184.351425529047;4349.629866592013;2715.5926611008113;3362.411577973845;3404.914877128042;3430.3310854383158;3432.3306955144008;620.6431302001367;639.4149353341734;646.9159009328757;654.1724718231441;658.1279804259375;634.7524465458475;639.146739103293;648.3225029843825;652.9967350163218;675.3078094952713;8634.438761480484;8938.50838203905;9136.49749263797;9141.405808622418;9165.220956218664;637.7225906730495;663.8274048747361;666.4535081233439;667.7495939022866;683.5386114372778;4489.483709373399;4504.166729155117;4886.65793394459;4910.165271903785;4924.778384972685;77333.6133319341;105706;121527;121997.39001304937;122277;65360;95323;106026.40960385601;108528.91471085188;108893.45553272183;93108;94282;94815;94890;95361.04638953521;9316.34785565031;9473.621055157717;9537.427754334762;9566.378185417925;9568.856467153137;42337;56090.878182436936;56137.71931140318;57363.42636573581;57407.42592574021;49679.75160124176;50818;77167;81316;81616;9893.600677942606;12381.195222310522;12611.87388126107;12657;13122.540711075066;11626.70933226676;13899.930500347433;14130.434782608992;14236.217008064656;14593.051451656032;12318.507259709511;12577.87422125767;12618.305993170463;12685.365731713562;13542.390592423168;12873.356332183166;13177.47290108385;13227.140235884637;13297.335133243105;13376.598702038955;12202.511899523919;12332.868489056267;12334.50661973547;12376.876231237933;12488.687782805502;10826.350418974887;10846.349219046882;11077.446127693422;11169.497372618414;11587.710307242387;11007.669769906915;11238.887611123784;11257.15571332137;11468.541258349573;11475.713107172387 15:21:09 INFO - PROCESS | 1638 | __end_tp_report 15:21:09 INFO - PROCESS | 1638 | __start_cc_report 15:21:09 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1695 15:21:09 INFO - PROCESS | 1638 | __end_cc_report 15:21:09 INFO - PROCESS | 1638 | __startTimestamp1484781669286__endTimestamp 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | ------- Summary: start ------- 15:21:09 INFO - PROCESS | 1638 | Number of tests: 6 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5744.41 Median:5972.91 stddev:661.94 (11.1%) stddev-sans-first:634.75 15:21:09 INFO - PROCESS | 1638 | Values: 3265.0 3321.9 3323.9 3353.2 3370.3 5674.6 5731.7 5739.6 5753.9 5786.5 5560.1 5597.4 5620.8 5621.7 5637.2 5140.0 5162.0 5164.9 5168.7 5210.1 5142.8 5161.4 5169.0 5252.7 5268.4 5200.1 5267.3 5271.6 5294.3 5296.7 5268.9 5290.0 5294.9 5296.0 5311.7 4350.4 5138.7 5280.0 5291.4 5297.7 5604.9 5651.5 5658.4 5680.9 5766.2 6188.1 6224.4 6230.1 6235.6 6264.8 6357.5 6357.8 6359.2 6360.2 6381.6 5698.5 5732.7 5766.2 5874.1 5889.1 6280.6 6310.1 6333.9 6334.7 6339.4 6202.5 6205.9 6207.9 6209.0 6216.4 6123.2 6188.5 6191.3 6275.9 6304.9 6208.3 6261.4 6285.9 6289.6 6290.4 6220.8 6222.9 6293.3 6303.9 6308.4 4874.4 4914.7 4957.1 4988.0 4996.2 4393.5 4406.6 4414.1 4420.8 4461.4 5842.9 5848.3 5848.8 5884.9 5905.0 6176.9 6189.6 6298.3 6307.2 6323.1 5549.9 5598.3 5641.6 5781.1 5836.7 5451.7 5503.1 5509.6 5514.0 5544.8 6396.0 6401.8 6402.7 6424.3 6428.3 6137.4 6178.3 6231.8 6313.4 6313.5 5135.9 5365.5 6310.2 6380.2 6406.0 6222.4 6231.4 6239.5 6249.5 6251.7 5087.9 6072.9 6121.4 6135.0 6295.4 5877.2 6015.2 6032.5 6100.8 6143.6 6139.7 6161.0 6172.2 6190.6 6200.1 5932.6 5972.9 5989.3 6020.5 6085.6 5968.3 6055.6 6061.8 6184.3 6206.4 5040.6 5973.5 6012.5 6032.8 6104.2 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:67105.41 Median:36924.13 stddev:144706.44 (391.9%) stddev-sans-first:145025.88 15:21:09 INFO - PROCESS | 1638 | Values: 464.6 479.5 482.8 489.7 519.2 29659.7 30290.4 38697.2 40020.4 40111.2 39338.4 41313.8 41390.6 41429.4 41593.8 9245.3 9403.2 9416.0 9419.3 9455.2 8359.4 8545.6 9293.6 11027.4 11308.9 11230.0 11277.3 11299.2 11306.6 11327.8 11237.6 11306.4 11308.7 11331.7 11373.5 8248.2 8470.9 10951.2 11278.4 11283.9 39980.6 40128.8 40196.4 40222.2 40225.4 3199.5 3289.7 3405.9 3576.5 3610.2 28830.9 29838.4 29879.7 30297.0 30320.4 3105.6 3169.1 3205.2 3218.9 3248.6 481942.0 484572.0 485096.0 485132.0 485171.6 58304.8 58735.0 58822.0 58900.8 58982.7 60327.7 60418.7 60451.7 60597.7 60692.8 15730.2 15956.4 15967.8 15986.5 15989.6 11136.7 12457.3 12461.1 12464.2 12482.6 14134.2 14436.9 14463.4 14497.3 15840.8 6094.3 6665.4 6708.7 6715.4 6779.7 847.9 999.8 1002.2 1015.4 1026.4 28771.9 28779.3 29425.1 29462.0 29594.9 955.9 970.3 1052.7 1071.8 1090.9 14582.1 15019.8 15057.8 15429.9 15451.1 576714.0 635150.0 636638.0 638490.8 638988.0 48319.0 49069.0 49104.5 54873.0 56206.2 1328.5 1360.4 1368.6 1372.7 1375.3 29094.9 29951.6 30294.0 30313.0 30824.7 49841.3 50238.5 50239.0 50262.5 50378.0 503707.0 504500.0 506554.0 506790.0 506831.0 25830.0 38748.0 38972.0 39011.0 39056.0 34947.8 44635.3 45094.4 45560.9 45797.6 36592.8 36846.6 36884.0 37340.3 38312.0 31077.8 37092.8 37378.6 37652.6 38400.2 36089.5 36128.5 36964.3 37318.0 37358.4 31038.5 32163.8 33781.2 33959.5 34346.0 20129.7 23907.4 24969.1 25356.4 25397.2 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:32736.85 Median:13479.43 stddev:93499.81 (693.6%) stddev-sans-first:93730.48 15:21:09 INFO - PROCESS | 1638 | Values: 349.6 373.2 374.4 382.7 401.4 12463.8 14605.6 15368.6 18852.0 19147.6 19116.3 19220.6 19905.8 20022.7 20070.2 5840.6 6105.4 6113.6 6115.2 6116.7 4972.7 6014.9 6067.2 6067.7 6071.4 5707.5 5996.8 6011.1 6021.6 6027.0 5867.0 5915.2 5944.9 5948.9 5949.3 5012.5 5092.4 5137.3 5197.5 5201.5 24011.3 24040.6 24184.5 24261.4 24497.6 2223.5 2282.6 2298.9 2461.2 2954.5 15132.8 15207.6 15445.9 15624.5 15629.7 1757.1 1779.2 1796.8 1838.9 1888.7 114118.4 119466.0 124573.0 125745.2 125883.0 10359.2 10425.3 10819.5 10860.9 11022.9 13629.4 13655.0 13667.3 13673.1 13690.0 8176.6 8431.5 8505.3 8574.2 8642.0 8423.2 8450.7 8471.9 8580.7 8655.2 6422.5 6426.4 6536.2 6586.7 6654.4 1663.8 1769.6 1774.8 1785.1 1860.7 672.5 869.8 900.8 941.1 945.6 20450.8 20932.0 21447.4 21625.2 21811.3 944.4 950.9 954.4 991.5 1042.3 11145.3 11529.1 11575.0 11583.5 11597.8 488382.0 544407.0 577511.0 596042.0 596410.0 62792.4 74088.0 111571.0 113442.0 114384.0 958.1 977.3 998.4 1001.6 1002.0 18467.4 18648.6 18743.0 18787.2 18855.8 48832.5 49109.3 50545.4 50623.2 51024.0 68503.7 69224.0 70199.0 71530.0 72442.9 6043.5 6900.9 7169.2 7271.7 7475.0 9053.8 12264.4 12279.6 12366.9 12550.3 10491.6 10560.4 10598.0 10628.8 10900.0 10394.2 10500.7 10609.9 10744.7 10973.9 10299.3 10617.5 10686.1 10686.6 10856.7 6848.1 7064.7 7085.3 7301.3 7321.3 8726.7 9228.5 10027.4 10443.7 10780.0 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5444.14 Median:4939.72 stddev:3020.09 (61.1%) stddev-sans-first:3012.26 15:21:09 INFO - PROCESS | 1638 | Values: 1268.5 1438.8 1557.3 1791.5 1803.9 8092.1 8400.0 8400.8 8401.1 8403.0 5795.3 6805.4 7726.5 7772.4 8078.3 1883.9 2347.9 2351.7 2356.5 2357.8 2328.1 2351.2 2353.4 2371.5 2372.5 1944.7 2307.6 2310.5 2340.7 2341.9 2290.1 2315.1 2317.0 2318.5 2319.9 2314.8 2346.1 2346.3 2349.5 2349.6 8431.7 8521.4 8525.7 8528.5 8529.7 5113.4 5262.2 5267.0 5271.6 5272.9 3250.9 3342.0 3509.6 3564.1 3566.3 1035.6 1053.2 1069.5 1084.0 1084.0 10861.7 10945.7 11084.8 11100.0 11105.6 4514.2 4595.7 4692.9 4696.3 4769.3 9537.2 9545.4 9549.2 9552.2 9553.8 5229.9 5231.6 5236.2 5238.1 5247.4 4016.7 4179.7 4765.0 4778.4 4792.4 3825.2 3837.8 3886.8 3921.4 3924.5 1161.4 1232.9 1259.7 1262.2 1272.4 757.3 861.7 884.7 896.9 909.8 5182.7 5499.1 5639.8 5653.3 5977.0 430.8 439.5 443.2 443.8 444.5 3866.6 3870.9 3906.4 3996.0 4009.2 9785.2 9984.3 10140.6 10335.4 10347.6 10092.1 10249.3 10254.8 10271.7 10281.9 7559.4 7842.7 7848.0 7942.0 7963.0 4851.5 5704.6 5774.2 5949.7 6089.9 8418.7 8914.4 9078.3 9442.7 9568.9 9600.5 9753.4 9756.6 9756.8 9769.8 6603.1 6856.6 6857.3 7127.0 7257.0 7668.9 7826.7 7970.6 8066.2 8067.0 6995.4 7138.0 7269.6 7327.3 7386.6 6719.7 6859.2 6985.7 7008.4 7082.9 6715.8 6736.4 6830.9 6832.8 6837.9 4223.8 4823.0 4869.2 4876.1 4915.5 4843.2 4866.7 4964.0 5031.3 5055.7 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4305.45 Median:4796.33 stddev:1308.11 (27.3%) stddev-sans-first:1275.88 15:21:09 INFO - PROCESS | 1638 | Values: 250.0 301.4 306.6 311.8 315.1 4771.9 5216.3 5278.7 5288.9 5371.4 4786.4 4974.0 5062.4 5134.9 5298.8 4018.6 4056.6 4069.5 4076.1 4109.2 4040.4 4053.4 4081.4 4096.6 4114.2 3752.6 3990.3 4023.4 4061.3 4065.9 3275.6 3960.7 3965.3 3997.7 4014.3 3470.3 3475.8 3478.7 3480.0 3482.5 4248.7 5162.4 5164.8 5172.0 5181.9 3836.9 4083.2 4254.3 4367.3 4589.9 4991.7 5537.5 5556.6 5568.7 5690.8 3010.0 3791.9 3804.2 3812.7 3823.0 5603.9 5763.5 5771.7 5797.6 5809.3 3212.9 3748.6 3826.6 3838.6 3845.3 3512.0 3883.4 3929.4 3931.2 3939.6 3966.5 4282.6 4298.0 4572.2 4595.9 4540.7 5542.6 5564.2 5584.5 5594.3 1050.9 1251.6 1257.8 1265.8 1270.5 742.2 792.6 811.5 834.3 844.9 4313.9 4525.0 4531.8 4798.2 4943.7 4634.5 5148.7 5303.8 5306.7 5346.7 4288.8 4308.9 4651.8 4729.4 4816.9 2362.6 2482.4 2490.6 2509.5 2791.9 4929.9 5072.9 5311.7 5550.5 5565.4 4739.4 4834.7 5063.8 5337.0 5501.8 4708.7 4953.7 5172.5 5516.7 5569.9 4144.0 4947.4 5351.8 5374.0 5419.0 4816.7 4857.4 4887.7 5273.4 5307.3 4687.7 4906.0 4913.0 5121.8 5504.9 3352.6 3496.9 3556.8 3583.3 3611.5 4794.4 4975.4 5265.8 5285.8 5307.8 4610.0 5014.7 5166.9 5221.8 5257.5 4369.8 4533.5 5087.0 5121.6 5202.9 3961.0 4941.3 5070.9 5248.4 5485.6 4933.3 5112.6 5470.6 5493.2 5619.2 4806.8 5304.9 5463.2 5503.8 5518.3 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20818.81 Median:23343.31 stddev:31005.62 (132.8%) stddev-sans-first:31055.56 15:21:09 INFO - PROCESS | 1638 | Values: 636.5 722.4 775.8 776.2 783.3 14341.6 14659.8 14661.1 15631.4 16494.8 14783.4 14883.6 15180.2 15203.8 15225.5 793.2 819.9 820.2 821.3 821.5 644.7 665.8 669.8 818.3 823.9 823.5 847.3 847.5 848.4 850.6 834.9 835.6 835.7 835.7 836.0 499.5 509.3 624.0 624.7 627.1 13752.3 14290.0 14324.3 14627.4 14656.2 11509.0 13064.9 13142.8 13469.5 13632.7 11358.5 11410.7 11465.4 11563.8 11625.2 3575.0 3582.2 3608.6 3691.9 3737.9 88049.5 90516.0 92882.5 93492.1 94299.1 10093.2 10127.9 10342.8 10372.0 10490.6 20120.4 20408.4 20456.5 20485.0 20499.9 7484.4 7531.2 7552.2 7581.3 7631.7 4088.5 4116.6 4175.6 4184.4 4349.6 2715.6 3362.4 3404.9 3430.3 3432.3 620.6 639.4 646.9 654.2 658.1 634.8 639.1 648.3 653.0 675.3 8634.4 8938.5 9136.5 9141.4 9165.2 637.7 663.8 666.5 667.7 683.5 4489.5 4504.2 4886.7 4910.2 4924.8 77333.6 105706.0 121527.0 121997.4 122277.0 65360.0 95323.0 106026.4 108528.9 108893.5 93108.0 94282.0 94815.0 94890.0 95361.0 9316.3 9473.6 9537.4 9566.4 9568.9 42337.0 56090.9 56137.7 57363.4 57407.4 49679.8 50818.0 77167.0 81316.0 81616.0 9893.6 12381.2 12611.9 12657.0 13122.5 11626.7 13899.9 14130.4 14236.2 14593.1 12318.5 12577.9 12618.3 12685.4 13542.4 12873.4 13177.5 13227.1 13297.3 13376.6 12202.5 12332.9 12334.5 12376.9 12488.7 10826.4 10846.3 11077.4 11169.5 11587.7 11007.7 11238.9 11257.2 11468.5 11475.7 15:21:09 INFO - PROCESS | 1638 | -------- Summary: end -------- 15:21:09 INFO - PROCESS | 1638 | 15:21:09 INFO - TEST-INFO | 1638: exit 0 15:21:09 INFO - TEST-OK | dromaeo_css | took 1118865ms 15:21:09 INFO - TEST-START | kraken 15:21:09 INFO - operating with platform_type : mac_ 15:21:09 INFO - Initialising browser for kraken test... 15:21:09 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpD9pZGg/profile http://localhost:49247/getInfo.html) 15:21:12 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 15:21:12 INFO - PROCESS | 1647 | colorDepth:24 15:21:12 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 15:21:12 INFO - PROCESS | 1647 | __metrics 15:21:12 INFO - PROCESS | 1647 | 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" 15:21:12 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:21:13 INFO - TEST-INFO | 1647: exit 0 15:21:13 INFO - Browser initialized. 15:21:13 INFO - Running cycle 1/1 for kraken test... 15:21:13 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpD9pZGg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:25 INFO - PROCESS | 1648 | RSS: Main: 222134272 15:21:25 INFO - PROCESS | 1648 | 15:21:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:29 INFO - PROCESS | 1648 | RSS: Main: 271908864 15:21:29 INFO - PROCESS | 1648 | 15:21:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 15:21:32 INFO - PROCESS | 1648 | RSS: Main: 283090944 15:21:32 INFO - PROCESS | 1648 | 15:21:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 15:21:36 INFO - PROCESS | 1648 | RSS: Main: 379641856 15:21:36 INFO - PROCESS | 1648 | 15:21:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 15:21:39 INFO - PROCESS | 1648 | RSS: Main: 282107904 15:21:39 INFO - PROCESS | 1648 | 15:21:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:41 INFO - PROCESS | 1648 | RSS: Main: 283316224 15:21:41 INFO - PROCESS | 1648 | 15:21:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:45 INFO - PROCESS | 1648 | RSS: Main: 323358720 15:21:45 INFO - PROCESS | 1648 | 15:21:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:48 INFO - PROCESS | 1648 | RSS: Main: 326283264 15:21:48 INFO - PROCESS | 1648 | 15:21:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 15:21:52 INFO - PROCESS | 1648 | RSS: Main: 324034560 15:21:52 INFO - PROCESS | 1648 | 15:21:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:54 INFO - PROCESS | 1648 | RSS: Main: 299274240 15:21:54 INFO - PROCESS | 1648 | 15:21:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:56 INFO - PROCESS | 1648 | RSS: Main: 303144960 15:21:56 INFO - PROCESS | 1648 | 15:21:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:59 INFO - PROCESS | 1648 | RSS: Main: 305221632 15:21:59 INFO - PROCESS | 1648 | 15:22:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:03 INFO - PROCESS | 1648 | RSS: Main: 321617920 15:22:03 INFO - PROCESS | 1648 | 15:22:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:06 INFO - PROCESS | 1648 | RSS: Main: 315031552 15:22:06 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 15:22:08 INFO - PROCESS | 1648 | RSS: Main: 358944768 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | __start_tp_report 15:22:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 15:22:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 15:22:08 INFO - PROCESS | 1648 | |i|pagename|runs| 15:22:08 INFO - PROCESS | 1648 | |0;ai-astar;113;114;113;114;114;114;114;114;115;115 15:22:08 INFO - PROCESS | 1648 | |1;audio-beat-detection;143;107;111;143;110;108;109;107;139;108 15:22:08 INFO - PROCESS | 1648 | |2;audio-dft;181;181;185;185;181;184;183;183;183;184 15:22:08 INFO - PROCESS | 1648 | |3;audio-fft;81;59;59;88;64;96;83;83;103;59 15:22:08 INFO - PROCESS | 1648 | |4;audio-oscillator;89;72;92;81;95;72;90;67;68;93 15:22:08 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;85;89;90;87;85;94;87;88;85 15:22:08 INFO - PROCESS | 1648 | |6;imaging-darkroom;92;94;94;94;93;121;152;103;93;107 15:22:08 INFO - PROCESS | 1648 | |7;imaging-desaturate;83;84;81;81;81;84;86;87;81;81 15:22:08 INFO - PROCESS | 1648 | |8;json-parse-financial;54;54;53;54;58;57;58;57;57;57 15:22:08 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;64;69;83;76;73;70;70;71;69;70 15:22:08 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;85;83;84;84;84;84;83;83;81;84 15:22:08 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;142;141;140;138;139;145;162;153;186;140 15:22:08 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;166;165;167;167;164;166;166;163;164;163 15:22:08 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;68;62;59;70;80;86;86;67;65 15:22:08 INFO - PROCESS | 1648 | __end_tp_report 15:22:08 INFO - PROCESS | 1648 | __start_cc_report 15:22:08 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1934 15:22:08 INFO - PROCESS | 1648 | __end_cc_report 15:22:08 INFO - PROCESS | 1648 | __startTimestamp1484781728635__endTimestamp 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | ------- Summary: start ------- 15:22:08 INFO - PROCESS | 1648 | Number of tests: 14 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 15:22:08 INFO - PROCESS | 1648 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:110.50 stddev:16.07 (14.5%) stddev-sans-first:14.39 15:22:08 INFO - PROCESS | 1648 | Values: 143.0 107.0 111.0 143.0 110.0 108.0 109.0 107.0 139.0 108.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.56 (0.9%) stddev-sans-first:1.48 15:22:08 INFO - PROCESS | 1648 | Values: 181.0 181.0 185.0 185.0 181.0 184.0 183.0 183.0 183.0 184.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:77.50 Median:82.00 stddev:16.28 (19.9%) stddev-sans-first:17.22 15:22:08 INFO - PROCESS | 1648 | Values: 81.0 59.0 59.0 88.0 64.0 96.0 83.0 83.0 103.0 59.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:81.90 Median:89.50 stddev:11.18 (12.5%) stddev-sans-first:11.56 15:22:08 INFO - PROCESS | 1648 | Values: 89.0 72.0 92.0 81.0 95.0 72.0 90.0 67.0 68.0 93.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:87.50 stddev:2.79 (3.2%) stddev-sans-first:2.95 15:22:08 INFO - PROCESS | 1648 | Values: 87.0 85.0 89.0 90.0 87.0 85.0 94.0 87.0 88.0 85.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:93.00 stddev:19.11 (20.6%) stddev-sans-first:19.75 15:22:08 INFO - PROCESS | 1648 | Values: 92.0 94.0 94.0 94.0 93.0 121.0 152.0 103.0 93.0 107.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:82.90 Median:83.50 stddev:2.28 (2.7%) stddev-sans-first:2.42 15:22:08 INFO - PROCESS | 1648 | Values: 83.0 84.0 81.0 81.0 81.0 84.0 86.0 87.0 81.0 81.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.91 (3.4%) stddev-sans-first:1.90 15:22:08 INFO - PROCESS | 1648 | Values: 54.0 54.0 53.0 54.0 58.0 57.0 58.0 57.0 57.0 57.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:70.50 stddev:5.06 (7.2%) stddev-sans-first:4.58 15:22:08 INFO - PROCESS | 1648 | Values: 64.0 69.0 83.0 76.0 73.0 70.0 70.0 71.0 69.0 70.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:1.00 15:22:08 INFO - PROCESS | 1648 | Values: 85.0 83.0 84.0 84.0 84.0 84.0 83.0 83.0 81.0 84.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:143.50 stddev:15.15 (10.6%) stddev-sans-first:15.87 15:22:08 INFO - PROCESS | 1648 | Values: 142.0 141.0 140.0 138.0 139.0 145.0 162.0 153.0 186.0 140.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 15:22:08 INFO - PROCESS | 1648 | Values: 166.0 165.0 167.0 167.0 164.0 166.0 166.0 163.0 164.0 163.0 15:22:08 INFO - PROCESS | 1648 | 15:22:08 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:69.00 stddev:9.59 (13.9%) stddev-sans-first:10.10 15:22:08 INFO - PROCESS | 1648 | Values: 68.0 68.0 62.0 59.0 70.0 80.0 86.0 86.0 67.0 65.0 15:22:08 INFO - PROCESS | 1648 | -------- Summary: end -------- 15:22:08 INFO - PROCESS | 1648 | 15:22:09 INFO - TEST-INFO | 1648: exit 0 15:22:09 INFO - TEST-OK | kraken | took 59725ms 15:22:09 INFO - SUITE-END | took 1178s 15:22:09 INFO - Completed test suite (00:19:38) 15:22:09 INFO - javascript benchmark 15:22:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.036814139829, 3321.9335613287726, 3323.900282991511, 3353.2287573858025, 3370.2585431205143, 5674.631148975319, 5731.656100633965, 5739.598228124033, 5753.856153596163, 5786.508146807516, 5560.082586373253, 5597.356304025028, 5620.831375058745, 5621.690807005613, 5637.182608521762, 5140.023395554833, 5161.9741901290445, 5164.9483505164935, 5168.741562921858, 5210.114280572312, 5142.794288228485, 5161.406438259592, 5169.0, 5252.737363131828, 5268.394134674504, 5200.063988482072, 5267.26258323835, 5271.630985830974, 5294.258803767476, 5296.708681022542, 5268.894622107556, 5289.973550132225, 5294.947050529484, 5296.0, 5311.707856067915, 4350.390945267665, 5138.665986710889, 5279.973600132013, 5291.417944026154, 5297.6821390716295, 5604.887902241932, 5651.463111004448, 5658.405867383906, 5680.914786278209, 5766.192733017381, 6188.1027251048345, 6224.408681175281, 6230.096635987757, 6235.594686345418, 6264.812055638338, 6357.523185761041, 6357.809265722036, 6359.20509936258, 6360.2367715873925, 6381.585196962183, 5698.487136157766, 5732.6847023413275, 5766.163906233573, 5874.060150375962, 5889.146073819272, 6280.5603607747935, 6310.05349197624, 6333.904991425133, 6334.714937827809, 6339.366063393623, 6202.534809889276, 6205.937940620626, 6207.937920620826, 6209.0, 6216.378362163748, 6123.170895756613, 6188.535859810442, 6191.318954914956, 6275.937240627535, 6304.936950630527, 6208.255009398901, 6261.436470717657, 6285.9057114143325, 6289.55973081889, 6290.370962903673, 6220.7511699531515, 6222.937770622236, 6293.2762732285455, 6303.936960630427, 6308.400701933309, 4874.36633237684, 4914.70511769295, 4957.132501812169, 4988.002399520038, 4996.200607902791, 4393.494748103945, 4406.6474682026, 4414.1171765647, 4420.756858372756, 4461.442319710036, 5842.912356314659, 5848.2689663792025, 5848.795292164754, 5884.941150588525, 5905.025670764362, 6176.907346389808, 6189.597676151036, 6298.275698294663, 6307.211598550181, 6323.051542268697, 5549.861253468695, 5598.300212473441, 5641.605087643908, 5781.075027995501, 5836.737346819404, 5451.727413629303, 5503.091989821634, 5509.641873278224, 5514.007478653881, 5544.805931792368, 6395.968020159869, 6401.775937842153, 6402.679866006774, 6424.261209960728, 6428.292887782433, 6137.447629713347, 6178.258608966953, 6231.750729970931, 6313.43179113882, 6313.46335561464, 5135.897282054263, 5365.490278423544, 6310.1796766420075, 6380.234371875405, 6405.967970160119, 6222.439980401786, 6231.40801623845, 6239.469645080219, 6249.468795152463, 6251.6874156292915, 5087.9456435648735, 6072.8785424292155, 6121.392004143408, 6134.987697083657, 6295.370462953668, 5877.23595932526, 6015.218021657157, 6032.517398608188, 6100.75596976116, 6143.56995010345, 6139.706800529493, 6160.969195153995, 6172.22847144107, 6190.597611155261, 6200.100985357189, 5932.614380065282, 5972.910406343995, 5989.341172470938, 6020.54845886569, 6085.6348619083, 5968.253968253968, 6055.636661800306, 6061.757529698939, 6184.319724830175, 6206.441420272197, 5040.5967522597375, 5973.49225315853, 6012.518998480024, 6032.75868965254, 6104.20645316106], "value": 5701.728320954716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.59812262393035, 479.486948964608, 482.79239926831457, 489.7257535779961, 519.2185760430551, 29659.70340296599, 30290.39419211617, 38697.22605547887, 40020.39969400461, 40111.197776044464, 39338.40992385116, 41313.79343103288, 41390.58609413912, 41429.37855932156, 41593.792031039804, 9245.306602004843, 9403.153716165543, 9416.0, 9419.340646154771, 9455.243580513577, 8359.373047021467, 8545.572721363938, 9293.628254869796, 11027.44862756859, 11308.943455282753, 11230.0, 11277.266977646426, 11299.209055366087, 11306.604268850591, 11327.773444531105, 11237.550497980072, 11306.378149201832, 11308.717282067932, 11331.660050198425, 11373.488193031333, 8248.175182481704, 8470.915290847075, 10951.178661600412, 11278.436078196057, 11283.943580282128, 39980.600193997976, 40128.79935600333, 40196.39705404421, 40222.195556089006, 40225.396619050734, 3199.4560924642865, 3289.703926646613, 3405.914852128692, 3576.4635304704243, 3610.2238018825815, 28830.855845720846, 29838.40323193524, 29879.701202987908, 30297.0, 30320.393592128035, 3105.642851072133, 3169.0968074098773, 3205.1987003249187, 3218.855151518187, 3248.642649308574, 481942.0, 484572.0, 485096.0, 485132.0, 485171.57414213056, 58304.83390332254, 58735.0, 58822.0, 58900.82198356009, 58982.70508647429, 60327.69836150791, 60418.697906510184, 60451.69774151101, 60597.69701151554, 60692.78614427687, 15730.213489325717, 15956.361745530048, 15967.840321596635, 15986.520404387888, 15989.60025999336, 11136.66590002285, 12457.314847683283, 12461.127721059438, 12464.189827661174, 12482.563110291278, 14134.15195088298, 14436.855631443761, 14463.421463141356, 14497.347619357155, 15840.76238856418, 6094.268687757409, 6665.400113989765, 6708.664566771642, 6715.429188518933, 6779.72881084751, 847.9321654267644, 999.7500624843789, 1002.2082554781641, 1015.410881969715, 1026.3636545341787, 28771.856140719163, 28779.280517986797, 29425.11724648264, 29462.0, 29594.852025739732, 955.9474228917337, 970.3304719743354, 1052.736815796051, 1071.7802850415646, 1090.9345439273668, 14582.125072495684, 15019.774703379459, 15057.774133388008, 15429.922850385676, 15451.072935623899, 576714.0, 635150.0, 636638.0, 638490.8075459686, 638988.0, 48319.0, 49069.0, 49104.50895491071, 54873.0, 56206.156907646415, 1328.5018118205674, 1360.4014233737123, 1368.5620601407454, 1372.670559065797, 1375.3467103125936, 29094.854525727234, 29951.550726738682, 30294.0, 30313.0, 30824.69175308308, 49841.252381213584, 50238.497615023385, 50239.0, 50262.497375025785, 50378.0, 503707.0, 504500.0, 506554.0, 506790.0, 506831.0, 25830.0, 38748.0, 38972.0, 39011.0, 39056.0, 34947.825260873535, 44635.33047004363, 45094.42169524051, 45560.8609784758, 45797.626071217914, 36592.81703591465, 36846.63153368432, 36884.0, 37340.25319493649, 38312.0, 31077.844610776803, 37092.81453592715, 37378.626213737516, 37652.623473764914, 38400.231995359376, 36089.458658120675, 36128.518850093875, 36964.26071478609, 37318.0, 37358.439623405124, 31038.482126925628, 32163.839180803945, 33781.15547111243, 33959.4906076414, 34346.0, 20129.6980545289, 23907.402314942265, 24969.12608058709, 25356.449362091145, 25397.236399850615], "value": 19588.798284246786, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5892326516343, 373.1752826253979, 374.44768965775467, 382.7129652760429, 401.3918912847037, 12463.813042804366, 14605.634859128528, 15368.61578460539, 18852.0, 19147.617047659038, 19116.33092841751, 19220.636388632003, 19905.800941990576, 20022.699659505084, 20070.197192112297, 5840.561957853157, 6105.419985101408, 6113.633182009072, 6115.205023346981, 6116.694165291718, 4972.701637901738, 6014.8797024059495, 6067.211262535864, 6067.696615169224, 6071.3625069367745, 5707.486326230638, 5996.790112346069, 6011.098335249704, 6021.608595441304, 6027.0, 5867.002609556385, 5915.171875937351, 5944.851378715523, 5948.940510594882, 5949.315828679714, 5012.473690262543, 5092.363454568179, 5137.33214682089, 5197.506236907488, 5201.505856943584, 24011.27966161018, 24040.639390409156, 24184.51630967371, 24261.393465163335, 24497.63253551198, 2223.5330580578097, 2282.6461898405773, 2298.9425264368356, 2461.2247142150163, 2954.5125054366217, 15132.848671513255, 15207.61980950474, 15445.922770386189, 15624.531264062096, 15629.687406251925, 1757.139001889078, 1779.217144456435, 1796.8203179682057, 1838.8528917686554, 1888.688366419539, 114118.42940785243, 119466.0, 124573.0, 125745.22764317085, 125883.0, 10359.22305827066, 10425.270231083903, 10819.513121909533, 10860.927152317881, 11022.921519038007, 13629.386677599532, 13655.0, 13667.316634168252, 13673.111247768864, 13690.0, 8176.591170441454, 8431.494110353398, 8505.277051450572, 8574.185452382013, 8641.956790216009, 8423.199796019368, 8450.704225352083, 8471.872921906177, 8580.65677372898, 8655.17775811297, 6422.4862011039, 6426.35736426363, 6536.150300460909, 6586.73653053882, 6654.401103900575, 1663.8169801321844, 1769.646070785848, 1774.751534785131, 1785.0628420079563, 1860.6929856573784, 672.5258692621787, 869.7651634058768, 900.819836032796, 941.0589410589411, 945.6264775413673, 20450.79549204489, 20931.953402329822, 21447.356579302646, 21625.24311649085, 21811.345659630235, 944.4097439100562, 950.9381890177116, 954.4082668745423, 991.4943378876825, 1042.2860340666668, 11145.328200769787, 11529.077673786078, 11575.016123629417, 11583.536658533565, 11597.826032609517, 488382.0, 544407.0, 577511.0, 596042.0, 596410.0, 62792.372076279564, 74088.0, 111571.0, 113442.0, 114384.0, 958.0898146760605, 977.2768151567931, 998.4458625462938, 1001.5893483671659, 1001.9899801001897, 18467.414561961068, 18648.627027459646, 18742.96913669761, 18787.248510059446, 18855.811441885406, 48832.51167488422, 49109.2633610489, 50545.41828696809, 50623.24065138952, 51024.0, 68503.65748171427, 69223.96164057644, 70199.0, 71530.0, 72442.91335629864, 6043.54673399488, 6900.896486552806, 7169.247229041084, 7271.745488908075, 7475.02824632816, 9053.818923621358, 12264.38678066111, 12279.570215042431, 12366.876331236572, 12550.309732964775, 10491.632792852213, 10560.366378017343, 10598.04617584421, 10628.84056739134, 10900.0, 10394.168466522811, 10500.684979450629, 10609.9469502652, 10744.73138171552, 10973.945130274298, 10299.330543514647, 10617.469126543796, 10686.114749017877, 10686.625968091079, 10856.674299771019, 6848.14398200225, 7064.717411303491, 7085.256048114874, 7301.342879140902, 7321.267873212636, 8726.69456569017, 9228.538573071186, 10027.448490333101, 10443.68668939933, 10780.0], "value": 9360.81988491453, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.467243757622, 1438.762604170312, 1557.3147814961417, 1791.4804706635077, 1803.8556915446766, 8092.109867914532, 8400.033996090451, 8400.789980250489, 8401.117882622328, 8403.033651130121, 5795.304563452381, 6805.387515123638, 7726.497777644449, 7772.378209743221, 8078.313343365806, 1883.8869667819974, 2347.882605869708, 2351.670766092748, 2356.5404746074523, 2357.834951553392, 2328.0687724910085, 2351.235848349285, 2353.352827972304, 2371.5494056129364, 2372.4543355028354, 1944.7277381166648, 2307.5846347657416, 2310.4570425949887, 2340.67230587717, 2341.882905854709, 2290.061074959267, 2315.1086831569796, 2316.976830231693, 2318.4783423729696, 2319.907203711858, 2314.7916687498205, 2346.085026839534, 2346.3195673254736, 2349.5066036132434, 2349.565330413879, 8431.704890328809, 8521.44610600309, 8525.701600444017, 8528.488290702515, 8529.74410767678, 5113.437521872591, 5262.236975638511, 5267.0, 5271.604629652753, 5272.947270527284, 3250.9349813003846, 3342.0, 3509.5613048368955, 3564.108972756811, 3566.32239874423, 1035.5702383510834, 1053.2048303530785, 1069.5080263078994, 1084.0297933349686, 1084.046039485248, 10861.728456788565, 10945.671629851116, 11084.833727494093, 11100.0, 11105.555777768961, 4514.210013247734, 4595.655325850575, 4692.859214223578, 4696.319033740157, 4769.260764581495, 9537.189338906272, 9545.427274363561, 9549.188318992963, 9552.188064014637, 9553.761155971017, 5229.921551176735, 5231.633785635046, 5236.24074509194, 5238.083335416287, 5247.396549396792, 4016.7188296819527, 4179.749215047107, 4765.0, 4778.402699662543, 4792.353032340659, 3825.2158307547443, 3837.7505462144873, 3886.8250928708276, 3921.3725803871243, 3924.50943632046, 1161.4076820821442, 1232.8520577530753, 1259.6724851538484, 1262.1921969939247, 1272.3638180909545, 757.2541047068632, 861.7199410191713, 884.6903583745637, 896.8699538567001, 909.7543663211028, 5182.689038657692, 5499.1476321170285, 5639.830805075854, 5653.265075540154, 5977.043673012384, 430.834128860391, 439.50555624921964, 443.24869346457444, 443.81803460581006, 444.46442037344923, 3866.5940076292145, 3870.9225815483533, 3906.374980003186, 3995.961050126988, 4009.1981603679383, 9785.168260697777, 9984.251181161442, 10140.594376224868, 10335.37987720724, 10347.63783267582, 10092.091711745978, 10249.282550221413, 10254.846177307347, 10271.7432064199, 10281.897181028244, 7559.433042521723, 7842.725504607311, 7847.960760196277, 7941.9999999998845, 7962.960185199153, 4851.51484851512, 5704.629199102045, 5774.1916131740745, 5949.672767997802, 6089.878202436015, 8418.747437576883, 8914.420562663665, 9078.273738101068, 9442.669506567237, 9568.856467153137, 9600.519974001412, 9753.366031207948, 9756.60973561078, 9756.804863902824, 9769.80460390774, 6603.075569420381, 6856.6228857413325, 6857.348551887562, 7127.037849890198, 7257.020302259339, 7668.923310766821, 7826.726064587712, 7970.641321140679, 8066.23370779775, 8067.0, 6995.370416662321, 7138.0, 7269.636518173965, 7327.303906128909, 7386.593737344498, 6719.664016799043, 6859.211190713132, 6985.685644145924, 7008.369246767816, 7082.893756593552, 6715.764948226789, 6736.393724564813, 6830.863382732218, 6832.829179270558, 6837.9316206839285, 4223.7751052195745, 4822.9758851205515, 4869.245266983623, 4876.122297986397, 4915.483874193301, 4843.249296358929, 4866.732329721758, 4963.950360496493, 5031.295618613471, 5055.6713813602], "value": 4331.941573156121, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [250.04358329390084, 301.38818199055925, 306.5738623313594, 311.80356375483444, 315.147525942326, 4771.8807029824275, 5216.269722238885, 5278.7360631968395, 5288.947110528894, 5371.435999220084, 4786.353842231298, 4973.975130124353, 5062.367204099488, 5134.922976155361, 5298.761555729991, 4018.5981401859726, 4056.6066021047577, 4069.511658600957, 4076.084240407004, 4109.21924834282, 4040.4141399497057, 4053.3717273822604, 4081.3673880548413, 4096.631303182713, 4114.156597897439, 3752.587215406303, 3990.2817492851277, 4023.396490526415, 4061.3298805697023, 4065.918681626366, 3275.5577996970583, 3960.6731744865506, 3965.3060714375156, 3997.660198883113, 4014.3376342903384, 3470.2538954124984, 3475.7566970312087, 3478.7390945679176, 3479.9652003480146, 3482.547268855058, 4248.660107191417, 5162.432132465426, 5164.767585458626, 5171.974140129275, 5181.870453238662, 3836.865709700175, 4083.2445997490263, 4254.298040823261, 4367.279398899178, 4589.862304130881, 4991.725455099968, 5537.501624853742, 5556.611037227396, 5568.693721845297, 5690.772369105231, 3009.9849500752575, 3791.9431208531896, 3804.2201348723447, 3812.7331086823933, 3823.0, 5603.915941260884, 5763.452472015152, 5771.6725153214575, 5797.608573942266, 5809.302883653989, 3212.8754935772295, 3748.606396328401, 3826.559945606235, 3838.596947320491, 3845.3270677631303, 3511.964880351215, 3883.417487376916, 3929.410588411761, 3931.2334094851803, 3939.6060393960374, 3966.5438474575217, 4282.6359759420175, 4297.978510107492, 4572.199865023607, 4595.862124136282, 4540.705898818821, 5542.584306176972, 5564.165375193753, 5584.492187109539, 5594.300712410949, 1050.9316894401838, 1251.5807204586565, 1257.8427696537933, 1265.8354413926315, 1270.5489551209373, 742.2021327073418, 792.6155814429997, 811.4806523824757, 834.3325339728193, 844.8774927635582, 4313.935290970638, 4524.977375113103, 4531.796069176829, 4798.2082956312515, 4943.714634195135, 4634.490206077328, 5148.716820574904, 5303.814366497154, 5306.681599104066, 5346.652467589594, 4288.764117973541, 4308.858152589566, 4651.837185698552, 4729.432468103781, 4816.903661926812, 2362.5629258587214, 2482.416632091457, 2490.5517006938926, 2509.4855554611627, 2791.9441611167663, 4929.852104436873, 5072.898542029138, 5311.7344132793205, 5550.500454959073, 5565.387807341189, 4739.3838800955655, 4834.734089625104, 5063.822766203165, 5337.0, 5501.807436739695, 4708.670393072452, 4953.678010929278, 5172.456892026434, 5516.668999859941, 5569.944300556943, 4143.97928010358, 4947.356843610308, 5351.839444816662, 5374.0, 5418.970395624819, 4816.735079570657, 4857.417109946829, 4887.731174785421, 5273.393559740525, 5307.283516725192, 4687.6795985987155, 4905.950940490692, 4913.0, 5121.79512819498, 5504.91742623869, 3352.6479719630065, 3496.9334353022573, 3556.8221588919932, 3583.3337498063524, 3611.5124458197806, 4794.448638406628, 4975.4278258000795, 5265.842024739264, 5285.788568457218, 5307.761150748149, 4610.040732688661, 5014.671112155209, 5166.948330516647, 5221.791128354823, 5257.526822585833, 4369.798305466023, 4533.501314855297, 5086.982603479245, 5121.590272778243, 5202.947970520247, 3960.9603903961743, 4941.308216849716, 5070.949290507047, 5248.448912864094, 5485.588580856372, 4933.29801218579, 5112.590992720648, 5470.580886945659, 5493.176023596492, 5619.213310136666, 4806.759662016955, 5304.9204261936875, 5463.235147079492, 5503.807366742305, 5518.310211223597], "value": 3883.9707251204495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.519427831987, 722.4220623501197, 775.8266660729217, 776.1501156233921, 783.3028604541955, 14341.569752907417, 14659.780103298446, 14661.120332780027, 15631.374745010186, 16494.75257871133, 14783.408663653468, 14883.553493395188, 15180.240987950587, 15203.847961520381, 15225.543233703007, 793.183021487867, 819.9467034642759, 820.2003047029159, 821.2772759971217, 821.4742564758559, 644.6937704590329, 665.7636539028648, 669.7923643670454, 818.3289702443998, 823.9382046346548, 823.4770920465518, 847.3390755210945, 847.5211505499404, 848.440029580477, 850.612971098152, 834.929031032363, 835.6197929941862, 835.7075023741703, 835.7325655790149, 835.9874601880977, 499.45060433523196, 509.2971699055317, 624.0327492386782, 624.6501958903029, 627.1251604012423, 13752.31238438074, 14290.0, 14324.283785810669, 14627.414903403851, 14656.193909334983, 11508.96419322265, 13064.86935130646, 13142.802857957138, 13469.528566500125, 13632.659183520393, 11358.488868000877, 11410.657680269605, 11465.426728663533, 11563.826542601868, 11625.24435911663, 3574.982125089358, 3582.1940063485767, 3608.639136086397, 3691.8523259069607, 3737.906552336186, 88049.54797462703, 90516.0, 92882.53558732163, 93492.06507934969, 94299.0570094304, 10093.192544596415, 10127.898721012696, 10342.844857327145, 10371.962803719718, 10490.636217291856, 20120.39638810838, 20408.38774836757, 20456.488587785127, 20485.0, 20499.8975005124, 7484.401247900264, 7531.171571127281, 7552.169261381244, 7581.317681408589, 7631.732889348847, 4088.509378874554, 4116.629503344653, 4175.62419382257, 4184.351425529047, 4349.629866592013, 2715.5926611008113, 3362.411577973845, 3404.914877128042, 3430.3310854383158, 3432.3306955144008, 620.6431302001367, 639.4149353341734, 646.9159009328757, 654.1724718231441, 658.1279804259375, 634.7524465458475, 639.146739103293, 648.3225029843825, 652.9967350163218, 675.3078094952713, 8634.438761480484, 8938.50838203905, 9136.49749263797, 9141.405808622418, 9165.220956218664, 637.7225906730495, 663.8274048747361, 666.4535081233439, 667.7495939022866, 683.5386114372778, 4489.483709373399, 4504.166729155117, 4886.65793394459, 4910.165271903785, 4924.778384972685, 77333.6133319341, 105706.0, 121527.0, 121997.39001304937, 122277.0, 65360.0, 95323.0, 106026.40960385601, 108528.91471085188, 108893.45553272183, 93108.0, 94282.0, 94815.0, 94890.0, 95361.04638953521, 9316.34785565031, 9473.621055157717, 9537.427754334762, 9566.378185417925, 9568.856467153137, 42337.0, 56090.878182436936, 56137.71931140318, 57363.42636573581, 57407.42592574021, 49679.75160124176, 50818.0, 77167.0, 81316.0, 81616.0, 9893.600677942606, 12381.195222310522, 12611.87388126107, 12657.0, 13122.540711075066, 11626.70933226676, 13899.930500347433, 14130.434782608992, 14236.217008064656, 14593.051451656032, 12318.507259709511, 12577.87422125767, 12618.305993170463, 12685.365731713562, 13542.390592423168, 12873.356332183166, 13177.47290108385, 13227.140235884637, 13297.335133243105, 13376.598702038955, 12202.511899523919, 12332.868489056267, 12334.50661973547, 12376.876231237933, 12488.687782805502, 10826.350418974887, 10846.349219046882, 11077.446127693422, 11169.497372618414, 11587.710307242387, 11007.669769906915, 11238.887611123784, 11257.15571332137, 11468.541258349573, 11475.713107172387], "value": 7288.519318762829, "unit": "score"}], "name": "dromaeo_css", "value": 7101.159155808765, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 111.0, 143.0, 110.0, 108.0, 109.0, 107.0, 139.0, 108.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 185.0, 185.0, 181.0, 184.0, 183.0, 183.0, 183.0, 184.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 64.0, 96.0, 83.0, 83.0, 103.0, 59.0], "value": 77.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 92.0, 81.0, 95.0, 72.0, 90.0, 67.0, 68.0, 93.0], "value": 81.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 90.0, 87.0, 85.0, 94.0, 87.0, 88.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 94.0, 93.0, 121.0, 152.0, 103.0, 93.0, 107.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 81.0, 81.0, 84.0, 86.0, 87.0, 81.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 58.0, 57.0, 58.0, 57.0, 57.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 83.0, 76.0, 73.0, 70.0, 70.0, 71.0, 69.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 84.0, 84.0, 84.0, 83.0, 83.0, 81.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 140.0, 138.0, 139.0, 145.0, 162.0, 153.0, 186.0, 140.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 167.0, 167.0, 164.0, 166.0, 166.0, 163.0, 164.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 62.0, 59.0, 70.0, 80.0, 86.0, 86.0, 67.0, 65.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1445.4999999999995, "alertThreshold": 2.0}]} 15:22:09 INFO - Return code: 0 15:22:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:22:09 INFO - # TBPL SUCCESS # 15:22:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:22:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:22:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:22:09 INFO - 2017-01-18 15:22:09.973 screenresolution[1652:9875] starting screenresolution argv=screenresolution get 15:22:09 INFO - 2017-01-18 15:22:09.976 screenresolution[1652:9875] Display 0: 1600x1200x32@60 15:22:09 INFO - 2017-01-18 15:22:09.983 screenresolution[1653:9879] starting screenresolution argv=screenresolution list 15:22:09 INFO - Available Modes on Display 0 15:22:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:22:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:22:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:22:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:22:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:22:10 INFO - Intel Iris: 15:22:10 INFO - Chipset Model: Intel Iris 15:22:10 INFO - Type: GPU 15:22:10 INFO - Bus: Built-In 15:22:10 INFO - VRAM (Dynamic, Max): 1536 MB 15:22:10 INFO - Vendor: Intel (0x8086) 15:22:10 INFO - Device ID: 0x0a2e 15:22:10 INFO - Revision ID: 0x0009 15:22:10 INFO - Displays: 15:22:10 INFO - Display: 15:22:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:22:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:22:10 INFO - Display Serial Number: 1600x1200 60 15:22:10 INFO - Main Display: Yes 15:22:10 INFO - Mirror: Off 15:22:10 INFO - Online: Yes 15:22:10 INFO - Rotation: Supported 15:22:10 INFO - Return code: 0 15:22:10 INFO - Running post-action listener: _resource_record_post_action 15:22:10 INFO - [mozharness: 2017-01-18 23:22:10.231594Z] Finished run-tests step (success) 15:22:10 INFO - Running post-run listener: _resource_record_post_run 15:22:10 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38773760; Write bytes: 658347008; Read time: 374; Write time: 2161 15:22:10 INFO - TinderboxPrint: CPU usage
53.3% 15:22:10 INFO - TinderboxPrint: I/O read bytes / time
38,773,760 / 374 15:22:10 INFO - TinderboxPrint: I/O write bytes / time
658,347,008 / 2,161 15:22:10 INFO - TinderboxPrint: CPU idle
2,262.0 (46.7%) 15:22:10 INFO - TinderboxPrint: CPU system
967.3 (20.0%) 15:22:10 INFO - TinderboxPrint: CPU user
1,616.5 (33.4%) 15:22:10 INFO - TinderboxPrint: Swap in / out
387,747,840 / 0 15:22:10 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 336939520; Write bytes: 334211072; Read time: 26453; Write time: 585 15:22:10 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 37766144; Write bytes: 306363392; Read time: 356; Write time: 1524 15:22:10 INFO - Running post-run listener: _upload_blobber_files 15:22:10 INFO - Blob upload gear active. 15:22:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:11 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:12 INFO - (blobuploader) - INFO - Done attempting. 15:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:22:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:13 INFO - (blobuploader) - INFO - Done attempting. 15:22:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:15 INFO - (blobuploader) - INFO - Done attempting. 15:22:15 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:15 INFO - Return code: 0 15:22:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ce1aae3f48689f325f04aa4d0f111a380426e98169ff76edcac6093488ea0c2b690aebe5e2dcd6bf5887b521620c1d06b731bacd00079fbe677db82fee1c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0222833099c86119e0911c9444f415d4664609374508d015c630b259099300080c61ea14460557498cea12d79c54734d0557748ab14f0981110956e5e3626048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b363b5393a5c9269f712d80c7d22a41ef08aedc10bff8e194c2a92dcdcc4f2281a7b22327225579a72437e73b40838c5155b4a3d3b6cf5b6a4f706d26a391b66"} 15:22:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:15 INFO - Contents: 15:22:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ce1aae3f48689f325f04aa4d0f111a380426e98169ff76edcac6093488ea0c2b690aebe5e2dcd6bf5887b521620c1d06b731bacd00079fbe677db82fee1c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0222833099c86119e0911c9444f415d4664609374508d015c630b259099300080c61ea14460557498cea12d79c54734d0557748ab14f0981110956e5e3626048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b363b5393a5c9269f712d80c7d22a41ef08aedc10bff8e194c2a92dcdcc4f2281a7b22327225579a72437e73b40838c5155b4a3d3b6cf5b6a4f706d26a391b66"} 15:22:15 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:15 INFO - Copying logs to upload dir... 15:22:15 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.935945 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-18 15:22:15.592111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 15:22:15.595935) ========= 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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ce1aae3f48689f325f04aa4d0f111a380426e98169ff76edcac6093488ea0c2b690aebe5e2dcd6bf5887b521620c1d06b731bacd00079fbe677db82fee1c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0222833099c86119e0911c9444f415d4664609374508d015c630b259099300080c61ea14460557498cea12d79c54734d0557748ab14f0981110956e5e3626048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b363b5393a5c9269f712d80c7d22a41ef08aedc10bff8e194c2a92dcdcc4f2281a7b22327225579a72437e73b40838c5155b4a3d3b6cf5b6a4f706d26a391b66"} build_url:https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010985 build_url: 'https://queue.taskcluster.net/v1/task/a92dCqhyT96W84y_7zddHw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48ce1aae3f48689f325f04aa4d0f111a380426e98169ff76edcac6093488ea0c2b690aebe5e2dcd6bf5887b521620c1d06b731bacd00079fbe677db82fee1c7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0222833099c86119e0911c9444f415d4664609374508d015c630b259099300080c61ea14460557498cea12d79c54734d0557748ab14f0981110956e5e3626048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b363b5393a5c9269f712d80c7d22a41ef08aedc10bff8e194c2a92dcdcc4f2281a7b22327225579a72437e73b40838c5155b4a3d3b6cf5b6a4f706d26a391b66"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 15:22:15.628986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:22:15.629268) ========= 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.mQ6W1qQzmy/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.ekstFFBhgm/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005273 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 15:22:15.676979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 15:22:15.677253) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 15:22:15.677542) ========= ========= Total master_lag: 0.17 =========