builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0290 starttime: 1478234712.69 results: success (0) buildid: 20161103192522 builduid: 49ca7423ec714576a97ee386d40902e4 revision: 38fcc30d818f99f3798865d551acce5681b0a3c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.685510) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.685912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.686205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.713480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.713846) ========= 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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners TMPDIR=/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-03 21:45:12-- 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% 74.0M=0s 2016-11-03 21:45:12 (74.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074135 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.834649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.834977) ========= 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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners TMPDIR=/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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.019927 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.886533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:12.886871) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 38fcc30d818f99f3798865d551acce5681b0a3c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 38fcc30d818f99f3798865d551acce5681b0a3c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners TMPDIR=/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-03 21:45:12,969 truncating revision to first 12 chars 2016-11-03 21:45:12,969 Setting DEBUG logging. 2016-11-03 21:45:12,969 attempt 1/10 2016-11-03 21:45:12,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/38fcc30d818f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 21:45:13,670 unpacking tar archive at: mozilla-central-38fcc30d818f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.947051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:13.857440) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:13.857714) ========= script_repo_revision: 38fcc30d818f99f3798865d551acce5681b0a3c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:13.862108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:13.862396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 21:45:13.881841) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-03 21:45:13.882147) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners TMPDIR=/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:14 INFO - MultiFileLogger online at 20161103 21:45:14 in /builds/slave/test 21:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:45:14 INFO - {'append_to_log': False, 21:45:14 INFO - 'base_work_dir': '/builds/slave/test', 21:45:14 INFO - 'blob_upload_branch': 'Firefox', 21:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:45:14 INFO - 'branch': 'Firefox', 21:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:14 INFO - 'config_files': ('talos/mac_config.py',), 21:45:14 INFO - 'default_actions': ('clobber', 21:45:14 INFO - 'read-buildbot-config', 21:45:14 INFO - 'download-and-extract', 21:45:14 INFO - 'populate-webroot', 21:45:14 INFO - 'create-virtualenv', 21:45:14 INFO - 'install', 21:45:14 INFO - 'run-tests'), 21:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:14 INFO - 'download_minidump_stackwalk': True, 21:45:14 INFO - 'download_symbols': 'ondemand', 21:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:14 INFO - 'installer_path': 'installer.exe', 21:45:14 INFO - 'log_level': 'info', 21:45:14 INFO - 'log_name': 'talos', 21:45:14 INFO - 'log_to_console': True, 21:45:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:45:14 INFO - 'opt_config_files': (), 21:45:14 INFO - 'pip_index': False, 21:45:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:45:14 INFO - 'cmd': ('bash', 21:45:14 INFO - '-c', 21:45:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:45:14 INFO - 'enabled': True, 21:45:14 INFO - 'halt_on_failure': False, 21:45:14 INFO - 'name': 'check_screen_resolution'},), 21:45:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:45:14 INFO - 'cmd': ('bash', 21:45:14 INFO - '-c', 21:45:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:45:14 INFO - 'enabled': True, 21:45:14 INFO - 'halt_on_failure': False, 21:45:14 INFO - 'name': 'check_screen_resolution'},), 21:45:14 INFO - 'run_cmd_checks_enabled': True, 21:45:14 INFO - 'sps_profile': False, 21:45:14 INFO - 'sps_profile_interval': 0, 21:45:14 INFO - 'suite': 'dromaeojs', 21:45:14 INFO - 'system_bits': '32', 21:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:14 INFO - 'title': 't-yosemite-r7-0290', 21:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:14 INFO - 'use_talos_json': True, 21:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:14 INFO - 'work_dir': 'build'} 21:45:14 INFO - [mozharness: 2016-11-04 04:45:14.085650Z] Running clobber step. 21:45:14 INFO - Running pre-action listener: _resource_record_pre_action 21:45:14 INFO - Running main action method: clobber 21:45:14 INFO - rmtree: /builds/slave/test/build 21:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:45:15 INFO - Running post-action listener: _resource_record_post_action 21:45:15 INFO - [mozharness: 2016-11-04 04:45:15.644679Z] Finished clobber step (success) 21:45:15 INFO - [mozharness: 2016-11-04 04:45:15.644840Z] Running read-buildbot-config step. 21:45:15 INFO - Running pre-action listener: _resource_record_pre_action 21:45:15 INFO - Running main action method: read_buildbot_config 21:45:15 INFO - Using buildbot properties: 21:45:15 INFO - { 21:45:15 INFO - "project": "", 21:45:15 INFO - "product": "firefox", 21:45:15 INFO - "script_repo_revision": "production", 21:45:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:45:15 INFO - "repository": "", 21:45:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:45:15 INFO - "buildid": "20161103192522", 21:45:15 INFO - "pgo_build": "False", 21:45:15 INFO - "basedir": "/builds/slave/test", 21:45:15 INFO - "buildnumber": 19, 21:45:15 INFO - "slavename": "t-yosemite-r7-0290", 21:45:15 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:45:15 INFO - "platform": "yosemite_r7", 21:45:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:45:15 INFO - "branch": "mozilla-central", 21:45:15 INFO - "repo_path": "mozilla-central", 21:45:15 INFO - "revision": "38fcc30d818f99f3798865d551acce5681b0a3c0", 21:45:15 INFO - "stage_platform": "macosx64", 21:45:15 INFO - "builduid": "49ca7423ec714576a97ee386d40902e4", 21:45:15 INFO - "slavebuilddir": "test" 21:45:15 INFO - } 21:45:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:45:15 INFO - Running post-action listener: _resource_record_post_action 21:45:15 INFO - [mozharness: 2016-11-04 04:45:15.648199Z] Finished read-buildbot-config step (success) 21:45:15 INFO - [mozharness: 2016-11-04 04:45:15.648331Z] Running download-and-extract step. 21:45:15 INFO - Running pre-action listener: _resource_record_pre_action 21:45:15 INFO - Running main action method: download_and_extract 21:45:15 INFO - mkdir: /builds/slave/test/build/tests 21:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:15 INFO - trying https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:45:15 INFO - Downloading https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 21:45:17 INFO - Downloaded 1199 bytes. 21:45:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:45:17 INFO - Using the following test package requirements: 21:45:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:45:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:45:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:45:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'jsshell-mac.zip'], 21:45:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:45:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:45:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:45:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:45:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:45:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:45:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:45:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:45:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:45:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:45:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:45:17 INFO - Http code: 200 21:45:17 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 21:45:17 INFO - x-amz-cf-id: EVg6dHiF5ErnAxmhxrkSEu7dmovMXobUP-TsPT6bkMQ1Eac2t_iX7w== 21:45:17 INFO - x-amz-version-id: THy9YaF4jH4F52.d1t1dlZU.FH5XKA6f 21:45:17 INFO - Expected file size: 16390097 21:45:17 INFO - Obtained file size: 16390097 21:45:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:45:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:45:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:45:24 INFO - Fetch https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:45:25 INFO - Http code: 200 21:45:25 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 21:45:25 INFO - x-amz-cf-id: 9k1HqZ1-fcsmcK3zW1NyuxX21qCKHbOiSmFRcs8S_NhPOKf-E74QcQ== 21:45:25 INFO - x-amz-version-id: THy9YaF4jH4F52.d1t1dlZU.FH5XKA6f 21:45:25 INFO - Expected file size: 16390097 21:45:25 INFO - Obtained file size: 16390097 21:45:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:45:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:45:31 INFO - Fetch https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:45:32 INFO - Http code: 200 21:45:32 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 21:45:32 INFO - x-amz-cf-id: uCOjXCygtcBuefWMD2bE40vTfX6soRwKceVivolXP7jUBxOkWACsdA== 21:45:32 INFO - x-amz-version-id: RDuX.X0fHMn6T50kS2rW8VYYU1SAGmlE 21:45:32 INFO - Expected file size: 14409038 21:45:32 INFO - Obtained file size: 14409038 21:45:33 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')]} 21:45:33 INFO - trying https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:45:33 INFO - Downloading https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 21:45:37 INFO - Downloaded 111938398 bytes. 21:45:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:45:37 INFO - mkdir: /builds/slave/test/properties 21:45:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:45:37 INFO - Writing to file /builds/slave/test/properties/build_url 21:45:37 INFO - Contents: 21:45:37 INFO - build_url:https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:45:37 INFO - Running post-action listener: _resource_record_post_action 21:45:37 INFO - Running post-action listener: set_extra_try_arguments 21:45:37 INFO - [mozharness: 2016-11-04 04:45:37.969123Z] Finished download-and-extract step (success) 21:45:37 INFO - [mozharness: 2016-11-04 04:45:37.969275Z] Running populate-webroot step. 21:45:37 INFO - Running pre-action listener: _resource_record_pre_action 21:45:37 INFO - Running main action method: populate_webroot 21:45:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:45:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:45:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:45:37 INFO - '--tppagecycles', 21:45:37 INFO - '7'], 21:45:37 INFO - 'tests': ['tsvgm']}}, 21:45:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:45:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:45:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:45:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:45:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['damp', 'tps']}, 21:45:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'tests': ['damp', 'tps']}, 21:45:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['dromaeo_dom']}, 21:45:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:45:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['basic_compositor_video']}, 21:45:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:45:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['a11yr', 21:45:37 INFO - 'ts_paint', 21:45:37 INFO - 'tpaint', 21:45:37 INFO - 'sessionrestore', 21:45:37 INFO - 'sessionrestore_no_auto_restore', 21:45:37 INFO - 'tabpaint']}, 21:45:37 INFO - 'other-e10s': {'tests': ['a11yr', 21:45:37 INFO - 'ts_paint', 21:45:37 INFO - 'tpaint', 21:45:37 INFO - 'sessionrestore', 21:45:37 INFO - 'sessionrestore_no_auto_restore', 21:45:37 INFO - 'tabpaint']}, 21:45:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:45:37 INFO - 'ts_paint', 21:45:37 INFO - 'tpaint', 21:45:37 INFO - 'sessionrestore', 21:45:37 INFO - 'sessionrestore_no_auto_restore', 21:45:37 INFO - 'tabpaint']}, 21:45:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:45:37 INFO - 'ts_paint', 21:45:37 INFO - 'tpaint', 21:45:37 INFO - 'sessionrestore', 21:45:37 INFO - 'sessionrestore_no_auto_restore', 21:45:37 INFO - 'tabpaint']}, 21:45:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['a11yr', 21:45:37 INFO - 'ts_paint', 21:45:37 INFO - 'tpaint', 21:45:37 INFO - 'sessionrestore', 21:45:37 INFO - 'sessionrestore_no_auto_restore', 21:45:37 INFO - 'tabpaint']}, 21:45:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['a11yr', 21:45:37 INFO - 'ts_paint', 21:45:37 INFO - 'tpaint', 21:45:37 INFO - 'sessionrestore', 21:45:37 INFO - 'sessionrestore_no_auto_restore', 21:45:37 INFO - 'tabpaint']}, 21:45:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['tsvgx', 21:45:37 INFO - 'tsvgr_opacity', 21:45:37 INFO - 'tart', 21:45:37 INFO - 'tscrollx', 21:45:37 INFO - 'cart']}, 21:45:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:45:37 INFO - 'tsvgr_opacity', 21:45:37 INFO - 'tart', 21:45:37 INFO - 'tscrollx', 21:45:37 INFO - 'cart']}, 21:45:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'talos_options': ['--disable-e10s'], 21:45:37 INFO - 'tests': ['tp5o']}, 21:45:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'tests': ['tp5o']}, 21:45:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'talos_options': ['--disable-e10s', 21:45:37 INFO - '--xperf_path', 21:45:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:37 INFO - 'tests': ['tp5n']}, 21:45:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:37 INFO - 'talos_options': ['--xperf_path', 21:45:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:37 INFO - 'tests': ['tp5n']}}, 21:45:37 INFO - 'talos.zip': {'path': '', 21:45:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:45:37 INFO - Running post-action listener: _resource_record_post_action 21:45:37 INFO - [mozharness: 2016-11-04 04:45:37.987741Z] Finished populate-webroot step (success) 21:45:37 INFO - [mozharness: 2016-11-04 04:45:37.987855Z] Running create-virtualenv step. 21:45:37 INFO - Running pre-action listener: _resource_record_pre_action 21:45:37 INFO - Running main action method: create_virtualenv 21:45:37 INFO - Creating virtualenv /builds/slave/test/build/venv 21:45:37 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 21:45:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:45:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:45:38 INFO - Using real prefix '/tools/python27' 21:45:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:45:38 INFO - Installing distribute.............................................................................................................................................................................................done. 21:45:41 INFO - Installing pip.................done. 21:45:41 INFO - Return code: 0 21:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:45:41 INFO - Reading from file tmpfile_stdout 21:45:41 INFO - Output received: 21:45:41 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) 21:45:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:45: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')]} 21:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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')]} 21:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45: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', 'pip>=1.5'] in /builds/slave/test/build 21:45: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 pip>=1.5 21:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:41 INFO - 'HOME': '/Users/cltbld', 21:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:41 INFO - 'LOGNAME': 'cltbld', 21:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:41 INFO - 'MOZ_NO_REMOTE': '1', 21:45:41 INFO - 'NO_EM_RESTART': '1', 21:45:41 INFO - 'PAGER': '/bin/cat', 21:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:41 INFO - 'PWD': '/builds/slave/test', 21:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:41 INFO - 'SHELL': '/bin/bash', 21:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:41 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:41 INFO - 'USER': 'cltbld', 21:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:41 INFO - 'XPC_FLAGS': '0x0', 21:45:41 INFO - 'XPC_SERVICE_NAME': '0', 21:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:42 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 21:45:42 INFO - Cleaning up... 21:45:42 INFO - Return code: 0 21:45:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:45:42 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')]} 21:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:42 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')]} 21:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:42 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:42 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 21:45:42 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 21:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:42 INFO - 'HOME': '/Users/cltbld', 21:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:42 INFO - 'LOGNAME': 'cltbld', 21:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:42 INFO - 'MOZ_NO_REMOTE': '1', 21:45:42 INFO - 'NO_EM_RESTART': '1', 21:45:42 INFO - 'PAGER': '/bin/cat', 21:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:42 INFO - 'PWD': '/builds/slave/test', 21:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:42 INFO - 'SHELL': '/bin/bash', 21:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:42 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:42 INFO - 'USER': 'cltbld', 21:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:42 INFO - 'XPC_FLAGS': '0x0', 21:45:42 INFO - 'XPC_SERVICE_NAME': '0', 21:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:42 INFO - Downloading/unpacking psutil>=3.1.1 21:45:42 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 21:45:42 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 21:45:42 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 21:45:42 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 21:45:42 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 21:45:42 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 21:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:45:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:45 INFO - Installing collected packages: psutil 21:45:45 INFO - Running setup.py install for psutil 21:45:45 INFO - building 'psutil._psutil_osx' extension 21:45:45 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 21:45:46 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 21:45:46 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 21:45:46 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 21:45:46 INFO - building 'psutil._psutil_posix' extension 21:45:46 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 21:45:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:45:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:45:46 INFO - ^ 21:45:46 INFO - 1 warning generated. 21:45:46 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 21:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:46 INFO - Successfully installed psutil 21:45:46 INFO - Cleaning up... 21:45:46 INFO - Return code: 0 21:45:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:45: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')]} 21:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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')]} 21:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:46 INFO - 'HOME': '/Users/cltbld', 21:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:46 INFO - 'LOGNAME': 'cltbld', 21:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:46 INFO - 'MOZ_NO_REMOTE': '1', 21:45:46 INFO - 'NO_EM_RESTART': '1', 21:45:46 INFO - 'PAGER': '/bin/cat', 21:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:46 INFO - 'PWD': '/builds/slave/test', 21:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:46 INFO - 'SHELL': '/bin/bash', 21:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:46 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:46 INFO - 'USER': 'cltbld', 21:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:46 INFO - 'XPC_FLAGS': '0x0', 21:45:46 INFO - 'XPC_SERVICE_NAME': '0', 21:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:45:49 INFO - Installing collected packages: mozsystemmonitor 21:45:49 INFO - Running setup.py install for mozsystemmonitor 21:45:49 INFO - Successfully installed mozsystemmonitor 21:45:49 INFO - Cleaning up... 21:45:49 INFO - Return code: 0 21:45:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:45:49 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')]} 21:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:49 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')]} 21:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:49 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:49 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 21:45:49 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 21:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:49 INFO - 'HOME': '/Users/cltbld', 21:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:49 INFO - 'LOGNAME': 'cltbld', 21:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:49 INFO - 'MOZ_NO_REMOTE': '1', 21:45:49 INFO - 'NO_EM_RESTART': '1', 21:45:49 INFO - 'PAGER': '/bin/cat', 21:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:49 INFO - 'PWD': '/builds/slave/test', 21:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:49 INFO - 'SHELL': '/bin/bash', 21:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:49 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:49 INFO - 'USER': 'cltbld', 21:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:49 INFO - 'XPC_FLAGS': '0x0', 21:45:49 INFO - 'XPC_SERVICE_NAME': '0', 21:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:50 INFO - Downloading/unpacking jsonschema==2.5.1 21:45:50 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 21:45:50 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 21:45:50 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 21:45:50 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 21:45:50 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 21:45:50 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 21:45:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:45:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 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 21:45:53 INFO - Downloading functools32-3.2.3-2.tar.gz 21:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:45:53 INFO - warning: no files found matching '*.txt' 21:45:53 INFO - no previously-included directories found matching 'build' 21:45:53 INFO - no previously-included directories found matching 'dist' 21:45:53 INFO - no previously-included directories found matching '.git*' 21:45:53 INFO - Installing collected packages: jsonschema, functools32 21:45:53 INFO - Running setup.py install for functools32 21:45:53 INFO - warning: no files found matching '*.txt' 21:45:53 INFO - no previously-included directories found matching 'build' 21:45:53 INFO - no previously-included directories found matching 'dist' 21:45:53 INFO - no previously-included directories found matching '.git*' 21:45:53 INFO - Successfully installed jsonschema functools32 21:45:53 INFO - Cleaning up... 21:45:53 INFO - Return code: 0 21:45:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:53 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 21:45:53 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 21:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:53 INFO - 'HOME': '/Users/cltbld', 21:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:53 INFO - 'LOGNAME': 'cltbld', 21:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:53 INFO - 'MOZ_NO_REMOTE': '1', 21:45:53 INFO - 'NO_EM_RESTART': '1', 21:45:53 INFO - 'PAGER': '/bin/cat', 21:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:53 INFO - 'PWD': '/builds/slave/test', 21:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:53 INFO - 'SHELL': '/bin/bash', 21:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:53 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:53 INFO - 'USER': 'cltbld', 21:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:53 INFO - 'XPC_FLAGS': '0x0', 21:45:53 INFO - 'XPC_SERVICE_NAME': '0', 21:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:45:53 INFO - Cleaning up... 21:45:53 INFO - Return code: 0 21:45:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:53 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 21:45:53 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 21:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:53 INFO - 'HOME': '/Users/cltbld', 21:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:53 INFO - 'LOGNAME': 'cltbld', 21:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:53 INFO - 'MOZ_NO_REMOTE': '1', 21:45:53 INFO - 'NO_EM_RESTART': '1', 21:45:53 INFO - 'PAGER': '/bin/cat', 21:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:53 INFO - 'PWD': '/builds/slave/test', 21:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:53 INFO - 'SHELL': '/bin/bash', 21:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:53 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:53 INFO - 'USER': 'cltbld', 21:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:53 INFO - 'XPC_FLAGS': '0x0', 21:45:53 INFO - 'XPC_SERVICE_NAME': '0', 21:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 21:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:45:56 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 21:45:56 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 21:45:56 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 21:45:56 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 21:45:56 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 21:45:56 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 21:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:45:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:45:57 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 21:45:57 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 21:45:57 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 21:45:57 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 21:45:57 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 21:45:57 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 21:45:57 INFO - Downloading docopt-0.6.1.tar.gz 21:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:45:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:45:57 INFO - Running setup.py install for blobuploader 21:45:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:45:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:45:57 INFO - Running setup.py install for requests 21:45:58 INFO - Running setup.py install for docopt 21:45:58 INFO - Successfully installed blobuploader requests docopt 21:45:58 INFO - Cleaning up... 21:45:58 INFO - Return code: 0 21:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:58 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:45:58 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 21:45:58 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 21:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:58 INFO - 'HOME': '/Users/cltbld', 21:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:58 INFO - 'LOGNAME': 'cltbld', 21:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:58 INFO - 'MOZ_NO_REMOTE': '1', 21:45:58 INFO - 'NO_EM_RESTART': '1', 21:45:58 INFO - 'PAGER': '/bin/cat', 21:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:58 INFO - 'PWD': '/builds/slave/test', 21:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:58 INFO - 'SHELL': '/bin/bash', 21:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:45:58 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:58 INFO - 'USER': 'cltbld', 21:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:58 INFO - 'XPC_FLAGS': '0x0', 21:45:58 INFO - 'XPC_SERVICE_NAME': '0', 21:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:45:58 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-46cb98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-VIFElT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-Sy6_RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-GmV2KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-OQBcTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-AVDKD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-ZPxkDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-yE5Qn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-h02dSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:45:59 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-EcPFKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-kpStLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-wyA8WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-zUBhAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-8HUleh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-yLDG8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-FfL0tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:00 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-K9nTIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:00 INFO - Running setup.py install for manifestparser 21:46:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:46:00 INFO - Running setup.py install for mozcrash 21:46:01 INFO - Running setup.py install for mozdebug 21:46:01 INFO - Running setup.py install for mozdevice 21:46:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Running setup.py install for mozfile 21:46:01 INFO - Running setup.py install for mozhttpd 21:46:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Running setup.py install for mozinfo 21:46:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Running setup.py install for mozInstall 21:46:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:46:01 INFO - Running setup.py install for mozleak 21:46:02 INFO - Running setup.py install for mozlog 21:46:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:46:02 INFO - Running setup.py install for moznetwork 21:46:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:46:02 INFO - Running setup.py install for mozprocess 21:46:02 INFO - Running setup.py install for mozprofile 21:46:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:46:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:46:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:46:02 INFO - Running setup.py install for mozrunner 21:46:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:46:02 INFO - Running setup.py install for mozscreenshot 21:46:03 INFO - Running setup.py install for moztest 21:46:03 INFO - Running setup.py install for mozversion 21:46:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:46:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:03 INFO - Cleaning up... 21:46:03 INFO - Return code: 0 21:46:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:03 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')]} 21:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:03 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')]} 21:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:03 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:46:03 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 21:46:03 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 21:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:03 INFO - 'HOME': '/Users/cltbld', 21:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:03 INFO - 'LOGNAME': 'cltbld', 21:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:03 INFO - 'MOZ_NO_REMOTE': '1', 21:46:03 INFO - 'NO_EM_RESTART': '1', 21:46:03 INFO - 'PAGER': '/bin/cat', 21:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:03 INFO - 'PWD': '/builds/slave/test', 21:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:03 INFO - 'SHELL': '/bin/bash', 21:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:46:03 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:03 INFO - 'USER': 'cltbld', 21:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:03 INFO - 'XPC_FLAGS': '0x0', 21:46:03 INFO - 'XPC_SERVICE_NAME': '0', 21:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-9rQKLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:46:04 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)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-dHimMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-8t3KnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:46:04 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)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-96ze4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:46:04 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)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-krQqbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:46:04 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)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-2Rm_mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:46:04 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)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-scXdep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:46:04 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)) 21:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:46:04 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-qFo69b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-SGxqaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-3FLyFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-ZrRevi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-1NfpvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-af9g8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-5qekre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-NzFV6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:05 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)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-IhJ9z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:05 INFO - Running setup.py (path:/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/pip-n5qYxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:05 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)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:46:05 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)) 21:46:05 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)) 21:46:05 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)) 21:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:08 INFO - Downloading blessings-1.6.tar.gz 21:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:08 INFO - Installing collected packages: blessings 21:46:08 INFO - Running setup.py install for blessings 21:46:09 INFO - Successfully installed blessings 21:46:09 INFO - Cleaning up... 21:46:09 INFO - Return code: 0 21:46:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:09 INFO - Reading from file tmpfile_stdout 21:46:09 INFO - Current package versions: 21:46:09 INFO - blessings == 1.6 21:46:09 INFO - blobuploader == 1.2.4 21:46:09 INFO - docopt == 0.6.1 21:46:09 INFO - functools32 == 3.2.3-2 21:46:09 INFO - jsonschema == 2.5.1 21:46:09 INFO - manifestparser == 1.1 21:46:09 INFO - mozInstall == 1.12 21:46:09 INFO - mozcrash == 0.17 21:46:09 INFO - mozdebug == 0.1 21:46:09 INFO - mozdevice == 0.48 21:46:09 INFO - mozfile == 1.2 21:46:09 INFO - mozhttpd == 0.7 21:46:09 INFO - mozinfo == 0.9 21:46:09 INFO - mozleak == 0.1 21:46:09 INFO - mozlog == 3.4 21:46:09 INFO - moznetwork == 0.27 21:46:09 INFO - mozprocess == 0.23 21:46:09 INFO - mozprofile == 0.28 21:46:09 INFO - mozrunner == 6.12 21:46:09 INFO - mozscreenshot == 0.1 21:46:09 INFO - mozsystemmonitor == 0.3 21:46:09 INFO - moztest == 0.7 21:46:09 INFO - mozversion == 1.4 21:46:09 INFO - psutil == 3.1.1 21:46:09 INFO - requests == 1.2.3 21:46:09 INFO - wsgiref == 0.1.2 21:46:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:09 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')]} 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 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')]} 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:46:09 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 21:46:09 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 21:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:09 INFO - 'HOME': '/Users/cltbld', 21:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:09 INFO - 'LOGNAME': 'cltbld', 21:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:09 INFO - 'MOZ_NO_REMOTE': '1', 21:46:09 INFO - 'NO_EM_RESTART': '1', 21:46:09 INFO - 'PAGER': '/bin/cat', 21:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:09 INFO - 'PWD': '/builds/slave/test', 21:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:09 INFO - 'SHELL': '/bin/bash', 21:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:46:09 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:09 INFO - 'USER': 'cltbld', 21:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:09 INFO - 'XPC_FLAGS': '0x0', 21:46:09 INFO - 'XPC_SERVICE_NAME': '0', 21:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 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)) 21:46:09 INFO - Cleaning up... 21:46:09 INFO - Return code: 0 21:46:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:09 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')]} 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 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')]} 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 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 0x108b1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d25798b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, '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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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 21:46:09 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 21:46:09 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 21:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:09 INFO - 'HOME': '/Users/cltbld', 21:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:09 INFO - 'LOGNAME': 'cltbld', 21:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:09 INFO - 'MOZ_NO_REMOTE': '1', 21:46:09 INFO - 'NO_EM_RESTART': '1', 21:46:09 INFO - 'PAGER': '/bin/cat', 21:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:09 INFO - 'PWD': '/builds/slave/test', 21:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:09 INFO - 'SHELL': '/bin/bash', 21:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:46:09 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:09 INFO - 'USER': 'cltbld', 21:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:09 INFO - 'XPC_FLAGS': '0x0', 21:46:09 INFO - 'XPC_SERVICE_NAME': '0', 21:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:46:09 INFO - Cleaning up... 21:46:09 INFO - Return code: 0 21:46:09 INFO - Running post-action listener: _resource_record_post_action 21:46:09 INFO - Running post-action listener: _start_resource_monitoring 21:46:09 INFO - Starting resource monitoring. 21:46:10 INFO - [mozharness: 2016-11-04 04:46:10.001085Z] Finished create-virtualenv step (success) 21:46:10 INFO - [mozharness: 2016-11-04 04:46:10.002107Z] Running install step. 21:46:10 INFO - Running pre-action listener: _resource_record_pre_action 21:46:10 INFO - Running main action method: install 21:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:10 INFO - Reading from file tmpfile_stdout 21:46:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:10 INFO - Reading from file tmpfile_stdout 21:46:10 INFO - Output received: 21:46:10 INFO - Usage: mozinstall [options] installer 21:46:10 INFO - Options: 21:46:10 INFO - -h, --help show this help message and exit 21:46:10 INFO - -d DEST, --destination=DEST 21:46:10 INFO - Directory to install application into. [default: 21:46:10 INFO - "/builds/slave/test"] 21:46:10 INFO - --app=APP Application being installed. [default: firefox] 21:46:10 INFO - mkdir: /builds/slave/test/build/application 21:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:46:44 INFO - Reading from file tmpfile_stdout 21:46:44 INFO - Output received: 21:46:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:46:44 INFO - Running post-action listener: _resource_record_post_action 21:46:44 INFO - [mozharness: 2016-11-04 04:46:44.324804Z] Finished install step (success) 21:46:44 INFO - [mozharness: 2016-11-04 04:46:44.324903Z] Running run-tests step. 21:46:44 INFO - Running pre-action listener: _resource_record_pre_action 21:46:44 INFO - Running main action method: run_tests 21:46:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:46:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:46:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:46:44 INFO - 2016-11-03 21:46:44.338 screenresolution[2235:25363] starting screenresolution argv=screenresolution get 21:46:44 INFO - 2016-11-03 21:46:44.340 screenresolution[2235:25363] Display 0: 1600x1200x32@60 21:46:44 INFO - 2016-11-03 21:46:44.346 screenresolution[2236:25365] starting screenresolution argv=screenresolution list 21:46:44 INFO - Available Modes on Display 0 21:46:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:46:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:46:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:46:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:46:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:46:44 INFO - Intel Iris: 21:46:44 INFO - Chipset Model: Intel Iris 21:46:44 INFO - Type: GPU 21:46:44 INFO - Bus: Built-In 21:46:44 INFO - VRAM (Dynamic, Max): 1536 MB 21:46:44 INFO - Vendor: Intel (0x8086) 21:46:44 INFO - Device ID: 0x0a2e 21:46:44 INFO - Revision ID: 0x0009 21:46:44 INFO - Displays: 21:46:44 INFO - Display: 21:46:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:46:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:46:44 INFO - Display Serial Number: 1600x1200 60 21:46:44 INFO - Main Display: Yes 21:46:44 INFO - Mirror: Off 21:46:44 INFO - Online: Yes 21:46:44 INFO - Rotation: Supported 21:46:44 INFO - Return code: 0 21:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:46:44 INFO - Python 2.7.3 21:46:44 INFO - Return code: 0 21:46:44 INFO - grabbing minidump binary from tooltool 21:46:44 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')]} 21:46:44 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 0x108931d30>, '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 0x108757db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108929b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:46:44 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 21:46:44 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 21:46:44 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 21:46:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:44 INFO - Return code: 0 21:46:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:46:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:46:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:46:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:46:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0290', '--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 21:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0290 --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 21:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2SJOGDdgQJ/Render', 21:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:44 INFO - 'HOME': '/Users/cltbld', 21:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:44 INFO - 'LOGNAME': 'cltbld', 21:46:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:46:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:44 INFO - 'MOZ_NO_REMOTE': '1', 21:46:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:46:44 INFO - 'NO_EM_RESTART': '1', 21:46:44 INFO - 'PAGER': '/bin/cat', 21:46:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:44 INFO - 'PWD': '/builds/slave/test', 21:46:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:44 INFO - 'SHELL': '/bin/bash', 21:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m1LWuwhJJA/Listeners', 21:46:44 INFO - 'TMPDIR': '/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/', 21:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:44 INFO - 'USER': 'cltbld', 21:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:44 INFO - 'XPC_FLAGS': '0x0', 21:46:44 INFO - 'XPC_SERVICE_NAME': '0', 21:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0290', '--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 21:46:44 INFO - mozversion application_buildid: 20161103192522 21:46:44 INFO - mozversion application_changeset: 38fcc30d818f99f3798865d551acce5681b0a3c0 21:46:44 INFO - mozversion application_display_name: Nightly 21:46:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:44 INFO - mozversion application_name: Firefox 21:46:44 INFO - mozversion application_remotingname: firefox 21:46:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:46:44 INFO - mozversion application_vendor: Mozilla 21:46:44 INFO - mozversion application_version: 52.0a1 21:46:44 INFO - mozversion platform_buildid: 20161103192522 21:46:44 INFO - mozversion platform_changeset: 38fcc30d818f99f3798865d551acce5681b0a3c0 21:46:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:46:44 INFO - mozversion platform_version: 52.0a1 21:46:44 INFO - using testdate: 1478234804 21:46:44 INFO - actual date: 1478234804 21:46:44 INFO - starting webserver on 'localhost:55359' 21:46:44 INFO - SUITE-START | Running 2 tests 21:46:44 INFO - TEST-START | dromaeo_css 21:46:44 INFO - operating with platform_type : mac_ 21:46:44 INFO - Initialising browser for dromaeo_css test... 21:46:44 INFO - TEST-INFO | started process 2246 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/tmpyUHN1B/profile http://localhost:55359/getInfo.html) 21:46:47 INFO - PROCESS | 2246 | __metrics Screen width/height:1600/1200 21:46:47 INFO - PROCESS | 2246 | colorDepth:24 21:46:47 INFO - PROCESS | 2246 | Browser inner width/height: 1024/689 21:46:47 INFO - PROCESS | 2246 | __metrics 21:46:47 INFO - PROCESS | 2246 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:46:47 INFO - PROCESS | 2246 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:46:48 INFO - TEST-INFO | 2246: exit 0 21:46:48 INFO - Browser initialized. 21:46:48 INFO - Running cycle 1/1 for dromaeo_css test... 21:46:48 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/tmpyUHN1B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:00 INFO - PROCESS | 2248 | RSS: Main: 241057792 21:47:00 INFO - PROCESS | 2248 | 21:47:51 INFO - PROCESS | 2248 | 1478234871823 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:50:04 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55359/tests/dromaeo/cssquery-ext.html) 21:50:06 INFO - PROCESS | 2248 | RSS: Main: 361582592 21:50:06 INFO - PROCESS | 2248 | 21:53:09 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-ext.html (next: http://localhost:55359/tests/dromaeo/cssquery-jquery.html) 21:53:09 INFO - PROCESS | 2248 | RSS: Main: 374009856 21:53:09 INFO - PROCESS | 2248 | 21:56:12 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55359/tests/dromaeo/cssquery-mootools.html) 21:56:12 INFO - PROCESS | 2248 | RSS: Main: 337616896 21:56:12 INFO - PROCESS | 2248 | 21:59:15 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55359/tests/dromaeo/cssquery-prototype.html) 21:59:15 INFO - PROCESS | 2248 | RSS: Main: 339689472 21:59:15 INFO - PROCESS | 2248 | 22:02:19 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55359/tests/dromaeo/cssquery-yui.html) 22:02:19 INFO - PROCESS | 2248 | RSS: Main: 329752576 22:02:19 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | Cycle 1(1): loaded http://localhost:55359/tests/dromaeo/cssquery-yui.html (next: http://localhost:55359/tests/dromaeo/cssquery-dojo.html) 22:05:23 INFO - PROCESS | 2248 | RSS: Main: 395137024 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | __start_tp_report 22:05:23 INFO - PROCESS | 2248 | _x_x_mozilla_page_load 22:05:23 INFO - PROCESS | 2248 | _x_x_mozilla_page_load_details 22:05:23 INFO - PROCESS | 2248 | |i|pagename|runs| 22:05:23 INFO - PROCESS | 2248 | |0;dojo.html;3278.1804548862783;3279.7868138571007;3289.0954987378477;3300.8184549849757;3354.607837747335;5496.038193316163;5559;5642.322921249456;5662.462066103719;5674.205611214428;5582.91625625616;5633.15502674599;5640.520555752766;5647.915281270774;5655.4910058094865;5093.312402825617;5118.616103792212;5124.513171248744;5153.098207813618;5164.561012313958;5214.687118772867;5234.555062819665;5237.214417837316;5238.895222095575;5240.685558866461;5089.3638295213095;5163.251328557357;5164.896702065957;5172.6637768545115;5224.8693782655355;5224.8693782655355;5233.502817232356;5236;5241.947580524184;5310.70791106489;5041.974790126026;5065.594752419797;5127.9743601282125;5166.586673066184;5167.48325167484;5518.779248830042;5582.441755824426;5599.524040456566;5626.718664066781;5652.378238393773;6140.785072522441;6159.907601385938;6161.907571386433;6164.476019538344;6180.660063696495;6065.393460653943;6114.601521188683;6139.048447490646;6211.09939058834;6251.562390632657;5625.80309689163;5680.403557626472;5681.545476361881;5698.857528561819;5765.019946609086;6300.558960872695;6320.873582528416;6324.557280990379;6331.493480521547;6333.081703153017;5842.1236814477315;5954.225950626391;6031.366706495754;6045.78839740607;6062.302835173923;6098.207233059763;6108.053251745987;6121.296050954108;6138.202033735586;6190.0405437157315;6080.936264809853;6099.638013992866;6114.701653307849;6124.923288778401;6131.590761709946;6139.062858969425;6143.662098584531;6162.352952939967;6166.907496387557;6167.722452489649;4197.811098500575;4767.380240568704;4830.516948305211;4853.854384368475;4855.660103792771;3815.542134943769;4302.526722060571;4331.328644060176;4384.605385515319;4406.889827754268;5602.355729091207;5645.125005624135;5650.886982260332;5654.180143879114;5666.575006874418;6053.636781793107;6073.331933487313;6129.847850912876;6195.039768835838;6199.070139479114;5652.660840349592;5672.149177623307;5674.914876276859;5676.233708449389;5681.744321505542;5337.439568845293;5342.5993050521365;5348.973255133699;5349.491798279158;5353.839384818461;6204.13142160089;6213.347598502092;6243.719032643542;6307.558470907176;6309.652969086653;6262.53031022666;6263.060540918898;6270.278917924497;6270.4670103039925;6281.246250449975;6300.7479700811455;6309.463695585927;6314.084457753692;6332.398422149889;6335.1447554579545;5894.70526473666;5997.640141591519;6006.399360063959;6128.050152226412;6144.446999770043;6116.449519543263;6118.4668989547035;6132.263729246545;6145.4161854623735;6192.566520343533;6040.546958978006;6053.818385448443;6055.9091613626715;6072.0284754440845;6100.786472473442;5882.588218824641;6036.124761909587;6054.878902421839;6068.21113255274;6075;5700.600957932905;5779.162021506942;5802.984477716298;5871.383504731942;5883.676397798162;5991.400859913973;6011.27864656244;6044.818655440344;6052.818415447544;6112.235970503687;5827.155062515827;5868.67722275279;5872.29532456108;5890.7054647266605;5921.5558833086825 22:05:23 INFO - PROCESS | 2248 | |1;ext.html;493.24040976895583;507.3987325019851;508.8346287456577;521.3431076843176;522.5636593444474;30190.698093019062;31569.84215078927;31587.68412315876;31619.20951976202;31661.68338316616;33640;40355.59644403555;40981;43097.35353969693;43147.78426107873;9430.151286384242;9578.712638620853;9580.952095239514;9587.233021358275;9612;9363.016883227265;9442.197413219885;9456.952715236413;9463.492174573743;9470.526473676324;9456.148946594805;9484.90515094847;9492.66775662852;9527.047295270451;9544.665936692218;8104.8379032419025;9356.625734970594;9438.056194380575;9454.196393306578;9463.574139163686;9315.860262096074;9384.24926005918;9402.62389504419;9414.340996130273;9422.293328000427;39339.606603933884;39652.60347396518;39656.801715991234;39735.20529589421;39748.40377394341;3226.7257283130725;3324.5844269466315;3330.134165117063;3348.547946027304;3451.137215696076;29961;31069;31083.37833243345;31140.688593114006;31469.37061258762;3101.8914337998285;3116.6415862175913;3295.670432956709;3345.130266130799;3345.3476572068457;466567;468099;468278;468835;473767.6311618454;55205;55467;55511.444885551435;55634.16548751772;55635.443645563835;57996.4200357991;58100;58167;58177.70911145502;58231.70884145637;15496.457623983106;15694.76457853133;15706.214689265491;15716.057036577613;15719.449819256271;12190.878091219152;12272.44773985155;12291.262524248574;12295.56965506203;12322.630321090382;14577;15218.543443696706;15265.313060912285;15288.541343759483;15467.75177212798;5201.921971170435;5988.185552790182;6230.688465576703;6257.124002639634;6278.717457714414;834.5785378383998;884.4472204871955;917.5824999625155;948.8766460360109;967.4775621164492;28499.857500712365;28538.571921421197;29139.12582622525;29280.853595731885;29343.972960946263;1059.3379138038727;1061.1616822710128;1070.8982646648712;1077.849101125843;1095.3920574081462;11853.822192667118;14801.333939972727;14990.400383984519;15222.41218992774;15372.30824612895;537946;542069.6619888685;543391;544422;625847;56056.439435605935;56441.71779141078;56521.71739141278;56551.71724141435;56969.14546281809;1210.4129497193853;1252.4927404401415;1324.073148795866;1361.0880709924375;1370.6093763277418;28154.155375338774;29641.851790740908;29682.851585741933;30299.848500757354;30513.23716907095;48094.03811923812;48347.516524834304;48365.27452088292;48518.272225917346;48669.756651216514;525140;527840;528111.3594432003;528873;529315;25158.62262066107;25862.09482668173;25866.35334116662;26555.203343899713;26591.60112598274;45311.86720331886;45744.54255457536;46670.06659866851;46976.29535556901;47031.76484117557;36427;37696.246075078896;38219.61780382161;38912.41631375588;39566.40650390189;37765.4335184978;38617.806910965264;38688.41967370435;39205.607943921335;39577.02876621809;31390.68609313969;37137.44293835541;37404.81297593495;37685.623143769306;37935.05162370963;32637.347253055283;32979.505307420884;33856;34071.48892766561;34100.82949585236;24261.878690606434;24696.382590435383;24769.50460990806;24862.502749945263;25585.23244302674 22:05:23 INFO - PROCESS | 2248 | |2;jquery.html;354.80840346213046;368.8248082160973;374.6908800239803;381.90643292393366;406.55279192887826;14767.778483322745;14876;15866.96864703795;20247.088881000353;20395.592088158228;19285.325013624526;19856.801431985677;20236.8988155059;20481.07835147418;20992.26527071553;5589.077802162648;5628.917300598784;5763.0202865512965;5766.423357664221;5857.912131318034;5602.719864006804;5755.82732518023;5767.192593036978;5789.681567513785;5794.072948328248;5416.214648875911;5731.799387021455;5732.22614946981;5740.856478588048;5743.224664670279;5592.748326325304;5663.292088488939;5736.885262294752;5741.052726300156;5747.62640428375;5017.147084995559;5025.623078269145;5030.195168772979;6948;7369.963150184269;27370;27869;28488.430231395258;28607;28988.71011289881;2148.7099241602496;2415.577273977047;2484.558607611957;2526.4315529005826;2550.923472295834;16128.596785080466;16632.417865374653;16664.58338541534;17026.829731702772;17735.911320443443;1969.3205843983803;2051.3333166720727;2055.321743824534;2060.8660437071694;2082.72924519813;86684;111831.29012259291;112775.74448510984;125696;136159;17988.820111798977;18389.54026149357;20965.161393544393;21147.25984590532;21314;32996.83501582477;34410.655893441246;34564.82717586446;34715.30569388598;34781.826090869385;10345.741356465998;10553;10744.570217191382;10796.082333001626;10901.236913416144;8576.914230857736;8850.468971861708;8857;9020.729378118667;9058.5017824019;9603.951980240054;9654.586353411647;9700.90299097;9808.558614862348;9848.507574621384;2980.821150730963;3684.521012268388;3749.7562658427114;3838.808059597009;3845.2693988142723;809.3039985612369;874.4971641306274;879.6701237036111;903.0337538833385;932.5383934952242;19803.93039078945;20604;20639.174433022512;20717.378478645664;21057.684134737992;794.9523028618186;888.7156110044853;946.3233787841726;982.9950850245702;997.9251556133319;10104.898951010542;10451.68644940653;10889.074428673493;11021.614243501439;11023.72440688973;497584;502239;530840;601604;609802;133584;144653;146228;149847.50152498554;150873.73689394668;426.31363504757314;449.2609657114029;451.4447229907233;452.46609001378687;452.97055691379956;10856.620018299322;11192.328460292409;11201.551937922392;11257.774844502901;11502.82745758831;37334;47773;48900.2664960033;53833.730831345594;53859.73070134624;76946.8457973142;77475.61262193653;77896.61051694705;79919.20080799118;81547.59226204068;7515.323620874147;7713.344365728976;7758.728444504415;7926.722564710208;8374.665013399395;10640.787184256116;12029.45867435985;12067.81898271509;12958.935205323913;13186.802197966847;10855.620053298097;11031.731350894428;11258.718532036437;11359;11445;8677.913220867964;10664.680059598224;11092.279001864854;11138.053265472201;11425.942870285928;9238.769030774285;10962.451877406258;11186.440677965906;11363;11687.006604438719;8013.599320034092;8279.586020699062;8306.543140127109;8448.155184481502;8506.659733610586;10712.14302855754;10943.616973405893;11228.382438965935;11355;11370.260933039326 22:05:23 INFO - PROCESS | 2248 | |3;mootools.html;1453.7528620134574;1493.8879584031197;1651.4302565614867;1782.4474412932;1845.427917345622;8129.796755081118;8545.145485451452;8558.443701159427;8559.486430814155;8573.671080982442;7474.738384156555;7686.9231307686905;8049.637766300516;8304.377171712116;8345.624446899888;2292.323764489471;2328.045501344449;2328.499372634883;2329.580675478413;2333.5449587330477;2311.8612883226974;2333.708286464192;2350.17743789674;2358.9410264743346;2359.6696462495265;2301.2635956493928;2301.4476525633895;2320.176337400224;2327.44141406063;2332.265336419031;1960.7353007343968;2283.6232021716396;2286.9771302287013;2305.5965206088867;2309.307207837659;2283.235116236063;2318.188633978111;2323.256557901472;2325.069972011192;2339.3683705399617;8271.95864020676;8455.95772021136;8458.323334133254;8460.069392366835;8460.576971151419;5015.247712843066;5198.558122559587;5201.08980928336;5202.713850738208;5203.4796520348045;3251.829341437081;3360.4119279126057;3571.5535558055244;3611.079174810433;3613.1328481164596;1045.325764881647;1058.4544171268112;1067.3275836223208;1086.4024786367545;1089.4988305379457;10755.247132700713;10791.676249712522;10947.726306842313;10963.945180274048;10980.725481862937;4147.91704165915;4439.933400998988;4441.978344980673;4690.343351930733;4703;9427.670031548863;9437.575309111107;9441.716748497556;9447.071407863585;9471.763205919908;5141.614378921596;5230.032443997872;5231.3199284092825;5233.241180028875;5246.816361427332;4220.198162349144;4487.192305385062;4719.905601887943;4810.086083644096;4820.987592605592;3434.9828250858586;3543.2382037861985;3748.6438788315068;3819.904502387407;3838.328292548793;1247.9875201248053;1252.7181384188666;1255.5291765587904;1264.6395777203452;1267.765463389276;733.8789099798473;793.3454899707764;824.6824972385675;828.1221904780951;861.6294993153004;5520.53075488588;5609.943900560942;5687.146927960756;5798.10129429939;5814.680192589363;871.215905684876;882.8852249207562;886.6630680341558;897.9236764874928;937.5640327247862;3644.4168932970597;3664.523611930432;3665.8167091645846;3753.6246375362243;3813.370793819044;9904.257180711475;10126.291159618757;10317.123044541298;10321.63874264397;10334.328268662513;10267.024632659886;10268.332558383681;10270.33242839213;10274.178065754722;10277.023682750127;6772.424343930821;6776.93223067763;7817.218278172138;7974.242446967529;7980.082290536547;5045.192769156917;5157.329547158845;5413.485718856702;5433.592480563894;5455.345358556999;9296.767580810534;9384.483853388128;9438.811223775623;9455.432674039579;9571.569279382584;9394.342396032485;9555.61777528891;9625.807483850424;9642.951785241028;9663;6252.374762523711;6458.644774537258;6478.5141114415665;6638.435732962752;6788.321167883172;7401;7454.850902982019;7972.960135199287;7976.282134607681;8043;6981;7097.82255443618;7133.678984445816;7197.640117994184;7199.8560028800175;6672.299408562031;6930.341617546325;6946.895796563157;6995.685194166173;7023.789286321418;6454.903176452263;6667.633280169637;6747.831304217434;6752.864942701217;6807.115075040213;4773.212419950669;4828.324034635224;4833.250846118857;4847.757612119451;4969.0807200668;4773.307870358848;4846.709197448165;4869.732164730974;4923.679960802537;4949.896294075075 22:05:23 INFO - PROCESS | 2248 | |4;prototype.html;298.4076607933253;300.7729164480815;309.7692219296624;314.5344889563448;315.5944611174641;4613.162904813541;5117.848484091082;5335.306410166682;5344.465553444654;5367.597430192742;3738.0467980664894;4445.466544014715;5113.463086375923;5127.512886275807;5263.7365932648945;3882.844686212548;3963.4451176835196;4015.6586690131226;4073;4084.89787755307;3383.881564145255;3546.982265088684;3851.2297540491872;4102.113028007106;4103.958960410402;3540.6990405815536;3546.9290614187703;4009.2382447334912;4064.496136429525;4070.860159155441;4014.879553613396;4033.576474470197;4037.6366127048414;4042.555318914917;4045.8988525286954;3450.7929524228625;3455.188030812757;3472.1840367513614;3474.3149572457337;3475.322312149132;4387.714798538085;4563.520830312836;5223.477652234784;5228.477152284741;5318.388385335658;3599.6580324869096;3831.4061320495366;4064.2074795414906;4119.485064366954;4181.790910454495;5553.972230138864;5559.916601250984;5560.164316198728;5578.246936663539;5623.240862483594;3763.9623603764157;3768.586779957516;3773.754705944105;3779.130799916007;3823.388257878754;5055.938252966881;5734.225879506255;5832.562557808139;5840.795572154997;5910.911336329958;3190.808551486918;3434.7252219822353;3683.8158092095823;3836.731428799957;3853;3922.156736301709;3922.9607703923166;3925.823337949799;3930.7051971102283;3934.783586902691;4243.5119961204855;4450.933236001462;4591.701539399928;4600.470945841271;4608.654350923694;5560.388357280777;5606.55147588192;5623.381428042912;5634.098544232903;5638.915416268759;1294.8446186457686;1314.3756715560223;1324.6953200763878;1332.9066965312336;1333.3200067965213;728.9198188199293;758.1879308452802;805.7542449552942;858.742377286824;887.7780554861284;4495.820167193276;4738.597219236403;5071.949280507221;5149.45930677281;5233.842984710464;4680.870204057146;5256.553192978563;5547.252615426128;5707.543396528268;5821.448916161138;4380.978095109568;4654.813807447732;5310.734463276898;5312.5218730314455;5372.462753724596;2553.9106131285316;2560.9103681371435;3025.6066711327826;3054.9847250764046;3078.399712056172;5087.160618497906;5155.38135423744;5541.722913854291;5757.253682715349;5940.524758019348;5256.2904007959205;5366.865828354323;5539.030669632879;5660.009498337775;5788.305403351625;5270.631055826132;5827.417258274223;5832.12518122285;5909.42019934537;5919.289685237799;5013.047520971149;5058.898822023465;5469.72651367438;5629.915551266816;5916.585838991229;5023.296738456546;5536.989024932443;5800.9419905800405;5864.296284445893;5944.138099975393;5564.137558678412;6033.728482218398;6044.304904935989;6056.636601803906;6126.785562505291;3715.2909661555987;3801.5975701747334;3836.635519625631;3843.807809609564;3853.670483683125;5220.817271395483;5416.593755468277;5729.828105156852;5784;5801.245838041028;4492.887677808081;5802.448767367094;5817.389174136655;5824.271966004249;5854.824355269348;4576.725396476222;4848.369711937426;5237.973810131078;5635.562931452453;5647.486868343548;4864.537868902448;4948.430930442901;5239.816606418757;5549.306336707911;5584;4937.703737775745;5217.34783152106;5581.7767289309595;5619.049998750688;5715.599218465007;4743.5019322971975;5499.230107784993;5556.972215138899;5570.86072848182;5616.017196990429 22:05:23 INFO - PROCESS | 2248 | |5;yui.html;706.4136766483817;721.1670520548764;758.207672981734;794.2970471133045;803.8231589050407;15151.696966060672;15393;15468.922655386707;15485.690286194269;15793.60515987101;13577.389017494212;13686.315684215775;13707.588772336821;13726.725465490685;13739.381727822247;670.9396154346108;691.8097523181115;694.4444444444424;823.2672921100226;826.305903041445;838.6813011055821;838.9832203355929;851.4040171879678;851.8083431227986;852.3224036890687;910.6858133943779;910.8542633178693;914.1452741686511;914.3051281026401;917.078336272049;599.7900734742849;737.0418456007169;740.8444226712343;909.295296145486;910.6038873090193;544.6296518367509;545.0298468725674;558.7876606889397;656.3862788292961;660.686174067319;14407.639809004753;14491.927540362336;14495.42018319266;14508.1295122293;14521.78217326741;13193.538226162038;13308.001899857549;13347.866521334856;13351.265680387574;13456.730865382637;12062.517499300018;12132.878671213351;12306.138570300083;12350.5059797608;12384.504619815196;4320.567943205686;4360.607545320905;4389.626881715058;4454.020115574568;4591.035882464686;81909;82810.58594706988;83877;91373.62939555846;93027;8670.523121228392;8831.779205519784;10636.574537018587;10704.571817127227;10755.247132700635;20368.287109951376;20399.592008159754;20411.97940102989;20442.977851107386;20444;6639.634820084845;7810.6875724971505;7836.764897053097;8002.51984880909;8082.232187942136;4219.236604647402;4319.4816622005565;4338.370936214231;4465.106978604292;4512.842050528216;3284.3595498877967;3396.796192228425;3404.676555727202;3404.931901361959;3405.540252065989;604.619089973314;611.7736437518147;611.8256296955346;630.8738252349549;634.946029587481;602.2020822410324;654.1430725749284;665.930062412279;666.9966650166718;693.1820451866846;8930.374873758905;9116.498592577473;9127.543622818832;9190.356675032683;9362.95318523403;529.7351324337831;578.9681567513827;617.9567430279927;677.6103740349319;691.7890043536669;4465.330200469955;4499.52754960731;4516.1419330327135;4522.34426008227;4573.611243044312;121470;122038.38980805039;123414;124102;125982;62070.37929620646;78956.6052169747;81220;85674.14325856787;86448.135518644;55237.17144242839;56210.43789562134;56307.71846140743;67970.66014669895;81499.18500814916;9016.368854180408;9467.905320946702;9726.319157658896;9737;9767.658131965347;40941.976450588976;47998.80107902915;50314.74842625763;52876.47123528869;52940.470595293555;50432.74783626058;54239;73786;75912.62043689746;77277.61361193383;12279.324637144686;12297.56958506448;12450.564230251897;12700.36498175106;12729.363531823557;13816.792748108586;14043.227622480861;14405.207713575854;14438.350274237475;14685;11069.723256918642;12176.695582610506;12981.480740770263;13571.932140339235;13766.174029558259;12391.814122787984;12405.449318835146;13186.208827470382;13221.603351899459;13267.80098298507;12622.87377126217;12880;12888.806667899802;12890.226586404846;12931;10303.690889273334;10916.945415272872;10944.39805810688;11008.559657613605;11550.480228389575;9478.431294122374;11146.665600031687;11163.776724465302;11270.380129092979;11483.885161148615 22:05:23 INFO - PROCESS | 2248 | __end_tp_report 22:05:23 INFO - PROCESS | 2248 | __start_cc_report 22:05:23 INFO - PROCESS | 2248 | _x_x_mozilla_cycle_collect,2099 22:05:23 INFO - PROCESS | 2248 | __end_cc_report 22:05:23 INFO - PROCESS | 2248 | __startTimestamp1478235923470__endTimestamp 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | ------- Summary: start ------- 22:05:23 INFO - PROCESS | 2248 | Number of tests: 6 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | [#0] dojo.html Cycles:165 Average:5676.21 Median:5872.30 stddev:651.03 (11.1%) stddev-sans-first:625.26 22:05:23 INFO - PROCESS | 2248 | Values: 3278.2 3279.8 3289.1 3300.8 3354.6 5496.0 5559.0 5642.3 5662.5 5674.2 5582.9 5633.2 5640.5 5647.9 5655.5 5093.3 5118.6 5124.5 5153.1 5164.6 5214.7 5234.6 5237.2 5238.9 5240.7 5089.4 5163.3 5164.9 5172.7 5224.9 5224.9 5233.5 5236.0 5241.9 5310.7 5042.0 5065.6 5128.0 5166.6 5167.5 5518.8 5582.4 5599.5 5626.7 5652.4 6140.8 6159.9 6161.9 6164.5 6180.7 6065.4 6114.6 6139.0 6211.1 6251.6 5625.8 5680.4 5681.5 5698.9 5765.0 6300.6 6320.9 6324.6 6331.5 6333.1 5842.1 5954.2 6031.4 6045.8 6062.3 6098.2 6108.1 6121.3 6138.2 6190.0 6080.9 6099.6 6114.7 6124.9 6131.6 6139.1 6143.7 6162.4 6166.9 6167.7 4197.8 4767.4 4830.5 4853.9 4855.7 3815.5 4302.5 4331.3 4384.6 4406.9 5602.4 5645.1 5650.9 5654.2 5666.6 6053.6 6073.3 6129.8 6195.0 6199.1 5652.7 5672.1 5674.9 5676.2 5681.7 5337.4 5342.6 5349.0 5349.5 5353.8 6204.1 6213.3 6243.7 6307.6 6309.7 6262.5 6263.1 6270.3 6270.5 6281.2 6300.7 6309.5 6314.1 6332.4 6335.1 5894.7 5997.6 6006.4 6128.1 6144.4 6116.4 6118.5 6132.3 6145.4 6192.6 6040.5 6053.8 6055.9 6072.0 6100.8 5882.6 6036.1 6054.9 6068.2 6075.0 5700.6 5779.2 5803.0 5871.4 5883.7 5991.4 6011.3 6044.8 6052.8 6112.2 5827.2 5868.7 5872.3 5890.7 5921.6 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | [#1] ext.html Cycles:180 Average:64997.92 Median:39571.72 stddev:138727.07 (350.6%) stddev-sans-first:139031.70 22:05:23 INFO - PROCESS | 2248 | Values: 493.2 507.4 508.8 521.3 522.6 30190.7 31569.8 31587.7 31619.2 31661.7 33640.0 40355.6 40981.0 43097.4 43147.8 9430.2 9578.7 9581.0 9587.2 9612.0 9363.0 9442.2 9457.0 9463.5 9470.5 9456.1 9484.9 9492.7 9527.0 9544.7 8104.8 9356.6 9438.1 9454.2 9463.6 9315.9 9384.2 9402.6 9414.3 9422.3 39339.6 39652.6 39656.8 39735.2 39748.4 3226.7 3324.6 3330.1 3348.5 3451.1 29961.0 31069.0 31083.4 31140.7 31469.4 3101.9 3116.6 3295.7 3345.1 3345.3 466567.0 468099.0 468278.0 468835.0 473767.6 55205.0 55467.0 55511.4 55634.2 55635.4 57996.4 58100.0 58167.0 58177.7 58231.7 15496.5 15694.8 15706.2 15716.1 15719.4 12190.9 12272.4 12291.3 12295.6 12322.6 14577.0 15218.5 15265.3 15288.5 15467.8 5201.9 5988.2 6230.7 6257.1 6278.7 834.6 884.4 917.6 948.9 967.5 28499.9 28538.6 29139.1 29280.9 29344.0 1059.3 1061.2 1070.9 1077.8 1095.4 11853.8 14801.3 14990.4 15222.4 15372.3 537946.0 542069.7 543391.0 544422.0 625847.0 56056.4 56441.7 56521.7 56551.7 56969.1 1210.4 1252.5 1324.1 1361.1 1370.6 28154.2 29641.9 29682.9 30299.8 30513.2 48094.0 48347.5 48365.3 48518.3 48669.8 525140.0 527840.0 528111.4 528873.0 529315.0 25158.6 25862.1 25866.4 26555.2 26591.6 45311.9 45744.5 46670.1 46976.3 47031.8 36427.0 37696.2 38219.6 38912.4 39566.4 37765.4 38617.8 38688.4 39205.6 39577.0 31390.7 37137.4 37404.8 37685.6 37935.1 32637.3 32979.5 33856.0 34071.5 34100.8 24261.9 24696.4 24769.5 24862.5 25585.2 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | [#2] jquery.html Cycles:180 Average:34867.63 Median:34640.07 stddev:92702.63 (267.6%) stddev-sans-first:92926.47 22:05:23 INFO - PROCESS | 2248 | Values: 354.8 368.8 374.7 381.9 406.6 14767.8 14876.0 15867.0 20247.1 20395.6 19285.3 19856.8 20236.9 20481.1 20992.3 5589.1 5628.9 5763.0 5766.4 5857.9 5602.7 5755.8 5767.2 5789.7 5794.1 5416.2 5731.8 5732.2 5740.9 5743.2 5592.7 5663.3 5736.9 5741.1 5747.6 5017.1 5025.6 5030.2 6948.0 7370.0 27370.0 27869.0 28488.4 28607.0 28988.7 2148.7 2415.6 2484.6 2526.4 2550.9 16128.6 16632.4 16664.6 17026.8 17735.9 1969.3 2051.3 2055.3 2060.9 2082.7 86684.0 111831.3 112775.7 125696.0 136159.0 17988.8 18389.5 20965.2 21147.3 21314.0 32996.8 34410.7 34564.8 34715.3 34781.8 10345.7 10553.0 10744.6 10796.1 10901.2 8576.9 8850.5 8857.0 9020.7 9058.5 9604.0 9654.6 9700.9 9808.6 9848.5 2980.8 3684.5 3749.8 3838.8 3845.3 809.3 874.5 879.7 903.0 932.5 19803.9 20604.0 20639.2 20717.4 21057.7 795.0 888.7 946.3 983.0 997.9 10104.9 10451.7 10889.1 11021.6 11023.7 497584.0 502239.0 530840.0 601604.0 609802.0 133584.0 144653.0 146228.0 149847.5 150873.7 426.3 449.3 451.4 452.5 453.0 10856.6 11192.3 11201.6 11257.8 11502.8 37334.0 47773.0 48900.3 53833.7 53859.7 76946.8 77475.6 77896.6 79919.2 81547.6 7515.3 7713.3 7758.7 7926.7 8374.7 10640.8 12029.5 12067.8 12958.9 13186.8 10855.6 11031.7 11258.7 11359.0 11445.0 8677.9 10664.7 11092.3 11138.1 11425.9 9238.8 10962.5 11186.4 11363.0 11687.0 8013.6 8279.6 8306.5 8448.2 8506.7 10712.1 10943.6 11228.4 11355.0 11370.3 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | [#3] mootools.html Cycles:180 Average:5428.22 Median:5093.40 stddev:2999.37 (58.9%) stddev-sans-first:2992.91 22:05:23 INFO - PROCESS | 2248 | Values: 1453.8 1493.9 1651.4 1782.4 1845.4 8129.8 8545.1 8558.4 8559.5 8573.7 7474.7 7686.9 8049.6 8304.4 8345.6 2292.3 2328.0 2328.5 2329.6 2333.5 2311.9 2333.7 2350.2 2358.9 2359.7 2301.3 2301.4 2320.2 2327.4 2332.3 1960.7 2283.6 2287.0 2305.6 2309.3 2283.2 2318.2 2323.3 2325.1 2339.4 8272.0 8456.0 8458.3 8460.1 8460.6 5015.2 5198.6 5201.1 5202.7 5203.5 3251.8 3360.4 3571.6 3611.1 3613.1 1045.3 1058.5 1067.3 1086.4 1089.5 10755.2 10791.7 10947.7 10963.9 10980.7 4147.9 4439.9 4442.0 4690.3 4703.0 9427.7 9437.6 9441.7 9447.1 9471.8 5141.6 5230.0 5231.3 5233.2 5246.8 4220.2 4487.2 4719.9 4810.1 4821.0 3435.0 3543.2 3748.6 3819.9 3838.3 1248.0 1252.7 1255.5 1264.6 1267.8 733.9 793.3 824.7 828.1 861.6 5520.5 5609.9 5687.1 5798.1 5814.7 871.2 882.9 886.7 897.9 937.6 3644.4 3664.5 3665.8 3753.6 3813.4 9904.3 10126.3 10317.1 10321.6 10334.3 10267.0 10268.3 10270.3 10274.2 10277.0 6772.4 6776.9 7817.2 7974.2 7980.1 5045.2 5157.3 5413.5 5433.6 5455.3 9296.8 9384.5 9438.8 9455.4 9571.6 9394.3 9555.6 9625.8 9643.0 9663.0 6252.4 6458.6 6478.5 6638.4 6788.3 7401.0 7454.9 7973.0 7976.3 8043.0 6981.0 7097.8 7133.7 7197.6 7199.9 6672.3 6930.3 6946.9 6995.7 7023.8 6454.9 6667.6 6747.8 6752.9 6807.1 4773.2 4828.3 4833.3 4847.8 4969.1 4773.3 4846.7 4869.7 4923.7 4949.9 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | [#4] prototype.html Cycles:180 Average:4478.82 Median:5065.42 stddev:1399.85 (27.6%) stddev-sans-first:1368.16 22:05:23 INFO - PROCESS | 2248 | Values: 298.4 300.8 309.8 314.5 315.6 4613.2 5117.8 5335.3 5344.5 5367.6 3738.0 4445.5 5113.5 5127.5 5263.7 3882.8 3963.4 4015.7 4073.0 4084.9 3383.9 3547.0 3851.2 4102.1 4104.0 3540.7 3546.9 4009.2 4064.5 4070.9 4014.9 4033.6 4037.6 4042.6 4045.9 3450.8 3455.2 3472.2 3474.3 3475.3 4387.7 4563.5 5223.5 5228.5 5318.4 3599.7 3831.4 4064.2 4119.5 4181.8 5554.0 5559.9 5560.2 5578.2 5623.2 3764.0 3768.6 3773.8 3779.1 3823.4 5055.9 5734.2 5832.6 5840.8 5910.9 3190.8 3434.7 3683.8 3836.7 3853.0 3922.2 3923.0 3925.8 3930.7 3934.8 4243.5 4450.9 4591.7 4600.5 4608.7 5560.4 5606.6 5623.4 5634.1 5638.9 1294.8 1314.4 1324.7 1332.9 1333.3 728.9 758.2 805.8 858.7 887.8 4495.8 4738.6 5071.9 5149.5 5233.8 4680.9 5256.6 5547.3 5707.5 5821.4 4381.0 4654.8 5310.7 5312.5 5372.5 2553.9 2560.9 3025.6 3055.0 3078.4 5087.2 5155.4 5541.7 5757.3 5940.5 5256.3 5366.9 5539.0 5660.0 5788.3 5270.6 5827.4 5832.1 5909.4 5919.3 5013.0 5058.9 5469.7 5629.9 5916.6 5023.3 5537.0 5800.9 5864.3 5944.1 5564.1 6033.7 6044.3 6056.6 6126.8 3715.3 3801.6 3836.6 3843.8 3853.7 5220.8 5416.6 5729.8 5784.0 5801.2 4492.9 5802.4 5817.4 5824.3 5854.8 4576.7 4848.4 5238.0 5635.6 5647.5 4864.5 4948.4 5239.8 5549.3 5584.0 4937.7 5217.3 5581.8 5619.0 5715.6 4743.5 5499.2 5557.0 5570.9 5616.0 22:05:23 INFO - PROCESS | 2248 | 22:05:23 INFO - PROCESS | 2248 | [#5] yui.html Cycles:180 Average:19551.58 Median:4547.98 stddev:28586.69 (628.6%) stddev-sans-first:28631.86 22:05:23 INFO - PROCESS | 2248 | Values: 706.4 721.2 758.2 794.3 803.8 15151.7 15393.0 15468.9 15485.7 15793.6 13577.4 13686.3 13707.6 13726.7 13739.4 670.9 691.8 694.4 823.3 826.3 838.7 839.0 851.4 851.8 852.3 910.7 910.9 914.1 914.3 917.1 599.8 737.0 740.8 909.3 910.6 544.6 545.0 558.8 656.4 660.7 14407.6 14491.9 14495.4 14508.1 14521.8 13193.5 13308.0 13347.9 13351.3 13456.7 12062.5 12132.9 12306.1 12350.5 12384.5 4320.6 4360.6 4389.6 4454.0 4591.0 81909.0 82810.6 83877.0 91373.6 93027.0 8670.5 8831.8 10636.6 10704.6 10755.2 20368.3 20399.6 20412.0 20443.0 20444.0 6639.6 7810.7 7836.8 8002.5 8082.2 4219.2 4319.5 4338.4 4465.1 4512.8 3284.4 3396.8 3404.7 3404.9 3405.5 604.6 611.8 611.8 630.9 634.9 602.2 654.1 665.9 667.0 693.2 8930.4 9116.5 9127.5 9190.4 9363.0 529.7 579.0 618.0 677.6 691.8 4465.3 4499.5 4516.1 4522.3 4573.6 121470.0 122038.4 123414.0 124102.0 125982.0 62070.4 78956.6 81220.0 85674.1 86448.1 55237.2 56210.4 56307.7 67970.7 81499.2 9016.4 9467.9 9726.3 9737.0 9767.7 40942.0 47998.8 50314.7 52876.5 52940.5 50432.7 54239.0 73786.0 75912.6 77277.6 12279.3 12297.6 12450.6 12700.4 12729.4 13816.8 14043.2 14405.2 14438.4 14685.0 11069.7 12176.7 12981.5 13571.9 13766.2 12391.8 12405.4 13186.2 13221.6 13267.8 12622.9 12880.0 12888.8 12890.2 12931.0 10303.7 10916.9 10944.4 11008.6 11550.5 9478.4 11146.7 11163.8 11270.4 11483.9 22:05:23 INFO - PROCESS | 2248 | -------- Summary: end -------- 22:05:23 INFO - PROCESS | 2248 | 22:05:24 INFO - TEST-INFO | 2248: exit 0 22:05:24 INFO - TEST-OK | dromaeo_css | took 1119178ms 22:05:24 INFO - TEST-START | kraken 22:05:24 INFO - operating with platform_type : mac_ 22:05:24 INFO - Initialising browser for kraken test... 22:05:24 INFO - TEST-INFO | started process 2252 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/tmpzjoxRT/profile http://localhost:55359/getInfo.html) 22:05:26 INFO - PROCESS | 2252 | __metrics Screen width/height:1600/1200 22:05:26 INFO - PROCESS | 2252 | colorDepth:24 22:05:26 INFO - PROCESS | 2252 | Browser inner width/height: 1024/689 22:05:26 INFO - PROCESS | 2252 | __metrics 22:05:26 INFO - PROCESS | 2252 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:05:26 INFO - PROCESS | 2252 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:27 INFO - TEST-INFO | 2252: exit 0 22:05:27 INFO - Browser initialized. 22:05:27 INFO - Running cycle 1/1 for kraken test... 22:05:27 INFO - TEST-INFO | started process 2253 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/T/tmpzjoxRT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:39 INFO - PROCESS | 2253 | RSS: Main: 239583232 22:05:39 INFO - PROCESS | 2253 | 22:05:41 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:42 INFO - PROCESS | 2253 | RSS: Main: 290459648 22:05:42 INFO - PROCESS | 2253 | 22:05:45 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-dft) 22:05:45 INFO - PROCESS | 2253 | RSS: Main: 289525760 22:05:45 INFO - PROCESS | 2253 | 22:05:49 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-fft) 22:05:50 INFO - PROCESS | 2253 | RSS: Main: 380731392 22:05:50 INFO - PROCESS | 2253 | 22:05:52 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55359/tests/kraken/driver.html?testName=audio-oscillator) 22:05:52 INFO - PROCESS | 2253 | RSS: Main: 283160576 22:05:52 INFO - PROCESS | 2253 | 22:05:55 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:05:55 INFO - PROCESS | 2253 | RSS: Main: 287772672 22:05:55 INFO - PROCESS | 2253 | 22:05:58 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55359/tests/kraken/driver.html?testName=imaging-darkroom) 22:05:59 INFO - PROCESS | 2253 | RSS: Main: 326021120 22:05:59 INFO - PROCESS | 2253 | 22:06:01 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55359/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:02 INFO - PROCESS | 2253 | RSS: Main: 327491584 22:06:02 INFO - PROCESS | 2253 | 22:06:05 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55359/tests/kraken/driver.html?testName=json-parse-financial) 22:06:05 INFO - PROCESS | 2253 | RSS: Main: 323661824 22:06:05 INFO - PROCESS | 2253 | 22:06:07 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:08 INFO - PROCESS | 2253 | RSS: Main: 303013888 22:06:08 INFO - PROCESS | 2253 | 22:06:09 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:10 INFO - PROCESS | 2253 | RSS: Main: 304238592 22:06:10 INFO - PROCESS | 2253 | 22:06:12 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:13 INFO - PROCESS | 2253 | RSS: Main: 307965952 22:06:13 INFO - PROCESS | 2253 | 22:06:16 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:17 INFO - PROCESS | 2253 | RSS: Main: 322252800 22:06:17 INFO - PROCESS | 2253 | 22:06:20 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:20 INFO - PROCESS | 2253 | RSS: Main: 316256256 22:06:20 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:55359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55359/tests/kraken/driver.html?testName=ai-astar) 22:06:22 INFO - PROCESS | 2253 | RSS: Main: 360493056 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | __start_tp_report 22:06:22 INFO - PROCESS | 2253 | _x_x_mozilla_page_load 22:06:22 INFO - PROCESS | 2253 | _x_x_mozilla_page_load_details 22:06:22 INFO - PROCESS | 2253 | |i|pagename|runs| 22:06:22 INFO - PROCESS | 2253 | |0;ai-astar;113;115;114;114;114;115;112;114;114;115 22:06:22 INFO - PROCESS | 2253 | |1;audio-beat-detection;150;113;113;149;117;114;112;112;144;95 22:06:22 INFO - PROCESS | 2253 | |2;audio-dft;183;186;182;184;194;264;187;184;181;180 22:06:22 INFO - PROCESS | 2253 | |3;audio-fft;80;59;58;88;62;72;83;81;100;58 22:06:22 INFO - PROCESS | 2253 | |4;audio-oscillator;92;70;91;70;70;79;103;68;68;92 22:06:22 INFO - PROCESS | 2253 | |5;imaging-gaussian-blur;88;88;135;85;87;84;90;127;88;86 22:06:22 INFO - PROCESS | 2253 | |6;imaging-darkroom;95;96;96;95;95;96;95;95;95;96 22:06:22 INFO - PROCESS | 2253 | |7;imaging-desaturate;81;81;81;81;84;84;82;84;81;82 22:06:22 INFO - PROCESS | 2253 | |8;json-parse-financial;57;56;56;56;56;58;56;57;57;55 22:06:22 INFO - PROCESS | 2253 | |9;json-stringify-tinderbox;65;72;73;76;72;70;70;70;70;74 22:06:22 INFO - PROCESS | 2253 | |10;stanford-crypto-aes;88;86;90;87;87;90;87;85;89;93 22:06:22 INFO - PROCESS | 2253 | |11;stanford-crypto-ccm;156;172;159;159;146;153;166;168;204;146 22:06:22 INFO - PROCESS | 2253 | |12;stanford-crypto-pbkdf2;174;176;173;172;172;175;174;173;208;171 22:06:22 INFO - PROCESS | 2253 | |13;stanford-crypto-sha256-iterative;68;66;69;81;70;56;68;61;57;70 22:06:22 INFO - PROCESS | 2253 | __end_tp_report 22:06:22 INFO - PROCESS | 2253 | __start_cc_report 22:06:22 INFO - PROCESS | 2253 | _x_x_mozilla_cycle_collect,2012 22:06:22 INFO - PROCESS | 2253 | __end_cc_report 22:06:22 INFO - PROCESS | 2253 | __startTimestamp1478235982823__endTimestamp 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | ------- Summary: start ------- 22:06:22 INFO - PROCESS | 2253 | Number of tests: 14 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 22:06:22 INFO - PROCESS | 2253 | Values: 113.0 115.0 114.0 114.0 114.0 115.0 112.0 114.0 114.0 115.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#1] audio-beat-detection Cycles:10 Average:121.90 Median:130.50 stddev:18.79 (14.4%) stddev-sans-first:16.95 22:06:22 INFO - PROCESS | 2253 | Values: 150.0 113.0 113.0 149.0 117.0 114.0 112.0 112.0 144.0 95.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#2] audio-dft Cycles:10 Average:192.50 Median:185.00 stddev:25.43 (13.7%) stddev-sans-first:26.74 22:06:22 INFO - PROCESS | 2253 | Values: 183.0 186.0 182.0 184.0 194.0 264.0 187.0 184.0 181.0 180.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#3] audio-fft Cycles:10 Average:74.10 Median:76.00 stddev:14.62 (19.2%) stddev-sans-first:15.35 22:06:22 INFO - PROCESS | 2253 | Values: 80.0 59.0 58.0 88.0 62.0 72.0 83.0 81.0 100.0 58.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:74.50 stddev:13.02 (17.5%) stddev-sans-first:13.11 22:06:22 INFO - PROCESS | 2253 | Values: 92.0 70.0 91.0 70.0 70.0 79.0 103.0 68.0 68.0 92.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:87.50 stddev:18.72 (21.4%) stddev-sans-first:19.65 22:06:22 INFO - PROCESS | 2253 | Values: 88.0 88.0 135.0 85.0 87.0 84.0 90.0 127.0 88.0 86.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:06:22 INFO - PROCESS | 2253 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#7] imaging-desaturate Cycles:10 Average:82.10 Median:82.00 stddev:1.37 (1.7%) stddev-sans-first:1.39 22:06:22 INFO - PROCESS | 2253 | Values: 81.0 81.0 81.0 81.0 84.0 84.0 82.0 84.0 81.0 82.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 22:06:22 INFO - PROCESS | 2253 | Values: 57.0 56.0 56.0 56.0 56.0 58.0 56.0 57.0 57.0 55.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.00 stddev:2.97 (4.1%) stddev-sans-first:2.15 22:06:22 INFO - PROCESS | 2253 | Values: 65.0 72.0 73.0 76.0 72.0 70.0 70.0 70.0 70.0 74.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:88.50 stddev:2.35 (2.7%) stddev-sans-first:2.49 22:06:22 INFO - PROCESS | 2253 | Values: 88.0 86.0 90.0 87.0 87.0 90.0 87.0 85.0 89.0 93.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#11] stanford-crypto-ccm Cycles:10 Average:162.90 Median:162.50 stddev:16.85 (10.4%) stddev-sans-first:17.68 22:06:22 INFO - PROCESS | 2253 | Values: 156.0 172.0 159.0 159.0 146.0 153.0 166.0 168.0 204.0 146.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:174.00 stddev:11.06 (6.4%) stddev-sans-first:11.69 22:06:22 INFO - PROCESS | 2253 | Values: 174.0 176.0 173.0 172.0 172.0 175.0 174.0 173.0 208.0 171.0 22:06:22 INFO - PROCESS | 2253 | 22:06:22 INFO - PROCESS | 2253 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:68.50 stddev:7.28 (10.6%) stddev-sans-first:7.70 22:06:22 INFO - PROCESS | 2253 | Values: 68.0 66.0 69.0 81.0 70.0 56.0 68.0 61.0 57.0 70.0 22:06:22 INFO - PROCESS | 2253 | -------- Summary: end -------- 22:06:22 INFO - PROCESS | 2253 | 22:06:23 INFO - TEST-INFO | 2253: exit 0 22:06:23 INFO - TEST-OK | kraken | took 59699ms 22:06:23 INFO - SUITE-END | took 1178s 22:06:23 INFO - Completed test suite (00:19:39) 22:06:23 INFO - javascript benchmark 22:06:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.1804548862783, 3279.7868138571007, 3289.0954987378477, 3300.8184549849757, 3354.607837747335, 5496.038193316163, 5559.0, 5642.322921249456, 5662.462066103719, 5674.205611214428, 5582.91625625616, 5633.15502674599, 5640.520555752766, 5647.915281270774, 5655.4910058094865, 5093.312402825617, 5118.616103792212, 5124.513171248744, 5153.098207813618, 5164.561012313958, 5214.687118772867, 5234.555062819665, 5237.214417837316, 5238.895222095575, 5240.685558866461, 5089.3638295213095, 5163.251328557357, 5164.896702065957, 5172.6637768545115, 5224.8693782655355, 5224.8693782655355, 5233.502817232356, 5236.0, 5241.947580524184, 5310.70791106489, 5041.974790126026, 5065.594752419797, 5127.9743601282125, 5166.586673066184, 5167.48325167484, 5518.779248830042, 5582.441755824426, 5599.524040456566, 5626.718664066781, 5652.378238393773, 6140.785072522441, 6159.907601385938, 6161.907571386433, 6164.476019538344, 6180.660063696495, 6065.393460653943, 6114.601521188683, 6139.048447490646, 6211.09939058834, 6251.562390632657, 5625.80309689163, 5680.403557626472, 5681.545476361881, 5698.857528561819, 5765.019946609086, 6300.558960872695, 6320.873582528416, 6324.557280990379, 6331.493480521547, 6333.081703153017, 5842.1236814477315, 5954.225950626391, 6031.366706495754, 6045.78839740607, 6062.302835173923, 6098.207233059763, 6108.053251745987, 6121.296050954108, 6138.202033735586, 6190.0405437157315, 6080.936264809853, 6099.638013992866, 6114.701653307849, 6124.923288778401, 6131.590761709946, 6139.062858969425, 6143.662098584531, 6162.352952939967, 6166.907496387557, 6167.722452489649, 4197.811098500575, 4767.380240568704, 4830.516948305211, 4853.854384368475, 4855.660103792771, 3815.542134943769, 4302.526722060571, 4331.328644060176, 4384.605385515319, 4406.889827754268, 5602.355729091207, 5645.125005624135, 5650.886982260332, 5654.180143879114, 5666.575006874418, 6053.636781793107, 6073.331933487313, 6129.847850912876, 6195.039768835838, 6199.070139479114, 5652.660840349592, 5672.149177623307, 5674.914876276859, 5676.233708449389, 5681.744321505542, 5337.439568845293, 5342.5993050521365, 5348.973255133699, 5349.491798279158, 5353.839384818461, 6204.13142160089, 6213.347598502092, 6243.719032643542, 6307.558470907176, 6309.652969086653, 6262.53031022666, 6263.060540918898, 6270.278917924497, 6270.4670103039925, 6281.246250449975, 6300.7479700811455, 6309.463695585927, 6314.084457753692, 6332.398422149889, 6335.1447554579545, 5894.70526473666, 5997.640141591519, 6006.399360063959, 6128.050152226412, 6144.446999770043, 6116.449519543263, 6118.4668989547035, 6132.263729246545, 6145.4161854623735, 6192.566520343533, 6040.546958978006, 6053.818385448443, 6055.9091613626715, 6072.0284754440845, 6100.786472473442, 5882.588218824641, 6036.124761909587, 6054.878902421839, 6068.21113255274, 6075.0, 5700.600957932905, 5779.162021506942, 5802.984477716298, 5871.383504731942, 5883.676397798162, 5991.400859913973, 6011.27864656244, 6044.818655440344, 6052.818415447544, 6112.235970503687, 5827.155062515827, 5868.67722275279, 5872.29532456108, 5890.7054647266605, 5921.5558833086825], "value": 5632.3850919315155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.24040976895583, 507.3987325019851, 508.8346287456577, 521.3431076843176, 522.5636593444474, 30190.698093019062, 31569.84215078927, 31587.68412315876, 31619.20951976202, 31661.68338316616, 33640.0, 40355.59644403555, 40981.0, 43097.35353969693, 43147.78426107873, 9430.151286384242, 9578.712638620853, 9580.952095239514, 9587.233021358275, 9612.0, 9363.016883227265, 9442.197413219885, 9456.952715236413, 9463.492174573743, 9470.526473676324, 9456.148946594805, 9484.90515094847, 9492.66775662852, 9527.047295270451, 9544.665936692218, 8104.8379032419025, 9356.625734970594, 9438.056194380575, 9454.196393306578, 9463.574139163686, 9315.860262096074, 9384.24926005918, 9402.62389504419, 9414.340996130273, 9422.293328000427, 39339.606603933884, 39652.60347396518, 39656.801715991234, 39735.20529589421, 39748.40377394341, 3226.7257283130725, 3324.5844269466315, 3330.134165117063, 3348.547946027304, 3451.137215696076, 29961.0, 31069.0, 31083.37833243345, 31140.688593114006, 31469.37061258762, 3101.8914337998285, 3116.6415862175913, 3295.670432956709, 3345.130266130799, 3345.3476572068457, 466567.0, 468099.0, 468278.0, 468835.0, 473767.6311618454, 55205.0, 55467.0, 55511.444885551435, 55634.16548751772, 55635.443645563835, 57996.4200357991, 58100.0, 58167.0, 58177.70911145502, 58231.70884145637, 15496.457623983106, 15694.76457853133, 15706.214689265491, 15716.057036577613, 15719.449819256271, 12190.878091219152, 12272.44773985155, 12291.262524248574, 12295.56965506203, 12322.630321090382, 14577.0, 15218.543443696706, 15265.313060912285, 15288.541343759483, 15467.75177212798, 5201.921971170435, 5988.185552790182, 6230.688465576703, 6257.124002639634, 6278.717457714414, 834.5785378383998, 884.4472204871955, 917.5824999625155, 948.8766460360109, 967.4775621164492, 28499.857500712365, 28538.571921421197, 29139.12582622525, 29280.853595731885, 29343.972960946263, 1059.3379138038727, 1061.1616822710128, 1070.8982646648712, 1077.849101125843, 1095.3920574081462, 11853.822192667118, 14801.333939972727, 14990.400383984519, 15222.41218992774, 15372.30824612895, 537946.0, 542069.6619888685, 543391.0, 544422.0, 625847.0, 56056.439435605935, 56441.71779141078, 56521.71739141278, 56551.71724141435, 56969.14546281809, 1210.4129497193853, 1252.4927404401415, 1324.073148795866, 1361.0880709924375, 1370.6093763277418, 28154.155375338774, 29641.851790740908, 29682.851585741933, 30299.848500757354, 30513.23716907095, 48094.03811923812, 48347.516524834304, 48365.27452088292, 48518.272225917346, 48669.756651216514, 525140.0, 527840.0, 528111.3594432003, 528873.0, 529315.0, 25158.62262066107, 25862.09482668173, 25866.35334116662, 26555.203343899713, 26591.60112598274, 45311.86720331886, 45744.54255457536, 46670.06659866851, 46976.29535556901, 47031.76484117557, 36427.0, 37696.246075078896, 38219.61780382161, 38912.41631375588, 39566.40650390189, 37765.4335184978, 38617.806910965264, 38688.41967370435, 39205.607943921335, 39577.02876621809, 31390.68609313969, 37137.44293835541, 37404.81297593495, 37685.623143769306, 37935.05162370963, 32637.347253055283, 32979.505307420884, 33856.0, 34071.48892766561, 34100.82949585236, 24261.878690606434, 24696.382590435383, 24769.50460990806, 24862.502749945263, 25585.23244302674], "value": 19031.001037970203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.80840346213046, 368.8248082160973, 374.6908800239803, 381.90643292393366, 406.55279192887826, 14767.778483322745, 14876.0, 15866.96864703795, 20247.088881000353, 20395.592088158228, 19285.325013624526, 19856.801431985677, 20236.8988155059, 20481.07835147418, 20992.26527071553, 5589.077802162648, 5628.917300598784, 5763.0202865512965, 5766.423357664221, 5857.912131318034, 5602.719864006804, 5755.82732518023, 5767.192593036978, 5789.681567513785, 5794.072948328248, 5416.214648875911, 5731.799387021455, 5732.22614946981, 5740.856478588048, 5743.224664670279, 5592.748326325304, 5663.292088488939, 5736.885262294752, 5741.052726300156, 5747.62640428375, 5017.147084995559, 5025.623078269145, 5030.195168772979, 6948.0, 7369.963150184269, 27370.0, 27869.0, 28488.430231395258, 28607.0, 28988.71011289881, 2148.7099241602496, 2415.577273977047, 2484.558607611957, 2526.4315529005826, 2550.923472295834, 16128.596785080466, 16632.417865374653, 16664.58338541534, 17026.829731702772, 17735.911320443443, 1969.3205843983803, 2051.3333166720727, 2055.321743824534, 2060.8660437071694, 2082.72924519813, 86684.0, 111831.29012259291, 112775.74448510984, 125696.0, 136159.0, 17988.820111798977, 18389.54026149357, 20965.161393544393, 21147.25984590532, 21314.0, 32996.83501582477, 34410.655893441246, 34564.82717586446, 34715.30569388598, 34781.826090869385, 10345.741356465998, 10553.0, 10744.570217191382, 10796.082333001626, 10901.236913416144, 8576.914230857736, 8850.468971861708, 8857.0, 9020.729378118667, 9058.5017824019, 9603.951980240054, 9654.586353411647, 9700.90299097, 9808.558614862348, 9848.507574621384, 2980.821150730963, 3684.521012268388, 3749.7562658427114, 3838.808059597009, 3845.2693988142723, 809.3039985612369, 874.4971641306274, 879.6701237036111, 903.0337538833385, 932.5383934952242, 19803.93039078945, 20604.0, 20639.174433022512, 20717.378478645664, 21057.684134737992, 794.9523028618186, 888.7156110044853, 946.3233787841726, 982.9950850245702, 997.9251556133319, 10104.898951010542, 10451.68644940653, 10889.074428673493, 11021.614243501439, 11023.72440688973, 497584.0, 502239.0, 530840.0, 601604.0, 609802.0, 133584.0, 144653.0, 146228.0, 149847.50152498554, 150873.73689394668, 426.31363504757314, 449.2609657114029, 451.4447229907233, 452.46609001378687, 452.97055691379956, 10856.620018299322, 11192.328460292409, 11201.551937922392, 11257.774844502901, 11502.82745758831, 37334.0, 47773.0, 48900.2664960033, 53833.730831345594, 53859.73070134624, 76946.8457973142, 77475.61262193653, 77896.61051694705, 79919.20080799118, 81547.59226204068, 7515.323620874147, 7713.344365728976, 7758.728444504415, 7926.722564710208, 8374.665013399395, 10640.787184256116, 12029.45867435985, 12067.81898271509, 12958.935205323913, 13186.802197966847, 10855.620053298097, 11031.731350894428, 11258.718532036437, 11359.0, 11445.0, 8677.913220867964, 10664.680059598224, 11092.279001864854, 11138.053265472201, 11425.942870285928, 9238.769030774285, 10962.451877406258, 11186.440677965906, 11363.0, 11687.006604438719, 8013.599320034092, 8279.586020699062, 8306.543140127109, 8448.155184481502, 8506.659733610586, 10712.14302855754, 10943.616973405893, 11228.382438965935, 11355.0, 11370.260933039326], "value": 10126.01495689676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.7528620134574, 1493.8879584031197, 1651.4302565614867, 1782.4474412932, 1845.427917345622, 8129.796755081118, 8545.145485451452, 8558.443701159427, 8559.486430814155, 8573.671080982442, 7474.738384156555, 7686.9231307686905, 8049.637766300516, 8304.377171712116, 8345.624446899888, 2292.323764489471, 2328.045501344449, 2328.499372634883, 2329.580675478413, 2333.5449587330477, 2311.8612883226974, 2333.708286464192, 2350.17743789674, 2358.9410264743346, 2359.6696462495265, 2301.2635956493928, 2301.4476525633895, 2320.176337400224, 2327.44141406063, 2332.265336419031, 1960.7353007343968, 2283.6232021716396, 2286.9771302287013, 2305.5965206088867, 2309.307207837659, 2283.235116236063, 2318.188633978111, 2323.256557901472, 2325.069972011192, 2339.3683705399617, 8271.95864020676, 8455.95772021136, 8458.323334133254, 8460.069392366835, 8460.576971151419, 5015.247712843066, 5198.558122559587, 5201.08980928336, 5202.713850738208, 5203.4796520348045, 3251.829341437081, 3360.4119279126057, 3571.5535558055244, 3611.079174810433, 3613.1328481164596, 1045.325764881647, 1058.4544171268112, 1067.3275836223208, 1086.4024786367545, 1089.4988305379457, 10755.247132700713, 10791.676249712522, 10947.726306842313, 10963.945180274048, 10980.725481862937, 4147.91704165915, 4439.933400998988, 4441.978344980673, 4690.343351930733, 4703.0, 9427.670031548863, 9437.575309111107, 9441.716748497556, 9447.071407863585, 9471.763205919908, 5141.614378921596, 5230.032443997872, 5231.3199284092825, 5233.241180028875, 5246.816361427332, 4220.198162349144, 4487.192305385062, 4719.905601887943, 4810.086083644096, 4820.987592605592, 3434.9828250858586, 3543.2382037861985, 3748.6438788315068, 3819.904502387407, 3838.328292548793, 1247.9875201248053, 1252.7181384188666, 1255.5291765587904, 1264.6395777203452, 1267.765463389276, 733.8789099798473, 793.3454899707764, 824.6824972385675, 828.1221904780951, 861.6294993153004, 5520.53075488588, 5609.943900560942, 5687.146927960756, 5798.10129429939, 5814.680192589363, 871.215905684876, 882.8852249207562, 886.6630680341558, 897.9236764874928, 937.5640327247862, 3644.4168932970597, 3664.523611930432, 3665.8167091645846, 3753.6246375362243, 3813.370793819044, 9904.257180711475, 10126.291159618757, 10317.123044541298, 10321.63874264397, 10334.328268662513, 10267.024632659886, 10268.332558383681, 10270.33242839213, 10274.178065754722, 10277.023682750127, 6772.424343930821, 6776.93223067763, 7817.218278172138, 7974.242446967529, 7980.082290536547, 5045.192769156917, 5157.329547158845, 5413.485718856702, 5433.592480563894, 5455.345358556999, 9296.767580810534, 9384.483853388128, 9438.811223775623, 9455.432674039579, 9571.569279382584, 9394.342396032485, 9555.61777528891, 9625.807483850424, 9642.951785241028, 9663.0, 6252.374762523711, 6458.644774537258, 6478.5141114415665, 6638.435732962752, 6788.321167883172, 7401.0, 7454.850902982019, 7972.960135199287, 7976.282134607681, 8043.0, 6981.0, 7097.82255443618, 7133.678984445816, 7197.640117994184, 7199.8560028800175, 6672.299408562031, 6930.341617546325, 6946.895796563157, 6995.685194166173, 7023.789286321418, 6454.903176452263, 6667.633280169637, 6747.831304217434, 6752.864942701217, 6807.115075040213, 4773.212419950669, 4828.324034635224, 4833.250846118857, 4847.757612119451, 4969.0807200668, 4773.307870358848, 4846.709197448165, 4869.732164730974, 4923.679960802537, 4949.896294075075], "value": 4391.241643941689, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4076607933253, 300.7729164480815, 309.7692219296624, 314.5344889563448, 315.5944611174641, 4613.162904813541, 5117.848484091082, 5335.306410166682, 5344.465553444654, 5367.597430192742, 3738.0467980664894, 4445.466544014715, 5113.463086375923, 5127.512886275807, 5263.7365932648945, 3882.844686212548, 3963.4451176835196, 4015.6586690131226, 4073.0, 4084.89787755307, 3383.881564145255, 3546.982265088684, 3851.2297540491872, 4102.113028007106, 4103.958960410402, 3540.6990405815536, 3546.9290614187703, 4009.2382447334912, 4064.496136429525, 4070.860159155441, 4014.879553613396, 4033.576474470197, 4037.6366127048414, 4042.555318914917, 4045.8988525286954, 3450.7929524228625, 3455.188030812757, 3472.1840367513614, 3474.3149572457337, 3475.322312149132, 4387.714798538085, 4563.520830312836, 5223.477652234784, 5228.477152284741, 5318.388385335658, 3599.6580324869096, 3831.4061320495366, 4064.2074795414906, 4119.485064366954, 4181.790910454495, 5553.972230138864, 5559.916601250984, 5560.164316198728, 5578.246936663539, 5623.240862483594, 3763.9623603764157, 3768.586779957516, 3773.754705944105, 3779.130799916007, 3823.388257878754, 5055.938252966881, 5734.225879506255, 5832.562557808139, 5840.795572154997, 5910.911336329958, 3190.808551486918, 3434.7252219822353, 3683.8158092095823, 3836.731428799957, 3853.0, 3922.156736301709, 3922.9607703923166, 3925.823337949799, 3930.7051971102283, 3934.783586902691, 4243.5119961204855, 4450.933236001462, 4591.701539399928, 4600.470945841271, 4608.654350923694, 5560.388357280777, 5606.55147588192, 5623.381428042912, 5634.098544232903, 5638.915416268759, 1294.8446186457686, 1314.3756715560223, 1324.6953200763878, 1332.9066965312336, 1333.3200067965213, 728.9198188199293, 758.1879308452802, 805.7542449552942, 858.742377286824, 887.7780554861284, 4495.820167193276, 4738.597219236403, 5071.949280507221, 5149.45930677281, 5233.842984710464, 4680.870204057146, 5256.553192978563, 5547.252615426128, 5707.543396528268, 5821.448916161138, 4380.978095109568, 4654.813807447732, 5310.734463276898, 5312.5218730314455, 5372.462753724596, 2553.9106131285316, 2560.9103681371435, 3025.6066711327826, 3054.9847250764046, 3078.399712056172, 5087.160618497906, 5155.38135423744, 5541.722913854291, 5757.253682715349, 5940.524758019348, 5256.2904007959205, 5366.865828354323, 5539.030669632879, 5660.009498337775, 5788.305403351625, 5270.631055826132, 5827.417258274223, 5832.12518122285, 5909.42019934537, 5919.289685237799, 5013.047520971149, 5058.898822023465, 5469.72651367438, 5629.915551266816, 5916.585838991229, 5023.296738456546, 5536.989024932443, 5800.9419905800405, 5864.296284445893, 5944.138099975393, 5564.137558678412, 6033.728482218398, 6044.304904935989, 6056.636601803906, 6126.785562505291, 3715.2909661555987, 3801.5975701747334, 3836.635519625631, 3843.807809609564, 3853.670483683125, 5220.817271395483, 5416.593755468277, 5729.828105156852, 5784.0, 5801.245838041028, 4492.887677808081, 5802.448767367094, 5817.389174136655, 5824.271966004249, 5854.824355269348, 4576.725396476222, 4848.369711937426, 5237.973810131078, 5635.562931452453, 5647.486868343548, 4864.537868902448, 4948.430930442901, 5239.816606418757, 5549.306336707911, 5584.0, 4937.703737775745, 5217.34783152106, 5581.7767289309595, 5619.049998750688, 5715.599218465007, 4743.5019322971975, 5499.230107784993, 5556.972215138899, 5570.86072848182, 5616.017196990429], "value": 4031.6166972020187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4136766483817, 721.1670520548764, 758.207672981734, 794.2970471133045, 803.8231589050407, 15151.696966060672, 15393.0, 15468.922655386707, 15485.690286194269, 15793.60515987101, 13577.389017494212, 13686.315684215775, 13707.588772336821, 13726.725465490685, 13739.381727822247, 670.9396154346108, 691.8097523181115, 694.4444444444424, 823.2672921100226, 826.305903041445, 838.6813011055821, 838.9832203355929, 851.4040171879678, 851.8083431227986, 852.3224036890687, 910.6858133943779, 910.8542633178693, 914.1452741686511, 914.3051281026401, 917.078336272049, 599.7900734742849, 737.0418456007169, 740.8444226712343, 909.295296145486, 910.6038873090193, 544.6296518367509, 545.0298468725674, 558.7876606889397, 656.3862788292961, 660.686174067319, 14407.639809004753, 14491.927540362336, 14495.42018319266, 14508.1295122293, 14521.78217326741, 13193.538226162038, 13308.001899857549, 13347.866521334856, 13351.265680387574, 13456.730865382637, 12062.517499300018, 12132.878671213351, 12306.138570300083, 12350.5059797608, 12384.504619815196, 4320.567943205686, 4360.607545320905, 4389.626881715058, 4454.020115574568, 4591.035882464686, 81909.0, 82810.58594706988, 83877.0, 91373.62939555846, 93027.0, 8670.523121228392, 8831.779205519784, 10636.574537018587, 10704.571817127227, 10755.247132700635, 20368.287109951376, 20399.592008159754, 20411.97940102989, 20442.977851107386, 20444.0, 6639.634820084845, 7810.6875724971505, 7836.764897053097, 8002.51984880909, 8082.232187942136, 4219.236604647402, 4319.4816622005565, 4338.370936214231, 4465.106978604292, 4512.842050528216, 3284.3595498877967, 3396.796192228425, 3404.676555727202, 3404.931901361959, 3405.540252065989, 604.619089973314, 611.7736437518147, 611.8256296955346, 630.8738252349549, 634.946029587481, 602.2020822410324, 654.1430725749284, 665.930062412279, 666.9966650166718, 693.1820451866846, 8930.374873758905, 9116.498592577473, 9127.543622818832, 9190.356675032683, 9362.95318523403, 529.7351324337831, 578.9681567513827, 617.9567430279927, 677.6103740349319, 691.7890043536669, 4465.330200469955, 4499.52754960731, 4516.1419330327135, 4522.34426008227, 4573.611243044312, 121470.0, 122038.38980805039, 123414.0, 124102.0, 125982.0, 62070.37929620646, 78956.6052169747, 81220.0, 85674.14325856787, 86448.135518644, 55237.17144242839, 56210.43789562134, 56307.71846140743, 67970.66014669895, 81499.18500814916, 9016.368854180408, 9467.905320946702, 9726.319157658896, 9737.0, 9767.658131965347, 40941.976450588976, 47998.80107902915, 50314.74842625763, 52876.47123528869, 52940.470595293555, 50432.74783626058, 54239.0, 73786.0, 75912.62043689746, 77277.61361193383, 12279.324637144686, 12297.56958506448, 12450.564230251897, 12700.36498175106, 12729.363531823557, 13816.792748108586, 14043.227622480861, 14405.207713575854, 14438.350274237475, 14685.0, 11069.723256918642, 12176.695582610506, 12981.480740770263, 13571.932140339235, 13766.174029558259, 12391.814122787984, 12405.449318835146, 13186.208827470382, 13221.603351899459, 13267.80098298507, 12622.87377126217, 12880.0, 12888.806667899802, 12890.226586404846, 12931.0, 10303.690889273334, 10916.945415272872, 10944.39805810688, 11008.559657613605, 11550.480228389575, 9478.431294122374, 11146.665600031687, 11163.776724465302, 11270.380129092979, 11483.885161148615], "value": 7216.901792362343, "unit": "score"}], "name": "dromaeo_css", "value": 7194.648058475878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 115.0, 112.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 113.0, 149.0, 117.0, 114.0, 112.0, 112.0, 144.0, 95.0], "value": 121.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 182.0, 184.0, 194.0, 264.0, 187.0, 184.0, 181.0, 180.0], "value": 192.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 62.0, 72.0, 83.0, 81.0, 100.0, 58.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 91.0, 70.0, 70.0, 79.0, 103.0, 68.0, 68.0, 92.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 135.0, 85.0, 87.0, 84.0, 90.0, 127.0, 88.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 81.0, 84.0, 84.0, 82.0, 84.0, 81.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 58.0, 56.0, 57.0, 57.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 73.0, 76.0, 72.0, 70.0, 70.0, 70.0, 70.0, 74.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 90.0, 87.0, 87.0, 90.0, 87.0, 85.0, 89.0, 93.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 172.0, 159.0, 159.0, 146.0, 153.0, 166.0, 168.0, 204.0, 146.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 173.0, 172.0, 172.0, 175.0, 174.0, 173.0, 208.0, 171.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 81.0, 70.0, 56.0, 68.0, 61.0, 57.0, 70.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1478.1999999999998, "alertThreshold": 2.0}]} 22:06:24 INFO - Return code: 0 22:06:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:06:24 INFO - # TBPL SUCCESS # 22:06:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:06:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:06:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:06:24 INFO - 2016-11-03 22:06:24.131 screenresolution[2257:27568] starting screenresolution argv=screenresolution get 22:06:24 INFO - 2016-11-03 22:06:24.135 screenresolution[2257:27568] Display 0: 1600x1200x32@60 22:06:24 INFO - 2016-11-03 22:06:24.142 screenresolution[2258:27571] starting screenresolution argv=screenresolution list 22:06:24 INFO - Available Modes on Display 0 22:06:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:06:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:06:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:06:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:06:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:06:24 INFO - Intel Iris: 22:06:24 INFO - Chipset Model: Intel Iris 22:06:24 INFO - Type: GPU 22:06:24 INFO - Bus: Built-In 22:06:24 INFO - VRAM (Dynamic, Max): 1536 MB 22:06:24 INFO - Vendor: Intel (0x8086) 22:06:24 INFO - Device ID: 0x0a2e 22:06:24 INFO - Revision ID: 0x0009 22:06:24 INFO - Displays: 22:06:24 INFO - Display: 22:06:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:06:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:06:24 INFO - Display Serial Number: 1600x1200 60 22:06:24 INFO - Main Display: Yes 22:06:24 INFO - Mirror: Off 22:06:24 INFO - Online: Yes 22:06:24 INFO - Rotation: Supported 22:06:24 INFO - Return code: 0 22:06:24 INFO - Running post-action listener: _resource_record_post_action 22:06:24 INFO - [mozharness: 2016-11-04 05:06:24.387028Z] Finished run-tests step (success) 22:06:24 INFO - Running post-run listener: _resource_record_post_run 22:06:24 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 561152; Write bytes: 705171968; Read time: 5; Write time: 2048 22:06:24 INFO - TinderboxPrint: CPU usage
53.5% 22:06:24 INFO - TinderboxPrint: I/O read bytes / time
561,152 / 5 22:06:24 INFO - TinderboxPrint: I/O write bytes / time
705,171,968 / 2,048 22:06:24 INFO - TinderboxPrint: CPU idle
2,256.6 (46.5%) 22:06:24 INFO - TinderboxPrint: CPU system
969.1 (20.0%) 22:06:24 INFO - TinderboxPrint: CPU user
1,628.0 (33.5%) 22:06:24 INFO - TinderboxPrint: Swap in / out
405,876,736 / 0 22:06:24 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400837120; Write bytes: 396441088; Read time: 29541; Write time: 917 22:06:24 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 520192; Write bytes: 294235136; Read time: 4; Write time: 1090 22:06:24 INFO - Running post-run listener: _upload_blobber_files 22:06:24 INFO - Blob upload gear active. 22:06:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:06:24 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 22:06:24 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:06:24 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:06:25 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:26 INFO - (blobuploader) - INFO - Done attempting. 22:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:27 INFO - (blobuploader) - INFO - Done attempting. 22:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:06:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:29 INFO - (blobuploader) - INFO - Done attempting. 22:06:29 INFO - (blobuploader) - INFO - Iteration through files over. 22:06:29 INFO - Return code: 0 22:06:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:06:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:06:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95fbc53f0d286e71e6ff92f6907fb8b22acaecd47a91f19c592b37c083785ed7e673e9c5f9c3711fda473362775a373f3e89124af40bdd396eab1ad23ecbca34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58cdc8e6811ee8f3c1deaa28209d7fd63a208af055e2e1eece471b8e5f5173329392d40817ca8e476ebec24bf042309e5c526bb007de0b39182ed0ce9045f412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a6ce636224416083c099a23295590fc80b5857ce7006b70e77d4bc920590cdb2a5b55c20276a5e89975eb3308c5709e505cdca6a0187c0d76741fbce6a74b99"} 22:06:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:06:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:06:29 INFO - Contents: 22:06:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95fbc53f0d286e71e6ff92f6907fb8b22acaecd47a91f19c592b37c083785ed7e673e9c5f9c3711fda473362775a373f3e89124af40bdd396eab1ad23ecbca34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58cdc8e6811ee8f3c1deaa28209d7fd63a208af055e2e1eece471b8e5f5173329392d40817ca8e476ebec24bf042309e5c526bb007de0b39182ed0ce9045f412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a6ce636224416083c099a23295590fc80b5857ce7006b70e77d4bc920590cdb2a5b55c20276a5e89975eb3308c5709e505cdca6a0187c0d76741fbce6a74b99"} 22:06:29 INFO - Running post-run listener: copy_logs_to_upload_dir 22:06:29 INFO - Copying logs to upload dir... 22:06:29 INFO - mkdir: /builds/slave/test/build/upload/logs 22:06:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.707957 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-03 22:06:29.633749) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 22:06:29.637352) ========= 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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners TMPDIR=/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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/Firefox/sha512/95fbc53f0d286e71e6ff92f6907fb8b22acaecd47a91f19c592b37c083785ed7e673e9c5f9c3711fda473362775a373f3e89124af40bdd396eab1ad23ecbca34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58cdc8e6811ee8f3c1deaa28209d7fd63a208af055e2e1eece471b8e5f5173329392d40817ca8e476ebec24bf042309e5c526bb007de0b39182ed0ce9045f412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a6ce636224416083c099a23295590fc80b5857ce7006b70e77d4bc920590cdb2a5b55c20276a5e89975eb3308c5709e505cdca6a0187c0d76741fbce6a74b99"} build_url:https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010955 build_url: 'https://queue.taskcluster.net/v1/task/JSNZ3BgiQzGrEW5ggewgyg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95fbc53f0d286e71e6ff92f6907fb8b22acaecd47a91f19c592b37c083785ed7e673e9c5f9c3711fda473362775a373f3e89124af40bdd396eab1ad23ecbca34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58cdc8e6811ee8f3c1deaa28209d7fd63a208af055e2e1eece471b8e5f5173329392d40817ca8e476ebec24bf042309e5c526bb007de0b39182ed0ce9045f412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a6ce636224416083c099a23295590fc80b5857ce7006b70e77d4bc920590cdb2a5b55c20276a5e89975eb3308c5709e505cdca6a0187c0d76741fbce6a74b99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 22:06:29.672649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:06:29.673401) ========= 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.2SJOGDdgQJ/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.m1LWuwhJJA/Listeners TMPDIR=/var/folders/46/tpjncvvj3m5c4y043tjxh8th00000w/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.005497 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 22:06:29.726303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 22:06:29.726991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 22:06:29.727681) ========= ========= Total master_lag: 0.22 =========