builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0315 starttime: 1476189109.58 results: success (0) buildid: 20161011030212 builduid: c8b18b67ab494b4ca852b70243c96ad1 revision: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.577487) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.577866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.578130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.619591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:49.619933) ========= 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.YTwe0orb8c/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.nruVQKctiG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-11 05:31:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 36.6M=0s 2016-10-11 05:31:50 (36.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.451378 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.115161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.115434) ========= 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.YTwe0orb8c/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.nruVQKctiG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.026817 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:50.165201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 05:31:50.165520) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb --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 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YTwe0orb8c/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.nruVQKctiG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-11 05:31:50,245 truncating revision to first 12 chars 2016-10-11 05:31:50,245 Setting DEBUG logging. 2016-10-11 05:31:50,245 attempt 1/10 2016-10-11 05:31:50,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f4c28b59a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 05:31:51,332 unpacking tar archive at: mozilla-central-8f4c28b59a8c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374734 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 05:31:51.561208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.561469) ========= script_repo_revision: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.561852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.562113) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 05:31:51.579762) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-11 05:31:51.580033) ========= /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.YTwe0orb8c/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.nruVQKctiG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:31:51 INFO - MultiFileLogger online at 20161011 05:31:51 in /builds/slave/test 05:31:51 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 05:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:51 INFO - {'append_to_log': False, 05:31:51 INFO - 'base_work_dir': '/builds/slave/test', 05:31:51 INFO - 'blob_upload_branch': 'Firefox', 05:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:51 INFO - 'branch': 'Firefox', 05:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:51 INFO - 'config_files': ('talos/mac_config.py',), 05:31:51 INFO - 'default_actions': ('clobber', 05:31:51 INFO - 'read-buildbot-config', 05:31:51 INFO - 'download-and-extract', 05:31:51 INFO - 'populate-webroot', 05:31:51 INFO - 'create-virtualenv', 05:31:51 INFO - 'install', 05:31:51 INFO - 'run-tests'), 05:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:51 INFO - 'download_minidump_stackwalk': True, 05:31:51 INFO - 'download_symbols': 'ondemand', 05:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:51 INFO - 'installer_path': 'installer.exe', 05:31:51 INFO - 'log_level': 'info', 05:31:51 INFO - 'log_name': 'talos', 05:31:51 INFO - 'log_to_console': True, 05:31:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:51 INFO - 'opt_config_files': (), 05:31:51 INFO - 'pip_index': False, 05:31:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:51 INFO - 'cmd': ('bash', 05:31:51 INFO - '-c', 05:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:51 INFO - 'enabled': True, 05:31:51 INFO - 'halt_on_failure': False, 05:31:51 INFO - 'name': 'check_screen_resolution'},), 05:31:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:51 INFO - 'cmd': ('bash', 05:31:51 INFO - '-c', 05:31:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:51 INFO - 'enabled': True, 05:31:51 INFO - 'halt_on_failure': False, 05:31:51 INFO - 'name': 'check_screen_resolution'},), 05:31:51 INFO - 'run_cmd_checks_enabled': True, 05:31:51 INFO - 'sps_profile': False, 05:31:51 INFO - 'sps_profile_interval': 0, 05:31:51 INFO - 'suite': 'dromaeojs', 05:31:51 INFO - 'system_bits': '32', 05:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:51 INFO - 'title': 't-yosemite-r7-0315', 05:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:51 INFO - 'use_talos_json': True, 05:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:51 INFO - 'work_dir': 'build'} 05:31:51 INFO - [mozharness: 2016-10-11 12:31:51.783391Z] Running clobber step. 05:31:51 INFO - Running pre-action listener: _resource_record_pre_action 05:31:51 INFO - Running main action method: clobber 05:31:51 INFO - rmtree: /builds/slave/test/build 05:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:53 INFO - Running post-action listener: _resource_record_post_action 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.864999Z] Finished clobber step (success) 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.865183Z] Running read-buildbot-config step. 05:31:53 INFO - Running pre-action listener: _resource_record_pre_action 05:31:53 INFO - Running main action method: read_buildbot_config 05:31:53 INFO - Using buildbot properties: 05:31:53 INFO - { 05:31:53 INFO - "project": "", 05:31:53 INFO - "product": "firefox", 05:31:53 INFO - "script_repo_revision": "production", 05:31:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:31:53 INFO - "repository": "", 05:31:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:31:53 INFO - "buildid": "20161011030212", 05:31:53 INFO - "stage_platform": "macosx64", 05:31:53 INFO - "basedir": "/builds/slave/test", 05:31:53 INFO - "nightly_build": "True", 05:31:53 INFO - "buildnumber": 2, 05:31:53 INFO - "slavename": "t-yosemite-r7-0315", 05:31:53 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:31:53 INFO - "platform": "yosemite_r7", 05:31:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:53 INFO - "branch": "mozilla-central", 05:31:53 INFO - "repo_path": "mozilla-central", 05:31:53 INFO - "revision": "8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb", 05:31:53 INFO - "pgo_build": "False", 05:31:53 INFO - "builduid": "c8b18b67ab494b4ca852b70243c96ad1", 05:31:53 INFO - "slavebuilddir": "test" 05:31:53 INFO - } 05:31:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:31:53 INFO - Running post-action listener: _resource_record_post_action 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.868761Z] Finished read-buildbot-config step (success) 05:31:53 INFO - [mozharness: 2016-10-11 12:31:53.868897Z] Running download-and-extract step. 05:31:53 INFO - Running pre-action listener: _resource_record_pre_action 05:31:53 INFO - Running main action method: download_and_extract 05:31:53 INFO - mkdir: /builds/slave/test/build/tests 05:31: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')]} 05:31:53 INFO - trying https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/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 05:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/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 05:31:54 INFO - Downloaded 1199 bytes. 05:31:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:54 INFO - Using the following test package requirements: 05:31:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:31:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:31:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'jsshell-mac.zip'], 05:31:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:31:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:31:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:31:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:31:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:31:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:31:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:54 INFO - Fetch https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:31:55 INFO - Http code: 200 05:31:55 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 05:31:55 INFO - x-amz-cf-id: VU3DFD1aivnrMcYVe6UzaRzRmVr1Cnji8G4IYofg7nOUGIeWELnfew== 05:31:55 INFO - x-amz-version-id: dPqUYccmk9TkqckgTYVZ46ZIrXdr1NTU 05:31:55 INFO - Expected file size: 16508662 05:31:55 INFO - Obtained file size: 16508662 05:32:02 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 05:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:32:03 INFO - Http code: 200 05:32:03 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 05:32:03 INFO - x-amz-cf-id: 3qfe8Zs-6RiU1Miz5FHvq8dWckI8R7VH1WPDvbPr_CrA12CFlOhxMw== 05:32:03 INFO - x-amz-version-id: dPqUYccmk9TkqckgTYVZ46ZIrXdr1NTU 05:32:03 INFO - Expected file size: 16508662 05:32:03 INFO - Obtained file size: 16508662 05:32:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:32:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:09 INFO - Fetch https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:32:10 INFO - Http code: 200 05:32:10 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 05:32:10 INFO - x-amz-cf-id: i41Q6aNeOe7jt5uyCPh-PcpaTZgejUNet7fCMZGzJxzt3AtuarYPQg== 05:32:10 INFO - x-amz-version-id: lzqvBS932gvp9foLWZ1WiIdSAN1yFZwI 05:32:11 INFO - Expected file size: 14409006 05:32:11 INFO - Obtained file size: 14409006 05:32:11 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')]} 05:32:11 INFO - trying https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/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 05:32:14 INFO - Downloaded 111886471 bytes. 05:32:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:14 INFO - mkdir: /builds/slave/test/properties 05:32:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:14 INFO - Contents: 05:32:14 INFO - build_url:https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:15 INFO - Running post-action listener: _resource_record_post_action 05:32:15 INFO - Running post-action listener: set_extra_try_arguments 05:32:15 INFO - [mozharness: 2016-10-11 12:32:15.341987Z] Finished download-and-extract step (success) 05:32:15 INFO - [mozharness: 2016-10-11 12:32:15.342106Z] Running populate-webroot step. 05:32:15 INFO - Running pre-action listener: _resource_record_pre_action 05:32:15 INFO - Running main action method: populate_webroot 05:32:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:15 INFO - '--tppagecycles', 05:32:15 INFO - '7'], 05:32:15 INFO - 'tests': ['tsvgm']}}, 05:32:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['damp', 'tps']}, 05:32:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'tests': ['damp', 'tps']}, 05:32:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['dromaeo_dom']}, 05:32:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['basic_compositor_video']}, 05:32:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['a11yr', 05:32:15 INFO - 'ts_paint', 05:32:15 INFO - 'tpaint', 05:32:15 INFO - 'sessionrestore', 05:32:15 INFO - 'sessionrestore_no_auto_restore', 05:32:15 INFO - 'tabpaint']}, 05:32:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tsvgx', 05:32:15 INFO - 'tsvgr_opacity', 05:32:15 INFO - 'tart', 05:32:15 INFO - 'tscrollx', 05:32:15 INFO - 'cart']}, 05:32:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:15 INFO - 'tsvgr_opacity', 05:32:15 INFO - 'tart', 05:32:15 INFO - 'tscrollx', 05:32:15 INFO - 'cart']}, 05:32:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s'], 05:32:15 INFO - 'tests': ['tp5o']}, 05:32:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'tests': ['tp5o']}, 05:32:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'talos_options': ['--disable-e10s', 05:32:15 INFO - '--xperf_path', 05:32:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:15 INFO - 'tests': ['tp5n']}, 05:32:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:15 INFO - 'talos_options': ['--xperf_path', 05:32:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:15 INFO - 'tests': ['tp5n']}}, 05:32:15 INFO - 'talos.zip': {'path': '', 05:32:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:15 INFO - Running post-action listener: _resource_record_post_action 05:32:15 INFO - [mozharness: 2016-10-11 12:32:15.360988Z] Finished populate-webroot step (success) 05:32:15 INFO - [mozharness: 2016-10-11 12:32:15.361125Z] Running create-virtualenv step. 05:32:15 INFO - Running pre-action listener: _resource_record_pre_action 05:32:15 INFO - Running main action method: create_virtualenv 05:32:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:15 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 05:32:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:15 INFO - Using real prefix '/tools/python27' 05:32:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:19 INFO - Installing pip.................done. 05:32:19 INFO - Return code: 0 05:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:19 INFO - Reading from file tmpfile_stdout 05:32:19 INFO - Output received: 05:32:19 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) 05:32:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:19 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')]} 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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')]} 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:19 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 05:32:19 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 05:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:19 INFO - 'HOME': '/Users/cltbld', 05:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PAGER': '/bin/cat', 05:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test', 05:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:19 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - 'XPC_FLAGS': '0x0', 05:32:19 INFO - 'XPC_SERVICE_NAME': '0', 05:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 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 05:32:19 INFO - Cleaning up... 05:32:19 INFO - Return code: 0 05:32:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:19 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')]} 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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')]} 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:19 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 05:32:19 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 05:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:19 INFO - 'HOME': '/Users/cltbld', 05:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PAGER': '/bin/cat', 05:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test', 05:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:19 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - 'XPC_FLAGS': '0x0', 05:32:19 INFO - 'XPC_SERVICE_NAME': '0', 05:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 INFO - Downloading/unpacking psutil>=3.1.1 05:32:19 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 05:32:19 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 05:32:19 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 05:32:19 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 05:32:19 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 05:32:19 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 05:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:23 INFO - Installing collected packages: psutil 05:32:23 INFO - Running setup.py install for psutil 05:32:23 INFO - building 'psutil._psutil_osx' extension 05:32:23 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 INFO - building 'psutil._psutil_posix' extension 05:32:24 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 05:32:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:24 INFO - ^ 05:32:24 INFO - 1 warning generated. 05:32:24 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 05:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:24 INFO - Successfully installed psutil 05:32:24 INFO - Cleaning up... 05:32:24 INFO - Return code: 0 05:32:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:24 INFO - 'HOME': '/Users/cltbld', 05:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:24 INFO - 'LOGNAME': 'cltbld', 05:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:24 INFO - 'MOZ_NO_REMOTE': '1', 05:32:24 INFO - 'NO_EM_RESTART': '1', 05:32:24 INFO - 'PAGER': '/bin/cat', 05:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:24 INFO - 'PWD': '/builds/slave/test', 05:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:24 INFO - 'SHELL': '/bin/bash', 05:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:24 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:24 INFO - 'USER': 'cltbld', 05:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:24 INFO - 'XPC_FLAGS': '0x0', 05:32:24 INFO - 'XPC_SERVICE_NAME': '0', 05:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:27 INFO - Installing collected packages: mozsystemmonitor 05:32:27 INFO - Running setup.py install for mozsystemmonitor 05:32:27 INFO - Successfully installed mozsystemmonitor 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:28 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:31 INFO - warning: no files found matching '*.txt' 05:32:31 INFO - no previously-included directories found matching 'build' 05:32:31 INFO - no previously-included directories found matching 'dist' 05:32:31 INFO - no previously-included directories found matching '.git*' 05:32:31 INFO - Installing collected packages: jsonschema, functools32 05:32:31 INFO - Running setup.py install for functools32 05:32:31 INFO - warning: no files found matching '*.txt' 05:32:31 INFO - no previously-included directories found matching 'build' 05:32:31 INFO - no previously-included directories found matching 'dist' 05:32:31 INFO - no previously-included directories found matching '.git*' 05:32:31 INFO - Successfully installed jsonschema functools32 05:32:31 INFO - Cleaning up... 05:32:31 INFO - Return code: 0 05:32:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:31 INFO - 'HOME': '/Users/cltbld', 05:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:31 INFO - 'LOGNAME': 'cltbld', 05:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:31 INFO - 'MOZ_NO_REMOTE': '1', 05:32:31 INFO - 'NO_EM_RESTART': '1', 05:32:31 INFO - 'PAGER': '/bin/cat', 05:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:31 INFO - 'PWD': '/builds/slave/test', 05:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:31 INFO - 'SHELL': '/bin/bash', 05:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:31 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:31 INFO - 'USER': 'cltbld', 05:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:31 INFO - 'XPC_FLAGS': '0x0', 05:32:31 INFO - 'XPC_SERVICE_NAME': '0', 05:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:31 INFO - Cleaning up... 05:32:31 INFO - Return code: 0 05:32:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:31 INFO - 'HOME': '/Users/cltbld', 05:32:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:31 INFO - 'LOGNAME': 'cltbld', 05:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:31 INFO - 'MOZ_NO_REMOTE': '1', 05:32:31 INFO - 'NO_EM_RESTART': '1', 05:32:31 INFO - 'PAGER': '/bin/cat', 05:32:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:31 INFO - 'PWD': '/builds/slave/test', 05:32:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:31 INFO - 'SHELL': '/bin/bash', 05:32:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:31 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:31 INFO - 'USER': 'cltbld', 05:32:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:31 INFO - 'XPC_FLAGS': '0x0', 05:32:31 INFO - 'XPC_SERVICE_NAME': '0', 05:32:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:35 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 05:32:35 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 05:32:35 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 05:32:35 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 05:32:35 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 05:32:35 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 05:32:35 INFO - Downloading docopt-0.6.1.tar.gz 05:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:35 INFO - Running setup.py install for blobuploader 05:32:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:35 INFO - Running setup.py install for requests 05:32:36 INFO - Running setup.py install for docopt 05:32:36 INFO - Successfully installed blobuploader requests docopt 05:32:36 INFO - Cleaning up... 05:32:36 INFO - Return code: 0 05:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:36 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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:36 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 05:32:36 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 05:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:36 INFO - 'HOME': '/Users/cltbld', 05:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:36 INFO - 'LOGNAME': 'cltbld', 05:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:36 INFO - 'MOZ_NO_REMOTE': '1', 05:32:36 INFO - 'NO_EM_RESTART': '1', 05:32:36 INFO - 'PAGER': '/bin/cat', 05:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:36 INFO - 'PWD': '/builds/slave/test', 05:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:36 INFO - 'SHELL': '/bin/bash', 05:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:36 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:36 INFO - 'USER': 'cltbld', 05:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:36 INFO - 'XPC_FLAGS': '0x0', 05:32:36 INFO - 'XPC_SERVICE_NAME': '0', 05:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9HiRhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-MwfpeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-1nZo21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-zXYoH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-zmd1j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-iBwV9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-alpEiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-PWQn9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-toFUl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:37 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-2raNA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-fO2XDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-qrP7Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-z_uDJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-MJWhyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Ab1MjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-YL96qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:38 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-PsrFiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:38 INFO - Running setup.py install for manifestparser 05:32:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:38 INFO - Running setup.py install for mozcrash 05:32:39 INFO - Running setup.py install for mozdebug 05:32:39 INFO - Running setup.py install for mozdevice 05:32:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozfile 05:32:39 INFO - Running setup.py install for mozhttpd 05:32:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozinfo 05:32:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozInstall 05:32:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:39 INFO - Running setup.py install for mozleak 05:32:40 INFO - Running setup.py install for mozlog 05:32:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for moznetwork 05:32:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozprocess 05:32:40 INFO - Running setup.py install for mozprofile 05:32:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozrunner 05:32:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozscreenshot 05:32:40 INFO - Running setup.py install for moztest 05:32:41 INFO - Running setup.py install for mozversion 05:32:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:41 INFO - Cleaning up... 05:32:41 INFO - Return code: 0 05:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:41 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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:41 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 05:32:41 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 05:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:41 INFO - 'HOME': '/Users/cltbld', 05:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:41 INFO - 'LOGNAME': 'cltbld', 05:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:41 INFO - 'MOZ_NO_REMOTE': '1', 05:32:41 INFO - 'NO_EM_RESTART': '1', 05:32:41 INFO - 'PAGER': '/bin/cat', 05:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:41 INFO - 'PWD': '/builds/slave/test', 05:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:41 INFO - 'SHELL': '/bin/bash', 05:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:41 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:41 INFO - 'USER': 'cltbld', 05:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:41 INFO - 'XPC_FLAGS': '0x0', 05:32:41 INFO - 'XPC_SERVICE_NAME': '0', 05:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-znV30e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-TvgLoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-1HNLSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:41 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-csxulP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:41 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)) 05:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Hg4p9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-zGRlK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9rHaZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-nzZMQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-YKYtTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-Gq0pBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-rYIDC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-DqOQlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9lxhEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:42 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)) 05:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:42 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-SmKU2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:43 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-R2Z4xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:43 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-T3kk_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:43 INFO - Running setup.py (path:/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/pip-9YnhQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:43 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)) 05:32:43 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)) 05:32:43 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)) 05:32:43 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)) 05:32:43 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)) 05:32:43 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)) 05:32:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:45 INFO - Downloading blessings-1.6.tar.gz 05:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:46 INFO - Installing collected packages: blessings 05:32:46 INFO - Running setup.py install for blessings 05:32:46 INFO - Successfully installed blessings 05:32:46 INFO - Cleaning up... 05:32:46 INFO - Return code: 0 05:32:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:46 INFO - Reading from file tmpfile_stdout 05:32:46 INFO - Current package versions: 05:32:46 INFO - blessings == 1.6 05:32:46 INFO - blobuploader == 1.2.4 05:32:46 INFO - docopt == 0.6.1 05:32:46 INFO - functools32 == 3.2.3-2 05:32:46 INFO - jsonschema == 2.5.1 05:32:46 INFO - manifestparser == 1.1 05:32:46 INFO - mozInstall == 1.12 05:32:46 INFO - mozcrash == 0.17 05:32:46 INFO - mozdebug == 0.1 05:32:46 INFO - mozdevice == 0.48 05:32:46 INFO - mozfile == 1.2 05:32:46 INFO - mozhttpd == 0.7 05:32:46 INFO - mozinfo == 0.9 05:32:46 INFO - mozleak == 0.1 05:32:46 INFO - mozlog == 3.4 05:32:46 INFO - moznetwork == 0.27 05:32:46 INFO - mozprocess == 0.23 05:32:46 INFO - mozprofile == 0.28 05:32:46 INFO - mozrunner == 6.12 05:32:46 INFO - mozscreenshot == 0.1 05:32:46 INFO - mozsystemmonitor == 0.3 05:32:46 INFO - moztest == 0.7 05:32:46 INFO - mozversion == 1.4 05:32:46 INFO - psutil == 3.1.1 05:32:46 INFO - requests == 1.2.3 05:32:46 INFO - wsgiref == 0.1.2 05:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:46 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 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32:46 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 05:32:46 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 05:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:46 INFO - 'HOME': '/Users/cltbld', 05:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:46 INFO - 'LOGNAME': 'cltbld', 05:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:46 INFO - 'MOZ_NO_REMOTE': '1', 05:32:46 INFO - 'NO_EM_RESTART': '1', 05:32:46 INFO - 'PAGER': '/bin/cat', 05:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:46 INFO - 'PWD': '/builds/slave/test', 05:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:46 INFO - 'SHELL': '/bin/bash', 05:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:46 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:46 INFO - 'USER': 'cltbld', 05:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:46 INFO - 'XPC_FLAGS': '0x0', 05:32:46 INFO - 'XPC_SERVICE_NAME': '0', 05:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 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)) 05:32:46 INFO - Cleaning up... 05:32:46 INFO - Return code: 0 05:32:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018bd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101833570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8cd1be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, '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.YTwe0orb8c/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.nruVQKctiG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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 05:32: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', 'jsonschema'] in /builds/slave/test/build 05:32: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 jsonschema 05:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:46 INFO - 'HOME': '/Users/cltbld', 05:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:46 INFO - 'LOGNAME': 'cltbld', 05:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:46 INFO - 'MOZ_NO_REMOTE': '1', 05:32:46 INFO - 'NO_EM_RESTART': '1', 05:32:46 INFO - 'PAGER': '/bin/cat', 05:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:46 INFO - 'PWD': '/builds/slave/test', 05:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:46 INFO - 'SHELL': '/bin/bash', 05:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:32:46 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:46 INFO - 'USER': 'cltbld', 05:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:46 INFO - 'XPC_FLAGS': '0x0', 05:32:46 INFO - 'XPC_SERVICE_NAME': '0', 05:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:47 INFO - Cleaning up... 05:32:47 INFO - Return code: 0 05:32:47 INFO - Running post-action listener: _resource_record_post_action 05:32:47 INFO - Running post-action listener: _start_resource_monitoring 05:32:47 INFO - Starting resource monitoring. 05:32:47 INFO - [mozharness: 2016-10-11 12:32:47.137121Z] Finished create-virtualenv step (success) 05:32:47 INFO - [mozharness: 2016-10-11 12:32:47.138104Z] Running install step. 05:32:47 INFO - Running pre-action listener: _resource_record_pre_action 05:32:47 INFO - Running main action method: install 05:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:47 INFO - Reading from file tmpfile_stdout 05:32:47 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:47 INFO - Reading from file tmpfile_stdout 05:32:47 INFO - Output received: 05:32:47 INFO - Usage: mozinstall [options] installer 05:32:47 INFO - Options: 05:32:47 INFO - -h, --help show this help message and exit 05:32:47 INFO - -d DEST, --destination=DEST 05:32:47 INFO - Directory to install application into. [default: 05:32:47 INFO - "/builds/slave/test"] 05:32:47 INFO - --app=APP Application being installed. [default: firefox] 05:32:47 INFO - mkdir: /builds/slave/test/build/application 05:32:47 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'] 05:32:47 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 05:33:21 INFO - Reading from file tmpfile_stdout 05:33:21 INFO - Output received: 05:33:21 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:21 INFO - Running post-action listener: _resource_record_post_action 05:33:21 INFO - [mozharness: 2016-10-11 12:33:21.798555Z] Finished install step (success) 05:33:21 INFO - [mozharness: 2016-10-11 12:33:21.798730Z] Running run-tests step. 05:33:21 INFO - Running pre-action listener: _resource_record_pre_action 05:33:21 INFO - Running main action method: run_tests 05:33:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:21 INFO - 2016-10-11 05:33:21.813 screenresolution[1645:8022] starting screenresolution argv=screenresolution get 05:33:21 INFO - 2016-10-11 05:33:21.815 screenresolution[1645:8022] Display 0: 1600x1200x32@60 05:33:21 INFO - 2016-10-11 05:33:21.822 screenresolution[1646:8024] starting screenresolution argv=screenresolution list 05:33:21 INFO - Available Modes on Display 0 05:33:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:22 INFO - Intel Iris: 05:33:22 INFO - Chipset Model: Intel Iris 05:33:22 INFO - Type: GPU 05:33:22 INFO - Bus: Built-In 05:33:22 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:22 INFO - Vendor: Intel (0x8086) 05:33:22 INFO - Device ID: 0x0a2e 05:33:22 INFO - Revision ID: 0x0009 05:33:22 INFO - Displays: 05:33:22 INFO - Display: 05:33:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:22 INFO - Display Serial Number: 1600x1200 60 05:33:22 INFO - Main Display: Yes 05:33:22 INFO - Mirror: Off 05:33:22 INFO - Online: Yes 05:33:22 INFO - Rotation: Supported 05:33:22 INFO - Return code: 0 05:33:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:22 INFO - Python 2.7.3 05:33:22 INFO - Return code: 0 05:33:22 INFO - grabbing minidump binary from tooltool 05:33:22 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')]} 05:33:22 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 0x1016d1d30>, '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 0x1014f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1016c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:22 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 05:33:22 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 05:33:22 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 05:33:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:22 INFO - Return code: 0 05:33:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:22 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 05:33:22 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0315 --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 05:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YTwe0orb8c/Render', 05:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:22 INFO - 'HOME': '/Users/cltbld', 05:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:22 INFO - 'LOGNAME': 'cltbld', 05:33:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:22 INFO - 'MOZ_NO_REMOTE': '1', 05:33:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:22 INFO - 'NO_EM_RESTART': '1', 05:33:22 INFO - 'PAGER': '/bin/cat', 05:33:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:22 INFO - 'PWD': '/builds/slave/test', 05:33:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:22 INFO - 'SHELL': '/bin/bash', 05:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nruVQKctiG/Listeners', 05:33:22 INFO - 'TMPDIR': '/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/', 05:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:22 INFO - 'USER': 'cltbld', 05:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:22 INFO - 'XPC_FLAGS': '0x0', 05:33:22 INFO - 'XPC_SERVICE_NAME': '0', 05:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:22 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0315', '--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 05:33:22 INFO - mozversion application_buildid: 20161011030212 05:33:22 INFO - mozversion application_changeset: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb 05:33:22 INFO - mozversion application_display_name: Nightly 05:33:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:22 INFO - mozversion application_name: Firefox 05:33:22 INFO - mozversion application_remotingname: firefox 05:33:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:22 INFO - mozversion application_vendor: Mozilla 05:33:22 INFO - mozversion application_version: 52.0a1 05:33:22 INFO - mozversion platform_buildid: 20161011030212 05:33:22 INFO - mozversion platform_changeset: 8f4c28b59a8c4a33ca4aaf0e139a63ab9aff5ddb 05:33:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:22 INFO - mozversion platform_version: 52.0a1 05:33:22 INFO - using testdate: 1476189202 05:33:22 INFO - actual date: 1476189202 05:33:22 INFO - starting webserver on 'localhost:49269' 05:33:22 INFO - SUITE-START | Running 2 tests 05:33:22 INFO - TEST-START | dromaeo_css 05:33:22 INFO - operating with platform_type : mac_ 05:33:22 INFO - Initialising browser for dromaeo_css test... 05:33:22 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp0cESCc/profile http://localhost:49269/getInfo.html) 05:33:25 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 05:33:25 INFO - PROCESS | 1656 | colorDepth:24 05:33:25 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 05:33:25 INFO - PROCESS | 1656 | __metrics 05:33:25 INFO - PROCESS | 1656 | 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" 05:33:25 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:26 INFO - TEST-INFO | 1656: exit 0 05:33:26 INFO - Browser initialized. 05:33:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:26 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp0cESCc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:38 INFO - PROCESS | 1659 | RSS: Main: 234532864 05:33:38 INFO - PROCESS | 1659 | 05:34:30 INFO - PROCESS | 1659 | 1476189270048 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] 05:36:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 05:36:43 INFO - PROCESS | 1659 | RSS: Main: 402518016 05:36:43 INFO - PROCESS | 1659 | 05:39:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 05:39:47 INFO - PROCESS | 1659 | RSS: Main: 371994624 05:39:47 INFO - PROCESS | 1659 | 05:42:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 05:42:50 INFO - PROCESS | 1659 | RSS: Main: 343752704 05:42:50 INFO - PROCESS | 1659 | 05:45:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 05:45:53 INFO - PROCESS | 1659 | RSS: Main: 347410432 05:45:53 INFO - PROCESS | 1659 | 05:48:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 05:48:57 INFO - PROCESS | 1659 | RSS: Main: 343236608 05:48:57 INFO - PROCESS | 1659 | 05:52:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 05:52:01 INFO - PROCESS | 1659 | RSS: Main: 462368768 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | __start_tp_report 05:52:01 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 05:52:01 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 05:52:01 INFO - PROCESS | 1659 | |i|pagename|runs| 05:52:01 INFO - PROCESS | 1659 | |0;dojo.html;2680.182544323981;2930.355321829197;3256.609206895173;3286.227736481928;3321.750868684849;5397.8380648580605;5474.069408200606;5487.094629386146;5526.58550608704;5551.91737611166;5450.31871016123;5502.0921547944545;5562.749676264568;5574.637648552841;5588.888222235553;4952.158133117378;4992.500749925015;5006.499350065001;5042.773075211624;5077.974610126944;4975.228839529878;5160.535551800337;5167.328247327842;5200.479952004807;5232.502912223333;5142.408623008365;5152.639315247934;5155.819546315861;5191.169412893938;5226.111561034614;4980.402351717817;5019.096562618727;5037.899242015139;5058.215976523645;5066.03745288394;5030.144875371196;5034.848954531333;5048.495150484959;5082.720450375228;5088.92366614501;5497.697626630534;5502.80740174092;5504.284443022381;5545.77816887324;5574.804881829116;4815.374001379798;5816.738246778905;5820.592558520905;5933.762649494015;5966.2840459144745;5922.466977972003;5942.821715348503;5979.491743201833;6003.699815009232;6009.75960961561;5545.334559852843;5547.44525547446;5554.305711786027;5567.832965011056;5568;6022.939770602326;6039.66781826995;6159.599626024294;6188.783392581238;6192.349803270682;5803.361630220672;5805.419458054245;5835.649861008353;5851.005329094064;5895.4399332063385;5989.610675306179;6003.159557661931;6005.489533389711;6017.308009578955;6036.366181550961;5848.385919478478;5888;5910.763569457259;5920.082387229986;5961.254843144607;5689.487946084872;5823.126531020296;5830.41695830422;5883.264591926009;5897.2333596633025;4719.174144524694;4728.361671174416;4733.668643195012;4734.881627959328;4748.074125545554;4198.118395137056;4211.347241177622;4317.309230523101;4331.956680433155;4333.566643335641;5449.128139497661;5503.449655034465;5511.476409741068;5512.6968016759465;5521.641093328921;5932.851678708067;5937.762489500458;5948.167256584082;5949.25634295713;5957.076653118774;5483.451654834565;5528.364238112668;5528.44715528444;5532.75102620383;5543.279373681396;5137.922931156036;5147.176451767699;5156.535911767884;5189.7405129743365;5195.740212989335;6213.720382582795;6227.9377206227355;6235.3452887446165;6236.719347629368;6243.282022567372;5864.179014937998;5897.498712609477;5900.0264956281735;5947.494462970696;5982.641041537521;6139.461473530676;6158.661273629993;6217.160683307877;6219.378062193744;6238.532110091671;5837.591368604157;5860.794872179454;5867.618604790675;5877.059670452878;5891.852703682443;5842.269716285465;5948.672822994777;5974.820755377345;6001.849953751192;6003.5797494174985;5681.517071049007;5747.396523365153;5753.71231438418;5768;5812.447817457335;4592.770361481979;5278.577713782812;5857.26784151981;5880.676562789087;5887.028640274307;5642.830715078554;5701.344345400166;5702.315722113373;5705.686187259741;5708.115242137475;5489.39616642177;5779.624324419067;5850.414958504116;5853.2976042875125;5860.941390586039;4542.727436353829;5404.297441332602;5657.094864821609;5717.599768016199;5718.885622287614 05:52:01 INFO - PROCESS | 1659 | |1;ext.html;450.032430274909;460.27506676983757;474.72940423958335;486.15651844050586;496.33986797559237;27741.306467338327;39208;41505;41580.168396632085;41610.58389416112;42388.364174537404;43206;43355.916102097464;43402.56597434025;43489.56510434895;8848.2478989286;9642.662506812245;9850.753731156707;9856.507174641276;9866.112049915506;8869.556522173898;11816.7636647267;12114.93942530286;12118.272903625766;12260.5708800192;12061.457234424472;12115.394230288495;12142.39288035599;12163;12175.208611440228;12205.694857628541;12279.324637144953;12288;12301.815472767916;12305.753884922251;11894.702632434259;11984.9812765915;11992.400379980965;11993.100517461226;12005.699857503632;40128.598714012776;40402.595974040174;40421.797891010654;40567.98580035493;40749.79625101885;3205.5512228288057;3221.3396253767924;3265.2000259936467;3468.8265586720563;3542.5217595624517;25415.872920635462;30028.399432011454;31851.362972740415;31895.840520797246;32033.679663203537;3101.953470697941;3246.772725909187;3312.2381852173894;3316.7844090134063;3352.4636058230567;487685;489668;490089;490405;497581;60074.79850402968;60321.69839150776;60398.69800651057;60401.69799150976;60612;64905.86035536087;65116.69766604641;65131.34868651253;65161;65203.065862036325;15900.443484477988;16142.354305827635;16163;16186;16198.838011619968;11032;11332.660020199408;12290.262584244974;12352;12389.504419823286;15973.943386381265;19448.12483438249;19834.50413739639;19906.104225309897;19917.402477925687;7815.335696465864;7816.804579885435;7894;7981.960090199512;8027.357811375076;829.6100832608664;932.9720108396759;1034.637876743149;1114.9108071354271;1136.9545218191179;26914.461710765674;28903;29045.56431653527;30066.24834379158;30218.79124835026;998.336106489191;1041.5677493839971;1101.779644071189;1106.8893110689028;1186.32379543661;14961.925190373979;15454.845451545341;15606.29771660278;15630.452934147477;16064.678706425806;654975;664381;664526;664848;666120;52051.91792328264;55430;58518.82962340729;58750;58885.116723249186;1325.8011298305332;1367.6170672211797;1375.8624137586362;1377.5040985245505;1380.8412032616377;29683.851580741957;29936.101916942527;29974.051686640298;30234.54648180235;30418.205409720824;50689;51201.92788432706;51202;51209.97580048453;51235.74382128065;478190;561744;564543;564827;568041;35332.293354132256;35657.64342356543;36077.63922360848;42414.5758542423;43147.784261078494;37917.43123853199;42472.57527424686;44355.89110272269;47169.292460613804;47377.76311118422;38793.418098727976;38898;39262;40057;40517.59482405256;38817.41773873338;38952.610473896035;40333.596664032986;40374.798126009184;40665.8668266342;37516.87449376523;37695.434568480945;38453.03867403337;38617.61382386253;38793;30095.247618809706;33356;33988;34476.48285275673;34767;21817.127314907862;25575.744242557335;25606.871965640054;25673.871630641726;26086 05:52:01 INFO - PROCESS | 1659 | |2;jquery.html;322.76438200113915;341.7129611126653;349.40600978336835;359.5631307960828;369.77074213987316;15387.538373848789;15683;17955.461336159937;20654.586908261826;21570.676439853414;20708.48228794281;21200.363989080313;21255.25606603769;21423.464413389673;21624.783752162475;5766.682832444224;6125.448709616134;6139.048447490646;6139.263288405397;6154.415330543591;4865.951340486603;5210.76551555181;5793.5365170786445;6034.69826508675;6059.575829691923;5973.611715238518;5974.044152935531;5978.8206353809455;6001.909971350433;6002.639841609517;5671.432856714337;5930.525557955353;5949.375315591866;5978.701064946736;5991.281046274431;4498.595126438636;5182.689038657692;5198.2722418861385;5198.818041368571;5201.08980928336;20789.688154677693;25402.618960715605;25827.35431614206;25950.87024564884;26126.738732612812;2201.8899055047345;2205.9669104963436;2338.1933233034574;2344.27327528465;2385.3440303916386;15008.849911500964;15377.692446151126;15517.689646207125;15535.223238838125;16024.536322448892;1800.3518733256017;1831.4160592669466;1871.9344822931132;1878.9060546972596;1905.3045638342044;93463;93781;119092;119723.99999999913;122512;10496.265261431627;10522.894771052344;10899.891001089887;10923.289986150874;11130.554777808959;13630.93184534071;13652.180869147684;13665.521706740416;13680.110792798436;13682.863171368357;8192.30365418946;8215.671373145007;8456.957715211507;8640.524771137647;8645.610947507377;8461.069282378934;8482.830343393098;8492.787680307918;8625.39622226438;8681.739547813575;5423.891522169613;5562.610617256834;6679.632620205935;6694.364035416725;6709.295523969913;1768.6904791661407;1807.7649905512199;1808.4574627611928;1813.0934532733634;1813.954651133732;707.9451617090601;882.9360620452339;899.6986009686698;906.7098528470958;972.5672075926286;18941.637739430167;21623.13507459684;22493.887530562242;22570.77429225687;22669.88665056664;820.6348175062041;898.5013317608659;911.2573252798948;923.6997975657804;965.2471072563412;10770.78458430827;11760.823587646191;11838.644840654793;11840.70398240051;11850.585229516926;589583;598758.0062099661;601533;618688;618889;112367;114410.42794785973;118227;119783;122861;971.2424309038961;980.6567701304629;1010.6462738041773;1014.7970405918845;1018.4805749068029;13269.86730132725;19453.4163975081;19633.60732785365;19776.505587360432;19849.106790194764;49709;51135.97728045493;51480.71298217575;52387.47612523979;56496.55829557493;52417.213741793144;72130.63934680293;78294;79570;80949.59525202337;11569.942150289195;11805.409729513662;11935;12050.638480845588;12413.31726755001;13502.257375844423;13595.32023398846;13890.861091388957;13933.72132557323;14064.859351406354;11440.542378304775;11534.019608333385;11967.222130561486;12004.39978001114;12037.217580857216;11425.085993120365;11567;11762.70593235176;11795.52817887275;12121.27272363661;9656.565454554422;11686.94156529212;12049.277043377426;12174.57388991381;12207.511699532275;12196.390180491117;12290.938545307215;12302.569410070604;12408.007359411406;12624.810627840407;11630.302181869114;11697.122715796178;11873.168878178445;11978.281303121841;12013.459394327101 05:52:01 INFO - PROCESS | 1659 | |3;mootools.html;1372.7323171981468;1428.9499867504637;1433.8781203597691;1638.721417359049;1891.640588288226;7643.9235607643905;8092.433529652927;8328.458650187733;8674.74216238645;8710.085441028696;8576.742697719079;8685.174908383693;8690.044095149544;8696.1303869613;8728.869066964;2237.653163759616;2256.5148493073984;2260.050778672953;2260.649599312101;2264.3772962435296;2207.514346843692;2229.832762542816;2252.358077947777;2253.1438053539714;2253.583087128878;2240.764719704432;2263.864168149908;2268.1494439585153;2274.9090036398607;2281.441046943501;2222;2249.8200143988443;2251.515924076315;2251.6172250717254;2262.468319944812;2234.72065991751;2240.350298413458;2245.438640339915;2245.663150527434;2246.326102169359;8452.450590711645;8568.828623427496;8629.525376104311;8696.304295656333;8700.173483519118;4539.4779600346055;5063.392392912874;5198.986197691452;5251.76367063483;5257.053730328539;3318.369509793132;3462.480627905809;3531.2584357285;3550.7692000019915;3558.982205088984;1011.1354791653177;1044.2220545693508;1053.5996321397897;1070.8714954205468;1081.5944020992129;9661.661841835503;11313.264637798517;11425.200235983484;11494.31034137946;11510.136739744552;4206.326987681956;4290.656747460196;4438.201123797748;4455.77721113943;4462.888427789267;7777.961110194526;8836.425632334007;8896.332775041898;8902.198802107841;8921.197092261727;5110.463401342806;5118.872028199325;5121.231815227746;5121.897562048738;5125;3311.569495965509;3812.1803812180515;4315.374270730789;4461.687681862239;4811.855644330676;3590.1563132663805;3636.818159092035;3648.5804132524568;3688.188598508324;3689.723270754704;1033.7674023344687;1058.1481907064888;1116.9888301116885;1132.597927735642;1136.1535655936216;763.3625922354785;853.1681610429905;907.8502047162276;910.6858133943779;934.4299977014016;4830.541098595628;5062.265971434122;5514.779408823682;5519.39286678465;5709.74306156224;884.12471653063;890.857462805948;897.1611543207122;899.1233547291339;907.3195103672246;3676.2647470506004;3747.569029561581;3787.6780473660046;3884.6698030667144;3891.2412079644196;10238.283320167666;10545.683629490974;10704.678859634223;10709.98255165758;10735.51690173944;10479.580816767397;10692.946535267429;10700.983406576363;10703.62537311206;10704.625338113285;7937.2062793721325;8091.716789912325;8109;8128;8134.674613015532;5668.914966275592;5675;5745.3105627324985;5794.154005662634;6030.366811484906;9667.854982175413;9833.262505311986;9967.601295948081;9982.401055936667;9999.650012249536;7125.572465652078;9119.270458363448;10145.34055286404;10162.898371016196;10192.337498062601;6788.25329213796;7010.228874823663;7326.6702998364135;7400.925990740239;7457.105147382132;8023.759287221393;8069.757907262791;8072.4752891064245;8131.390145739211;8164.632591533514;6393.1688880445245;7368.557886526825;7437.219091995479;7448.9627551861895;7495.250474952461;7150.67821948024;7242.7465038725495;7248.818779530554;7322.926770732438;7325.047743793486;6770.729170833111;6813.216480104851;6836.350546698056;6888.655567221519;6903.240643529108;4569.200389931815;4731.929021064756;4844.370231869975;4861.392325959255;4958.925616115834;4752.287156926489;4814.133455977958;4906.582940450102;4946.431160416598;5047.87380315495 05:52:01 INFO - PROCESS | 1659 | |4;prototype.html;264.56611157701366;296.9257685578605;297.9612650355454;311.6945393514356;314.57689407746574;4773.809047638099;4933.851984440468;4943.901121977558;4994.825181118662;5000.324956130921;4780.968088562356;4821.325014497965;4857.975710121454;4859.246816743402;4937.210046392578;3210.871565137392;3707.924701836464;3783.4703141560203;3821.5032045834005;3835.789031603261;3147.5908131942815;3846.769193848364;3870.4581358609817;3876.9224615507815;3911.5110611173604;3323.2854936188714;3656.067702735799;3819.618038196172;3833.7891415972113;3869.2648396804657;3794.563625183098;3811.3711237645757;3834.8082595870374;3842.865499707511;3867.361885288924;2815.366542527915;3356.087030392677;3370.4775759757276;3378.831058447068;3406.6423025582203;4104.261232978063;4578.198815207325;4768.833090841838;4873.390826146731;4885.462599114095;3643.708503319728;3742.5508938927233;4119.765983702779;4340.045190058182;4377.1683380157665;5128.333316668846;5150.665206761549;5157.277981082651;5212.869678258036;5258.6318957672975;2951.67531571527;3306.96693033069;3384.5769278840144;3715.1826598148364;3716.7769933804057;4640.721556706575;5092.719900405476;5319.38827034896;5343.732813359316;5361.544268737162;3732.4028155495535;3748.400255959088;3755.4275321404925;3767.698584113264;3768.2275133597545;3209.5988001499813;3821;3838.2323535293053;3846.7114966377635;3864.7874366909527;3617.782933024027;4074.0425999890003;4314.289710848668;4380.540043295408;4408.206522825858;4494.3820224719075;4975.293406412246;5152.330197074356;5164.690118592896;5220.660657057355;1032.9070383665505;1214.36245970866;1255.3221260519217;1269.9682507937375;1295.4559085184246;808.4825711544617;885.7741275974714;912.7033714042963;916.4134953629682;917.9082091790901;3846.9615303846604;4269.573042695768;4327.8485253016;4433.91369114569;4748.955229849427;4683.103343146031;5052.8484145475695;5220.321358223407;5242.842714718488;5287.339082614673;3998.7200895937585;4821.023380414013;4830.275458681226;4842.5157484251995;4893.143699852511;1900.429871038683;1985;2086.384516567616;2171.772948284214;2371.573116838951;4230.534641189467;4480.289424897955;4524.615407690318;4560.315952607136;4570.291604801261;4189.6438802701505;4451.109778044404;4478.529754375809;4491.034427598017;4493.460784705856;4543.704659197141;4545.840895568639;4560.749158796231;4565.863024109282;4571.405717256735;4356.738595684269;4476.813644384176;4499.310565336393;4505.7296562206375;4506.842260520866;3557.288542291604;3928.576776969618;4087.448194493705;4111.09555897702;4388.802503887269;4049.838006479708;4507.932381014221;4517.344984977094;4537.3438694876795;4545.5908968193025;3230.596175478065;3253.4220902862567;3260.527223552524;3263.51047342891;3274.230555819428;3590.2809158940363;3853.5183102112237;4436.401085853368;4459.241928872165;4468.21806183923;3771.8868433947027;3830.9042273943373;3975.8012099394336;4279.828806847816;4354.931407581374;4250.851220207278;4292.699511034198;4307.22469955411;4312.310030395121;4330.328799036154;3847.3651847445976;4027.4160246763468;4331.848385306499;4805.3512775774825;5041.8487445376695;4377.387165796855;4380.693351465495;5197.974010129925;5228;5228.451012643618;4550.294704320703;4988.900221995467;5053.570446511941;5087.8788181573045;5110.284560161506 05:52:01 INFO - PROCESS | 1659 | |5;yui.html;681.2880539835871;715;732.2494443195724;735.3051366458692;760.3954855889567;14364.281785910714;14970.5508834735;15032.77450838237;15035.248237588105;15091.471798487055;13319.667008324797;13388.66528336792;13409.865901340983;13417.329133543308;13434.93282533586;675.7094449386761;687.8693048320803;688.0607970120774;688.5180373738378;841.3101256969287;858.2919091749301;858.8926384201975;874.0647507167333;874.7769318823723;874.8381549413347;916.2807196350866;916.7020718266557;920.3557509743207;923.7090316550299;923.8475651517491;710.5630037526884;732.842438875639;911.7538264668535;919.2094798473274;919.5632074764434;610.261583483985;633.1294470103608;660.359451332207;685.4995853027268;685.9828504287383;13678.110922790087;13729.519466818614;13775.586732398044;13778.65553361164;13834.100783449043;13455;14003.439862405492;14108.858911410856;14144.575662730134;14179.361928713233;12559.058070644738;12638;12721.491140354376;12766.744665106738;12990.87009129906;4509.413776209072;4548.113117942003;4624.3757092792375;4728.101660684459;4742.644301677388;113817;114390.99999999917;115784.42107789492;115800.42099789531;119532;10993.945030274797;11112.333260004263;11130.944345278222;11269.830952535718;11340.43297835105;22218.11127554912;22227.555448890933;22229.55540889173;22230.55538889213;22261.888690556443;7365.9631701841145;7420.146683131509;7564.130125035691;7597;7664.65509052094;4041.151358214749;4056.8782936511952;4097.119119389286;4193.622573968358;4208.389783481378;3362.29391827714;3509.350770107538;3526.0303416560137;3540.6459354064905;3540.8406621702084;633.7211626884156;636.3572791480545;647.304148040858;663.4692246203018;666.1706175811146;533.6264614769599;562.594931649212;567.9233303503975;613.6808859393091;620.5221979076086;7381.446391520657;8489.702860399857;8702.782430439289;8814.074522175208;9056.052948615947;544.7358031354869;573.3406582430239;598.4015984015984;609.7378127405258;619.6870580356981;4145.854895078658;4383.9342409863875;4392.604665580049;4420.823167073281;4497.168023915586;158591;158718;160547.19726401527;162348;164564;116600.86314357047;139383;141792;142638;142710;119639;119685;123127;124611.75388246182;124872.75127248793;8414.495130292202;8444.451110677786;8499.74500764978;8618.78453038679;8662.192483171648;54886.45113548813;64168;66782.6660866712;70038.64980675065;70637.29362706513;94996;98951;105671;106081.93918060721;106386;10804.67585972422;11164.944175279397;11420.143489238506;11480.770384592428;11612.419379030845;12131.09016823724;12150.02799775998;12231.694207644525;12562.057845661795;12643;11577.273470358396;12019.278843269432;12038.518459261531;12141.817872732092;12157;11055.336679799238;11067.169962252703;11471.770564588494;11573.189876708886;11696.888795564408;10973.835392469278;11334.489947952197;11515.424228788695;11515.884841151816;12010;9662.497518364162;9699.6120155193;9999.950000249952;10130.341527800669;10223.335483193569;9163.450192988443;9221.631134754534;9765.169960553432;9790.06994335537;9910.35582687123 05:52:01 INFO - PROCESS | 1659 | __end_tp_report 05:52:01 INFO - PROCESS | 1659 | __start_cc_report 05:52:01 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1763 05:52:01 INFO - PROCESS | 1659 | __end_cc_report 05:52:01 INFO - PROCESS | 1659 | __startTimestamp1476190321178__endTimestamp 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | ------- Summary: start ------- 05:52:01 INFO - PROCESS | 1659 | Number of tests: 6 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5496.83 Median:5657.09 stddev:625.54 (11.1%) stddev-sans-first:587.14 05:52:01 INFO - PROCESS | 1659 | Values: 2680.2 2930.4 3256.6 3286.2 3321.8 5397.8 5474.1 5487.1 5526.6 5551.9 5450.3 5502.1 5562.7 5574.6 5588.9 4952.2 4992.5 5006.5 5042.8 5078.0 4975.2 5160.5 5167.3 5200.5 5232.5 5142.4 5152.6 5155.8 5191.2 5226.1 4980.4 5019.1 5037.9 5058.2 5066.0 5030.1 5034.8 5048.5 5082.7 5088.9 5497.7 5502.8 5504.3 5545.8 5574.8 4815.4 5816.7 5820.6 5933.8 5966.3 5922.5 5942.8 5979.5 6003.7 6009.8 5545.3 5547.4 5554.3 5567.8 5568.0 6022.9 6039.7 6159.6 6188.8 6192.3 5803.4 5805.4 5835.6 5851.0 5895.4 5989.6 6003.2 6005.5 6017.3 6036.4 5848.4 5888.0 5910.8 5920.1 5961.3 5689.5 5823.1 5830.4 5883.3 5897.2 4719.2 4728.4 4733.7 4734.9 4748.1 4198.1 4211.3 4317.3 4332.0 4333.6 5449.1 5503.4 5511.5 5512.7 5521.6 5932.9 5937.8 5948.2 5949.3 5957.1 5483.5 5528.4 5528.4 5532.8 5543.3 5137.9 5147.2 5156.5 5189.7 5195.7 6213.7 6227.9 6235.3 6236.7 6243.3 5864.2 5897.5 5900.0 5947.5 5982.6 6139.5 6158.7 6217.2 6219.4 6238.5 5837.6 5860.8 5867.6 5877.1 5891.9 5842.3 5948.7 5974.8 6001.8 6003.6 5681.5 5747.4 5753.7 5768.0 5812.4 4592.8 5278.6 5857.3 5880.7 5887.0 5642.8 5701.3 5702.3 5705.7 5708.1 5489.4 5779.6 5850.4 5853.3 5860.9 4542.7 5404.3 5657.1 5717.6 5718.9 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:70632.24 Median:37606.15 stddev:152719.77 (406.1%) stddev-sans-first:153057.29 05:52:01 INFO - PROCESS | 1659 | Values: 450.0 460.3 474.7 486.2 496.3 27741.3 39208.0 41505.0 41580.2 41610.6 42388.4 43206.0 43355.9 43402.6 43489.6 8848.2 9642.7 9850.8 9856.5 9866.1 8869.6 11816.8 12114.9 12118.3 12260.6 12061.5 12115.4 12142.4 12163.0 12175.2 12205.7 12279.3 12288.0 12301.8 12305.8 11894.7 11985.0 11992.4 11993.1 12005.7 40128.6 40402.6 40421.8 40568.0 40749.8 3205.6 3221.3 3265.2 3468.8 3542.5 25415.9 30028.4 31851.4 31895.8 32033.7 3102.0 3246.8 3312.2 3316.8 3352.5 487685.0 489668.0 490089.0 490405.0 497581.0 60074.8 60321.7 60398.7 60401.7 60612.0 64905.9 65116.7 65131.3 65161.0 65203.1 15900.4 16142.4 16163.0 16186.0 16198.8 11032.0 11332.7 12290.3 12352.0 12389.5 15973.9 19448.1 19834.5 19906.1 19917.4 7815.3 7816.8 7894.0 7982.0 8027.4 829.6 933.0 1034.6 1114.9 1137.0 26914.5 28903.0 29045.6 30066.2 30218.8 998.3 1041.6 1101.8 1106.9 1186.3 14961.9 15454.8 15606.3 15630.5 16064.7 654975.0 664381.0 664526.0 664848.0 666120.0 52051.9 55430.0 58518.8 58750.0 58885.1 1325.8 1367.6 1375.9 1377.5 1380.8 29683.9 29936.1 29974.1 30234.5 30418.2 50689.0 51201.9 51202.0 51210.0 51235.7 478190.0 561744.0 564543.0 564827.0 568041.0 35332.3 35657.6 36077.6 42414.6 43147.8 37917.4 42472.6 44355.9 47169.3 47377.8 38793.4 38898.0 39262.0 40057.0 40517.6 38817.4 38952.6 40333.6 40374.8 40665.9 37516.9 37695.4 38453.0 38617.6 38793.0 30095.2 33356.0 33988.0 34476.5 34767.0 21817.1 25575.7 25606.9 25673.9 26086.0 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34986.06 Median:21596.91 stddev:100440.21 (465.1%) stddev-sans-first:100688.25 05:52:01 INFO - PROCESS | 1659 | Values: 322.8 341.7 349.4 359.6 369.8 15387.5 15683.0 17955.5 20654.6 21570.7 20708.5 21200.4 21255.3 21423.5 21624.8 5766.7 6125.4 6139.0 6139.3 6154.4 4866.0 5210.8 5793.5 6034.7 6059.6 5973.6 5974.0 5978.8 6001.9 6002.6 5671.4 5930.5 5949.4 5978.7 5991.3 4498.6 5182.7 5198.3 5198.8 5201.1 20789.7 25402.6 25827.4 25950.9 26126.7 2201.9 2206.0 2338.2 2344.3 2385.3 15008.8 15377.7 15517.7 15535.2 16024.5 1800.4 1831.4 1871.9 1878.9 1905.3 93463.0 93781.0 119092.0 119724.0 122512.0 10496.3 10522.9 10899.9 10923.3 11130.6 13630.9 13652.2 13665.5 13680.1 13682.9 8192.3 8215.7 8457.0 8640.5 8645.6 8461.1 8482.8 8492.8 8625.4 8681.7 5423.9 5562.6 6679.6 6694.4 6709.3 1768.7 1807.8 1808.5 1813.1 1814.0 707.9 882.9 899.7 906.7 972.6 18941.6 21623.1 22493.9 22570.8 22669.9 820.6 898.5 911.3 923.7 965.2 10770.8 11760.8 11838.6 11840.7 11850.6 589583.0 598758.0 601533.0 618688.0 618889.0 112367.0 114410.4 118227.0 119783.0 122861.0 971.2 980.7 1010.6 1014.8 1018.5 13269.9 19453.4 19633.6 19776.5 19849.1 49709.0 51136.0 51480.7 52387.5 56496.6 52417.2 72130.6 78294.0 79570.0 80949.6 11569.9 11805.4 11935.0 12050.6 12413.3 13502.3 13595.3 13890.9 13933.7 14064.9 11440.5 11534.0 11967.2 12004.4 12037.2 11425.1 11567.0 11762.7 11795.5 12121.3 9656.6 11686.9 12049.3 12174.6 12207.5 12196.4 12290.9 12302.6 12408.0 12624.8 11630.3 11697.1 11873.2 11978.3 12013.5 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5490.25 Median:4926.51 stddev:3115.73 (63.2%) stddev-sans-first:3109.11 05:52:01 INFO - PROCESS | 1659 | Values: 1372.7 1428.9 1433.9 1638.7 1891.6 7643.9 8092.4 8328.5 8674.7 8710.1 8576.7 8685.2 8690.0 8696.1 8728.9 2237.7 2256.5 2260.1 2260.6 2264.4 2207.5 2229.8 2252.4 2253.1 2253.6 2240.8 2263.9 2268.1 2274.9 2281.4 2222.0 2249.8 2251.5 2251.6 2262.5 2234.7 2240.4 2245.4 2245.7 2246.3 8452.5 8568.8 8629.5 8696.3 8700.2 4539.5 5063.4 5199.0 5251.8 5257.1 3318.4 3462.5 3531.3 3550.8 3559.0 1011.1 1044.2 1053.6 1070.9 1081.6 9661.7 11313.3 11425.2 11494.3 11510.1 4206.3 4290.7 4438.2 4455.8 4462.9 7778.0 8836.4 8896.3 8902.2 8921.2 5110.5 5118.9 5121.2 5121.9 5125.0 3311.6 3812.2 4315.4 4461.7 4811.9 3590.2 3636.8 3648.6 3688.2 3689.7 1033.8 1058.1 1117.0 1132.6 1136.2 763.4 853.2 907.9 910.7 934.4 4830.5 5062.3 5514.8 5519.4 5709.7 884.1 890.9 897.2 899.1 907.3 3676.3 3747.6 3787.7 3884.7 3891.2 10238.3 10545.7 10704.7 10710.0 10735.5 10479.6 10692.9 10701.0 10703.6 10704.6 7937.2 8091.7 8109.0 8128.0 8134.7 5668.9 5675.0 5745.3 5794.2 6030.4 9667.9 9833.3 9967.6 9982.4 9999.7 7125.6 9119.3 10145.3 10162.9 10192.3 6788.3 7010.2 7326.7 7400.9 7457.1 8023.8 8069.8 8072.5 8131.4 8164.6 6393.2 7368.6 7437.2 7449.0 7495.3 7150.7 7242.7 7248.8 7322.9 7325.0 6770.7 6813.2 6836.4 6888.7 6903.2 4569.2 4731.9 4844.4 4861.4 4958.9 4752.3 4814.1 4906.6 4946.4 5047.9 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:3945.13 Median:4331.09 stddev:1169.73 (27.0%) stddev-sans-first:1139.93 05:52:01 INFO - PROCESS | 1659 | Values: 264.6 296.9 298.0 311.7 314.6 4773.8 4933.9 4943.9 4994.8 5000.3 4781.0 4821.3 4858.0 4859.2 4937.2 3210.9 3707.9 3783.5 3821.5 3835.8 3147.6 3846.8 3870.5 3876.9 3911.5 3323.3 3656.1 3819.6 3833.8 3869.3 3794.6 3811.4 3834.8 3842.9 3867.4 2815.4 3356.1 3370.5 3378.8 3406.6 4104.3 4578.2 4768.8 4873.4 4885.5 3643.7 3742.6 4119.8 4340.0 4377.2 5128.3 5150.7 5157.3 5212.9 5258.6 2951.7 3307.0 3384.6 3715.2 3716.8 4640.7 5092.7 5319.4 5343.7 5361.5 3732.4 3748.4 3755.4 3767.7 3768.2 3209.6 3821.0 3838.2 3846.7 3864.8 3617.8 4074.0 4314.3 4380.5 4408.2 4494.4 4975.3 5152.3 5164.7 5220.7 1032.9 1214.4 1255.3 1270.0 1295.5 808.5 885.8 912.7 916.4 917.9 3847.0 4269.6 4327.8 4433.9 4749.0 4683.1 5052.8 5220.3 5242.8 5287.3 3998.7 4821.0 4830.3 4842.5 4893.1 1900.4 1985.0 2086.4 2171.8 2371.6 4230.5 4480.3 4524.6 4560.3 4570.3 4189.6 4451.1 4478.5 4491.0 4493.5 4543.7 4545.8 4560.7 4565.9 4571.4 4356.7 4476.8 4499.3 4505.7 4506.8 3557.3 3928.6 4087.4 4111.1 4388.8 4049.8 4507.9 4517.3 4537.3 4545.6 3230.6 3253.4 3260.5 3263.5 3274.2 3590.3 3853.5 4436.4 4459.2 4468.2 3771.9 3830.9 3975.8 4279.8 4354.9 4250.9 4292.7 4307.2 4312.3 4330.3 3847.4 4027.4 4331.8 4805.4 5041.8 4377.4 4380.7 5198.0 5228.0 5228.5 4550.3 4988.9 5053.6 5087.9 5110.3 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:25872.13 Median:4049.01 stddev:43106.24 (1064.6%) stddev-sans-first:43185.66 05:52:01 INFO - PROCESS | 1659 | Values: 681.3 715.0 732.2 735.3 760.4 14364.3 14970.6 15032.8 15035.2 15091.5 13319.7 13388.7 13409.9 13417.3 13434.9 675.7 687.9 688.1 688.5 841.3 858.3 858.9 874.1 874.8 874.8 916.3 916.7 920.4 923.7 923.8 710.6 732.8 911.8 919.2 919.6 610.3 633.1 660.4 685.5 686.0 13678.1 13729.5 13775.6 13778.7 13834.1 13455.0 14003.4 14108.9 14144.6 14179.4 12559.1 12638.0 12721.5 12766.7 12990.9 4509.4 4548.1 4624.4 4728.1 4742.6 113817.0 114391.0 115784.4 115800.4 119532.0 10993.9 11112.3 11130.9 11269.8 11340.4 22218.1 22227.6 22229.6 22230.6 22261.9 7366.0 7420.1 7564.1 7597.0 7664.7 4041.2 4056.9 4097.1 4193.6 4208.4 3362.3 3509.4 3526.0 3540.6 3540.8 633.7 636.4 647.3 663.5 666.2 533.6 562.6 567.9 613.7 620.5 7381.4 8489.7 8702.8 8814.1 9056.1 544.7 573.3 598.4 609.7 619.7 4145.9 4383.9 4392.6 4420.8 4497.2 158591.0 158718.0 160547.2 162348.0 164564.0 116600.9 139383.0 141792.0 142638.0 142710.0 119639.0 119685.0 123127.0 124611.8 124872.8 8414.5 8444.5 8499.7 8618.8 8662.2 54886.5 64168.0 66782.7 70038.6 70637.3 94996.0 98951.0 105671.0 106081.9 106386.0 10804.7 11164.9 11420.1 11480.8 11612.4 12131.1 12150.0 12231.7 12562.1 12643.0 11577.3 12019.3 12038.5 12141.8 12157.0 11055.3 11067.2 11471.8 11573.2 11696.9 10973.8 11334.5 11515.4 11515.9 12010.0 9662.5 9699.6 10000.0 10130.3 10223.3 9163.5 9221.6 9765.2 9790.1 9910.4 05:52:01 INFO - PROCESS | 1659 | -------- Summary: end -------- 05:52:01 INFO - PROCESS | 1659 | 05:52:01 INFO - TEST-INFO | 1659: exit 0 05:52:01 INFO - TEST-OK | dromaeo_css | took 1119506ms 05:52:01 INFO - TEST-START | kraken 05:52:01 INFO - operating with platform_type : mac_ 05:52:01 INFO - Initialising browser for kraken test... 05:52:01 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp220UbJ/profile http://localhost:49269/getInfo.html) 05:52:04 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:52:04 INFO - PROCESS | 1665 | colorDepth:24 05:52:04 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:52:04 INFO - PROCESS | 1665 | __metrics 05:52:04 INFO - PROCESS | 1665 | 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" 05:52:04 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:05 INFO - TEST-INFO | 1665: exit 0 05:52:05 INFO - Browser initialized. 05:52:05 INFO - Running cycle 1/1 for kraken test... 05:52:05 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/T/tmp220UbJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:17 INFO - PROCESS | 1667 | RSS: Main: 234647552 05:52:17 INFO - PROCESS | 1667 | 05:52:19 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:20 INFO - PROCESS | 1667 | RSS: Main: 293883904 05:52:20 INFO - PROCESS | 1667 | 05:52:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 05:52:23 INFO - PROCESS | 1667 | RSS: Main: 294072320 05:52:23 INFO - PROCESS | 1667 | 05:52:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 05:52:28 INFO - PROCESS | 1667 | RSS: Main: 384765952 05:52:28 INFO - PROCESS | 1667 | 05:52:30 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 05:52:31 INFO - PROCESS | 1667 | RSS: Main: 285810688 05:52:31 INFO - PROCESS | 1667 | 05:52:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:33 INFO - PROCESS | 1667 | RSS: Main: 289632256 05:52:33 INFO - PROCESS | 1667 | 05:52:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:37 INFO - PROCESS | 1667 | RSS: Main: 326950912 05:52:37 INFO - PROCESS | 1667 | 05:52:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:40 INFO - PROCESS | 1667 | RSS: Main: 327761920 05:52:40 INFO - PROCESS | 1667 | 05:52:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 05:52:44 INFO - PROCESS | 1667 | RSS: Main: 327122944 05:52:44 INFO - PROCESS | 1667 | 05:52:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:46 INFO - PROCESS | 1667 | RSS: Main: 301146112 05:52:46 INFO - PROCESS | 1667 | 05:52:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:48 INFO - PROCESS | 1667 | RSS: Main: 304074752 05:52:48 INFO - PROCESS | 1667 | 05:52:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:51 INFO - PROCESS | 1667 | RSS: Main: 308068352 05:52:51 INFO - PROCESS | 1667 | 05:52:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:55 INFO - PROCESS | 1667 | RSS: Main: 317345792 05:52:55 INFO - PROCESS | 1667 | 05:52:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:59 INFO - PROCESS | 1667 | RSS: Main: 317177856 05:52:59 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 05:53:01 INFO - PROCESS | 1667 | RSS: Main: 361009152 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | __start_tp_report 05:53:01 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:53:01 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:53:01 INFO - PROCESS | 1667 | |i|pagename|runs| 05:53:01 INFO - PROCESS | 1667 | |0;ai-astar;111;115;113;113;114;113;113;111;113;112 05:53:01 INFO - PROCESS | 1667 | |1;audio-beat-detection;148;112;98;164;142;142;118;113;141;113 05:53:01 INFO - PROCESS | 1667 | |2;audio-dft;178;186;184;185;252;226;183;235;257;184 05:53:01 INFO - PROCESS | 1667 | |3;audio-fft;80;60;57;88;59;60;60;76;108;82 05:53:01 INFO - PROCESS | 1667 | |4;audio-oscillator;89;71;91;71;70;94;128;97;99;118 05:53:01 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;88;85;89;86;87;85;89;86;88;85 05:53:01 INFO - PROCESS | 1667 | |6;imaging-darkroom;97;96;98;97;95;97;98;99;97;97 05:53:01 INFO - PROCESS | 1667 | |7;imaging-desaturate;85;84;81;86;84;84;83;84;84;85 05:53:01 INFO - PROCESS | 1667 | |8;json-parse-financial;57;55;54;55;54;53;53;55;54;53 05:53:01 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;72;69;64;75;71;68;69;70;71;72 05:53:01 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;84;85;83;88;83;85;89;85;86;88 05:53:01 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;165;152;149;146;143;149;160;151;156;153 05:53:01 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;213;228;172;173;172;182;238;194;171;171 05:53:01 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;83;85;87;85;72;69;71;83;86 05:53:01 INFO - PROCESS | 1667 | __end_tp_report 05:53:01 INFO - PROCESS | 1667 | __start_cc_report 05:53:01 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,2055 05:53:01 INFO - PROCESS | 1667 | __end_cc_report 05:53:01 INFO - PROCESS | 1667 | __startTimestamp1476190381305__endTimestamp 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:53:01 INFO - PROCESS | 1667 | Number of tests: 14 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.23 (1.1%) stddev-sans-first:1.12 05:53:01 INFO - PROCESS | 1667 | Values: 111.0 115.0 113.0 113.0 114.0 113.0 113.0 111.0 113.0 112.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:142.00 stddev:20.95 (14.8%) stddev-sans-first:21.08 05:53:01 INFO - PROCESS | 1667 | Values: 148.0 112.0 98.0 164.0 142.0 142.0 118.0 113.0 141.0 113.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:207.00 Median:206.00 stddev:31.75 (15.4%) stddev-sans-first:31.89 05:53:01 INFO - PROCESS | 1667 | Values: 178.0 186.0 184.0 185.0 252.0 226.0 183.0 235.0 257.0 184.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:73.00 Median:68.00 stddev:16.83 (24.7%) stddev-sans-first:17.65 05:53:01 INFO - PROCESS | 1667 | Values: 80.0 60.0 57.0 88.0 59.0 60.0 60.0 76.0 108.0 82.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:90.00 stddev:19.49 (21.7%) stddev-sans-first:20.63 05:53:01 INFO - PROCESS | 1667 | Values: 89.0 71.0 91.0 71.0 70.0 94.0 128.0 97.0 99.0 118.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.62 (1.9%) stddev-sans-first:1.66 05:53:01 INFO - PROCESS | 1667 | Values: 88.0 85.0 89.0 86.0 87.0 85.0 89.0 86.0 88.0 85.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:97.00 stddev:1.10 (1.1%) stddev-sans-first:1.17 05:53:01 INFO - PROCESS | 1667 | Values: 97.0 96.0 98.0 97.0 95.0 97.0 98.0 99.0 97.0 97.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.33 (1.6%) stddev-sans-first:1.36 05:53:01 INFO - PROCESS | 1667 | Values: 85.0 84.0 81.0 86.0 84.0 84.0 83.0 84.0 84.0 85.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.25 (2.3%) stddev-sans-first:0.87 05:53:01 INFO - PROCESS | 1667 | Values: 57.0 55.0 54.0 55.0 54.0 53.0 53.0 55.0 54.0 53.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:2.92 (4.1%) stddev-sans-first:3.02 05:53:01 INFO - PROCESS | 1667 | Values: 72.0 69.0 64.0 75.0 71.0 68.0 69.0 70.0 71.0 72.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:2.12 (2.5%) stddev-sans-first:2.17 05:53:01 INFO - PROCESS | 1667 | Values: 84.0 85.0 83.0 88.0 83.0 85.0 89.0 85.0 86.0 88.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:152.50 stddev:6.54 (4.3%) stddev-sans-first:5.10 05:53:01 INFO - PROCESS | 1667 | Values: 165.0 152.0 149.0 146.0 143.0 149.0 160.0 151.0 156.0 153.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:188.00 stddev:25.81 (13.7%) stddev-sans-first:26.17 05:53:01 INFO - PROCESS | 1667 | Values: 213.0 228.0 172.0 173.0 172.0 182.0 238.0 194.0 171.0 171.0 05:53:01 INFO - PROCESS | 1667 | 05:53:01 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.00 Median:84.00 stddev:7.67 (9.1%) stddev-sans-first:7.24 05:53:01 INFO - PROCESS | 1667 | Values: 69.0 83.0 85.0 87.0 85.0 72.0 69.0 71.0 83.0 86.0 05:53:01 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:53:01 INFO - PROCESS | 1667 | 05:53:02 INFO - TEST-INFO | 1667: exit 0 05:53:02 INFO - TEST-OK | kraken | took 60277ms 05:53:02 INFO - SUITE-END | took 1179s 05:53:02 INFO - Completed test suite (00:19:40) 05:53:02 INFO - javascript benchmark 05:53:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2680.182544323981, 2930.355321829197, 3256.609206895173, 3286.227736481928, 3321.750868684849, 5397.8380648580605, 5474.069408200606, 5487.094629386146, 5526.58550608704, 5551.91737611166, 5450.31871016123, 5502.0921547944545, 5562.749676264568, 5574.637648552841, 5588.888222235553, 4952.158133117378, 4992.500749925015, 5006.499350065001, 5042.773075211624, 5077.974610126944, 4975.228839529878, 5160.535551800337, 5167.328247327842, 5200.479952004807, 5232.502912223333, 5142.408623008365, 5152.639315247934, 5155.819546315861, 5191.169412893938, 5226.111561034614, 4980.402351717817, 5019.096562618727, 5037.899242015139, 5058.215976523645, 5066.03745288394, 5030.144875371196, 5034.848954531333, 5048.495150484959, 5082.720450375228, 5088.92366614501, 5497.697626630534, 5502.80740174092, 5504.284443022381, 5545.77816887324, 5574.804881829116, 4815.374001379798, 5816.738246778905, 5820.592558520905, 5933.762649494015, 5966.2840459144745, 5922.466977972003, 5942.821715348503, 5979.491743201833, 6003.699815009232, 6009.75960961561, 5545.334559852843, 5547.44525547446, 5554.305711786027, 5567.832965011056, 5568.0, 6022.939770602326, 6039.66781826995, 6159.599626024294, 6188.783392581238, 6192.349803270682, 5803.361630220672, 5805.419458054245, 5835.649861008353, 5851.005329094064, 5895.4399332063385, 5989.610675306179, 6003.159557661931, 6005.489533389711, 6017.308009578955, 6036.366181550961, 5848.385919478478, 5888.0, 5910.763569457259, 5920.082387229986, 5961.254843144607, 5689.487946084872, 5823.126531020296, 5830.41695830422, 5883.264591926009, 5897.2333596633025, 4719.174144524694, 4728.361671174416, 4733.668643195012, 4734.881627959328, 4748.074125545554, 4198.118395137056, 4211.347241177622, 4317.309230523101, 4331.956680433155, 4333.566643335641, 5449.128139497661, 5503.449655034465, 5511.476409741068, 5512.6968016759465, 5521.641093328921, 5932.851678708067, 5937.762489500458, 5948.167256584082, 5949.25634295713, 5957.076653118774, 5483.451654834565, 5528.364238112668, 5528.44715528444, 5532.75102620383, 5543.279373681396, 5137.922931156036, 5147.176451767699, 5156.535911767884, 5189.7405129743365, 5195.740212989335, 6213.720382582795, 6227.9377206227355, 6235.3452887446165, 6236.719347629368, 6243.282022567372, 5864.179014937998, 5897.498712609477, 5900.0264956281735, 5947.494462970696, 5982.641041537521, 6139.461473530676, 6158.661273629993, 6217.160683307877, 6219.378062193744, 6238.532110091671, 5837.591368604157, 5860.794872179454, 5867.618604790675, 5877.059670452878, 5891.852703682443, 5842.269716285465, 5948.672822994777, 5974.820755377345, 6001.849953751192, 6003.5797494174985, 5681.517071049007, 5747.396523365153, 5753.71231438418, 5768.0, 5812.447817457335, 4592.770361481979, 5278.577713782812, 5857.26784151981, 5880.676562789087, 5887.028640274307, 5642.830715078554, 5701.344345400166, 5702.315722113373, 5705.686187259741, 5708.115242137475, 5489.39616642177, 5779.624324419067, 5850.414958504116, 5853.2976042875125, 5860.941390586039, 4542.727436353829, 5404.297441332602, 5657.094864821609, 5717.599768016199, 5718.885622287614], "value": 5456.260531567234, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.032430274909, 460.27506676983757, 474.72940423958335, 486.15651844050586, 496.33986797559237, 27741.306467338327, 39208.0, 41505.0, 41580.168396632085, 41610.58389416112, 42388.364174537404, 43206.0, 43355.916102097464, 43402.56597434025, 43489.56510434895, 8848.2478989286, 9642.662506812245, 9850.753731156707, 9856.507174641276, 9866.112049915506, 8869.556522173898, 11816.7636647267, 12114.93942530286, 12118.272903625766, 12260.5708800192, 12061.457234424472, 12115.394230288495, 12142.39288035599, 12163.0, 12175.208611440228, 12205.694857628541, 12279.324637144953, 12288.0, 12301.815472767916, 12305.753884922251, 11894.702632434259, 11984.9812765915, 11992.400379980965, 11993.100517461226, 12005.699857503632, 40128.598714012776, 40402.595974040174, 40421.797891010654, 40567.98580035493, 40749.79625101885, 3205.5512228288057, 3221.3396253767924, 3265.2000259936467, 3468.8265586720563, 3542.5217595624517, 25415.872920635462, 30028.399432011454, 31851.362972740415, 31895.840520797246, 32033.679663203537, 3101.953470697941, 3246.772725909187, 3312.2381852173894, 3316.7844090134063, 3352.4636058230567, 487685.0, 489668.0, 490089.0, 490405.0, 497581.0, 60074.79850402968, 60321.69839150776, 60398.69800651057, 60401.69799150976, 60612.0, 64905.86035536087, 65116.69766604641, 65131.34868651253, 65161.0, 65203.065862036325, 15900.443484477988, 16142.354305827635, 16163.0, 16186.0, 16198.838011619968, 11032.0, 11332.660020199408, 12290.262584244974, 12352.0, 12389.504419823286, 15973.943386381265, 19448.12483438249, 19834.50413739639, 19906.104225309897, 19917.402477925687, 7815.335696465864, 7816.804579885435, 7894.0, 7981.960090199512, 8027.357811375076, 829.6100832608664, 932.9720108396759, 1034.637876743149, 1114.9108071354271, 1136.9545218191179, 26914.461710765674, 28903.0, 29045.56431653527, 30066.24834379158, 30218.79124835026, 998.336106489191, 1041.5677493839971, 1101.779644071189, 1106.8893110689028, 1186.32379543661, 14961.925190373979, 15454.845451545341, 15606.29771660278, 15630.452934147477, 16064.678706425806, 654975.0, 664381.0, 664526.0, 664848.0, 666120.0, 52051.91792328264, 55430.0, 58518.82962340729, 58750.0, 58885.116723249186, 1325.8011298305332, 1367.6170672211797, 1375.8624137586362, 1377.5040985245505, 1380.8412032616377, 29683.851580741957, 29936.101916942527, 29974.051686640298, 30234.54648180235, 30418.205409720824, 50689.0, 51201.92788432706, 51202.0, 51209.97580048453, 51235.74382128065, 478190.0, 561744.0, 564543.0, 564827.0, 568041.0, 35332.293354132256, 35657.64342356543, 36077.63922360848, 42414.5758542423, 43147.784261078494, 37917.43123853199, 42472.57527424686, 44355.89110272269, 47169.292460613804, 47377.76311118422, 38793.418098727976, 38898.0, 39262.0, 40057.0, 40517.59482405256, 38817.41773873338, 38952.610473896035, 40333.596664032986, 40374.798126009184, 40665.8668266342, 37516.87449376523, 37695.434568480945, 38453.03867403337, 38617.61382386253, 38793.0, 30095.247618809706, 33356.0, 33988.0, 34476.48285275673, 34767.0, 21817.127314907862, 25575.744242557335, 25606.871965640054, 25673.871630641726, 26086.0], "value": 20621.830558925823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.76438200113915, 341.7129611126653, 349.40600978336835, 359.5631307960828, 369.77074213987316, 15387.538373848789, 15683.0, 17955.461336159937, 20654.586908261826, 21570.676439853414, 20708.48228794281, 21200.363989080313, 21255.25606603769, 21423.464413389673, 21624.783752162475, 5766.682832444224, 6125.448709616134, 6139.048447490646, 6139.263288405397, 6154.415330543591, 4865.951340486603, 5210.76551555181, 5793.5365170786445, 6034.69826508675, 6059.575829691923, 5973.611715238518, 5974.044152935531, 5978.8206353809455, 6001.909971350433, 6002.639841609517, 5671.432856714337, 5930.525557955353, 5949.375315591866, 5978.701064946736, 5991.281046274431, 4498.595126438636, 5182.689038657692, 5198.2722418861385, 5198.818041368571, 5201.08980928336, 20789.688154677693, 25402.618960715605, 25827.35431614206, 25950.87024564884, 26126.738732612812, 2201.8899055047345, 2205.9669104963436, 2338.1933233034574, 2344.27327528465, 2385.3440303916386, 15008.849911500964, 15377.692446151126, 15517.689646207125, 15535.223238838125, 16024.536322448892, 1800.3518733256017, 1831.4160592669466, 1871.9344822931132, 1878.9060546972596, 1905.3045638342044, 93463.0, 93781.0, 119092.0, 119723.99999999913, 122512.0, 10496.265261431627, 10522.894771052344, 10899.891001089887, 10923.289986150874, 11130.554777808959, 13630.93184534071, 13652.180869147684, 13665.521706740416, 13680.110792798436, 13682.863171368357, 8192.30365418946, 8215.671373145007, 8456.957715211507, 8640.524771137647, 8645.610947507377, 8461.069282378934, 8482.830343393098, 8492.787680307918, 8625.39622226438, 8681.739547813575, 5423.891522169613, 5562.610617256834, 6679.632620205935, 6694.364035416725, 6709.295523969913, 1768.6904791661407, 1807.7649905512199, 1808.4574627611928, 1813.0934532733634, 1813.954651133732, 707.9451617090601, 882.9360620452339, 899.6986009686698, 906.7098528470958, 972.5672075926286, 18941.637739430167, 21623.13507459684, 22493.887530562242, 22570.77429225687, 22669.88665056664, 820.6348175062041, 898.5013317608659, 911.2573252798948, 923.6997975657804, 965.2471072563412, 10770.78458430827, 11760.823587646191, 11838.644840654793, 11840.70398240051, 11850.585229516926, 589583.0, 598758.0062099661, 601533.0, 618688.0, 618889.0, 112367.0, 114410.42794785973, 118227.0, 119783.0, 122861.0, 971.2424309038961, 980.6567701304629, 1010.6462738041773, 1014.7970405918845, 1018.4805749068029, 13269.86730132725, 19453.4163975081, 19633.60732785365, 19776.505587360432, 19849.106790194764, 49709.0, 51135.97728045493, 51480.71298217575, 52387.47612523979, 56496.55829557493, 52417.213741793144, 72130.63934680293, 78294.0, 79570.0, 80949.59525202337, 11569.942150289195, 11805.409729513662, 11935.0, 12050.638480845588, 12413.31726755001, 13502.257375844423, 13595.32023398846, 13890.861091388957, 13933.72132557323, 14064.859351406354, 11440.542378304775, 11534.019608333385, 11967.222130561486, 12004.39978001114, 12037.217580857216, 11425.085993120365, 11567.0, 11762.70593235176, 11795.52817887275, 12121.27272363661, 9656.565454554422, 11686.94156529212, 12049.277043377426, 12174.57388991381, 12207.511699532275, 12196.390180491117, 12290.938545307215, 12302.569410070604, 12408.007359411406, 12624.810627840407, 11630.302181869114, 11697.122715796178, 11873.168878178445, 11978.281303121841, 12013.459394327101], "value": 9890.508624755512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.7323171981468, 1428.9499867504637, 1433.8781203597691, 1638.721417359049, 1891.640588288226, 7643.9235607643905, 8092.433529652927, 8328.458650187733, 8674.74216238645, 8710.085441028696, 8576.742697719079, 8685.174908383693, 8690.044095149544, 8696.1303869613, 8728.869066964, 2237.653163759616, 2256.5148493073984, 2260.050778672953, 2260.649599312101, 2264.3772962435296, 2207.514346843692, 2229.832762542816, 2252.358077947777, 2253.1438053539714, 2253.583087128878, 2240.764719704432, 2263.864168149908, 2268.1494439585153, 2274.9090036398607, 2281.441046943501, 2222.0, 2249.8200143988443, 2251.515924076315, 2251.6172250717254, 2262.468319944812, 2234.72065991751, 2240.350298413458, 2245.438640339915, 2245.663150527434, 2246.326102169359, 8452.450590711645, 8568.828623427496, 8629.525376104311, 8696.304295656333, 8700.173483519118, 4539.4779600346055, 5063.392392912874, 5198.986197691452, 5251.76367063483, 5257.053730328539, 3318.369509793132, 3462.480627905809, 3531.2584357285, 3550.7692000019915, 3558.982205088984, 1011.1354791653177, 1044.2220545693508, 1053.5996321397897, 1070.8714954205468, 1081.5944020992129, 9661.661841835503, 11313.264637798517, 11425.200235983484, 11494.31034137946, 11510.136739744552, 4206.326987681956, 4290.656747460196, 4438.201123797748, 4455.77721113943, 4462.888427789267, 7777.961110194526, 8836.425632334007, 8896.332775041898, 8902.198802107841, 8921.197092261727, 5110.463401342806, 5118.872028199325, 5121.231815227746, 5121.897562048738, 5125.0, 3311.569495965509, 3812.1803812180515, 4315.374270730789, 4461.687681862239, 4811.855644330676, 3590.1563132663805, 3636.818159092035, 3648.5804132524568, 3688.188598508324, 3689.723270754704, 1033.7674023344687, 1058.1481907064888, 1116.9888301116885, 1132.597927735642, 1136.1535655936216, 763.3625922354785, 853.1681610429905, 907.8502047162276, 910.6858133943779, 934.4299977014016, 4830.541098595628, 5062.265971434122, 5514.779408823682, 5519.39286678465, 5709.74306156224, 884.12471653063, 890.857462805948, 897.1611543207122, 899.1233547291339, 907.3195103672246, 3676.2647470506004, 3747.569029561581, 3787.6780473660046, 3884.6698030667144, 3891.2412079644196, 10238.283320167666, 10545.683629490974, 10704.678859634223, 10709.98255165758, 10735.51690173944, 10479.580816767397, 10692.946535267429, 10700.983406576363, 10703.62537311206, 10704.625338113285, 7937.2062793721325, 8091.716789912325, 8109.0, 8128.0, 8134.674613015532, 5668.914966275592, 5675.0, 5745.3105627324985, 5794.154005662634, 6030.366811484906, 9667.854982175413, 9833.262505311986, 9967.601295948081, 9982.401055936667, 9999.650012249536, 7125.572465652078, 9119.270458363448, 10145.34055286404, 10162.898371016196, 10192.337498062601, 6788.25329213796, 7010.228874823663, 7326.6702998364135, 7400.925990740239, 7457.105147382132, 8023.759287221393, 8069.757907262791, 8072.4752891064245, 8131.390145739211, 8164.632591533514, 6393.1688880445245, 7368.557886526825, 7437.219091995479, 7448.9627551861895, 7495.250474952461, 7150.67821948024, 7242.7465038725495, 7248.818779530554, 7322.926770732438, 7325.047743793486, 6770.729170833111, 6813.216480104851, 6836.350546698056, 6888.655567221519, 6903.240643529108, 4569.200389931815, 4731.929021064756, 4844.370231869975, 4861.392325959255, 4958.925616115834, 4752.287156926489, 4814.133455977958, 4906.582940450102, 4946.431160416598, 5047.87380315495], "value": 4394.171694337745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.56611157701366, 296.9257685578605, 297.9612650355454, 311.6945393514356, 314.57689407746574, 4773.809047638099, 4933.851984440468, 4943.901121977558, 4994.825181118662, 5000.324956130921, 4780.968088562356, 4821.325014497965, 4857.975710121454, 4859.246816743402, 4937.210046392578, 3210.871565137392, 3707.924701836464, 3783.4703141560203, 3821.5032045834005, 3835.789031603261, 3147.5908131942815, 3846.769193848364, 3870.4581358609817, 3876.9224615507815, 3911.5110611173604, 3323.2854936188714, 3656.067702735799, 3819.618038196172, 3833.7891415972113, 3869.2648396804657, 3794.563625183098, 3811.3711237645757, 3834.8082595870374, 3842.865499707511, 3867.361885288924, 2815.366542527915, 3356.087030392677, 3370.4775759757276, 3378.831058447068, 3406.6423025582203, 4104.261232978063, 4578.198815207325, 4768.833090841838, 4873.390826146731, 4885.462599114095, 3643.708503319728, 3742.5508938927233, 4119.765983702779, 4340.045190058182, 4377.1683380157665, 5128.333316668846, 5150.665206761549, 5157.277981082651, 5212.869678258036, 5258.6318957672975, 2951.67531571527, 3306.96693033069, 3384.5769278840144, 3715.1826598148364, 3716.7769933804057, 4640.721556706575, 5092.719900405476, 5319.38827034896, 5343.732813359316, 5361.544268737162, 3732.4028155495535, 3748.400255959088, 3755.4275321404925, 3767.698584113264, 3768.2275133597545, 3209.5988001499813, 3821.0, 3838.2323535293053, 3846.7114966377635, 3864.7874366909527, 3617.782933024027, 4074.0425999890003, 4314.289710848668, 4380.540043295408, 4408.206522825858, 4494.3820224719075, 4975.293406412246, 5152.330197074356, 5164.690118592896, 5220.660657057355, 1032.9070383665505, 1214.36245970866, 1255.3221260519217, 1269.9682507937375, 1295.4559085184246, 808.4825711544617, 885.7741275974714, 912.7033714042963, 916.4134953629682, 917.9082091790901, 3846.9615303846604, 4269.573042695768, 4327.8485253016, 4433.91369114569, 4748.955229849427, 4683.103343146031, 5052.8484145475695, 5220.321358223407, 5242.842714718488, 5287.339082614673, 3998.7200895937585, 4821.023380414013, 4830.275458681226, 4842.5157484251995, 4893.143699852511, 1900.429871038683, 1985.0, 2086.384516567616, 2171.772948284214, 2371.573116838951, 4230.534641189467, 4480.289424897955, 4524.615407690318, 4560.315952607136, 4570.291604801261, 4189.6438802701505, 4451.109778044404, 4478.529754375809, 4491.034427598017, 4493.460784705856, 4543.704659197141, 4545.840895568639, 4560.749158796231, 4565.863024109282, 4571.405717256735, 4356.738595684269, 4476.813644384176, 4499.310565336393, 4505.7296562206375, 4506.842260520866, 3557.288542291604, 3928.576776969618, 4087.448194493705, 4111.09555897702, 4388.802503887269, 4049.838006479708, 4507.932381014221, 4517.344984977094, 4537.3438694876795, 4545.5908968193025, 3230.596175478065, 3253.4220902862567, 3260.527223552524, 3263.51047342891, 3274.230555819428, 3590.2809158940363, 3853.5183102112237, 4436.401085853368, 4459.241928872165, 4468.21806183923, 3771.8868433947027, 3830.9042273943373, 3975.8012099394336, 4279.828806847816, 4354.931407581374, 4250.851220207278, 4292.699511034198, 4307.22469955411, 4312.310030395121, 4330.328799036154, 3847.3651847445976, 4027.4160246763468, 4331.848385306499, 4805.3512775774825, 5041.8487445376695, 4377.387165796855, 4380.693351465495, 5197.974010129925, 5228.0, 5228.451012643618, 4550.294704320703, 4988.900221995467, 5053.570446511941, 5087.8788181573045, 5110.284560161506], "value": 3588.260218078991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.2880539835871, 715.0, 732.2494443195724, 735.3051366458692, 760.3954855889567, 14364.281785910714, 14970.5508834735, 15032.77450838237, 15035.248237588105, 15091.471798487055, 13319.667008324797, 13388.66528336792, 13409.865901340983, 13417.329133543308, 13434.93282533586, 675.7094449386761, 687.8693048320803, 688.0607970120774, 688.5180373738378, 841.3101256969287, 858.2919091749301, 858.8926384201975, 874.0647507167333, 874.7769318823723, 874.8381549413347, 916.2807196350866, 916.7020718266557, 920.3557509743207, 923.7090316550299, 923.8475651517491, 710.5630037526884, 732.842438875639, 911.7538264668535, 919.2094798473274, 919.5632074764434, 610.261583483985, 633.1294470103608, 660.359451332207, 685.4995853027268, 685.9828504287383, 13678.110922790087, 13729.519466818614, 13775.586732398044, 13778.65553361164, 13834.100783449043, 13455.0, 14003.439862405492, 14108.858911410856, 14144.575662730134, 14179.361928713233, 12559.058070644738, 12638.0, 12721.491140354376, 12766.744665106738, 12990.87009129906, 4509.413776209072, 4548.113117942003, 4624.3757092792375, 4728.101660684459, 4742.644301677388, 113817.0, 114390.99999999917, 115784.42107789492, 115800.42099789531, 119532.0, 10993.945030274797, 11112.333260004263, 11130.944345278222, 11269.830952535718, 11340.43297835105, 22218.11127554912, 22227.555448890933, 22229.55540889173, 22230.55538889213, 22261.888690556443, 7365.9631701841145, 7420.146683131509, 7564.130125035691, 7597.0, 7664.65509052094, 4041.151358214749, 4056.8782936511952, 4097.119119389286, 4193.622573968358, 4208.389783481378, 3362.29391827714, 3509.350770107538, 3526.0303416560137, 3540.6459354064905, 3540.8406621702084, 633.7211626884156, 636.3572791480545, 647.304148040858, 663.4692246203018, 666.1706175811146, 533.6264614769599, 562.594931649212, 567.9233303503975, 613.6808859393091, 620.5221979076086, 7381.446391520657, 8489.702860399857, 8702.782430439289, 8814.074522175208, 9056.052948615947, 544.7358031354869, 573.3406582430239, 598.4015984015984, 609.7378127405258, 619.6870580356981, 4145.854895078658, 4383.9342409863875, 4392.604665580049, 4420.823167073281, 4497.168023915586, 158591.0, 158718.0, 160547.19726401527, 162348.0, 164564.0, 116600.86314357047, 139383.0, 141792.0, 142638.0, 142710.0, 119639.0, 119685.0, 123127.0, 124611.75388246182, 124872.75127248793, 8414.495130292202, 8444.451110677786, 8499.74500764978, 8618.78453038679, 8662.192483171648, 54886.45113548813, 64168.0, 66782.6660866712, 70038.64980675065, 70637.29362706513, 94996.0, 98951.0, 105671.0, 106081.93918060721, 106386.0, 10804.67585972422, 11164.944175279397, 11420.143489238506, 11480.770384592428, 11612.419379030845, 12131.09016823724, 12150.02799775998, 12231.694207644525, 12562.057845661795, 12643.0, 11577.273470358396, 12019.278843269432, 12038.518459261531, 12141.817872732092, 12157.0, 11055.336679799238, 11067.169962252703, 11471.770564588494, 11573.189876708886, 11696.888795564408, 10973.835392469278, 11334.489947952197, 11515.424228788695, 11515.884841151816, 12010.0, 9662.497518364162, 9699.6120155193, 9999.950000249952, 10130.341527800669, 10223.335483193569, 9163.450192988443, 9221.631134754534, 9765.169960553432, 9790.06994335537, 9910.35582687123], "value": 7561.035187414245, "unit": "score"}], "name": "dromaeo_css", "value": 7141.7836626213275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0, 111.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 98.0, 164.0, 142.0, 142.0, 118.0, 113.0, 141.0, 113.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 186.0, 184.0, 185.0, 252.0, 226.0, 183.0, 235.0, 257.0, 184.0], "value": 207.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 57.0, 88.0, 59.0, 60.0, 60.0, 76.0, 108.0, 82.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 91.0, 71.0, 70.0, 94.0, 128.0, 97.0, 99.0, 118.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 87.0, 85.0, 89.0, 86.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 97.0, 95.0, 97.0, 98.0, 99.0, 97.0, 97.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 81.0, 86.0, 84.0, 84.0, 83.0, 84.0, 84.0, 85.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 55.0, 54.0, 53.0, 53.0, 55.0, 54.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 64.0, 75.0, 71.0, 68.0, 69.0, 70.0, 71.0, 72.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 88.0, 83.0, 85.0, 89.0, 85.0, 86.0, 88.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 152.0, 149.0, 146.0, 143.0, 149.0, 160.0, 151.0, 156.0, 153.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 228.0, 172.0, 173.0, 172.0, 182.0, 238.0, 194.0, 171.0, 171.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 83.0, 85.0, 87.0, 85.0, 72.0, 69.0, 71.0, 83.0, 86.0], "value": 79.0, "unit": "score"}], "name": "kraken", "value": 1515.4, "alertThreshold": 2.0}]} 05:53:02 INFO - Return code: 0 05:53:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:02 INFO - # TBPL SUCCESS # 05:53:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:02 INFO - 2016-10-11 05:53:02.588 screenresolution[1671:10182] starting screenresolution argv=screenresolution get 05:53:02 INFO - 2016-10-11 05:53:02.591 screenresolution[1671:10182] Display 0: 1600x1200x32@60 05:53:02 INFO - 2016-10-11 05:53:02.597 screenresolution[1672:10185] starting screenresolution argv=screenresolution list 05:53:02 INFO - Available Modes on Display 0 05:53:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:02 INFO - Intel Iris: 05:53:02 INFO - Chipset Model: Intel Iris 05:53:02 INFO - Type: GPU 05:53:02 INFO - Bus: Built-In 05:53:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:02 INFO - Vendor: Intel (0x8086) 05:53:02 INFO - Device ID: 0x0a2e 05:53:02 INFO - Revision ID: 0x0009 05:53:02 INFO - Displays: 05:53:02 INFO - Display: 05:53:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:02 INFO - Display Serial Number: 1600x1200 60 05:53:02 INFO - Main Display: Yes 05:53:02 INFO - Mirror: Off 05:53:02 INFO - Online: Yes 05:53:02 INFO - Rotation: Supported 05:53:02 INFO - Return code: 0 05:53:02 INFO - Running post-action listener: _resource_record_post_action 05:53:02 INFO - [mozharness: 2016-10-11 12:53:02.833310Z] Finished run-tests step (success) 05:53:02 INFO - Running post-run listener: _resource_record_post_run 05:53:02 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 31968256; Write bytes: 707248640; Read time: 196; Write time: 1961 05:53:02 INFO - TinderboxPrint: CPU usage
53.6% 05:53:02 INFO - TinderboxPrint: I/O read bytes / time
31,968,256 / 196 05:53:02 INFO - TinderboxPrint: I/O write bytes / time
707,248,640 / 1,961 05:53:02 INFO - TinderboxPrint: CPU idle
2,253.7 (46.4%) 05:53:02 INFO - TinderboxPrint: CPU system
972.9 (20.0%) 05:53:02 INFO - TinderboxPrint: CPU user
1,635.1 (33.6%) 05:53:02 INFO - TinderboxPrint: Swap in / out
435,404,800 / 0 05:53:02 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395794944; Write bytes: 389469696; Read time: 29264; Write time: 801 05:53:02 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30178304; Write bytes: 296627200; Read time: 182; Write time: 1109 05:53:03 INFO - Running post-run listener: _upload_blobber_files 05:53:03 INFO - Blob upload gear active. 05:53:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:03 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 05:53:03 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'] 05:53:03 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 05:53:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:04 INFO - (blobuploader) - INFO - Done attempting. 05:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:06 INFO - (blobuploader) - INFO - Done attempting. 05:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:08 INFO - (blobuploader) - INFO - Done attempting. 05:53:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:08 INFO - Return code: 0 05:53:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/833cd4bde24fae4ecd25c0152cd2dd92018b876c9e715ff357b5e89573b97d6424bf34b8cb45de4634614bd7350a36e26a03cffbd10a675574a31fd26b04a462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61adabb089739106fa944b9d3564ee308efc016b19f91633a0a8e18f9f0752eba909b0f7aebd66e3c9824ba77554a3906a33193044fff7deac8f208a48ad6958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e0cd5b531cee1fc0d599a7cd16fd33cc7d97d5726b3fdfc38faf4ec0422a00ebb6c650db3d14f91a0f58978d2d32cd4be93d34fb6a7207581902964c048a844"} 05:53:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:08 INFO - Contents: 05:53:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/833cd4bde24fae4ecd25c0152cd2dd92018b876c9e715ff357b5e89573b97d6424bf34b8cb45de4634614bd7350a36e26a03cffbd10a675574a31fd26b04a462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61adabb089739106fa944b9d3564ee308efc016b19f91633a0a8e18f9f0752eba909b0f7aebd66e3c9824ba77554a3906a33193044fff7deac8f208a48ad6958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e0cd5b531cee1fc0d599a7cd16fd33cc7d97d5726b3fdfc38faf4ec0422a00ebb6c650db3d14f91a0f58978d2d32cd4be93d34fb6a7207581902964c048a844"} 05:53:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:08 INFO - Copying logs to upload dir... 05:53:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.797257 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-11 05:53:08.428923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:08.433259) ========= 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.YTwe0orb8c/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.nruVQKctiG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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/833cd4bde24fae4ecd25c0152cd2dd92018b876c9e715ff357b5e89573b97d6424bf34b8cb45de4634614bd7350a36e26a03cffbd10a675574a31fd26b04a462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61adabb089739106fa944b9d3564ee308efc016b19f91633a0a8e18f9f0752eba909b0f7aebd66e3c9824ba77554a3906a33193044fff7deac8f208a48ad6958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e0cd5b531cee1fc0d599a7cd16fd33cc7d97d5726b3fdfc38faf4ec0422a00ebb6c650db3d14f91a0f58978d2d32cd4be93d34fb6a7207581902964c048a844"} build_url:https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/d5A295zxSty0TKcqFQLuig/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/833cd4bde24fae4ecd25c0152cd2dd92018b876c9e715ff357b5e89573b97d6424bf34b8cb45de4634614bd7350a36e26a03cffbd10a675574a31fd26b04a462", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61adabb089739106fa944b9d3564ee308efc016b19f91633a0a8e18f9f0752eba909b0f7aebd66e3c9824ba77554a3906a33193044fff7deac8f208a48ad6958", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e0cd5b531cee1fc0d599a7cd16fd33cc7d97d5726b3fdfc38faf4ec0422a00ebb6c650db3d14f91a0f58978d2d32cd4be93d34fb6a7207581902964c048a844"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:08.465712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:08.469071) ========= 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.YTwe0orb8c/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.nruVQKctiG/Listeners TMPDIR=/var/folders/hf/ps7y69tn3s12w25w6jngdq6000000w/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.005160 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 05:53:08.517674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 05:53:08.518015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 05:53:08.518347) ========= ========= Total master_lag: 0.20 =========