builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0390 starttime: 1477515052.55 results: success (0) buildid: 20161026075526 builduid: 1b6e62fa11104b93a83fb80681645e95 revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.547622) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.549702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.549978) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.634826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.635179) ========= 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.Hnurg7a6m7/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.TXkleeokp7/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-26 13:50:52-- 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% 9.70M=0.001s 2016-10-26 13:50:53 (9.70 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.532713 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.193783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.194105) ========= 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.Hnurg7a6m7/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.TXkleeokp7/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.021543 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.243413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.243713) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --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 d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hnurg7a6m7/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.TXkleeokp7/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-26 13:50:53,322 truncating revision to first 12 chars 2016-10-26 13:50:53,322 Setting DEBUG logging. 2016-10-26 13:50:53,322 attempt 1/10 2016-10-26 13:50:53,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d26ac63f1b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 13:50:53,730 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.940354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.940658) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.941050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.941354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.961440) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 13:50:53.961764) ========= /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.Hnurg7a6m7/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.TXkleeokp7/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:50:54 INFO - MultiFileLogger online at 20161026 13:50:54 in /builds/slave/test 13:50:54 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 13:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:54 INFO - {'append_to_log': False, 13:50:54 INFO - 'base_work_dir': '/builds/slave/test', 13:50:54 INFO - 'blob_upload_branch': 'Firefox', 13:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:54 INFO - 'branch': 'Firefox', 13:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:54 INFO - 'config_files': ('talos/mac_config.py',), 13:50:54 INFO - 'default_actions': ('clobber', 13:50:54 INFO - 'read-buildbot-config', 13:50:54 INFO - 'download-and-extract', 13:50:54 INFO - 'populate-webroot', 13:50:54 INFO - 'create-virtualenv', 13:50:54 INFO - 'install', 13:50:54 INFO - 'run-tests'), 13:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:54 INFO - 'download_minidump_stackwalk': True, 13:50:54 INFO - 'download_symbols': 'ondemand', 13:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:54 INFO - 'installer_path': 'installer.exe', 13:50:54 INFO - 'log_level': 'info', 13:50:54 INFO - 'log_name': 'talos', 13:50:54 INFO - 'log_to_console': True, 13:50:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:54 INFO - 'opt_config_files': (), 13:50:54 INFO - 'pip_index': False, 13:50:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:54 INFO - 'cmd': ('bash', 13:50:54 INFO - '-c', 13:50:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:54 INFO - 'enabled': True, 13:50:54 INFO - 'halt_on_failure': False, 13:50:54 INFO - 'name': 'check_screen_resolution'},), 13:50:54 INFO - 'run_cmd_checks_enabled': True, 13:50:54 INFO - 'sps_profile': False, 13:50:54 INFO - 'sps_profile_interval': 0, 13:50:54 INFO - 'suite': 'dromaeojs', 13:50:54 INFO - 'system_bits': '32', 13:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:54 INFO - 'title': 't-yosemite-r7-0390', 13:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:54 INFO - 'use_talos_json': True, 13:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:54 INFO - 'work_dir': 'build'} 13:50:54 INFO - [mozharness: 2016-10-26 20:50:54.163445Z] Running clobber step. 13:50:54 INFO - Running pre-action listener: _resource_record_pre_action 13:50:54 INFO - Running main action method: clobber 13:50:54 INFO - rmtree: /builds/slave/test/build 13:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:55 INFO - Running post-action listener: _resource_record_post_action 13:50:55 INFO - [mozharness: 2016-10-26 20:50:55.176857Z] Finished clobber step (success) 13:50:55 INFO - [mozharness: 2016-10-26 20:50:55.177146Z] Running read-buildbot-config step. 13:50:55 INFO - Running pre-action listener: _resource_record_pre_action 13:50:55 INFO - Running main action method: read_buildbot_config 13:50:55 INFO - Using buildbot properties: 13:50:55 INFO - { 13:50:55 INFO - "project": "", 13:50:55 INFO - "product": "firefox", 13:50:55 INFO - "script_repo_revision": "production", 13:50:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:50:55 INFO - "repository": "", 13:50:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:50:55 INFO - "buildid": "20161026075526", 13:50:55 INFO - "pgo_build": "False", 13:50:55 INFO - "basedir": "/builds/slave/test", 13:50:55 INFO - "buildnumber": 8, 13:50:55 INFO - "slavename": "t-yosemite-r7-0390", 13:50:55 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 13:50:55 INFO - "platform": "yosemite_r7", 13:50:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:55 INFO - "branch": "mozilla-central", 13:50:55 INFO - "repo_path": "mozilla-central", 13:50:55 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:50:55 INFO - "stage_platform": "macosx64", 13:50:55 INFO - "builduid": "1b6e62fa11104b93a83fb80681645e95", 13:50:55 INFO - "slavebuilddir": "test" 13:50:55 INFO - } 13:50:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:55 INFO - Running post-action listener: _resource_record_post_action 13:50:55 INFO - [mozharness: 2016-10-26 20:50:55.182944Z] Finished read-buildbot-config step (success) 13:50:55 INFO - [mozharness: 2016-10-26 20:50:55.183157Z] Running download-and-extract step. 13:50:55 INFO - Running pre-action listener: _resource_record_pre_action 13:50:55 INFO - Running main action method: download_and_extract 13:50:55 INFO - mkdir: /builds/slave/test/build/tests 13:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:55 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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 13:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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 13:50:56 INFO - Downloaded 1199 bytes. 13:50:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:56 INFO - Using the following test package requirements: 13:50:56 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'jsshell-mac.zip'], 13:50:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:56 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:56 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:56 INFO - Http code: 200 13:50:56 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 13:50:56 INFO - x-amz-cf-id: i7onBK3hqLKRZiidkiMo9dk_wjXz08EUbN0Y8hcbZii4E422dLbc0w== 13:50:56 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:50:57 INFO - Expected file size: 16442708 13:50:57 INFO - Obtained file size: 16442708 13:51:03 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 13:51:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:51:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:51:03 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:51:04 INFO - Http code: 200 13:51:04 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 13:51:04 INFO - x-amz-cf-id: G2h7--jPmfyNgIoSnjSQ5kS1IZHrAHZrG50QUrJkLyRUVDNda5pY1Q== 13:51:04 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:51:04 INFO - Expected file size: 16442708 13:51:04 INFO - Obtained file size: 16442708 13:51:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:51:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:51:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:51:11 INFO - Http code: 200 13:51:11 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 13:51:11 INFO - x-amz-cf-id: jll3lym8uR2---QoJo7L7hqTF9iY-uoIs2osi8Q1ftJiIsgeprvvIA== 13:51:11 INFO - x-amz-version-id: 0bXUQ92dp_r4joro14ZW7j22G0F3vbr6 13:51:11 INFO - Expected file size: 14409028 13:51:11 INFO - Obtained file size: 14409028 13:51: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')]} 13:51:11 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:11 INFO - Downloading https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:51:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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 13:51:14 INFO - Downloaded 111730824 bytes. 13:51:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 INFO - mkdir: /builds/slave/test/properties 13:51:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:14 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:14 INFO - Contents: 13:51:14 INFO - build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:15 INFO - Running post-action listener: _resource_record_post_action 13:51:15 INFO - Running post-action listener: set_extra_try_arguments 13:51:15 INFO - [mozharness: 2016-10-26 20:51:15.544678Z] Finished download-and-extract step (success) 13:51:15 INFO - [mozharness: 2016-10-26 20:51:15.544795Z] Running populate-webroot step. 13:51:15 INFO - Running pre-action listener: _resource_record_pre_action 13:51:15 INFO - Running main action method: populate_webroot 13:51:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:15 INFO - '--tppagecycles', 13:51:15 INFO - '7'], 13:51:15 INFO - 'tests': ['tsvgm']}}, 13:51:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['damp', 'tps']}, 13:51:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'tests': ['damp', 'tps']}, 13:51:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['dromaeo_dom']}, 13:51:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['basic_compositor_video']}, 13:51:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['a11yr', 13:51:15 INFO - 'ts_paint', 13:51:15 INFO - 'tpaint', 13:51:15 INFO - 'sessionrestore', 13:51:15 INFO - 'sessionrestore_no_auto_restore', 13:51:15 INFO - 'tabpaint']}, 13:51:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tsvgx', 13:51:15 INFO - 'tsvgr_opacity', 13:51:15 INFO - 'tart', 13:51:15 INFO - 'tscrollx', 13:51:15 INFO - 'cart']}, 13:51:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:15 INFO - 'tsvgr_opacity', 13:51:15 INFO - 'tart', 13:51:15 INFO - 'tscrollx', 13:51:15 INFO - 'cart']}, 13:51:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s'], 13:51:15 INFO - 'tests': ['tp5o']}, 13:51:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'tests': ['tp5o']}, 13:51:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'talos_options': ['--disable-e10s', 13:51:15 INFO - '--xperf_path', 13:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:15 INFO - 'tests': ['tp5n']}, 13:51:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:15 INFO - 'talos_options': ['--xperf_path', 13:51:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:15 INFO - 'tests': ['tp5n']}}, 13:51:15 INFO - 'talos.zip': {'path': '', 13:51:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:15 INFO - Running post-action listener: _resource_record_post_action 13:51:15 INFO - [mozharness: 2016-10-26 20:51:15.563383Z] Finished populate-webroot step (success) 13:51:15 INFO - [mozharness: 2016-10-26 20:51:15.563513Z] Running create-virtualenv step. 13:51:15 INFO - Running pre-action listener: _resource_record_pre_action 13:51:15 INFO - Running main action method: create_virtualenv 13:51:15 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51: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 13:51:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:15 INFO - Using real prefix '/tools/python27' 13:51:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:16 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:19 INFO - Installing pip.................done. 13:51:19 INFO - Return code: 0 13:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:19 INFO - Reading from file tmpfile_stdout 13:51:19 INFO - Output received: 13:51: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) 13:51:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:19 INFO - 'HOME': '/Users/cltbld', 13:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:19 INFO - 'LOGNAME': 'cltbld', 13:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:19 INFO - 'MOZ_NO_REMOTE': '1', 13:51:19 INFO - 'NO_EM_RESTART': '1', 13:51:19 INFO - 'PAGER': '/bin/cat', 13:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:19 INFO - 'PWD': '/builds/slave/test', 13:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:19 INFO - 'SHELL': '/bin/bash', 13:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:19 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:19 INFO - 'USER': 'cltbld', 13:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:19 INFO - 'XPC_FLAGS': '0x0', 13:51:19 INFO - 'XPC_SERVICE_NAME': '0', 13:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51: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 13:51:19 INFO - Cleaning up... 13:51:19 INFO - Return code: 0 13:51:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:19 INFO - 'HOME': '/Users/cltbld', 13:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:19 INFO - 'LOGNAME': 'cltbld', 13:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:19 INFO - 'MOZ_NO_REMOTE': '1', 13:51:19 INFO - 'NO_EM_RESTART': '1', 13:51:19 INFO - 'PAGER': '/bin/cat', 13:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:19 INFO - 'PWD': '/builds/slave/test', 13:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:19 INFO - 'SHELL': '/bin/bash', 13:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:19 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:19 INFO - 'USER': 'cltbld', 13:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:19 INFO - 'XPC_FLAGS': '0x0', 13:51:19 INFO - 'XPC_SERVICE_NAME': '0', 13:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:20 INFO - Downloading/unpacking psutil>=3.1.1 13:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:24 INFO - Installing collected packages: psutil 13:51:24 INFO - Running setup.py install for psutil 13:51:24 INFO - building 'psutil._psutil_osx' extension 13:51: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:51: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 13:51: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 13:51: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 13:51:24 INFO - building 'psutil._psutil_posix' extension 13:51: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 13:51:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:24 INFO - ^ 13:51:24 INFO - 1 warning generated. 13:51: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 13:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:24 INFO - Successfully installed psutil 13:51:24 INFO - Cleaning up... 13:51:24 INFO - Return code: 0 13:51:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:24 INFO - 'HOME': '/Users/cltbld', 13:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:24 INFO - 'LOGNAME': 'cltbld', 13:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:24 INFO - 'MOZ_NO_REMOTE': '1', 13:51:24 INFO - 'NO_EM_RESTART': '1', 13:51:24 INFO - 'PAGER': '/bin/cat', 13:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:24 INFO - 'PWD': '/builds/slave/test', 13:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:24 INFO - 'SHELL': '/bin/bash', 13:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:24 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:24 INFO - 'USER': 'cltbld', 13:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:24 INFO - 'XPC_FLAGS': '0x0', 13:51:24 INFO - 'XPC_SERVICE_NAME': '0', 13:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:51:27 INFO - Installing collected packages: mozsystemmonitor 13:51:27 INFO - Running setup.py install for mozsystemmonitor 13:51:28 INFO - Successfully installed mozsystemmonitor 13:51:28 INFO - Cleaning up... 13:51:28 INFO - Return code: 0 13:51:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:28 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')]} 13:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:28 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')]} 13:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:28 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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51:28 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 13:51:28 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 13:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:28 INFO - 'HOME': '/Users/cltbld', 13:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:28 INFO - 'LOGNAME': 'cltbld', 13:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:28 INFO - 'MOZ_NO_REMOTE': '1', 13:51:28 INFO - 'NO_EM_RESTART': '1', 13:51:28 INFO - 'PAGER': '/bin/cat', 13:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:28 INFO - 'PWD': '/builds/slave/test', 13:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:28 INFO - 'SHELL': '/bin/bash', 13:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:28 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:28 INFO - 'USER': 'cltbld', 13:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:28 INFO - 'XPC_FLAGS': '0x0', 13:51:28 INFO - 'XPC_SERVICE_NAME': '0', 13:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:28 INFO - Downloading/unpacking jsonschema==2.5.1 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:31 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:31 INFO - warning: no files found matching '*.txt' 13:51:31 INFO - no previously-included directories found matching 'build' 13:51:31 INFO - no previously-included directories found matching 'dist' 13:51:31 INFO - no previously-included directories found matching '.git*' 13:51:31 INFO - Installing collected packages: jsonschema, functools32 13:51:31 INFO - Running setup.py install for functools32 13:51:31 INFO - warning: no files found matching '*.txt' 13:51:31 INFO - no previously-included directories found matching 'build' 13:51:31 INFO - no previously-included directories found matching 'dist' 13:51:31 INFO - no previously-included directories found matching '.git*' 13:51:31 INFO - Successfully installed jsonschema functools32 13:51:31 INFO - Cleaning up... 13:51:31 INFO - Return code: 0 13:51:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:31 INFO - 'HOME': '/Users/cltbld', 13:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:31 INFO - 'LOGNAME': 'cltbld', 13:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:31 INFO - 'MOZ_NO_REMOTE': '1', 13:51:31 INFO - 'NO_EM_RESTART': '1', 13:51:31 INFO - 'PAGER': '/bin/cat', 13:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:31 INFO - 'PWD': '/builds/slave/test', 13:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:31 INFO - 'SHELL': '/bin/bash', 13:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:31 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:31 INFO - 'USER': 'cltbld', 13:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:31 INFO - 'XPC_FLAGS': '0x0', 13:51:31 INFO - 'XPC_SERVICE_NAME': '0', 13:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:31 INFO - Cleaning up... 13:51:31 INFO - Return code: 0 13:51:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:31 INFO - 'HOME': '/Users/cltbld', 13:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:31 INFO - 'LOGNAME': 'cltbld', 13:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:31 INFO - 'MOZ_NO_REMOTE': '1', 13:51:31 INFO - 'NO_EM_RESTART': '1', 13:51:31 INFO - 'PAGER': '/bin/cat', 13:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:31 INFO - 'PWD': '/builds/slave/test', 13:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:31 INFO - 'SHELL': '/bin/bash', 13:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:31 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:31 INFO - 'USER': 'cltbld', 13:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:31 INFO - 'XPC_FLAGS': '0x0', 13:51:31 INFO - 'XPC_SERVICE_NAME': '0', 13:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:32 INFO - Downloading/unpacking blobuploader==1.2.4 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:34 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:35 INFO - Downloading docopt-0.6.1.tar.gz 13:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:35 INFO - Running setup.py install for blobuploader 13:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:36 INFO - Running setup.py install for requests 13:51:36 INFO - Running setup.py install for docopt 13:51:36 INFO - Successfully installed blobuploader requests docopt 13:51:36 INFO - Cleaning up... 13:51:36 INFO - Return code: 0 13:51:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:36 INFO - 'HOME': '/Users/cltbld', 13:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:36 INFO - 'LOGNAME': 'cltbld', 13:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:36 INFO - 'MOZ_NO_REMOTE': '1', 13:51:36 INFO - 'NO_EM_RESTART': '1', 13:51:36 INFO - 'PAGER': '/bin/cat', 13:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:36 INFO - 'PWD': '/builds/slave/test', 13:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:36 INFO - 'SHELL': '/bin/bash', 13:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:36 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:36 INFO - 'USER': 'cltbld', 13:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:36 INFO - 'XPC_FLAGS': '0x0', 13:51:36 INFO - 'XPC_SERVICE_NAME': '0', 13:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-XVW7gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-hqvTWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-tLcn30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-8E0pad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-cFKHZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Anj5ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-DtumXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-prFiCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-sUMpCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-6mE1iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-k596kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-6T7CJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-teLNA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-GhMZmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-PFkJ1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qS8VMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-SQIg_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:38 INFO - Running setup.py install for manifestparser 13:51:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozcrash 13:51:39 INFO - Running setup.py install for mozdebug 13:51:39 INFO - Running setup.py install for mozdevice 13:51:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozfile 13:51:39 INFO - Running setup.py install for mozhttpd 13:51:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozinfo 13:51:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:39 INFO - Running setup.py install for mozInstall 13:51:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Running setup.py install for mozleak 13:51:40 INFO - Running setup.py install for mozlog 13:51:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Running setup.py install for moznetwork 13:51:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Running setup.py install for mozprocess 13:51:40 INFO - Running setup.py install for mozprofile 13:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:40 INFO - Running setup.py install for mozrunner 13:51:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Running setup.py install for mozscreenshot 13:51:41 INFO - Running setup.py install for moztest 13:51:41 INFO - Running setup.py install for mozversion 13:51:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:41 INFO - Cleaning up... 13:51:41 INFO - Return code: 0 13:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:41 INFO - 'HOME': '/Users/cltbld', 13:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:41 INFO - 'LOGNAME': 'cltbld', 13:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:41 INFO - 'MOZ_NO_REMOTE': '1', 13:51:41 INFO - 'NO_EM_RESTART': '1', 13:51:41 INFO - 'PAGER': '/bin/cat', 13:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:41 INFO - 'PWD': '/builds/slave/test', 13:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:41 INFO - 'SHELL': '/bin/bash', 13:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:41 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:41 INFO - 'USER': 'cltbld', 13:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:41 INFO - 'XPC_FLAGS': '0x0', 13:51:41 INFO - 'XPC_SERVICE_NAME': '0', 13:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-7IJ72k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51: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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-lN9l0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51: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)) 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Q_6aSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:42 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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-7SihEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:42 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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-0jNLFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-elIJc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-p7uv6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-YO_Qfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-fzeuDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-sqm1eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_HU2zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51: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)) 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qPYAJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:43 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-7iBg_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:43 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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:43 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-X8FKEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51: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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:43 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-5zbyXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51: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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:43 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Oecapc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51: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)) 13:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:43 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-eL3tb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51: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 13:51:46 INFO - Downloading blessings-1.6.tar.gz 13:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:46 INFO - Installing collected packages: blessings 13:51:46 INFO - Running setup.py install for blessings 13:51:46 INFO - Successfully installed blessings 13:51:46 INFO - Cleaning up... 13:51:46 INFO - Return code: 0 13:51:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:46 INFO - Reading from file tmpfile_stdout 13:51:46 INFO - Current package versions: 13:51:46 INFO - blessings == 1.6 13:51:46 INFO - blobuploader == 1.2.4 13:51:46 INFO - docopt == 0.6.1 13:51:46 INFO - functools32 == 3.2.3-2 13:51:46 INFO - jsonschema == 2.5.1 13:51:46 INFO - manifestparser == 1.1 13:51:46 INFO - mozInstall == 1.12 13:51:46 INFO - mozcrash == 0.17 13:51:46 INFO - mozdebug == 0.1 13:51:46 INFO - mozdevice == 0.48 13:51:46 INFO - mozfile == 1.2 13:51:46 INFO - mozhttpd == 0.7 13:51:46 INFO - mozinfo == 0.9 13:51:46 INFO - mozleak == 0.1 13:51:46 INFO - mozlog == 3.4 13:51:46 INFO - moznetwork == 0.27 13:51:46 INFO - mozprocess == 0.23 13:51:46 INFO - mozprofile == 0.28 13:51:46 INFO - mozrunner == 6.12 13:51:46 INFO - mozscreenshot == 0.1 13:51:46 INFO - mozsystemmonitor == 0.3 13:51:46 INFO - moztest == 0.7 13:51:46 INFO - mozversion == 1.4 13:51:46 INFO - psutil == 3.1.1 13:51:46 INFO - requests == 1.2.3 13:51:46 INFO - wsgiref == 0.1.2 13:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51: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')]} 13:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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')]} 13:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51: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 13:51: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 13:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:46 INFO - 'HOME': '/Users/cltbld', 13:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:46 INFO - 'LOGNAME': 'cltbld', 13:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:46 INFO - 'MOZ_NO_REMOTE': '1', 13:51:46 INFO - 'NO_EM_RESTART': '1', 13:51:46 INFO - 'PAGER': '/bin/cat', 13:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:46 INFO - 'PWD': '/builds/slave/test', 13:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:46 INFO - 'SHELL': '/bin/bash', 13:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:46 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:46 INFO - 'USER': 'cltbld', 13:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:46 INFO - 'XPC_FLAGS': '0x0', 13:51:46 INFO - 'XPC_SERVICE_NAME': '0', 13:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51: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)) 13:51:46 INFO - Cleaning up... 13:51:47 INFO - Return code: 0 13:51:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:47 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')]} 13:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:47 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')]} 13:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:47 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 0x10090e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100884570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8371cd4d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, '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.Hnurg7a6m7/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.TXkleeokp7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 13:51:47 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 13:51:47 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 13:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:47 INFO - 'HOME': '/Users/cltbld', 13:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:47 INFO - 'LOGNAME': 'cltbld', 13:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:47 INFO - 'MOZ_NO_REMOTE': '1', 13:51:47 INFO - 'NO_EM_RESTART': '1', 13:51:47 INFO - 'PAGER': '/bin/cat', 13:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:47 INFO - 'PWD': '/builds/slave/test', 13:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:47 INFO - 'SHELL': '/bin/bash', 13:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:51:47 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:47 INFO - 'USER': 'cltbld', 13:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:47 INFO - 'XPC_FLAGS': '0x0', 13:51:47 INFO - 'XPC_SERVICE_NAME': '0', 13:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:47 INFO - Cleaning up... 13:51:47 INFO - Return code: 0 13:51:47 INFO - Running post-action listener: _resource_record_post_action 13:51:47 INFO - Running post-action listener: _start_resource_monitoring 13:51:47 INFO - Starting resource monitoring. 13:51:47 INFO - [mozharness: 2016-10-26 20:51:47.308246Z] Finished create-virtualenv step (success) 13:51:47 INFO - [mozharness: 2016-10-26 20:51:47.309110Z] Running install step. 13:51:47 INFO - Running pre-action listener: _resource_record_pre_action 13:51:47 INFO - Running main action method: install 13:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:47 INFO - Reading from file tmpfile_stdout 13:51:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:47 INFO - Reading from file tmpfile_stdout 13:51:47 INFO - Output received: 13:51:47 INFO - Usage: mozinstall [options] installer 13:51:47 INFO - Options: 13:51:47 INFO - -h, --help show this help message and exit 13:51:47 INFO - -d DEST, --destination=DEST 13:51:47 INFO - Directory to install application into. [default: 13:51:47 INFO - "/builds/slave/test"] 13:51:47 INFO - --app=APP Application being installed. [default: firefox] 13:51:47 INFO - mkdir: /builds/slave/test/build/application 13:51: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'] 13:51: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 13:52:22 INFO - Reading from file tmpfile_stdout 13:52:22 INFO - Output received: 13:52:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:22 INFO - Running post-action listener: _resource_record_post_action 13:52:22 INFO - [mozharness: 2016-10-26 20:52:22.013763Z] Finished install step (success) 13:52:22 INFO - [mozharness: 2016-10-26 20:52:22.013907Z] Running run-tests step. 13:52:22 INFO - Running pre-action listener: _resource_record_pre_action 13:52:22 INFO - Running main action method: run_tests 13:52:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:22 INFO - 2016-10-26 13:52:22.028 screenresolution[6908:121364] starting screenresolution argv=screenresolution get 13:52:22 INFO - 2016-10-26 13:52:22.031 screenresolution[6908:121364] Display 0: 1600x1200x32@60 13:52:22 INFO - 2016-10-26 13:52:22.037 screenresolution[6909:121366] starting screenresolution argv=screenresolution list 13:52:22 INFO - Available Modes on Display 0 13:52:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:22 INFO - Intel Iris: 13:52:22 INFO - Chipset Model: Intel Iris 13:52:22 INFO - Type: GPU 13:52:22 INFO - Bus: Built-In 13:52:22 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:22 INFO - Vendor: Intel (0x8086) 13:52:22 INFO - Device ID: 0x0a2e 13:52:22 INFO - Revision ID: 0x0009 13:52:22 INFO - Displays: 13:52:22 INFO - Display: 13:52:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:22 INFO - Display Serial Number: 1600x1200 60 13:52:22 INFO - Main Display: Yes 13:52:22 INFO - Mirror: Off 13:52:22 INFO - Online: Yes 13:52:22 INFO - Rotation: Supported 13:52:22 INFO - Return code: 0 13:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:22 INFO - Python 2.7.3 13:52:22 INFO - Return code: 0 13:52:22 INFO - grabbing minidump binary from tooltool 13:52: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')]} 13:52: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 0x100722d30>, '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 0x100548db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10071ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52: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 13:52: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 13:52: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 13:52:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:22 INFO - Return code: 0 13:52:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 13:52: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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0390 --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 13:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hnurg7a6m7/Render', 13:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:22 INFO - 'HOME': '/Users/cltbld', 13:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:22 INFO - 'LOGNAME': 'cltbld', 13:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:22 INFO - 'MOZ_NO_REMOTE': '1', 13:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:22 INFO - 'NO_EM_RESTART': '1', 13:52:22 INFO - 'PAGER': '/bin/cat', 13:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:22 INFO - 'PWD': '/builds/slave/test', 13:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:22 INFO - 'SHELL': '/bin/bash', 13:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TXkleeokp7/Listeners', 13:52:22 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 13:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:22 INFO - 'USER': 'cltbld', 13:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:22 INFO - 'XPC_FLAGS': '0x0', 13:52:22 INFO - 'XPC_SERVICE_NAME': '0', 13:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 13:52:22 INFO - mozversion application_buildid: 20161026075526 13:52:22 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:22 INFO - mozversion application_display_name: Nightly 13:52:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:22 INFO - mozversion application_name: Firefox 13:52:22 INFO - mozversion application_remotingname: firefox 13:52:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:22 INFO - mozversion application_vendor: Mozilla 13:52:22 INFO - mozversion application_version: 52.0a1 13:52:22 INFO - mozversion platform_buildid: 20161026075526 13:52:22 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:22 INFO - mozversion platform_version: 52.0a1 13:52:22 INFO - using testdate: 1477515142 13:52:22 INFO - actual date: 1477515142 13:52:22 INFO - starting webserver on 'localhost:58729' 13:52:22 INFO - SUITE-START | Running 2 tests 13:52:22 INFO - TEST-START | dromaeo_css 13:52:22 INFO - operating with platform_type : mac_ 13:52:22 INFO - Initialising browser for dromaeo_css test... 13:52:22 INFO - TEST-INFO | started process 6919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp_QUJvP/profile http://localhost:58729/getInfo.html) 13:52:25 INFO - PROCESS | 6919 | __metrics Screen width/height:1600/1200 13:52:25 INFO - PROCESS | 6919 | colorDepth:24 13:52:25 INFO - PROCESS | 6919 | Browser inner width/height: 1024/689 13:52:25 INFO - PROCESS | 6919 | __metrics 13:52:25 INFO - PROCESS | 6919 | 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" 13:52:25 INFO - PROCESS | 6919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:25 INFO - TEST-INFO | 6919: exit 0 13:52:25 INFO - Browser initialized. 13:52:25 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:25 INFO - TEST-INFO | started process 6921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp_QUJvP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:37 INFO - PROCESS | 6921 | RSS: Main: 239202304 13:52:37 INFO - PROCESS | 6921 | 13:53:28 INFO - PROCESS | 6921 | 1477515208792 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] 13:55:42 INFO - PROCESS | 6921 | Cycle 1(1): loaded http://localhost:58729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58729/tests/dromaeo/cssquery-ext.html) 13:55:44 INFO - PROCESS | 6921 | RSS: Main: 412946432 13:55:44 INFO - PROCESS | 6921 | 13:58:47 INFO - PROCESS | 6921 | Cycle 1(1): loaded http://localhost:58729/tests/dromaeo/cssquery-ext.html (next: http://localhost:58729/tests/dromaeo/cssquery-jquery.html) 13:58:47 INFO - PROCESS | 6921 | RSS: Main: 370155520 13:58:47 INFO - PROCESS | 6921 | 14:01:50 INFO - PROCESS | 6921 | Cycle 1(1): loaded http://localhost:58729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58729/tests/dromaeo/cssquery-mootools.html) 14:01:50 INFO - PROCESS | 6921 | RSS: Main: 364863488 14:01:50 INFO - PROCESS | 6921 | 14:04:53 INFO - PROCESS | 6921 | Cycle 1(1): loaded http://localhost:58729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58729/tests/dromaeo/cssquery-prototype.html) 14:04:53 INFO - PROCESS | 6921 | RSS: Main: 346075136 14:04:53 INFO - PROCESS | 6921 | 14:07:57 INFO - PROCESS | 6921 | Cycle 1(1): loaded http://localhost:58729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58729/tests/dromaeo/cssquery-yui.html) 14:07:57 INFO - PROCESS | 6921 | RSS: Main: 343707648 14:07:57 INFO - PROCESS | 6921 | 14:11:00 INFO - PROCESS | 6921 | Cycle 1(1): loaded http://localhost:58729/tests/dromaeo/cssquery-yui.html (next: http://localhost:58729/tests/dromaeo/cssquery-dojo.html) 14:11:01 INFO - PROCESS | 6921 | RSS: Main: 390881280 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | __start_tp_report 14:11:01 INFO - PROCESS | 6921 | _x_x_mozilla_page_load 14:11:01 INFO - PROCESS | 6921 | _x_x_mozilla_page_load_details 14:11:01 INFO - PROCESS | 6921 | |i|pagename|runs| 14:11:01 INFO - PROCESS | 6921 | |0;dojo.html;3294.8632721711015;3304.3060957198986;3320.8671653133874;3329.7669163158557;3355.8322083895814;5562.554995600352;5696.287964004499;5718.799842005531;5720.22776925115;5756.856078598032;5676.801311954083;5701;5721.856953576163;5800.013997620415;5800.390958949302;5113.463086375933;5124.461931497195;5194.818181363653;5197.740112994354;5220.712860792655;5145.716985565792;5260.842174734764;5280.445553216915;5292.073887069767;5332.093544097513;5274.498922602346;5278.973605131969;5306.097963346221;5318.46815318467;5361.142217245241;5126.205438157054;5151.7681704323395;5155.278261043457;5177.974110129425;5179.19722443022;5177.275181474596;5180.507851754115;5190.974045129788;5227.503387178212;5264.842054738364;4706.482286948467;5672.744726487277;5685.232493613351;5712.114622233519;5713.657180569179;6073.453389194994;6137.78517751881;6217.751289948442;6222.471089957359;6243.906341404882;5181.792728290864;6169.568130230886;6192.380761923817;6230.283517395512;6286.371362863722;5708.457696518824;5776.989026920272;5790.131480277908;5801.332846722681;5829.5919285650025;6323.652199129;6356.77751278703;6356.8410789729705;6357.523185760994;6367;5805;5888.705564721747;5977.342492325841;6028.246469191351;6030.547708921848;6101.4896331263535;6102.843291144261;6103.580118178676;6104.398524058527;6108.912269535978;5978.671173085522;6003.8198854034445;6004.519638428916;6044.607100538451;6069.119977603223;5949.345571987078;6066.66633335162;6086.6348019119;6107.735039974563;6108.152987207968;4900.534449227318;4907;4908.4846091160625;4909.116359055333;4914.483979182134;4355.3684715716045;4362.367456718758;4404.2512772828695;4461.5092339842595;4463.709858859163;5706.629069110494;5736.856578585569;5751.051076572402;5759.395263497272;5771.336296325892;6200.255969283715;6201.255849298022;6202.255729312511;6217.253929528486;6225.252969643671;5746.569007324468;5757.0788673811985;5770.19217309577;5775.913361299584;5778.971105144447;5355.705436201047;5356.4107948125675;5369.382521010134;5371.946280537145;5392.89445663638;6312.747490100344;6313.463355614824;6326.240851097898;6326.620402775756;6331.335209802996;6134.907976380268;6287.591306565058;6292.3078461368295;6292.748290068346;6294.213223347082;5150.6137039721425;6255.343188965093;6278.215223097113;6293.622382657055;6329.430351268408;6172.135900973957;6177.135201071764;6185.195924529782;6194.783182588588;6198.845028874134;6268.185135932482;6271.247450305992;6277.654728989949;6285.842853928689;6297.1813664223355;5946.226990491208;5991.460768530679;6016.578839481194;6057.697115144313;6128.8774224516155;5920.467157955804;6109.951287404173;6115.788007244199;6125.6933266224105;6140.662263575547;5039.672421292605;5952.821415357546;5953.1070339449425;5974.133750606225;6055.2430946131735;6021.096835474714;6056.152138700498;6104.908426373697;6114.144019837137;6116.510679145568;5797;5852.268466441695;5864.765409383747;5896.616719913363;5935.228420305332 14:11:01 INFO - PROCESS | 6921 | |1;ext.html;501.91085344801775;507.7613521644827;515.6751246714568;520.3469645594778;526.4603781124347;29259.56110658339;39451.2109757805;40204.99487512813;40267.99999999996;42217.77822217777;41407.79296103523;41849;41947.580524194746;42038.94902627436;42077.36883946736;9339.95330023349;9530.952345238298;9532.523373831315;9538.046195380475;9539.332246742732;9279.443233406017;9380.108889655507;9390.48352340621;9391.389559678633;9393.812123757521;9357.344985850994;9417.670381536647;9426.575804088798;9427.198688111519;9433.81132377352;9361.906380936172;9415.482148481831;9418.62325506979;9419.52902354883;9436.764080897963;9314.953425232898;9399.71800845969;9402.96567377588;9405.294602904809;9433.858492122623;37654.62345376539;38178.61821381778;39361.60638393608;39399.606003940164;39409.40885886714;3286.819224942627;3310.1724568857785;3365.158710322419;3390.610079840825;3391.3386889556546;29975;30301.93943211977;30804;31526.842365788023;31544.36911261785;3022.6523949745842;3108.1918701137643;3124.53132030195;3157.589513363248;3274.836258187105;495778;496421;496809;497462;497991;61363.38636613577;61958;61962.38037619656;62006;62102.68948655228;64211.678941605926;71634.64182679054;72062.9190562142;72063;72161.63919180476;16000.279987400594;16070.276837542338;16259.756103658454;16488.010719356877;16544.090075045988;12473.688157796129;12619.747605047847;12633.368331583384;12658.746825063447;12680.365981700877;20088.497787555134;20626.484337891372;20637.17451301961;20688;20715;8547.857572130328;8853.380263381501;8865.187969173188;8870.891138607674;8945.763559110223;768.5926458976751;780.9145288049616;945.9290553208536;1000.979001418549;1046.3878631000798;23010;29539.113826585235;29641.555376669367;30104.69895301019;30413;905.4748246017294;925.5927391947522;999.8200323941614;1037.1495373793568;1040.2198351236573;11862.22895511789;14440.205788681513;15198.924005379902;15509.99185052968;15552;600775;604857.3928258967;605165;605311;606211;53882.73058634682;54237.1864422034;54294.72852635712;54417;54519.36441906749;1232.7534493101416;1275.808628705683;1295.4105881823937;1330.7804212305055;1368.117564171104;30154.09537713872;30380.392392152477;30717.078487645405;31112.066638000895;31147.844260779457;47117.05765884732;47475.525244747114;47660;47681.523184769096;47683.284750728075;418575.90712046245;420135;422212;423095.7665926711;817285;40905.79547102245;42034;42184.156316874105;42274;42458.36312455254;46323;46516;46766.76616616895;47241.76379118083;47628;38819;39052.41421378625;39497.60502395054;39509.70033384363;40195.3970690434;32993.34013319768;36308.81845590755;39079.804600976815;39257;40557.986050348976;37637.24725505529;37708.62291377161;38402.61597383991;38412;38798.6120138795;31748.841255793574;32886;33744.831275844444;34334.48498272578;34663.960081197605;24863.62704559397;25177.74822251754;25219.621705674796;25591.87204063968;25807.741922580535 14:11:01 INFO - PROCESS | 6921 | |2;jquery.html;342.39396268604554;359.28322995623734;361.1747157744554;367.6250224770734;388.3436991484391;13114.803277950838;14680.755833187384;14954.850451495482;20213.898930505326;20340.389788306336;19751;19787.307444239454;20754.792452075475;21120.683189752166;21133.260335888248;5254.789808407669;5524.917126243109;5533.335999680024;5535.25274087999;5538.141588053858;5482.643628164156;5633.8591535211535;6044.818655440344;6097.420745029215;6097.5426842986735;6035.124906888498;6039.818805435822;6043.848903777397;6053.122297266894;6054.122152287916;5365.436629153941;5410.972945135289;5475.780968761244;5479.287692599976;5491.450854914517;5089.694618322913;5252.474752524755;5287.47125287472;5322.65402748824;5328.067588172094;25329.49341013188;25726.74273257262;25750.48499030009;26073.696315184356;26138.6079208812;2043.9591208175752;2061.2064355223197;2127.2022991378235;2280.532490839374;2290.415943934286;9499.667511637059;10198.235132365027;10277;12591.055670824724;14430.927845360811;1799.5411170151528;1835.4034938644993;1840.1995132117572;1870.7287443320643;1916.6741653918866;119435.61128777462;121420.71772215587;123713;133999.99999999904;139268;11117.22179447431;11291.717707057225;11309.151813614011;11485.655430337103;11614.30314181135;14676.706465870622;14722.484713034992;14723.411063557338;14725.55823325302;14749.336279867432;8411.621477033548;8603.182697643713;8620.18108279725;8652.740417787476;8726.04013558508;8167.101618821925;8199.918000820035;8391.118932512121;8479.788005299917;8568.871466928002;4522.5025247222775;4527.9547204527535;4539.16025535277;4557.863264102082;4630.699004564693;1573.9527814165594;1627.2758622413148;1855.7216417537477;1950.0932066589105;1954.8729332593336;869.7086476030601;884.8584226523725;914.9634014639473;948.7343543807744;959.6689142245914;21061.09643984652;21653.24213652546;21943.122275109137;22523.211687590854;22811;876.3164731509432;903.074348792493;930.6603089872283;934.6027938126269;1047.92064173901;10916.399598022026;11425;11583.362915039754;11610.535578576762;11670.591529296604;546954;579712;580549;583167;584265;131228;133537.33231333975;134591.32704336414;140890.84209526348;145862.2706886459;989.0850962859327;1003.247564326755;1009.808136454086;1048.7168464514539;1066.6266806617778;18304.450866474028;18963.810361896205;19624.803751962296;19902.70145947841;20065.197392104154;32791.524381403375;46317.91569379454;50621;57184.856302872875;58824.70587647035;87281;88378;88489;88986;89373;7045.471589630695;7301.671424785791;8010.879836802569;8069.757907262791;8415.284700800501;12102.576409825966;12739.363031848185;13242.271675057964;13360.665983350495;13555.457781688621;11331.546738130382;11381.54473821071;11658.475368608602;11684.357360345262;11830.585929492427;11312.547498100314;11393.772124557298;11620.244684095507;11761.235519691534;11955.581554645545;11357.261777984404;11579.536818527502;11747;11855.762884742084;12112;7372.852542949004;7457.888131677921;7467.92532074694;7567.356774674215;7778.92221077782;9309;11384.601538946097;11545.88454115448;11559.537618495166;11798.233114847852 14:11:01 INFO - PROCESS | 6921 | |3;mootools.html;1344.959651210464;1513.47028540011;1562.1564355248167;1741.3469948769211;1904.7809501907277;7711.691532338707;8072.1927807219245;8165.795855103625;8596.398252122353;8615.483071015744;8472.406931514797;8578.699745508908;8584.699535516258;8585.098564650716;8596.484210947348;2289.5077558324956;2298.138198175684;2307.8153747700185;2320.5590937721863;2348.6829278047417;2317.8493397929083;2331.62693968965;2340.918067867625;2355.1168311883043;2378.0487804878103;2298.195631528968;2325.093213646679;2336.2874323331375;2338.707661542307;2339.2748248043076;1916.3197065041918;1923.3556758485925;2259.0850705464313;2318.652202169671;2323.314622186442;2324.3956571291587;2338.5206032763413;2346.4133966508375;2349.119080344871;2354.0701422938014;8525.44584601999;8566.229039386486;8625.008124065687;8639.308855291561;8703.608337624759;5130.9230361544605;5345.198220266952;5355.651882627617;5357.785688572452;5359.330083739533;3462.740294477924;3570.3037907608027;3646.453032045188;3657.2868290683327;3673.7244706646843;1033.9483025848679;1060.2525219720078;1062.2245760594733;1063.9893601063968;1092.2190633696866;11231.382273974928;11243.269187502869;11276.379799111046;11321.830172547418;11338.773224535464;3824.6749026333073;4300.09697963425;4337.9783101084295;4472.351509031172;4473.194824931478;8837.867431988525;8838.646454141892;8838.690645827364;8840.690575829814;8844.911550884537;5173.120569503193;5176.559992400613;5182.740862956837;5188.45521220274;5188.688678679291;4103.507579090468;4353.673474489426;4500.887477813081;4520.909581808345;4793.5685788279225;3097.4424603571574;3111.3466172104113;3612.6026137124895;3623.8912832615065;3698.8705395311035;912.4206129108064;1111.9777604447866;1118.2898859224451;1122.8203487442133;1126.5831642292405;785.9803504912423;879.2789912272003;903.1645727701849;924.1451657217048;971.32007594684;4723.763811809465;5609.186667933209;5641.137986317898;5980.342162362137;5983.700814959235;418.6943531222225;424.6454210734072;440.08023231445793;440.0999955091781;442.0716495359783;3852.653261206505;3871.3031654302495;3986.7209295349626;4011.799410029545;4024.4304721158774;7607.505512141693;10093.24300677452;10364.170866330676;10486.213533984981;10590.258681892194;10185.592576297013;10204.4387558685;10349.120324772328;10392.896071039344;10439.112675422673;7291.723948309024;7374.373178279906;7376.856587229096;8175.427720059658;8205.58972051395;5495.560355171657;5654.264945557051;5729.1119876419225;5741.598088133791;5815.505682016907;8371.95814020926;9560.521973901137;9592.712218633453;9764.951175244078;9832.655857044969;8968;9202.907970920205;9299.721568215831;9910.702678919644;9917.752056198653;6901.75843845463;7116.537425067354;7413.629318533944;7423.665935033045;7425.517341372793;8152.592370381339;8169.223923727236;8205.548694821842;8257.133001034805;8262.091169971178;7200.8919866201;7281.672324745505;7307.3058059484265;7372.115346158281;7479.326860582573;7158.176809666955;7172.426205903411;7196.928030719835;7304.160021597584;7305.305995930378;6521.217453905561;6741.898871517029;6829;6889.862202755817;6922.203946546211;4910.165271903857;4981;4989.426215985208;5013.749312534285;5090.618203634668;4785.258284965836;4827.541383568555;4865;4866.562009419169;5158.045761534128 14:11:01 INFO - PROCESS | 6921 | |4;prototype.html;296.13085593782245;301.63200894908204;304.64813140822343;310.91916101813524;313.6424476097248;5307.097793375126;5318.840434786957;5322.175062865253;5343.3855106662695;5369.919451208225;4798.496157903413;5274.92087618686;5303.284056652351;5317.979167916196;5323.48649891072;3804.0599294359936;3824.9808750956277;3922.548906875703;3978.7413818101877;3979.263836190314;3033.726964573188;3708.4437334399786;3724.8266795959184;4079.571644977279;4116.526599441057;3664.7068234541307;4019.8995025124314;4028.697847661437;4039.5758445363253;4054.2702313583545;3937.6652984496354;4013;4022.5116706818662;4042.7776472294013;4056.2090392373498;3270.4440245158144;3346.882859099944;3529.1530032791943;3531.7285777120214;3538.5399898013093;4573.63410927125;5077.339945807058;5081.441041485434;5087.847364579068;5115.283860259567;3647.5258216431694;3966.7223294369405;4622.306654001893;4629.699069560468;4640.69835460694;4383.86019634894;4952.786567291037;5207.7916883325;5495.340559132889;5627.971860140714;3877.7673339599714;3888.786116763577;3894.2211557688574;3900;3903.316919539069;5330.813421530266;5518.530924871431;5774.7112644368035;5778.5377169826315;5847.327557330919;3894.604818036887;3938.6849052075763;3946.7829269389886;3983.721139520264;3997.84008639657;4034.6167114124696;4052.5947405259826;4053.6554392876346;4056.3104272273786;4070.229450189177;4632.397788287569;4657.74382408964;4661.650376221797;4696.9060618787435;4697.342372067913;5297.894042119136;5323.813666521653;5521.254630624894;5588.161775733673;5710.400407957105;1325.9933700331437;1361.977463466751;1369.2948131712176;1395.8972411794568;1398.5874266990413;796.6216047377566;836.8828364028919;837.9832403351899;849.8895143631288;852.3522123186299;4269.03946612016;5117.232415137759;5164.605556499724;5178.378594568676;5181.6631918925905;5497.835064948058;5572.749226284827;5729.8567535811935;5761.48146666802;5765.88468230633;4757.5718185363485;4961.503849615082;5194.558462530727;5216.974154990096;5253.684778913277;2743.684476285213;2811.8594070296404;2816.493031254394;2853.4876515446845;3071.677473865212;5540.750666220029;5879.353271140171;5896.7936122235515;5908.350081491032;5931.555133365015;5619.775208991595;5832.533397328203;5887.7056147193325;5898.439648233411;5904;5854.502367298742;5883.411478900758;5903.852403689943;5911;5934.109883517421;4735.857924262277;4813.547468591609;5557.833265002057;5625.015622266169;5723.284589426322;5233.194547880975;5650.773969041193;5668.858278543069;5671.291088613923;5709.916645011647;5886;5916.704164791657;5924.437178468039;6045.758169673164;6087.299960504599;3350.916227094342;3362.394768941614;3369.4440417330866;3609.3864043112208;3837.9040523987123;4653.650976176733;4801.51984801517;4817.614590832655;5744.885102297847;5800.216970709069;4930.4822993586595;5596.244506991504;5614.2701448811395;5626.705857652681;5644.887102258014;4598.022850174457;5247.370315562157;5463.230371043967;5602.467765562265;5652.202159930861;5089;5582.413846546055;5602.299712535933;5603.719814009201;5603.831885043455;5387.925648625229;5411.945880541301;5569.582281328998;5616.438356164351;5684.687342196219;5138.460461651623;5292.655977361459;5366.190005096425;5581.5813813963305;5643.802466913638 14:11:01 INFO - PROCESS | 6921 | |5;yui.html;693.4764252988996;758.4084414156956;787.7754839870636;812.3492904296951;825.8377776008915;14253.78619320711;14698.472366632011;15004.324805383756;15054.6989060219;15347.3093710783;13515.324233788297;13718.108322959026;13935.581932542014;13964.720705585882;13975.510857120003;851.8381507513568;880.995595022024;881.2333270055061;882.9801579176062;883.8188171424874;705.6859697434644;727.7816655003504;728.137157468399;732.0666150657901;734.5372415378331;756.8372799848031;918.673870775875;932.3100905330041;941.6986564299427;953.1755031897394;934.8550974598915;938.3572253006644;939.1735272959752;939.5771902643837;939.7603611079165;545.2611711131439;690.1580072311772;690.7237105157977;691.0912150522098;692.1763101908713;12248;12488.000959923183;12506.437210325557;12525.311107889063;12804.167729097671;11902.642920712393;12182.147249692525;12296.692582685415;12419.19275247106;12523.185992910432;9487.857682134774;10168.847467287997;11221.551137954471;11537.711557211136;12101.757964840654;3530.3998320285614;3667.3765459871884;3711.4989476420606;3726.887759428199;3799.8100094995416;86422;86761.56619216927;87286;89403.55298223533;89870;10551.577936882439;10563;10741.19441041925;10759.139268858473;11218.270812397168;21438.142474301167;21635;21635.02642381065;21734;21891.343259702233;7724.961375193088;7735.226477352332;7746.961265193638;7787.182345853604;7840.059192896889;3621.8913432597064;4194.167439415682;4278.315469524861;4308.655307575386;4337.282478787185;3352.5641666583674;3514.789112653249;3535.6641119093647;3566.8751593694615;3568.660977207161;642.56947844944;647.4852492268658;673.9730410783612;691.5263044814318;696.6864910790165;481.7687509995222;547.9205515200274;612.9724162412703;644.4007073421669;688.5558814564578;7654.464187506821;8275.717263824117;8431.196617210431;9065.184133428023;9140.725778226664;521.9034478621467;582.7435928191583;601.8736065426309;640.0303540136697;677.9762708305186;4249.596288352664;4440.955590444119;4454.242778727624;4475.216837053567;4557.612602928722;106342.46828765806;107999.46000269949;109127;109868.4506577478;110207.44896275467;65012.674936625015;92704;93288;94574.5271273653;94895;76739.23260767321;86866.56566717126;86937;87140;88684;8632.482051076955;8655.913440865763;8711.825763484821;8758;8903.19871211594;45851.77074114608;49734;52093;53714.65713357197;56142.43857561536;75793.6210318945;79237;80107.59946200465;80349.1965080365;82337.3532529358;11274;11467.426628668367;11565.653030409101;11622.476988535367;11759.764804703687;12245.448954796877;12485.26507935701;12686.619401417973;12698.555550555686;12815.102942793916;11730.998806207584;12082.758344832879;12180.634580962585;12295.69260768488;12442.129050966345;11702;11898.524059037542;12060.914517693449;12375.133740638068;12423.75152496927;11365.886341136484;11572.479238434458;11762.294262344287;12122.818157727464;12222.20555663879;9855.260855435728;9870.654527091518;9977.20182385393;10220.642277520548;10534.736631584272;9532.809343813224;10106;10131.138853197266;10173.796524069625;10179.7455063624 14:11:01 INFO - PROCESS | 6921 | __end_tp_report 14:11:01 INFO - PROCESS | 6921 | __start_cc_report 14:11:01 INFO - PROCESS | 6921 | _x_x_mozilla_cycle_collect,1786 14:11:01 INFO - PROCESS | 6921 | __end_cc_report 14:11:01 INFO - PROCESS | 6921 | __startTimestamp1477516261097__endTimestamp 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | ------- Summary: start ------- 14:11:01 INFO - PROCESS | 6921 | Number of tests: 6 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | [#0] dojo.html Cycles:165 Average:5702.70 Median:5888.71 stddev:637.47 (10.8%) stddev-sans-first:610.79 14:11:01 INFO - PROCESS | 6921 | Values: 3294.9 3304.3 3320.9 3329.8 3355.8 5562.6 5696.3 5718.8 5720.2 5756.9 5676.8 5701.0 5721.9 5800.0 5800.4 5113.5 5124.5 5194.8 5197.7 5220.7 5145.7 5260.8 5280.4 5292.1 5332.1 5274.5 5279.0 5306.1 5318.5 5361.1 5126.2 5151.8 5155.3 5178.0 5179.2 5177.3 5180.5 5191.0 5227.5 5264.8 4706.5 5672.7 5685.2 5712.1 5713.7 6073.5 6137.8 6217.8 6222.5 6243.9 5181.8 6169.6 6192.4 6230.3 6286.4 5708.5 5777.0 5790.1 5801.3 5829.6 6323.7 6356.8 6356.8 6357.5 6367.0 5805.0 5888.7 5977.3 6028.2 6030.5 6101.5 6102.8 6103.6 6104.4 6108.9 5978.7 6003.8 6004.5 6044.6 6069.1 5949.3 6066.7 6086.6 6107.7 6108.2 4900.5 4907.0 4908.5 4909.1 4914.5 4355.4 4362.4 4404.3 4461.5 4463.7 5706.6 5736.9 5751.1 5759.4 5771.3 6200.3 6201.3 6202.3 6217.3 6225.3 5746.6 5757.1 5770.2 5775.9 5779.0 5355.7 5356.4 5369.4 5371.9 5392.9 6312.7 6313.5 6326.2 6326.6 6331.3 6134.9 6287.6 6292.3 6292.7 6294.2 5150.6 6255.3 6278.2 6293.6 6329.4 6172.1 6177.1 6185.2 6194.8 6198.8 6268.2 6271.2 6277.7 6285.8 6297.2 5946.2 5991.5 6016.6 6057.7 6128.9 5920.5 6110.0 6115.8 6125.7 6140.7 5039.7 5952.8 5953.1 5974.1 6055.2 6021.1 6056.2 6104.9 6114.1 6116.5 5797.0 5852.3 5864.8 5896.6 5935.2 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | [#1] ext.html Cycles:180 Average:67713.63 Median:230212.45 stddev:145302.34 (63.1%) stddev-sans-first:145622.32 14:11:01 INFO - PROCESS | 6921 | Values: 501.9 507.8 515.7 520.3 526.5 29259.6 39451.2 40205.0 40268.0 42217.8 41407.8 41849.0 41947.6 42038.9 42077.4 9340.0 9531.0 9532.5 9538.0 9539.3 9279.4 9380.1 9390.5 9391.4 9393.8 9357.3 9417.7 9426.6 9427.2 9433.8 9361.9 9415.5 9418.6 9419.5 9436.8 9315.0 9399.7 9403.0 9405.3 9433.9 37654.6 38178.6 39361.6 39399.6 39409.4 3286.8 3310.2 3365.2 3390.6 3391.3 29975.0 30301.9 30804.0 31526.8 31544.4 3022.7 3108.2 3124.5 3157.6 3274.8 495778.0 496421.0 496809.0 497462.0 497991.0 61363.4 61958.0 61962.4 62006.0 62102.7 64211.7 71634.6 72062.9 72063.0 72161.6 16000.3 16070.3 16259.8 16488.0 16544.1 12473.7 12619.7 12633.4 12658.7 12680.4 20088.5 20626.5 20637.2 20688.0 20715.0 8547.9 8853.4 8865.2 8870.9 8945.8 768.6 780.9 945.9 1001.0 1046.4 23010.0 29539.1 29641.6 30104.7 30413.0 905.5 925.6 999.8 1037.1 1040.2 11862.2 14440.2 15198.9 15510.0 15552.0 600775.0 604857.4 605165.0 605311.0 606211.0 53882.7 54237.2 54294.7 54417.0 54519.4 1232.8 1275.8 1295.4 1330.8 1368.1 30154.1 30380.4 30717.1 31112.1 31147.8 47117.1 47475.5 47660.0 47681.5 47683.3 418575.9 420135.0 422212.0 423095.8 817285.0 40905.8 42034.0 42184.2 42274.0 42458.4 46323.0 46516.0 46766.8 47241.8 47628.0 38819.0 39052.4 39497.6 39509.7 40195.4 32993.3 36308.8 39079.8 39257.0 40558.0 37637.2 37708.6 38402.6 38412.0 38798.6 31748.8 32886.0 33744.8 34334.5 34664.0 24863.6 25177.7 25219.6 25591.9 25807.7 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | [#2] jquery.html Cycles:180 Average:35100.86 Median:12545.77 stddev:96866.23 (772.1%) stddev-sans-first:97102.81 14:11:01 INFO - PROCESS | 6921 | Values: 342.4 359.3 361.2 367.6 388.3 13114.8 14680.8 14954.9 20213.9 20340.4 19751.0 19787.3 20754.8 21120.7 21133.3 5254.8 5524.9 5533.3 5535.3 5538.1 5482.6 5633.9 6044.8 6097.4 6097.5 6035.1 6039.8 6043.8 6053.1 6054.1 5365.4 5411.0 5475.8 5479.3 5491.5 5089.7 5252.5 5287.5 5322.7 5328.1 25329.5 25726.7 25750.5 26073.7 26138.6 2044.0 2061.2 2127.2 2280.5 2290.4 9499.7 10198.2 10277.0 12591.1 14430.9 1799.5 1835.4 1840.2 1870.7 1916.7 119435.6 121420.7 123713.0 134000.0 139268.0 11117.2 11291.7 11309.2 11485.7 11614.3 14676.7 14722.5 14723.4 14725.6 14749.3 8411.6 8603.2 8620.2 8652.7 8726.0 8167.1 8199.9 8391.1 8479.8 8568.9 4522.5 4528.0 4539.2 4557.9 4630.7 1574.0 1627.3 1855.7 1950.1 1954.9 869.7 884.9 915.0 948.7 959.7 21061.1 21653.2 21943.1 22523.2 22811.0 876.3 903.1 930.7 934.6 1047.9 10916.4 11425.0 11583.4 11610.5 11670.6 546954.0 579712.0 580549.0 583167.0 584265.0 131228.0 133537.3 134591.3 140890.8 145862.3 989.1 1003.2 1009.8 1048.7 1066.6 18304.5 18963.8 19624.8 19902.7 20065.2 32791.5 46317.9 50621.0 57184.9 58824.7 87281.0 88378.0 88489.0 88986.0 89373.0 7045.5 7301.7 8010.9 8069.8 8415.3 12102.6 12739.4 13242.3 13360.7 13555.5 11331.5 11381.5 11658.5 11684.4 11830.6 11312.5 11393.8 11620.2 11761.2 11955.6 11357.3 11579.5 11747.0 11855.8 12112.0 7372.9 7457.9 7467.9 7567.4 7778.9 9309.0 11384.6 11545.9 11559.5 11798.2 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | [#3] mootools.html Cycles:180 Average:5471.68 Median:5001.59 stddev:3064.32 (61.3%) stddev-sans-first:3057.22 14:11:01 INFO - PROCESS | 6921 | Values: 1345.0 1513.5 1562.2 1741.3 1904.8 7711.7 8072.2 8165.8 8596.4 8615.5 8472.4 8578.7 8584.7 8585.1 8596.5 2289.5 2298.1 2307.8 2320.6 2348.7 2317.8 2331.6 2340.9 2355.1 2378.0 2298.2 2325.1 2336.3 2338.7 2339.3 1916.3 1923.4 2259.1 2318.7 2323.3 2324.4 2338.5 2346.4 2349.1 2354.1 8525.4 8566.2 8625.0 8639.3 8703.6 5130.9 5345.2 5355.7 5357.8 5359.3 3462.7 3570.3 3646.5 3657.3 3673.7 1033.9 1060.3 1062.2 1064.0 1092.2 11231.4 11243.3 11276.4 11321.8 11338.8 3824.7 4300.1 4338.0 4472.4 4473.2 8837.9 8838.6 8838.7 8840.7 8844.9 5173.1 5176.6 5182.7 5188.5 5188.7 4103.5 4353.7 4500.9 4520.9 4793.6 3097.4 3111.3 3612.6 3623.9 3698.9 912.4 1112.0 1118.3 1122.8 1126.6 786.0 879.3 903.2 924.1 971.3 4723.8 5609.2 5641.1 5980.3 5983.7 418.7 424.6 440.1 440.1 442.1 3852.7 3871.3 3986.7 4011.8 4024.4 7607.5 10093.2 10364.2 10486.2 10590.3 10185.6 10204.4 10349.1 10392.9 10439.1 7291.7 7374.4 7376.9 8175.4 8205.6 5495.6 5654.3 5729.1 5741.6 5815.5 8372.0 9560.5 9592.7 9765.0 9832.7 8968.0 9202.9 9299.7 9910.7 9917.8 6901.8 7116.5 7413.6 7423.7 7425.5 8152.6 8169.2 8205.5 8257.1 8262.1 7200.9 7281.7 7307.3 7372.1 7479.3 7158.2 7172.4 7196.9 7304.2 7305.3 6521.2 6741.9 6829.0 6889.9 6922.2 4910.2 4981.0 4989.4 5013.7 5090.6 4785.3 4827.5 4865.0 4866.6 5158.0 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | [#4] prototype.html Cycles:180 Average:4531.09 Median:5151.53 stddev:1400.39 (27.2%) stddev-sans-first:1367.77 14:11:01 INFO - PROCESS | 6921 | Values: 296.1 301.6 304.6 310.9 313.6 5307.1 5318.8 5322.2 5343.4 5369.9 4798.5 5274.9 5303.3 5318.0 5323.5 3804.1 3825.0 3922.5 3978.7 3979.3 3033.7 3708.4 3724.8 4079.6 4116.5 3664.7 4019.9 4028.7 4039.6 4054.3 3937.7 4013.0 4022.5 4042.8 4056.2 3270.4 3346.9 3529.2 3531.7 3538.5 4573.6 5077.3 5081.4 5087.8 5115.3 3647.5 3966.7 4622.3 4629.7 4640.7 4383.9 4952.8 5207.8 5495.3 5628.0 3877.8 3888.8 3894.2 3900.0 3903.3 5330.8 5518.5 5774.7 5778.5 5847.3 3894.6 3938.7 3946.8 3983.7 3997.8 4034.6 4052.6 4053.7 4056.3 4070.2 4632.4 4657.7 4661.7 4696.9 4697.3 5297.9 5323.8 5521.3 5588.2 5710.4 1326.0 1362.0 1369.3 1395.9 1398.6 796.6 836.9 838.0 849.9 852.4 4269.0 5117.2 5164.6 5178.4 5181.7 5497.8 5572.7 5729.9 5761.5 5765.9 4757.6 4961.5 5194.6 5217.0 5253.7 2743.7 2811.9 2816.5 2853.5 3071.7 5540.8 5879.4 5896.8 5908.4 5931.6 5619.8 5832.5 5887.7 5898.4 5904.0 5854.5 5883.4 5903.9 5911.0 5934.1 4735.9 4813.5 5557.8 5625.0 5723.3 5233.2 5650.8 5668.9 5671.3 5709.9 5886.0 5916.7 5924.4 6045.8 6087.3 3350.9 3362.4 3369.4 3609.4 3837.9 4653.7 4801.5 4817.6 5744.9 5800.2 4930.5 5596.2 5614.3 5626.7 5644.9 4598.0 5247.4 5463.2 5602.5 5652.2 5089.0 5582.4 5602.3 5603.7 5603.8 5387.9 5411.9 5569.6 5616.4 5684.7 5138.5 5292.7 5366.2 5581.6 5643.8 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - PROCESS | 6921 | [#5] yui.html Cycles:180 Average:20159.32 Median:23166.77 stddev:29776.26 (128.5%) stddev-sans-first:29823.92 14:11:01 INFO - PROCESS | 6921 | Values: 693.5 758.4 787.8 812.3 825.8 14253.8 14698.5 15004.3 15054.7 15347.3 13515.3 13718.1 13935.6 13964.7 13975.5 851.8 881.0 881.2 883.0 883.8 705.7 727.8 728.1 732.1 734.5 756.8 918.7 932.3 941.7 953.2 934.9 938.4 939.2 939.6 939.8 545.3 690.2 690.7 691.1 692.2 12248.0 12488.0 12506.4 12525.3 12804.2 11902.6 12182.1 12296.7 12419.2 12523.2 9487.9 10168.8 11221.6 11537.7 12101.8 3530.4 3667.4 3711.5 3726.9 3799.8 86422.0 86761.6 87286.0 89403.6 89870.0 10551.6 10563.0 10741.2 10759.1 11218.3 21438.1 21635.0 21635.0 21734.0 21891.3 7725.0 7735.2 7747.0 7787.2 7840.1 3621.9 4194.2 4278.3 4308.7 4337.3 3352.6 3514.8 3535.7 3566.9 3568.7 642.6 647.5 674.0 691.5 696.7 481.8 547.9 613.0 644.4 688.6 7654.5 8275.7 8431.2 9065.2 9140.7 521.9 582.7 601.9 640.0 678.0 4249.6 4441.0 4454.2 4475.2 4557.6 106342.5 107999.5 109127.0 109868.5 110207.4 65012.7 92704.0 93288.0 94574.5 94895.0 76739.2 86866.6 86937.0 87140.0 88684.0 8632.5 8655.9 8711.8 8758.0 8903.2 45851.8 49734.0 52093.0 53714.7 56142.4 75793.6 79237.0 80107.6 80349.2 82337.4 11274.0 11467.4 11565.7 11622.5 11759.8 12245.4 12485.3 12686.6 12698.6 12815.1 11731.0 12082.8 12180.6 12295.7 12442.1 11702.0 11898.5 12060.9 12375.1 12423.8 11365.9 11572.5 11762.3 12122.8 12222.2 9855.3 9870.7 9977.2 10220.6 10534.7 9532.8 10106.0 10131.1 10173.8 10179.7 14:11:01 INFO - PROCESS | 6921 | -------- Summary: end -------- 14:11:01 INFO - PROCESS | 6921 | 14:11:01 INFO - TEST-INFO | 6921: exit 0 14:11:01 INFO - TEST-OK | dromaeo_css | took 1119169ms 14:11:01 INFO - TEST-START | kraken 14:11:01 INFO - operating with platform_type : mac_ 14:11:01 INFO - Initialising browser for kraken test... 14:11:01 INFO - TEST-INFO | started process 6923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp7fRzjM/profile http://localhost:58729/getInfo.html) 14:11:04 INFO - PROCESS | 6923 | __metrics Screen width/height:1600/1200 14:11:04 INFO - PROCESS | 6923 | colorDepth:24 14:11:04 INFO - PROCESS | 6923 | Browser inner width/height: 1024/689 14:11:04 INFO - PROCESS | 6923 | __metrics 14:11:04 INFO - PROCESS | 6923 | 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" 14:11:04 INFO - PROCESS | 6923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:11:04 INFO - TEST-INFO | 6923: exit 0 14:11:04 INFO - Browser initialized. 14:11:04 INFO - Running cycle 1/1 for kraken test... 14:11:04 INFO - TEST-INFO | started process 6924 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp7fRzjM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:16 INFO - PROCESS | 6924 | RSS: Main: 231555072 14:11:16 INFO - PROCESS | 6924 | 14:11:19 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58729/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:20 INFO - PROCESS | 6924 | RSS: Main: 291803136 14:11:20 INFO - PROCESS | 6924 | 14:11:23 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58729/tests/kraken/driver.html?testName=audio-dft) 14:11:23 INFO - PROCESS | 6924 | RSS: Main: 292691968 14:11:23 INFO - PROCESS | 6924 | 14:11:27 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58729/tests/kraken/driver.html?testName=audio-fft) 14:11:28 INFO - PROCESS | 6924 | RSS: Main: 386183168 14:11:28 INFO - PROCESS | 6924 | 14:11:30 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58729/tests/kraken/driver.html?testName=audio-oscillator) 14:11:30 INFO - PROCESS | 6924 | RSS: Main: 286932992 14:11:30 INFO - PROCESS | 6924 | 14:11:32 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:33 INFO - PROCESS | 6924 | RSS: Main: 289161216 14:11:33 INFO - PROCESS | 6924 | 14:11:36 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58729/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:36 INFO - PROCESS | 6924 | RSS: Main: 326381568 14:11:36 INFO - PROCESS | 6924 | 14:11:39 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58729/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:40 INFO - PROCESS | 6924 | RSS: Main: 327753728 14:11:40 INFO - PROCESS | 6924 | 14:11:43 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58729/tests/kraken/driver.html?testName=json-parse-financial) 14:11:43 INFO - PROCESS | 6924 | RSS: Main: 324546560 14:11:43 INFO - PROCESS | 6924 | 14:11:45 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:45 INFO - PROCESS | 6924 | RSS: Main: 302723072 14:11:45 INFO - PROCESS | 6924 | 14:11:47 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:48 INFO - PROCESS | 6924 | RSS: Main: 303423488 14:11:48 INFO - PROCESS | 6924 | 14:11:50 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:51 INFO - PROCESS | 6924 | RSS: Main: 308731904 14:11:51 INFO - PROCESS | 6924 | 14:11:54 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:55 INFO - PROCESS | 6924 | RSS: Main: 319270912 14:11:55 INFO - PROCESS | 6924 | 14:11:58 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:58 INFO - PROCESS | 6924 | RSS: Main: 318996480 14:11:58 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | Cycle 1(1): loaded http://localhost:58729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58729/tests/kraken/driver.html?testName=ai-astar) 14:12:00 INFO - PROCESS | 6924 | RSS: Main: 362975232 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | __start_tp_report 14:12:00 INFO - PROCESS | 6924 | _x_x_mozilla_page_load 14:12:00 INFO - PROCESS | 6924 | _x_x_mozilla_page_load_details 14:12:00 INFO - PROCESS | 6924 | |i|pagename|runs| 14:12:00 INFO - PROCESS | 6924 | |0;ai-astar;104;113;113;115;166;168;113;112;113;113 14:12:00 INFO - PROCESS | 6924 | |1;audio-beat-detection;156;119;144;183;142;113;112;112;145;117 14:12:00 INFO - PROCESS | 6924 | |2;audio-dft;184;184;182;188;186;183;184;179;182;184 14:12:00 INFO - PROCESS | 6924 | |3;audio-fft;81;59;59;92;62;59;57;62;86;58 14:12:00 INFO - PROCESS | 6924 | |4;audio-oscillator;90;70;94;70;66;68;92;67;68;91 14:12:00 INFO - PROCESS | 6924 | |5;imaging-gaussian-blur;90;130;90;87;89;86;91;87;89;86 14:12:00 INFO - PROCESS | 6924 | |6;imaging-darkroom;98;98;98;98;98;98;98;97;97;96 14:12:00 INFO - PROCESS | 6924 | |7;imaging-desaturate;81;81;78;79;81;80;83;90;122;93 14:12:00 INFO - PROCESS | 6924 | |8;json-parse-financial;57;55;55;57;55;56;55;55;54;55 14:12:00 INFO - PROCESS | 6924 | |9;json-stringify-tinderbox;65;72;74;75;72;70;68;73;71;70 14:12:00 INFO - PROCESS | 6924 | |10;stanford-crypto-aes;91;90;87;89;89;99;107;108;86;94 14:12:00 INFO - PROCESS | 6924 | |11;stanford-crypto-ccm;155;159;161;149;147;145;147;147;236;154 14:12:00 INFO - PROCESS | 6924 | |12;stanford-crypto-pbkdf2;170;166;156;185;180;174;174;174;179;174 14:12:00 INFO - PROCESS | 6924 | |13;stanford-crypto-sha256-iterative;70;70;69;69;70;67;69;83;87;87 14:12:00 INFO - PROCESS | 6924 | __end_tp_report 14:12:00 INFO - PROCESS | 6924 | __start_cc_report 14:12:00 INFO - PROCESS | 6924 | _x_x_mozilla_cycle_collect,1988 14:12:00 INFO - PROCESS | 6924 | __end_cc_report 14:12:00 INFO - PROCESS | 6924 | __startTimestamp1477516320929__endTimestamp 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | ------- Summary: start ------- 14:12:00 INFO - PROCESS | 6924 | Number of tests: 14 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#0] ai-astar Cycles:10 Average:123.00 Median:113.00 stddev:23.38 (20.7%) stddev-sans-first:23.77 14:12:00 INFO - PROCESS | 6924 | Values: 104.0 113.0 113.0 115.0 166.0 168.0 113.0 112.0 113.0 113.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:143.00 stddev:23.79 (16.6%) stddev-sans-first:23.90 14:12:00 INFO - PROCESS | 6924 | Values: 156.0 119.0 144.0 183.0 142.0 113.0 112.0 112.0 145.0 117.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:2.41 (1.3%) stddev-sans-first:2.55 14:12:00 INFO - PROCESS | 6924 | Values: 184.0 184.0 182.0 188.0 186.0 183.0 184.0 179.0 182.0 184.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.00 stddev:13.34 (21.5%) stddev-sans-first:13.23 14:12:00 INFO - PROCESS | 6924 | Values: 81.0 59.0 59.0 92.0 62.0 59.0 57.0 62.0 86.0 58.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:80.00 stddev:12.28 (15.3%) stddev-sans-first:12.17 14:12:00 INFO - PROCESS | 6924 | Values: 90.0 70.0 94.0 70.0 66.0 68.0 92.0 67.0 68.0 91.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:89.00 stddev:13.29 (14.9%) stddev-sans-first:14.07 14:12:00 INFO - PROCESS | 6924 | Values: 90.0 130.0 90.0 87.0 89.0 86.0 91.0 87.0 89.0 86.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:98.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:12:00 INFO - PROCESS | 6924 | Values: 98.0 98.0 98.0 98.0 98.0 98.0 98.0 97.0 97.0 96.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:81.00 stddev:13.28 (16.4%) stddev-sans-first:13.92 14:12:00 INFO - PROCESS | 6924 | Values: 81.0 81.0 78.0 79.0 81.0 80.0 83.0 90.0 122.0 93.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 14:12:00 INFO - PROCESS | 6924 | Values: 57.0 55.0 55.0 57.0 55.0 56.0 55.0 55.0 54.0 55.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:72.00 stddev:2.94 (4.1%) stddev-sans-first:2.18 14:12:00 INFO - PROCESS | 6924 | Values: 65.0 72.0 74.0 75.0 72.0 70.0 68.0 73.0 71.0 70.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:89.50 stddev:8.01 (9.0%) stddev-sans-first:8.43 14:12:00 INFO - PROCESS | 6924 | Values: 91.0 90.0 87.0 89.0 89.0 99.0 107.0 108.0 86.0 94.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#11] stanford-crypto-ccm Cycles:10 Average:160.00 Median:154.50 stddev:27.27 (17.6%) stddev-sans-first:28.86 14:12:00 INFO - PROCESS | 6924 | Values: 155.0 159.0 161.0 149.0 147.0 145.0 147.0 147.0 236.0 154.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.00 stddev:8.02 (4.6%) stddev-sans-first:8.43 14:12:00 INFO - PROCESS | 6924 | Values: 170.0 166.0 156.0 185.0 180.0 174.0 174.0 174.0 179.0 174.0 14:12:00 INFO - PROCESS | 6924 | 14:12:00 INFO - PROCESS | 6924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:70.00 stddev:8.10 (11.6%) stddev-sans-first:8.46 14:12:00 INFO - PROCESS | 6924 | Values: 70.0 70.0 69.0 69.0 70.0 67.0 69.0 83.0 87.0 87.0 14:12:00 INFO - PROCESS | 6924 | -------- Summary: end -------- 14:12:00 INFO - PROCESS | 6924 | 14:12:01 INFO - TEST-INFO | 6924: exit 0 14:12:01 INFO - TEST-OK | kraken | took 60068ms 14:12:01 INFO - SUITE-END | took 1179s 14:12:02 INFO - Completed test suite (00:19:39) 14:12:02 INFO - javascript benchmark 14:12:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.8632721711015, 3304.3060957198986, 3320.8671653133874, 3329.7669163158557, 3355.8322083895814, 5562.554995600352, 5696.287964004499, 5718.799842005531, 5720.22776925115, 5756.856078598032, 5676.801311954083, 5701.0, 5721.856953576163, 5800.013997620415, 5800.390958949302, 5113.463086375933, 5124.461931497195, 5194.818181363653, 5197.740112994354, 5220.712860792655, 5145.716985565792, 5260.842174734764, 5280.445553216915, 5292.073887069767, 5332.093544097513, 5274.498922602346, 5278.973605131969, 5306.097963346221, 5318.46815318467, 5361.142217245241, 5126.205438157054, 5151.7681704323395, 5155.278261043457, 5177.974110129425, 5179.19722443022, 5177.275181474596, 5180.507851754115, 5190.974045129788, 5227.503387178212, 5264.842054738364, 4706.482286948467, 5672.744726487277, 5685.232493613351, 5712.114622233519, 5713.657180569179, 6073.453389194994, 6137.78517751881, 6217.751289948442, 6222.471089957359, 6243.906341404882, 5181.792728290864, 6169.568130230886, 6192.380761923817, 6230.283517395512, 6286.371362863722, 5708.457696518824, 5776.989026920272, 5790.131480277908, 5801.332846722681, 5829.5919285650025, 6323.652199129, 6356.77751278703, 6356.8410789729705, 6357.523185760994, 6367.0, 5805.0, 5888.705564721747, 5977.342492325841, 6028.246469191351, 6030.547708921848, 6101.4896331263535, 6102.843291144261, 6103.580118178676, 6104.398524058527, 6108.912269535978, 5978.671173085522, 6003.8198854034445, 6004.519638428916, 6044.607100538451, 6069.119977603223, 5949.345571987078, 6066.66633335162, 6086.6348019119, 6107.735039974563, 6108.152987207968, 4900.534449227318, 4907.0, 4908.4846091160625, 4909.116359055333, 4914.483979182134, 4355.3684715716045, 4362.367456718758, 4404.2512772828695, 4461.5092339842595, 4463.709858859163, 5706.629069110494, 5736.856578585569, 5751.051076572402, 5759.395263497272, 5771.336296325892, 6200.255969283715, 6201.255849298022, 6202.255729312511, 6217.253929528486, 6225.252969643671, 5746.569007324468, 5757.0788673811985, 5770.19217309577, 5775.913361299584, 5778.971105144447, 5355.705436201047, 5356.4107948125675, 5369.382521010134, 5371.946280537145, 5392.89445663638, 6312.747490100344, 6313.463355614824, 6326.240851097898, 6326.620402775756, 6331.335209802996, 6134.907976380268, 6287.591306565058, 6292.3078461368295, 6292.748290068346, 6294.213223347082, 5150.6137039721425, 6255.343188965093, 6278.215223097113, 6293.622382657055, 6329.430351268408, 6172.135900973957, 6177.135201071764, 6185.195924529782, 6194.783182588588, 6198.845028874134, 6268.185135932482, 6271.247450305992, 6277.654728989949, 6285.842853928689, 6297.1813664223355, 5946.226990491208, 5991.460768530679, 6016.578839481194, 6057.697115144313, 6128.8774224516155, 5920.467157955804, 6109.951287404173, 6115.788007244199, 6125.6933266224105, 6140.662263575547, 5039.672421292605, 5952.821415357546, 5953.1070339449425, 5974.133750606225, 6055.2430946131735, 6021.096835474714, 6056.152138700498, 6104.908426373697, 6114.144019837137, 6116.510679145568, 5797.0, 5852.268466441695, 5864.765409383747, 5896.616719913363, 5935.228420305332], "value": 5662.490933435436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.91085344801775, 507.7613521644827, 515.6751246714568, 520.3469645594778, 526.4603781124347, 29259.56110658339, 39451.2109757805, 40204.99487512813, 40267.99999999996, 42217.77822217777, 41407.79296103523, 41849.0, 41947.580524194746, 42038.94902627436, 42077.36883946736, 9339.95330023349, 9530.952345238298, 9532.523373831315, 9538.046195380475, 9539.332246742732, 9279.443233406017, 9380.108889655507, 9390.48352340621, 9391.389559678633, 9393.812123757521, 9357.344985850994, 9417.670381536647, 9426.575804088798, 9427.198688111519, 9433.81132377352, 9361.906380936172, 9415.482148481831, 9418.62325506979, 9419.52902354883, 9436.764080897963, 9314.953425232898, 9399.71800845969, 9402.96567377588, 9405.294602904809, 9433.858492122623, 37654.62345376539, 38178.61821381778, 39361.60638393608, 39399.606003940164, 39409.40885886714, 3286.819224942627, 3310.1724568857785, 3365.158710322419, 3390.610079840825, 3391.3386889556546, 29975.0, 30301.93943211977, 30804.0, 31526.842365788023, 31544.36911261785, 3022.6523949745842, 3108.1918701137643, 3124.53132030195, 3157.589513363248, 3274.836258187105, 495778.0, 496421.0, 496809.0, 497462.0, 497991.0, 61363.38636613577, 61958.0, 61962.38037619656, 62006.0, 62102.68948655228, 64211.678941605926, 71634.64182679054, 72062.9190562142, 72063.0, 72161.63919180476, 16000.279987400594, 16070.276837542338, 16259.756103658454, 16488.010719356877, 16544.090075045988, 12473.688157796129, 12619.747605047847, 12633.368331583384, 12658.746825063447, 12680.365981700877, 20088.497787555134, 20626.484337891372, 20637.17451301961, 20688.0, 20715.0, 8547.857572130328, 8853.380263381501, 8865.187969173188, 8870.891138607674, 8945.763559110223, 768.5926458976751, 780.9145288049616, 945.9290553208536, 1000.979001418549, 1046.3878631000798, 23010.0, 29539.113826585235, 29641.555376669367, 30104.69895301019, 30413.0, 905.4748246017294, 925.5927391947522, 999.8200323941614, 1037.1495373793568, 1040.2198351236573, 11862.22895511789, 14440.205788681513, 15198.924005379902, 15509.99185052968, 15552.0, 600775.0, 604857.3928258967, 605165.0, 605311.0, 606211.0, 53882.73058634682, 54237.1864422034, 54294.72852635712, 54417.0, 54519.36441906749, 1232.7534493101416, 1275.808628705683, 1295.4105881823937, 1330.7804212305055, 1368.117564171104, 30154.09537713872, 30380.392392152477, 30717.078487645405, 31112.066638000895, 31147.844260779457, 47117.05765884732, 47475.525244747114, 47660.0, 47681.523184769096, 47683.284750728075, 418575.90712046245, 420135.0, 422212.0, 423095.7665926711, 817285.0, 40905.79547102245, 42034.0, 42184.156316874105, 42274.0, 42458.36312455254, 46323.0, 46516.0, 46766.76616616895, 47241.76379118083, 47628.0, 38819.0, 39052.41421378625, 39497.60502395054, 39509.70033384363, 40195.3970690434, 32993.34013319768, 36308.81845590755, 39079.804600976815, 39257.0, 40557.986050348976, 37637.24725505529, 37708.62291377161, 38402.61597383991, 38412.0, 38798.6120138795, 31748.841255793574, 32886.0, 33744.831275844444, 34334.48498272578, 34663.960081197605, 24863.62704559397, 25177.74822251754, 25219.621705674796, 25591.87204063968, 25807.741922580535], "value": 19990.17684607899, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.39396268604554, 359.28322995623734, 361.1747157744554, 367.6250224770734, 388.3436991484391, 13114.803277950838, 14680.755833187384, 14954.850451495482, 20213.898930505326, 20340.389788306336, 19751.0, 19787.307444239454, 20754.792452075475, 21120.683189752166, 21133.260335888248, 5254.789808407669, 5524.917126243109, 5533.335999680024, 5535.25274087999, 5538.141588053858, 5482.643628164156, 5633.8591535211535, 6044.818655440344, 6097.420745029215, 6097.5426842986735, 6035.124906888498, 6039.818805435822, 6043.848903777397, 6053.122297266894, 6054.122152287916, 5365.436629153941, 5410.972945135289, 5475.780968761244, 5479.287692599976, 5491.450854914517, 5089.694618322913, 5252.474752524755, 5287.47125287472, 5322.65402748824, 5328.067588172094, 25329.49341013188, 25726.74273257262, 25750.48499030009, 26073.696315184356, 26138.6079208812, 2043.9591208175752, 2061.2064355223197, 2127.2022991378235, 2280.532490839374, 2290.415943934286, 9499.667511637059, 10198.235132365027, 10277.0, 12591.055670824724, 14430.927845360811, 1799.5411170151528, 1835.4034938644993, 1840.1995132117572, 1870.7287443320643, 1916.6741653918866, 119435.61128777462, 121420.71772215587, 123713.0, 133999.99999999904, 139268.0, 11117.22179447431, 11291.717707057225, 11309.151813614011, 11485.655430337103, 11614.30314181135, 14676.706465870622, 14722.484713034992, 14723.411063557338, 14725.55823325302, 14749.336279867432, 8411.621477033548, 8603.182697643713, 8620.18108279725, 8652.740417787476, 8726.04013558508, 8167.101618821925, 8199.918000820035, 8391.118932512121, 8479.788005299917, 8568.871466928002, 4522.5025247222775, 4527.9547204527535, 4539.16025535277, 4557.863264102082, 4630.699004564693, 1573.9527814165594, 1627.2758622413148, 1855.7216417537477, 1950.0932066589105, 1954.8729332593336, 869.7086476030601, 884.8584226523725, 914.9634014639473, 948.7343543807744, 959.6689142245914, 21061.09643984652, 21653.24213652546, 21943.122275109137, 22523.211687590854, 22811.0, 876.3164731509432, 903.074348792493, 930.6603089872283, 934.6027938126269, 1047.92064173901, 10916.399598022026, 11425.0, 11583.362915039754, 11610.535578576762, 11670.591529296604, 546954.0, 579712.0, 580549.0, 583167.0, 584265.0, 131228.0, 133537.33231333975, 134591.32704336414, 140890.84209526348, 145862.2706886459, 989.0850962859327, 1003.247564326755, 1009.808136454086, 1048.7168464514539, 1066.6266806617778, 18304.450866474028, 18963.810361896205, 19624.803751962296, 19902.70145947841, 20065.197392104154, 32791.524381403375, 46317.91569379454, 50621.0, 57184.856302872875, 58824.70587647035, 87281.0, 88378.0, 88489.0, 88986.0, 89373.0, 7045.471589630695, 7301.671424785791, 8010.879836802569, 8069.757907262791, 8415.284700800501, 12102.576409825966, 12739.363031848185, 13242.271675057964, 13360.665983350495, 13555.457781688621, 11331.546738130382, 11381.54473821071, 11658.475368608602, 11684.357360345262, 11830.585929492427, 11312.547498100314, 11393.772124557298, 11620.244684095507, 11761.235519691534, 11955.581554645545, 11357.261777984404, 11579.536818527502, 11747.0, 11855.762884742084, 12112.0, 7372.852542949004, 7457.888131677921, 7467.92532074694, 7567.356774674215, 7778.92221077782, 9309.0, 11384.601538946097, 11545.88454115448, 11559.537618495166, 11798.233114847852], "value": 9564.646985374913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.959651210464, 1513.47028540011, 1562.1564355248167, 1741.3469948769211, 1904.7809501907277, 7711.691532338707, 8072.1927807219245, 8165.795855103625, 8596.398252122353, 8615.483071015744, 8472.406931514797, 8578.699745508908, 8584.699535516258, 8585.098564650716, 8596.484210947348, 2289.5077558324956, 2298.138198175684, 2307.8153747700185, 2320.5590937721863, 2348.6829278047417, 2317.8493397929083, 2331.62693968965, 2340.918067867625, 2355.1168311883043, 2378.0487804878103, 2298.195631528968, 2325.093213646679, 2336.2874323331375, 2338.707661542307, 2339.2748248043076, 1916.3197065041918, 1923.3556758485925, 2259.0850705464313, 2318.652202169671, 2323.314622186442, 2324.3956571291587, 2338.5206032763413, 2346.4133966508375, 2349.119080344871, 2354.0701422938014, 8525.44584601999, 8566.229039386486, 8625.008124065687, 8639.308855291561, 8703.608337624759, 5130.9230361544605, 5345.198220266952, 5355.651882627617, 5357.785688572452, 5359.330083739533, 3462.740294477924, 3570.3037907608027, 3646.453032045188, 3657.2868290683327, 3673.7244706646843, 1033.9483025848679, 1060.2525219720078, 1062.2245760594733, 1063.9893601063968, 1092.2190633696866, 11231.382273974928, 11243.269187502869, 11276.379799111046, 11321.830172547418, 11338.773224535464, 3824.6749026333073, 4300.09697963425, 4337.9783101084295, 4472.351509031172, 4473.194824931478, 8837.867431988525, 8838.646454141892, 8838.690645827364, 8840.690575829814, 8844.911550884537, 5173.120569503193, 5176.559992400613, 5182.740862956837, 5188.45521220274, 5188.688678679291, 4103.507579090468, 4353.673474489426, 4500.887477813081, 4520.909581808345, 4793.5685788279225, 3097.4424603571574, 3111.3466172104113, 3612.6026137124895, 3623.8912832615065, 3698.8705395311035, 912.4206129108064, 1111.9777604447866, 1118.2898859224451, 1122.8203487442133, 1126.5831642292405, 785.9803504912423, 879.2789912272003, 903.1645727701849, 924.1451657217048, 971.32007594684, 4723.763811809465, 5609.186667933209, 5641.137986317898, 5980.342162362137, 5983.700814959235, 418.6943531222225, 424.6454210734072, 440.08023231445793, 440.0999955091781, 442.0716495359783, 3852.653261206505, 3871.3031654302495, 3986.7209295349626, 4011.799410029545, 4024.4304721158774, 7607.505512141693, 10093.24300677452, 10364.170866330676, 10486.213533984981, 10590.258681892194, 10185.592576297013, 10204.4387558685, 10349.120324772328, 10392.896071039344, 10439.112675422673, 7291.723948309024, 7374.373178279906, 7376.856587229096, 8175.427720059658, 8205.58972051395, 5495.560355171657, 5654.264945557051, 5729.1119876419225, 5741.598088133791, 5815.505682016907, 8371.95814020926, 9560.521973901137, 9592.712218633453, 9764.951175244078, 9832.655857044969, 8968.0, 9202.907970920205, 9299.721568215831, 9910.702678919644, 9917.752056198653, 6901.75843845463, 7116.537425067354, 7413.629318533944, 7423.665935033045, 7425.517341372793, 8152.592370381339, 8169.223923727236, 8205.548694821842, 8257.133001034805, 8262.091169971178, 7200.8919866201, 7281.672324745505, 7307.3058059484265, 7372.115346158281, 7479.326860582573, 7158.176809666955, 7172.426205903411, 7196.928030719835, 7304.160021597584, 7305.305995930378, 6521.217453905561, 6741.898871517029, 6829.0, 6889.862202755817, 6922.203946546211, 4910.165271903857, 4981.0, 4989.426215985208, 5013.749312534285, 5090.618203634668, 4785.258284965836, 4827.541383568555, 4865.0, 4866.562009419169, 5158.045761534128], "value": 4329.624990472775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.13085593782245, 301.63200894908204, 304.64813140822343, 310.91916101813524, 313.6424476097248, 5307.097793375126, 5318.840434786957, 5322.175062865253, 5343.3855106662695, 5369.919451208225, 4798.496157903413, 5274.92087618686, 5303.284056652351, 5317.979167916196, 5323.48649891072, 3804.0599294359936, 3824.9808750956277, 3922.548906875703, 3978.7413818101877, 3979.263836190314, 3033.726964573188, 3708.4437334399786, 3724.8266795959184, 4079.571644977279, 4116.526599441057, 3664.7068234541307, 4019.8995025124314, 4028.697847661437, 4039.5758445363253, 4054.2702313583545, 3937.6652984496354, 4013.0, 4022.5116706818662, 4042.7776472294013, 4056.2090392373498, 3270.4440245158144, 3346.882859099944, 3529.1530032791943, 3531.7285777120214, 3538.5399898013093, 4573.63410927125, 5077.339945807058, 5081.441041485434, 5087.847364579068, 5115.283860259567, 3647.5258216431694, 3966.7223294369405, 4622.306654001893, 4629.699069560468, 4640.69835460694, 4383.86019634894, 4952.786567291037, 5207.7916883325, 5495.340559132889, 5627.971860140714, 3877.7673339599714, 3888.786116763577, 3894.2211557688574, 3900.0, 3903.316919539069, 5330.813421530266, 5518.530924871431, 5774.7112644368035, 5778.5377169826315, 5847.327557330919, 3894.604818036887, 3938.6849052075763, 3946.7829269389886, 3983.721139520264, 3997.84008639657, 4034.6167114124696, 4052.5947405259826, 4053.6554392876346, 4056.3104272273786, 4070.229450189177, 4632.397788287569, 4657.74382408964, 4661.650376221797, 4696.9060618787435, 4697.342372067913, 5297.894042119136, 5323.813666521653, 5521.254630624894, 5588.161775733673, 5710.400407957105, 1325.9933700331437, 1361.977463466751, 1369.2948131712176, 1395.8972411794568, 1398.5874266990413, 796.6216047377566, 836.8828364028919, 837.9832403351899, 849.8895143631288, 852.3522123186299, 4269.03946612016, 5117.232415137759, 5164.605556499724, 5178.378594568676, 5181.6631918925905, 5497.835064948058, 5572.749226284827, 5729.8567535811935, 5761.48146666802, 5765.88468230633, 4757.5718185363485, 4961.503849615082, 5194.558462530727, 5216.974154990096, 5253.684778913277, 2743.684476285213, 2811.8594070296404, 2816.493031254394, 2853.4876515446845, 3071.677473865212, 5540.750666220029, 5879.353271140171, 5896.7936122235515, 5908.350081491032, 5931.555133365015, 5619.775208991595, 5832.533397328203, 5887.7056147193325, 5898.439648233411, 5904.0, 5854.502367298742, 5883.411478900758, 5903.852403689943, 5911.0, 5934.109883517421, 4735.857924262277, 4813.547468591609, 5557.833265002057, 5625.015622266169, 5723.284589426322, 5233.194547880975, 5650.773969041193, 5668.858278543069, 5671.291088613923, 5709.916645011647, 5886.0, 5916.704164791657, 5924.437178468039, 6045.758169673164, 6087.299960504599, 3350.916227094342, 3362.394768941614, 3369.4440417330866, 3609.3864043112208, 3837.9040523987123, 4653.650976176733, 4801.51984801517, 4817.614590832655, 5744.885102297847, 5800.216970709069, 4930.4822993586595, 5596.244506991504, 5614.2701448811395, 5626.705857652681, 5644.887102258014, 4598.022850174457, 5247.370315562157, 5463.230371043967, 5602.467765562265, 5652.202159930861, 5089.0, 5582.413846546055, 5602.299712535933, 5603.719814009201, 5603.831885043455, 5387.925648625229, 5411.945880541301, 5569.582281328998, 5616.438356164351, 5684.687342196219, 5138.460461651623, 5292.655977361459, 5366.190005096425, 5581.5813813963305, 5643.802466913638], "value": 4080.7205344234035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.4764252988996, 758.4084414156956, 787.7754839870636, 812.3492904296951, 825.8377776008915, 14253.78619320711, 14698.472366632011, 15004.324805383756, 15054.6989060219, 15347.3093710783, 13515.324233788297, 13718.108322959026, 13935.581932542014, 13964.720705585882, 13975.510857120003, 851.8381507513568, 880.995595022024, 881.2333270055061, 882.9801579176062, 883.8188171424874, 705.6859697434644, 727.7816655003504, 728.137157468399, 732.0666150657901, 734.5372415378331, 756.8372799848031, 918.673870775875, 932.3100905330041, 941.6986564299427, 953.1755031897394, 934.8550974598915, 938.3572253006644, 939.1735272959752, 939.5771902643837, 939.7603611079165, 545.2611711131439, 690.1580072311772, 690.7237105157977, 691.0912150522098, 692.1763101908713, 12248.0, 12488.000959923183, 12506.437210325557, 12525.311107889063, 12804.167729097671, 11902.642920712393, 12182.147249692525, 12296.692582685415, 12419.19275247106, 12523.185992910432, 9487.857682134774, 10168.847467287997, 11221.551137954471, 11537.711557211136, 12101.757964840654, 3530.3998320285614, 3667.3765459871884, 3711.4989476420606, 3726.887759428199, 3799.8100094995416, 86422.0, 86761.56619216927, 87286.0, 89403.55298223533, 89870.0, 10551.577936882439, 10563.0, 10741.19441041925, 10759.139268858473, 11218.270812397168, 21438.142474301167, 21635.0, 21635.02642381065, 21734.0, 21891.343259702233, 7724.961375193088, 7735.226477352332, 7746.961265193638, 7787.182345853604, 7840.059192896889, 3621.8913432597064, 4194.167439415682, 4278.315469524861, 4308.655307575386, 4337.282478787185, 3352.5641666583674, 3514.789112653249, 3535.6641119093647, 3566.8751593694615, 3568.660977207161, 642.56947844944, 647.4852492268658, 673.9730410783612, 691.5263044814318, 696.6864910790165, 481.7687509995222, 547.9205515200274, 612.9724162412703, 644.4007073421669, 688.5558814564578, 7654.464187506821, 8275.717263824117, 8431.196617210431, 9065.184133428023, 9140.725778226664, 521.9034478621467, 582.7435928191583, 601.8736065426309, 640.0303540136697, 677.9762708305186, 4249.596288352664, 4440.955590444119, 4454.242778727624, 4475.216837053567, 4557.612602928722, 106342.46828765806, 107999.46000269949, 109127.0, 109868.4506577478, 110207.44896275467, 65012.674936625015, 92704.0, 93288.0, 94574.5271273653, 94895.0, 76739.23260767321, 86866.56566717126, 86937.0, 87140.0, 88684.0, 8632.482051076955, 8655.913440865763, 8711.825763484821, 8758.0, 8903.19871211594, 45851.77074114608, 49734.0, 52093.0, 53714.65713357197, 56142.43857561536, 75793.6210318945, 79237.0, 80107.59946200465, 80349.1965080365, 82337.3532529358, 11274.0, 11467.426628668367, 11565.653030409101, 11622.476988535367, 11759.764804703687, 12245.448954796877, 12485.26507935701, 12686.619401417973, 12698.555550555686, 12815.102942793916, 11730.998806207584, 12082.758344832879, 12180.634580962585, 12295.69260768488, 12442.129050966345, 11702.0, 11898.524059037542, 12060.914517693449, 12375.133740638068, 12423.75152496927, 11365.886341136484, 11572.479238434458, 11762.294262344287, 12122.818157727464, 12222.20555663879, 9855.260855435728, 9870.654527091518, 9977.20182385393, 10220.642277520548, 10534.736631584272, 9532.809343813224, 10106.0, 10131.138853197266, 10173.796524069625, 10179.7455063624], "value": 7145.432856660586, "unit": "score"}], "name": "dromaeo_css", "value": 7177.273702185181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 115.0, 166.0, 168.0, 113.0, 112.0, 113.0, 113.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 144.0, 183.0, 142.0, 113.0, 112.0, 112.0, 145.0, 117.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 182.0, 188.0, 186.0, 183.0, 184.0, 179.0, 182.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 92.0, 62.0, 59.0, 57.0, 62.0, 86.0, 58.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 94.0, 70.0, 66.0, 68.0, 92.0, 67.0, 68.0, 91.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 130.0, 90.0, 87.0, 89.0, 86.0, 91.0, 87.0, 89.0, 86.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 98.0, 98.0, 98.0, 98.0, 97.0, 97.0, 96.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 78.0, 79.0, 81.0, 80.0, 83.0, 90.0, 122.0, 93.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 57.0, 55.0, 56.0, 55.0, 55.0, 54.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 74.0, 75.0, 72.0, 70.0, 68.0, 73.0, 71.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 87.0, 89.0, 89.0, 99.0, 107.0, 108.0, 86.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 161.0, 149.0, 147.0, 145.0, 147.0, 147.0, 236.0, 154.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 156.0, 185.0, 180.0, 174.0, 174.0, 174.0, 179.0, 174.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 70.0, 67.0, 69.0, 83.0, 87.0, 87.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1490.6, "alertThreshold": 2.0}]} 14:12:02 INFO - Return code: 0 14:12:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:02 INFO - # TBPL SUCCESS # 14:12:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:02 INFO - 2016-10-26 14:12:02.183 screenresolution[6928:123335] starting screenresolution argv=screenresolution get 14:12:02 INFO - 2016-10-26 14:12:02.186 screenresolution[6928:123335] Display 0: 1600x1200x32@60 14:12:02 INFO - 2016-10-26 14:12:02.193 screenresolution[6929:123338] starting screenresolution argv=screenresolution list 14:12:02 INFO - Available Modes on Display 0 14:12:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:02 INFO - Intel Iris: 14:12:02 INFO - Chipset Model: Intel Iris 14:12:02 INFO - Type: GPU 14:12:02 INFO - Bus: Built-In 14:12:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:02 INFO - Vendor: Intel (0x8086) 14:12:02 INFO - Device ID: 0x0a2e 14:12:02 INFO - Revision ID: 0x0009 14:12:02 INFO - Displays: 14:12:02 INFO - Display: 14:12:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:02 INFO - Display Serial Number: 1600x1200 60 14:12:02 INFO - Main Display: Yes 14:12:02 INFO - Mirror: Off 14:12:02 INFO - Online: Yes 14:12:02 INFO - Rotation: Supported 14:12:02 INFO - Return code: 0 14:12:02 INFO - Running post-action listener: _resource_record_post_action 14:12:02 INFO - [mozharness: 2016-10-26 21:12:02.435195Z] Finished run-tests step (success) 14:12:02 INFO - Running post-run listener: _resource_record_post_run 14:12:02 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 233984; Write bytes: 707524096; Read time: 2; Write time: 1995 14:12:02 INFO - TinderboxPrint: CPU usage
53.6% 14:12:02 INFO - TinderboxPrint: I/O read bytes / time
233,984 / 2 14:12:02 INFO - TinderboxPrint: I/O write bytes / time
707,524,096 / 1,995 14:12:02 INFO - TinderboxPrint: CPU idle
2,252.7 (46.4%) 14:12:02 INFO - TinderboxPrint: CPU system
972.3 (20.0%) 14:12:02 INFO - TinderboxPrint: CPU user
1,632.7 (33.6%) 14:12:02 INFO - TinderboxPrint: Swap in / out
405,991,424 / 0 14:12:02 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393038336; Write bytes: 387270656; Read time: 29220; Write time: 837 14:12:02 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 233472; Write bytes: 298573312; Read time: 1; Write time: 1101 14:12:02 INFO - Running post-run listener: _upload_blobber_files 14:12:02 INFO - Blob upload gear active. 14:12:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:02 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 14:12:02 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'] 14:12:02 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 14:12:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:12:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:12:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:04 INFO - (blobuploader) - INFO - Done attempting. 14:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:05 INFO - (blobuploader) - INFO - Done attempting. 14:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:08 INFO - (blobuploader) - INFO - Done attempting. 14:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:08 INFO - Return code: 0 14:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c12a73ef8831913a60351eb124cb5d75d33264713d4f77e27045c7fb3c5b0306e5a6f286d05a89d7b5e600e979b8a70eed936b05b7f31553ee35e2b1e043a8b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b9ed5229bd1d9769ad3fb482215e7dd1782ae00a9e0eaaf0a83ac7123d6a38c27e787daa5b851d5bef6870a92d91c32cdf1c35f5a0914ed4aad8b210b3958e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a115806348f07df8255092058979faad083be8898deb7f5644f8eea40f0345fbd445dd2add176d9847b89d35f66e7daa5bb3e51887ea7fb9273f9aad994fef6"} 14:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:08 INFO - Contents: 14:12:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c12a73ef8831913a60351eb124cb5d75d33264713d4f77e27045c7fb3c5b0306e5a6f286d05a89d7b5e600e979b8a70eed936b05b7f31553ee35e2b1e043a8b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b9ed5229bd1d9769ad3fb482215e7dd1782ae00a9e0eaaf0a83ac7123d6a38c27e787daa5b851d5bef6870a92d91c32cdf1c35f5a0914ed4aad8b210b3958e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a115806348f07df8255092058979faad083be8898deb7f5644f8eea40f0345fbd445dd2add176d9847b89d35f66e7daa5bb3e51887ea7fb9273f9aad994fef6"} 14:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:08 INFO - Copying logs to upload dir... 14:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.604869 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-26 14:12:08.603900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:08.607553) ========= 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.Hnurg7a6m7/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.TXkleeokp7/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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/c12a73ef8831913a60351eb124cb5d75d33264713d4f77e27045c7fb3c5b0306e5a6f286d05a89d7b5e600e979b8a70eed936b05b7f31553ee35e2b1e043a8b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b9ed5229bd1d9769ad3fb482215e7dd1782ae00a9e0eaaf0a83ac7123d6a38c27e787daa5b851d5bef6870a92d91c32cdf1c35f5a0914ed4aad8b210b3958e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a115806348f07df8255092058979faad083be8898deb7f5644f8eea40f0345fbd445dd2add176d9847b89d35f66e7daa5bb3e51887ea7fb9273f9aad994fef6"} build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011863 build_url: 'https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/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/c12a73ef8831913a60351eb124cb5d75d33264713d4f77e27045c7fb3c5b0306e5a6f286d05a89d7b5e600e979b8a70eed936b05b7f31553ee35e2b1e043a8b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b9ed5229bd1d9769ad3fb482215e7dd1782ae00a9e0eaaf0a83ac7123d6a38c27e787daa5b851d5bef6870a92d91c32cdf1c35f5a0914ed4aad8b210b3958e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a115806348f07df8255092058979faad083be8898deb7f5644f8eea40f0345fbd445dd2add176d9847b89d35f66e7daa5bb3e51887ea7fb9273f9aad994fef6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:08.641506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:08.641844) ========= 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.Hnurg7a6m7/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.TXkleeokp7/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.005371 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:08.691202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:08.691531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:08.691862) ========= ========= Total master_lag: 0.18 =========