builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0150 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.554973) ========= 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.555530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.555800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.637871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:52.638164) ========= 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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 67.9M=0s 2016-10-26 13:50:53 (67.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.677246 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.341753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.342053) ========= 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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.026171 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:53.390447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:50:53.390759) ========= 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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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,464 truncating revision to first 12 chars 2016-10-26 13:50:53,464 Setting DEBUG logging. 2016-10-26 13:50:53,465 attempt 1/10 2016-10-26 13:50:53,465 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:54,591 unpacking tar archive at: mozilla-central-d26ac63f1b81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 13:50:54.792652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.792950) ========= script_repo_revision: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.793765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.794043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 13:50:54.812138) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-26 13:50:54.812441) ========= /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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:55 INFO - MultiFileLogger online at 20161026 13:50:55 in /builds/slave/test 13:50:55 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:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:55 INFO - {'append_to_log': False, 13:50:55 INFO - 'base_work_dir': '/builds/slave/test', 13:50:55 INFO - 'blob_upload_branch': 'Firefox', 13:50:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:55 INFO - 'branch': 'Firefox', 13:50:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:55 INFO - 'config_files': ('talos/mac_config.py',), 13:50:55 INFO - 'default_actions': ('clobber', 13:50:55 INFO - 'read-buildbot-config', 13:50:55 INFO - 'download-and-extract', 13:50:55 INFO - 'populate-webroot', 13:50:55 INFO - 'create-virtualenv', 13:50:55 INFO - 'install', 13:50:55 INFO - 'run-tests'), 13:50:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:55 INFO - 'download_minidump_stackwalk': True, 13:50:55 INFO - 'download_symbols': 'ondemand', 13:50:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:55 INFO - 'installer_path': 'installer.exe', 13:50:55 INFO - 'log_level': 'info', 13:50:55 INFO - 'log_name': 'talos', 13:50:55 INFO - 'log_to_console': True, 13:50:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:55 INFO - 'opt_config_files': (), 13:50:55 INFO - 'pip_index': False, 13:50:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:55 INFO - 'cmd': ('bash', 13:50:55 INFO - '-c', 13:50:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:55 INFO - 'enabled': True, 13:50:55 INFO - 'halt_on_failure': False, 13:50:55 INFO - 'name': 'check_screen_resolution'},), 13:50:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:55 INFO - 'cmd': ('bash', 13:50:55 INFO - '-c', 13:50:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:55 INFO - 'enabled': True, 13:50:55 INFO - 'halt_on_failure': False, 13:50:55 INFO - 'name': 'check_screen_resolution'},), 13:50:55 INFO - 'run_cmd_checks_enabled': True, 13:50:55 INFO - 'sps_profile': False, 13:50:55 INFO - 'sps_profile_interval': 0, 13:50:55 INFO - 'suite': 'dromaeojs', 13:50:55 INFO - 'system_bits': '32', 13:50:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:55 INFO - 'title': 't-yosemite-r7-0150', 13:50:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:55 INFO - 'use_talos_json': True, 13:50:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:55 INFO - 'work_dir': 'build'} 13:50:55 INFO - [mozharness: 2016-10-26 20:50:55.022054Z] Running clobber step. 13:50:55 INFO - Running pre-action listener: _resource_record_pre_action 13:50:55 INFO - Running main action method: clobber 13:50:55 INFO - rmtree: /builds/slave/test/build 13:50:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:57 INFO - Running post-action listener: _resource_record_post_action 13:50:57 INFO - [mozharness: 2016-10-26 20:50:57.166146Z] Finished clobber step (success) 13:50:57 INFO - [mozharness: 2016-10-26 20:50:57.166268Z] Running read-buildbot-config step. 13:50:57 INFO - Running pre-action listener: _resource_record_pre_action 13:50:57 INFO - Running main action method: read_buildbot_config 13:50:57 INFO - Using buildbot properties: 13:50:57 INFO - { 13:50:57 INFO - "project": "", 13:50:57 INFO - "product": "firefox", 13:50:57 INFO - "script_repo_revision": "production", 13:50:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:50:57 INFO - "repository": "", 13:50:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:50:57 INFO - "buildid": "20161026075526", 13:50:57 INFO - "pgo_build": "False", 13:50:57 INFO - "basedir": "/builds/slave/test", 13:50:57 INFO - "buildnumber": 9, 13:50:57 INFO - "slavename": "t-yosemite-r7-0150", 13:50:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 13:50:57 INFO - "platform": "yosemite_r7", 13:50:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:50:57 INFO - "branch": "mozilla-central", 13:50:57 INFO - "repo_path": "mozilla-central", 13:50:57 INFO - "revision": "d26ac63f1b81c3fce35448a7c502e95e0b5c56c0", 13:50:57 INFO - "stage_platform": "macosx64", 13:50:57 INFO - "builduid": "1b6e62fa11104b93a83fb80681645e95", 13:50:57 INFO - "slavebuilddir": "test" 13:50:57 INFO - } 13:50:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:57 INFO - Running post-action listener: _resource_record_post_action 13:50:57 INFO - [mozharness: 2016-10-26 20:50:57.169526Z] Finished read-buildbot-config step (success) 13:50:57 INFO - [mozharness: 2016-10-26 20:50:57.169646Z] Running download-and-extract step. 13:50:57 INFO - Running pre-action listener: _resource_record_pre_action 13:50:57 INFO - Running main action method: download_and_extract 13:50:57 INFO - mkdir: /builds/slave/test/build/tests 13:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:57 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:57 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:57 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:58 INFO - Downloaded 1199 bytes. 13:50:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:58 INFO - Using the following test package requirements: 13:50:58 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'jsshell-mac.zip'], 13:50:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:58 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:58 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:58 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:58 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:58 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:59 INFO - Http code: 200 13:50:59 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 13:50:59 INFO - x-amz-cf-id: T_EwVPw0zuEh-JEgMha0ybP7l-do6NRPvkSX3PiKIaSayUpPPLJrQw== 13:50:59 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:50:59 INFO - Expected file size: 16442708 13:50:59 INFO - Obtained file size: 16442708 13:51:06 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:06 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:06 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:06 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:06 INFO - Http code: 200 13:51:06 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 13:51:06 INFO - x-amz-cf-id: hCba7q-rLgy0q01-6_vR6w6zZjdYhCLmRZ8h-SGPwHCcVqKXE1PrIg== 13:51:06 INFO - x-amz-version-id: oYs0S0BWLue4d5yNfzrDOVXSMP0of8m4 13:51:07 INFO - Expected file size: 16442708 13:51:07 INFO - Obtained file size: 16442708 13:51:13 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:13 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:13 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:14 INFO - Http code: 200 13:51:14 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 13:51:14 INFO - x-amz-cf-id: YheRTu81iAFsWOej6zcONpUivsfI2FvYrZ1C2c3KvE9TaFq4PE-Fpw== 13:51:14 INFO - x-amz-version-id: 0bXUQ92dp_r4joro14ZW7j22G0F3vbr6 13:51:14 INFO - Expected file size: 14409028 13:51:14 INFO - Obtained file size: 14409028 13:51:14 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:14 INFO - trying https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:14 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:14 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:17 INFO - Downloaded 111730824 bytes. 13:51:17 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:17 INFO - mkdir: /builds/slave/test/properties 13:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:51:17 INFO - Contents: 13:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/YxxHO84PSQat-ijixqtTCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:51:18 INFO - Running post-action listener: _resource_record_post_action 13:51:18 INFO - Running post-action listener: set_extra_try_arguments 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.466793Z] Finished download-and-extract step (success) 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.466916Z] Running populate-webroot step. 13:51:18 INFO - Running pre-action listener: _resource_record_pre_action 13:51:18 INFO - Running main action method: populate_webroot 13:51:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:51:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:51:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:51:18 INFO - '--tppagecycles', 13:51:18 INFO - '7'], 13:51:18 INFO - 'tests': ['tsvgm']}}, 13:51:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:51:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:51:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:51:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:51:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:51:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['damp', 'tps']}, 13:51:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['damp', 'tps']}, 13:51:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['dromaeo_dom']}, 13:51:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:51:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['basic_compositor_video']}, 13:51:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:51:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['a11yr', 13:51:18 INFO - 'ts_paint', 13:51:18 INFO - 'tpaint', 13:51:18 INFO - 'sessionrestore', 13:51:18 INFO - 'sessionrestore_no_auto_restore', 13:51:18 INFO - 'tabpaint']}, 13:51:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tsvgx', 13:51:18 INFO - 'tsvgr_opacity', 13:51:18 INFO - 'tart', 13:51:18 INFO - 'tscrollx', 13:51:18 INFO - 'cart']}, 13:51:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:51:18 INFO - 'tsvgr_opacity', 13:51:18 INFO - 'tart', 13:51:18 INFO - 'tscrollx', 13:51:18 INFO - 'cart']}, 13:51:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s'], 13:51:18 INFO - 'tests': ['tp5o']}, 13:51:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'tests': ['tp5o']}, 13:51:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--disable-e10s', 13:51:18 INFO - '--xperf_path', 13:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:18 INFO - 'tests': ['tp5n']}, 13:51:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:51:18 INFO - 'talos_options': ['--xperf_path', 13:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:51:18 INFO - 'tests': ['tp5n']}}, 13:51:18 INFO - 'talos.zip': {'path': '', 13:51:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:51:18 INFO - Running post-action listener: _resource_record_post_action 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.485877Z] Finished populate-webroot step (success) 13:51:18 INFO - [mozharness: 2016-10-26 20:51:18.486013Z] Running create-virtualenv step. 13:51:18 INFO - Running pre-action listener: _resource_record_pre_action 13:51:18 INFO - Running main action method: create_virtualenv 13:51:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:51:18 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:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:51:18 INFO - Using real prefix '/tools/python27' 13:51:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:51:19 INFO - Installing distribute.............................................................................................................................................................................................done. 13:51:22 INFO - Installing pip.................done. 13:51:22 INFO - Return code: 0 13:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:51:22 INFO - Reading from file tmpfile_stdout 13:51:22 INFO - Output received: 13:51:22 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:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:51: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:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:22 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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:22 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:22 INFO - 'USER': 'cltbld', 13:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:22 INFO - 'XPC_FLAGS': '0x0', 13:51:22 INFO - 'XPC_SERVICE_NAME': '0', 13:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:22 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:22 INFO - Cleaning up... 13:51:22 INFO - Return code: 0 13:51:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:51: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:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51: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:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:22 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:22 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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:22 INFO - 'HOME': '/Users/cltbld', 13:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:22 INFO - 'LOGNAME': 'cltbld', 13:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:22 INFO - 'MOZ_NO_REMOTE': '1', 13:51:22 INFO - 'NO_EM_RESTART': '1', 13:51:22 INFO - 'PAGER': '/bin/cat', 13:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:22 INFO - 'PWD': '/builds/slave/test', 13:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:22 INFO - 'SHELL': '/bin/bash', 13:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:22 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:22 INFO - 'USER': 'cltbld', 13:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:22 INFO - 'XPC_FLAGS': '0x0', 13:51:22 INFO - 'XPC_SERVICE_NAME': '0', 13:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:23 INFO - Downloading/unpacking psutil>=3.1.1 13:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:26 INFO - Installing collected packages: psutil 13:51:26 INFO - Running setup.py install for psutil 13:51:26 INFO - building 'psutil._psutil_osx' extension 13:51:26 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:27 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:27 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:27 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:27 INFO - building 'psutil._psutil_posix' extension 13:51:27 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:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:51:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:51:27 INFO - ^ 13:51:27 INFO - 1 warning generated. 13:51:27 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:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:51:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:51:28 INFO - Successfully installed psutil 13:51:28 INFO - Cleaning up... 13:51:28 INFO - Return code: 0 13:51:28 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 13:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 13:51:28 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 mozsystemmonitor==0.3 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:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:51:31 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:31 INFO - Installing collected packages: mozsystemmonitor 13:51:31 INFO - Running setup.py install for mozsystemmonitor 13:51:32 INFO - Successfully installed mozsystemmonitor 13:51:32 INFO - Cleaning up... 13:51:32 INFO - Return code: 0 13:51:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:32 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:32 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:32 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:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:32 INFO - 'HOME': '/Users/cltbld', 13:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:32 INFO - 'LOGNAME': 'cltbld', 13:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:32 INFO - 'MOZ_NO_REMOTE': '1', 13:51:32 INFO - 'NO_EM_RESTART': '1', 13:51:32 INFO - 'PAGER': '/bin/cat', 13:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:32 INFO - 'PWD': '/builds/slave/test', 13:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:32 INFO - 'SHELL': '/bin/bash', 13:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:32 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:32 INFO - 'USER': 'cltbld', 13:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:32 INFO - 'XPC_FLAGS': '0x0', 13:51:32 INFO - 'XPC_SERVICE_NAME': '0', 13:51:32 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 jsonschema==2.5.1 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 jsonschema-2.5.1-py2.py3-none-any.whl 13:51:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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 - Downloading functools32-3.2.3-2.tar.gz 13:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:35 INFO - warning: no files found matching '*.txt' 13:51:35 INFO - no previously-included directories found matching 'build' 13:51:35 INFO - no previously-included directories found matching 'dist' 13:51:35 INFO - no previously-included directories found matching '.git*' 13:51:35 INFO - Installing collected packages: jsonschema, functools32 13:51:35 INFO - Running setup.py install for functools32 13:51:35 INFO - warning: no files found matching '*.txt' 13:51:35 INFO - no previously-included directories found matching 'build' 13:51:35 INFO - no previously-included directories found matching 'dist' 13:51:35 INFO - no previously-included directories found matching '.git*' 13:51:35 INFO - Successfully installed jsonschema functools32 13:51:35 INFO - Cleaning up... 13:51:35 INFO - Return code: 0 13:51:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:51:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:35 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:35 INFO - 'HOME': '/Users/cltbld', 13:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:35 INFO - 'LOGNAME': 'cltbld', 13:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:35 INFO - 'MOZ_NO_REMOTE': '1', 13:51:35 INFO - 'NO_EM_RESTART': '1', 13:51:35 INFO - 'PAGER': '/bin/cat', 13:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:35 INFO - 'PWD': '/builds/slave/test', 13:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:35 INFO - 'SHELL': '/bin/bash', 13:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:35 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:35 INFO - 'USER': 'cltbld', 13:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:35 INFO - 'XPC_FLAGS': '0x0', 13:51:35 INFO - 'XPC_SERVICE_NAME': '0', 13:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:51:36 INFO - Cleaning up... 13:51:36 INFO - Return code: 0 13:51:36 INFO - Installing blobuploader==1.2.4 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', '--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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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', '--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:36 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:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 13:51:36 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:36 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:36 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:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:40 INFO - Downloading docopt-0.6.1.tar.gz 13:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:40 INFO - Running setup.py install for blobuploader 13:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:40 INFO - Running setup.py install for requests 13:51:40 INFO - Running setup.py install for docopt 13:51:40 INFO - Successfully installed blobuploader requests docopt 13:51:40 INFO - Cleaning up... 13:51:40 INFO - Return code: 0 13:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:40 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:40 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:40 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:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:40 INFO - 'HOME': '/Users/cltbld', 13:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:40 INFO - 'LOGNAME': 'cltbld', 13:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:40 INFO - 'MOZ_NO_REMOTE': '1', 13:51:40 INFO - 'NO_EM_RESTART': '1', 13:51:40 INFO - 'PAGER': '/bin/cat', 13:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:40 INFO - 'PWD': '/builds/slave/test', 13:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:40 INFO - 'SHELL': '/bin/bash', 13:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:40 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:40 INFO - 'USER': 'cltbld', 13:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:40 INFO - 'XPC_FLAGS': '0x0', 13:51:40 INFO - 'XPC_SERVICE_NAME': '0', 13:51:40 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/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-KZ7rrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-mzgXAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-AueGn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-KjGvNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-AXcG6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-OAt2vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-kDooVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:41 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-TBp6NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-miRqMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ERpskx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-d1fC2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Pc0gXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-kYOkhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-utrzcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-GjEObY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-w7PhBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:42 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-MTpsKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:43 INFO - Running setup.py install for manifestparser 13:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozcrash 13:51:43 INFO - Running setup.py install for mozdebug 13:51:43 INFO - Running setup.py install for mozdevice 13:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozfile 13:51:43 INFO - Running setup.py install for mozhttpd 13:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:43 INFO - Running setup.py install for mozinfo 13:51:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for mozInstall 13:51:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for mozleak 13:51:44 INFO - Running setup.py install for mozlog 13:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for moznetwork 13:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for mozprocess 13:51:44 INFO - Running setup.py install for mozprofile 13:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:44 INFO - Running setup.py install for mozrunner 13:51:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:45 INFO - Running setup.py install for mozscreenshot 13:51:45 INFO - Running setup.py install for moztest 13:51:45 INFO - Running setup.py install for mozversion 13:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:45 INFO - Cleaning up... 13:51:45 INFO - Return code: 0 13:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:45 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:45 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:45 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:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:45 INFO - 'HOME': '/Users/cltbld', 13:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:45 INFO - 'LOGNAME': 'cltbld', 13:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:45 INFO - 'MOZ_NO_REMOTE': '1', 13:51:45 INFO - 'NO_EM_RESTART': '1', 13:51:45 INFO - 'PAGER': '/bin/cat', 13:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:45 INFO - 'PWD': '/builds/slave/test', 13:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:45 INFO - 'SHELL': '/bin/bash', 13:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:45 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:45 INFO - 'USER': 'cltbld', 13:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:45 INFO - 'XPC_FLAGS': '0x0', 13:51:45 INFO - 'XPC_SERVICE_NAME': '0', 13:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:45 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-MBioYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:45 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-i6CVR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-5eINFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-7dQblU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-dQwbuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-28zlyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-G7xH0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-QDpoPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-2fUzCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-S96nl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:46 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-KmJhVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-qqp2iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-YTkug3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-uIl1DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-6pIQGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-oTePOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_EFHqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:50 INFO - Downloading blessings-1.6.tar.gz 13:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:50 INFO - Installing collected packages: blessings 13:51:50 INFO - Running setup.py install for blessings 13:51:50 INFO - Successfully installed blessings 13:51:50 INFO - Cleaning up... 13:51:50 INFO - Return code: 0 13:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Current package versions: 13:51:50 INFO - blessings == 1.6 13:51:50 INFO - blobuploader == 1.2.4 13:51:50 INFO - docopt == 0.6.1 13:51:50 INFO - functools32 == 3.2.3-2 13:51:50 INFO - jsonschema == 2.5.1 13:51:50 INFO - manifestparser == 1.1 13:51:50 INFO - mozInstall == 1.12 13:51:50 INFO - mozcrash == 0.17 13:51:50 INFO - mozdebug == 0.1 13:51:50 INFO - mozdevice == 0.48 13:51:50 INFO - mozfile == 1.2 13:51:50 INFO - mozhttpd == 0.7 13:51:50 INFO - mozinfo == 0.9 13:51:50 INFO - mozleak == 0.1 13:51:50 INFO - mozlog == 3.4 13:51:50 INFO - moznetwork == 0.27 13:51:50 INFO - mozprocess == 0.23 13:51:50 INFO - mozprofile == 0.28 13:51:50 INFO - mozrunner == 6.12 13:51:50 INFO - mozscreenshot == 0.1 13:51:50 INFO - mozsystemmonitor == 0.3 13:51:50 INFO - moztest == 0.7 13:51:50 INFO - mozversion == 1.4 13:51:50 INFO - psutil == 3.1.1 13:51:50 INFO - requests == 1.2.3 13:51:50 INFO - wsgiref == 0.1.2 13:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:50 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:50 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:50 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:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:50 INFO - 'HOME': '/Users/cltbld', 13:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:50 INFO - 'LOGNAME': 'cltbld', 13:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:50 INFO - 'MOZ_NO_REMOTE': '1', 13:51:50 INFO - 'NO_EM_RESTART': '1', 13:51:50 INFO - 'PAGER': '/bin/cat', 13:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:50 INFO - 'PWD': '/builds/slave/test', 13:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:50 INFO - 'SHELL': '/bin/bash', 13:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:50 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:50 INFO - 'USER': 'cltbld', 13:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:50 INFO - 'XPC_FLAGS': '0x0', 13:51:50 INFO - 'XPC_SERVICE_NAME': '0', 13:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Cleaning up... 13:51:51 INFO - Return code: 0 13:51:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:51 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 0x101f62490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ed8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff012cd9280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, '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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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:51 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:51 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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:51 INFO - 'HOME': '/Users/cltbld', 13:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:51 INFO - 'LOGNAME': 'cltbld', 13:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:51 INFO - 'MOZ_NO_REMOTE': '1', 13:51:51 INFO - 'NO_EM_RESTART': '1', 13:51:51 INFO - 'PAGER': '/bin/cat', 13:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:51 INFO - 'PWD': '/builds/slave/test', 13:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:51 INFO - 'SHELL': '/bin/bash', 13:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:51:51 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:51 INFO - 'USER': 'cltbld', 13:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:51 INFO - 'XPC_FLAGS': '0x0', 13:51:51 INFO - 'XPC_SERVICE_NAME': '0', 13:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:51 INFO - Cleaning up... 13:51:51 INFO - Return code: 0 13:51:51 INFO - Running post-action listener: _resource_record_post_action 13:51:51 INFO - Running post-action listener: _start_resource_monitoring 13:51:51 INFO - Starting resource monitoring. 13:51:51 INFO - [mozharness: 2016-10-26 20:51:51.345018Z] Finished create-virtualenv step (success) 13:51:51 INFO - [mozharness: 2016-10-26 20:51:51.346007Z] Running install step. 13:51:51 INFO - Running pre-action listener: _resource_record_pre_action 13:51:51 INFO - Running main action method: install 13:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:51 INFO - Reading from file tmpfile_stdout 13:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:51 INFO - Reading from file tmpfile_stdout 13:51:51 INFO - Output received: 13:51:51 INFO - Usage: mozinstall [options] installer 13:51:51 INFO - Options: 13:51:51 INFO - -h, --help show this help message and exit 13:51:51 INFO - -d DEST, --destination=DEST 13:51:51 INFO - Directory to install application into. [default: 13:51:51 INFO - "/builds/slave/test"] 13:51:51 INFO - --app=APP Application being installed. [default: firefox] 13:51:51 INFO - mkdir: /builds/slave/test/build/application 13:51:51 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:51 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:26 INFO - Reading from file tmpfile_stdout 13:52:26 INFO - Output received: 13:52:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:52:26 INFO - Running post-action listener: _resource_record_post_action 13:52:26 INFO - [mozharness: 2016-10-26 20:52:26.765834Z] Finished install step (success) 13:52:26 INFO - [mozharness: 2016-10-26 20:52:26.765974Z] Running run-tests step. 13:52:26 INFO - Running pre-action listener: _resource_record_pre_action 13:52:26 INFO - Running main action method: run_tests 13:52:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:52:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:52:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:52:26 INFO - 2016-10-26 13:52:26.780 screenresolution[1643:8197] starting screenresolution argv=screenresolution get 13:52:26 INFO - 2016-10-26 13:52:26.783 screenresolution[1643:8197] Display 0: 1600x1200x32@60 13:52:26 INFO - 2016-10-26 13:52:26.789 screenresolution[1644:8199] starting screenresolution argv=screenresolution list 13:52:26 INFO - Available Modes on Display 0 13:52:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:52:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:52:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:52:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:52:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:52:27 INFO - Intel Iris: 13:52:27 INFO - Chipset Model: Intel Iris 13:52:27 INFO - Type: GPU 13:52:27 INFO - Bus: Built-In 13:52:27 INFO - VRAM (Dynamic, Max): 1536 MB 13:52:27 INFO - Vendor: Intel (0x8086) 13:52:27 INFO - Device ID: 0x0a2e 13:52:27 INFO - Revision ID: 0x0009 13:52:27 INFO - Displays: 13:52:27 INFO - Display: 13:52:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:52:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:52:27 INFO - Display Serial Number: 1600x1200 60 13:52:27 INFO - Main Display: Yes 13:52:27 INFO - Mirror: Off 13:52:27 INFO - Online: Yes 13:52:27 INFO - Rotation: Supported 13:52:27 INFO - Return code: 0 13:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:27 INFO - Python 2.7.3 13:52:27 INFO - Return code: 0 13:52:27 INFO - grabbing minidump binary from tooltool 13:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:27 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 0x101d76d30>, '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 0x101b9cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d6eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:27 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:27 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:27 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:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:27 INFO - Return code: 0 13:52:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:52:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:52:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:27 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-0150', '--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:27 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-0150 --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:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1mahsMJMu2/Render', 13:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:52:27 INFO - 'HOME': '/Users/cltbld', 13:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:52:27 INFO - 'LOGNAME': 'cltbld', 13:52:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:27 INFO - 'MOZ_NO_REMOTE': '1', 13:52:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:27 INFO - 'NO_EM_RESTART': '1', 13:52:27 INFO - 'PAGER': '/bin/cat', 13:52:27 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:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:27 INFO - 'PWD': '/builds/slave/test', 13:52:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:52:27 INFO - 'SHELL': '/bin/bash', 13:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uk4WEsb9GY/Listeners', 13:52:27 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 13:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:52:27 INFO - 'USER': 'cltbld', 13:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:27 INFO - 'XPC_FLAGS': '0x0', 13:52:27 INFO - 'XPC_SERVICE_NAME': '0', 13:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:52:27 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-0150', '--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:27 INFO - mozversion application_buildid: 20161026075526 13:52:27 INFO - mozversion application_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:27 INFO - mozversion application_display_name: Nightly 13:52:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:27 INFO - mozversion application_name: Firefox 13:52:27 INFO - mozversion application_remotingname: firefox 13:52:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:27 INFO - mozversion application_vendor: Mozilla 13:52:27 INFO - mozversion application_version: 52.0a1 13:52:27 INFO - mozversion platform_buildid: 20161026075526 13:52:27 INFO - mozversion platform_changeset: d26ac63f1b81c3fce35448a7c502e95e0b5c56c0 13:52:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:27 INFO - mozversion platform_version: 52.0a1 13:52:27 INFO - using testdate: 1477515147 13:52:27 INFO - actual date: 1477515147 13:52:27 INFO - starting webserver on 'localhost:49273' 13:52:27 INFO - SUITE-START | Running 2 tests 13:52:27 INFO - TEST-START | dromaeo_css 13:52:27 INFO - operating with platform_type : mac_ 13:52:27 INFO - Initialising browser for dromaeo_css test... 13:52:27 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpGSV4W9/profile http://localhost:49273/getInfo.html) 13:52:29 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 13:52:29 INFO - PROCESS | 1654 | colorDepth:24 13:52:29 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 13:52:29 INFO - PROCESS | 1654 | __metrics 13:52:29 INFO - PROCESS | 1654 | 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:29 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:52:30 INFO - TEST-INFO | 1654: exit 0 13:52:30 INFO - Browser initialized. 13:52:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:52:30 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpGSV4W9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:42 INFO - PROCESS | 1657 | RSS: Main: 230481920 13:52:42 INFO - PROCESS | 1657 | 13:53:34 INFO - PROCESS | 1657 | 1477515214253 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:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 13:55:48 INFO - PROCESS | 1657 | RSS: Main: 408981504 13:55:48 INFO - PROCESS | 1657 | 13:58:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 13:58:52 INFO - PROCESS | 1657 | RSS: Main: 373932032 13:58:52 INFO - PROCESS | 1657 | 14:01:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 14:01:55 INFO - PROCESS | 1657 | RSS: Main: 361099264 14:01:55 INFO - PROCESS | 1657 | 14:04:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 14:04:58 INFO - PROCESS | 1657 | RSS: Main: 350064640 14:04:58 INFO - PROCESS | 1657 | 14:08:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 14:08:02 INFO - PROCESS | 1657 | RSS: Main: 340533248 14:08:02 INFO - PROCESS | 1657 | 14:11:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 14:11:05 INFO - PROCESS | 1657 | RSS: Main: 397029376 14:11:05 INFO - PROCESS | 1657 | 14:11:05 INFO - PROCESS | 1657 | __start_tp_report 14:11:05 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 14:11:05 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 14:11:05 INFO - PROCESS | 1657 | |i|pagename|runs| 14:11:05 INFO - PROCESS | 1657 | |0;dojo.html;2591.248537924002;3050.1764523578636;3327.0684208421635;3366.747493937952;3373.61203461602;5590.608657393984;5637.774489020434;5683.630564013336;5710.9714451427735;5734.856628584287;5664.291963504562;5700.942990570093;5753.626014309067;5787.884242315151;5789.652620842763;5076.416212135597;5077.695338279696;5131.743412829363;5179.948200517984;5189.8183563575285;5255.947440525584;5259.947400526004;5281.735913204344;5282.603804714642;5297.629165958385;5087.592992560586;5252.395974462909;5264.341957255343;5295.973520132394;5343.145096784515;5148.3564554430695;5192.61055420845;5202.08963431398;5203.323567936182;5207.791688332462;4334;5074.4671809460215;5164.251183578398;5167.7932882684645;5182.870428239286;5673.149027645845;5676.2620859288445;5685.147227915804;5689.345725241609;5712.485876271156;6146.815595532141;6147.309489890316;6147.801178770142;6153.4154255345675;6160.1375807387;6130.371434844235;6151.846203844895;6168.96915515424;6174.629522228635;6228.065790131516;5113.565346945514;5605.327360716699;5793.246877905845;5803.883922321615;5807.448292412257;6236.251649802053;6260.530460215502;6293.937060629427;6302.212223472066;6312.873742525124;5997.070454079625;6054.51563874889;6063.969680151659;6101.694915254219;6147.72335244915;6162;6199.814005579839;6206.503479721611;6221.906671399933;6237.376262373727;6201.689915504297;6208.286047104551;6217.191765070512;6218;6228.5017198624;6076.936536106164;6143.692815359214;6215;6223.284322302993;6232.719527621268;4844.709317440965;4847.491013443538;4848.248521479177;4853.150698627726;4855.927161092586;4259.190753756839;4412.161689279091;4416.205083085011;4457.621102206349;4459.843905463294;5703.116017017369;5727.5990680652785;5747.792963477633;5747.879163563149;5771.451712087345;6159.96920015406;6160.845978850475;6162.921488739453;6165.722542485599;6169.784057557964;5724.284464441945;5735.4551317624755;5795.130730390475;5801.9129713054335;5819.563532734977;4043.332850079763;4548.56788605082;5403.594730395236;5444.537214336826;5452.263944367539;6220.191375121205;6235.532335074888;6258.561900666909;6261.843453913598;6265.373462653789;6158.065320368985;6196.752129914753;6211.316755156839;6217.036359364306;6223.626582405071;6121.087175196906;6158.983767678283;6173.47525460323;6183.505319574513;6206.751729930752;6198.938010619836;6200.193974783249;6203.069539569101;6205.751769929152;6215.96892015537;6206.937930620817;6222.253329600477;6257.624542527463;6258.374162583706;6259.311475737756;5984.341722410444;6056.394360563909;6069.9089513656445;6098.207233059674;6133.355997620186;6039.667818270037;6066.605670631571;6108.389161083856;6143.603994442082;6146.5248340398875;5355.544778693855;5870.031444811559;5992.101184822312;5996.520278377807;6042.546808989431;5988.790392336247;6086.178365920721;6092.8781424372155;6121.081837724377;6127.356627554221;5896.410358964069;5899.262592175978;5958.523318134626;5961;5966.642001479925 14:11:05 INFO - PROCESS | 1657 | |1;ext.html;468.17367346633176;469.72286351052884;515.4664921805931;516.9325343166358;535.4859335038363;29608.555871661916;31432.52851207234;31454.528182077258;33407.66592334076;42315.576844231546;42592.78703606485;43148.784256078674;43263.35104973428;43280.78359608205;43287.78356108215;9512.191463725574;9606.039396060372;9698.321117521777;9714.854277185848;9726.319157658967;9582.616695332214;9612.90387096127;9629.807403851919;9737.707868763948;9757.560909759042;9672.22622190223;9740.51297435129;9742.756431089208;9761.707148785548;9771.755706107333;9676.225901927864;9728.319017668766;9733.951330243339;9736.464494452803;9746.75633109178;8242.670293188265;9430.528473576362;9509.66716164931;9511.239100871913;9531.046895310483;40417.39373909394;40730.796346018375;40848.59151408478;40934.79532602348;41092.58907410917;3371.4268574342423;3392.8473218705217;3413.2661477782394;3426.7601267911255;3437.3812713711523;30432.891559639385;30717.846410767805;30904.381912361852;31234;31695.683043169505;3153.243221626816;3188.3942051010467;3188.6651901550467;3214.6624604416434;3321.5681961345113;476527;476938;476982.61508692236;479894;480064;60595.697021514614;60896.39103608907;60923.69538152281;61011.81399581085;61019.6949015261;34218.14454638654;34561.96314110581;34987.30025399478;63985.680071600276;64289;15709.293081811118;16104.436344727877;16143;16154.838451615333;16168.434104806276;12388.56640017595;12481.063920206021;12483.438245278985;12487;12503.562375317002;19412.804741389988;19479.325578044165;19513.024348782503;19607.607907825462;19646;6762.560433571901;7925.630176985872;7967.601619918981;8031.518108913484;8042.758717238492;830.7715378271024;890.2610833008588;960.8606752020918;962.2879069488667;1067.8307253557343;29133.834646613897;30165.849170754005;30284.697153028188;30971.845140774603;31000.68999310023;995.4773743784426;1013.3869009249445;1025.2413214221422;1033.8862725100232;1151.1999160583314;15198.16248877586;15825;16034.469033593276;16035.518934431986;16194;546282;628989;631635;633238;633242;57879.710601447565;58798;58833;58844.82310353769;58882.70558647265;1330.5941687785319;1383.087162472763;1391.6173052410668;1397.804307396945;1400.0199860097973;29073.85463072671;29439.705602943697;29613;30162.84918575393;30387;51599.742001291255;51683.22475162951;51699.483005169466;51833.481665182866;51840.703982400744;551496;553727;553828;554878;555461;26352.60471092897;26769.732302676723;26773.598396023684;26789.86605066962;26810.731892681604;45697.54302456933;47752;48833.5116648829;48918;48958.75520622374;38450.807745961094;38920.221595568495;39240.803795980835;40695;40763.38854917238;39354;40115.7940732505;40224;40390.39414408845;40435.595644043184;38091.42862857115;38244;38732.41901371425;38738.4189237156;39289.410658839566;33235.66764332326;34012.31975360528;34561;34615.13462163365;34804;24703;25366.1121860734;25399;25803.354916126496;25824.483510330065 14:11:05 INFO - PROCESS | 1657 | |2;jquery.html;321.33804363012194;349.8635532142466;368.0798004987531;376.1348897535667;402.9677625789937;14781.630459238524;15019.32413041413;15726.213689315531;19808.504787380287;20152.294669686566;19257.903710481463;20198.29305974291;20198.39404817858;20447.488812779688;20697.96510174489;5709.77160913564;6065.029595264758;6077.361877002917;6078;6082.756689732428;4818.9157439576165;5994.130851026599;6047.3650266722025;6057.939420605781;6066.181065556159;5692.487676109149;5996.370381109986;6003.0695242237525;6010.729517171716;6022.939770602282;5834.329052159013;5953.553483488712;5966.134910438005;5973.701314934257;5986.2217911671205;4906.411230652309;5004.649674522785;5039.697618142886;5111.284420181178;5196.194589838581;25751.098711545194;25789.968401263926;25805.83873725668;25992.37474930002;26042.34894127643;2237.8433509654333;2237.865728056322;2385.546746118232;2391.868447235401;2415.7825795678473;14932.925335373253;15466.381344746196;15546;15817.920910395489;16217.189140542925;1804.2151664026192;1821.5355084453513;1847.3534263007973;1849.112426035497;1898.2027548429692;111323.44338278337;113779.19744459938;116163;116304.99999999916;119757.40121299424;11297.039751621205;11394.487248073856;11540.653780386601;11604.825927611093;11652;14640.267986600627;14649.26753662334;14650.120992740469;14658;14692;8247;8410.789730256793;8445;8463.788405289793;8576.914230857736;7035.874260118459;8256.793580160544;8273.958630206811;8425.578721063923;8480.491170529787;4309.762963037063;4574.627611716472;4608.654350923627;4612.86161415158;4624.884377890579;1653.4708893154316;1892.3565987564293;1928.2576208159678;1939.4957311099215;1942.7862935077412;817.9836403271901;905.212465155306;911.9726408207764;961.5144352102144;962.3696478806393;20500.69248961267;21144.259950901644;21205.469863253544;21279.893600531897;21286.680699789515;942.6229508196639;945.2626950978248;969.6266937229218;1003.19744204636;1013.5692330759398;8299.672052471575;9600.903990960001;10349.586016559404;11028.613998510014;11153.996140347408;571697;573945;576329;576912.6901479273;584264.0786796039;121068.78931210576;125992.46912290562;128598;130510;132041;892.5804871710286;940.4122423485321;959.2565761534867;1017.765913839821;1027.2655051637964;16151.111688857225;18300.267989280812;19162;19346.129424176226;19516.933238360172;34095;44847.10305793931;50633;53917.19124213218;54756.72621636866;60244;75191.62404187943;79683.2031679699;79914.80127798204;82529;6822.829429264308;7957.920420795718;8254.463459875089;8339.624716887633;8562.57187140653;11929.701757456132;12278.263304201777;12835;13484;13660.795088073886;10528.263021588722;11297.491612877604;11546.94226528862;11900.404979750805;11952.043836493234;11220.887791121984;11224.887751122384;11546.884531154918;11548.153612325345;11743.412829358327;9586.712398628053;11662.76674466489;11728.41357932083;11771.293722376684;12014.399280036137;7031.7890463286185;7304.423925096142;7476.327130558276;7515.670142255918;7741.92258077412;10652.09457196147;11535.957295586079;11550.364729939934;11788.646340609796;11862.584809531625 14:11:06 INFO - PROCESS | 1657 | |3;mootools.html;1345.1996062342903;1394.6931675031492;1501.954941351759;1674.3135314521048;1868.2153495531884;7714.382849372051;8084.070331911832;8244.505329680216;8655.134486551342;8692.261157801579;8514.872276915852;8601.225889669928;8612.181842724947;8622.482651040942;8656.43733157346;2321.3848330192513;2339.438534751656;2345.3784747042046;2347.8004369628516;2348.2368230325214;2321.5008773113777;2365.4033527368956;2381.1189859751917;2383.7497062808416;2386.486905315357;2098.3704888533457;2189.9014544345464;2319.9768002320016;2343.121329501437;2344.460774021976;2294.44552563162;2295.8507696999727;2324.047140672333;2326.8254880884;2330.207729372013;2004.6391649503084;2328.2433209206906;2341.8243631727687;2345.2143531916827;2351.2240960483173;8580.013298470692;8664.046954834963;8665.263452606536;8695.304375649996;8697.391182617219;5122.231665250205;5324.627276090675;5325.520703136736;5356.973215133899;5369.785208591652;3471.461923401877;3592.497050412944;3654.305681920453;3659.652333028358;3704.555453345589;921.3964853021282;1036.3419228789774;1038.6416686243233;1082.837574363844;1086.2450596835204;11392.601258955896;11427.428628568538;11502.482388292547;11515.36665483398;11529.711757205969;4202;4441.733495990251;4510.8424103127945;4532.32015197723;4538.704984176018;8745.518996455128;8814.427062240933;8881.200691937756;8892.777680558038;8903.287736981156;5161.819336323286;5163.690178589297;5173.32746742921;5173.611979101583;5190.766415511311;3851.730378873452;4362.323839804835;4497.977510112429;4852.927206091911;4865.5864251539015;3188.617365916105;3345.815980121117;3621.6378362163573;3659.524261845996;3721.962780372216;1021.4484178543503;1138.709629044605;1142.2518250545907;1143.7369405036723;1164.0920082335792;903.6520939438363;904.5567671840882;915.2632131134501;952.766572189804;958.6932181701928;5603.439656034364;5718.8070723709325;5902.085176797603;6039.577229593886;6067.663949379433;364.7629041123291;400.35542776130404;429.1181621767298;432.2737800495198;443.7537166872352;3835;3836.9040773980873;3843.7309388343106;3933.0757272041046;3958.2083583283456;10240.641577544899;10571.94714026425;10685.091767199876;10704.625338113128;10706.892931070746;10620.362778233177;10622.097121744739;10647.307924985005;10651.30766500175;10652.987966143204;7625.428092893055;8048.839023219386;8113.837723245502;8227;8230.62962166692;5438.673679579238;5723.885522289447;5993.940060599512;6037.366076561898;6078.3921607838865;9362.48506332131;9647.228221742103;9688.370255933341;9729.562169702522;9849.212063034796;9051.637934482547;9802.068803463659;9939.403635781877;9967.202623789934;9974.102330790263;6734.4612431004425;6905.723771049102;7112.964435177791;7120.074390329224;7410.2219266978345;7839.137694853447;8145.185481451807;8199.22107399796;8228.465149765247;8316.750497485085;7290.5625662460425;7330.120385553768;7349.338559529668;7382.077240344957;7437.330640242404;5805.79679711225;6942.271061538466;7214;7321.158066822383;7420.480566360303;6814.965925170541;6816.659167041727;6902.171739391305;6926.341997510229;6930.683170197646;4229.471316085489;4863.124637565272;4948.653594248368;4998.700077995332;5129.74351282427;4315.331123675835;4901.779419926183;4989.451160372429;5059.974700126623;5065.39215294167 14:11:06 INFO - PROCESS | 1657 | |4;prototype.html;270.41590165243076;297.90467050543833;297.94339075575647;306.0939618728564;311.9500879859223;4657.461683382556;4954;4974.552290293873;5038.244263360498;5236.371635403752;4206.107251736716;4567.802538223249;5004.249362595612;5084.847454576359;5149.274992877381;3472.826358682062;3527.694752941415;3997.4603428537066;4015.1367455996956;4015.156817068419;3177.4916013437855;4005.3591425371947;4023.637872591466;4033.910844072099;4055.7363771354917;3291.8189499577516;3703.68519675203;3954.9604503955024;3975.9602403976023;4020.5376381716037;3900.219956008781;3914.4324073009398;3958.208358328317;3970.82131304092;4007.5391329997133;3172.9851544269322;3219.4205043092234;3439.7420193485336;3456.913577160566;3463.2727127303297;4075.7758323292205;5085.143922468309;5145.253938178943;5159.793608255665;5162.406323272834;3958.841646334143;4516.548345165457;4517.819287228507;4532.750698711569;4559;5409.810656627039;5425.83722488326;5515.641483303572;5517.5585953124055;5532.446755324476;3308.834558272101;3463.9480407793903;3737.4767532545466;3757.380032294668;3771.151490914522;5660.490555849952;5719.342275638313;5728.914066289009;5755.712214389306;5757.366689664133;3967.920641587152;3977.164795393;3990.521137463523;3990.940135897964;3992.461017762565;3842.9231415371537;3991.560928297885;4016.168601136192;4042.4946881639794;4048.8380464781667;4574.931376029363;4621.653375996813;4626.676132670748;4633.86098417048;4634.629229661619;5534.584906132056;5545.473180047889;5550.250716153349;5561.304836895388;5572.637778544382;1204.4943820224719;1285.977647770025;1325.1447972838105;1346.3201083452989;1354.4040622126233;807.5195258820992;910.8633704944178;940.4498368454531;940.6519587752439;950.8067375443774;5113.210376368242;5128.974355128275;5132.435432102466;5182.4299327073995;5200.193969934666;5058.367704036996;5635.605507614509;5638.36325570005;5643;5655.971720141373;4329.848455304049;4953.777080031407;4967.751612419364;5175.353080864892;5221.503957124067;2494.301595553212;2636.8022398320204;2933.3399985003202;2951.5277555591;2999.4451026560155;5068.493150684902;5117.641765076483;5653.745581448845;5797.651950959784;5821.505172060422;4675.322078298627;5476.644018138808;5760.798372057042;5761.683107429048;5794.21778059965;5173.456787037382;5549.472800083986;5793.36273009977;5830.533557315404;5844.444777746107;4999.225120106389;5019.9880071958;5381.461853814587;5622.100463925753;5669.829905102853;4827.493113223061;5486.396496385474;5570.6657600544095;5570.716006437341;5575.327401779531;4635.860924172281;5430.321209848769;5500.4499550044675;5746.712664366849;5786.797462088806;3585.3367127081574;3667.7529639922554;3778.9433158502093;3818.94271585932;3826.559945606291;5154.329937108152;5613.943860561505;5623.325200975909;5639.885043108834;5696.401877802771;4885.706857588556;5476.863078423071;5480.26016487785;5497.505224529811;5497.780088796563;4702.683248690372;4737.763111844463;5486.354093771933;5535.418781027934;5542.612017158922;4328.48058233014;5190.532852043334;5271.393789714232;5327.815595605938;5352.9464705354;5489.39616642161;5493.203485494501;5518.392976772632;5525.044101405729;5544.500994910478;5049.84850454487;5093.668911520739;5141.665791723526;5398.464006076027;5408.837734867803 14:11:06 INFO - PROCESS | 1657 | |5;yui.html;776.4409625069951;780.4479352517269;808.1312588966862;835.9582020898955;861.8448679237739;14619.78070328946;14708.558743237692;15113.848861511382;15162.620934476643;15347.61630959228;13872.722545549108;14126.858731412683;14144.434222631082;14172.645683857909;14189.503367382118;839.7900524868783;858.8797568340422;862.8015556422026;873.1443185678039;876.7939534209455;875.2210532625968;880.3969281042474;880.5113162194979;882.0473888200728;882.1575395497284;927.9489628070453;928.1136514628514;929.1126973740062;929.2426672262119;930.50683137937;902.7156445719643;922.1147698209727;923.5659240157115;924.4915296586851;924.8104138651561;684.6200358800863;685.2496516314627;685.3763075601179;685.8833998220315;686.2314208086925;14470.927645361706;14689.412423503047;14876.62808429787;14880.255987200597;14995.700085998327;13620.591382258548;13693;13756;13882.270846832458;13987.510437134652;11317.886821131848;11596.4201789911;11807.704807379798;11828;12253.877461225451;3683.28176005679;3688.188598508324;3698;3702.777833330009;3855.151866589346;54343.45656543424;57592.13611795827;75796.62101689511;77867;89930.5503472485;10790.352578845295;10879.891201088047;10887.564497420173;10936.781264374667;11082.944585277022;20686.482837929172;20768.68846967297;20774.688379674317;20859.1656333748;20938.790612093682;6904.447644188453;7666.578338191453;8088.676452941934;8090.190980901981;8104.27061564462;4199.874003779892;4326.394304797331;4395.846145384896;4516.36770852081;4544.727316361029;3508.7193024557973;3581.5702115746276;3605;3637.4907512948207;3649.434337677664;667.9265280819106;668.4351722794231;670.0384947600112;670.7987603718963;685.3968507713181;569.1150261343568;634.0932466572752;657.7599176300616;658.664081318531;671.6876652356677;8676.566171691391;9143.725688229364;9174.082591740773;9281.628734850665;9297.628094876129;581.8109114537792;617.5461036138435;631.4474834519796;654.4927681047132;666.3902529185838;4416.955830441719;4549.863504094882;4575.5424457554645;4582.679212455096;4594.531594844052;99368.50315748375;109398;114509.4274528622;116879.41560292144;121361;64961.67519162374;67123;75060;84693;104841;81699;82785.27466263912;83460.58269708612;83642.5817870919;84521;8459.238668519863;8594;8609.741707748777;8811.515366654896;8916.375853690179;52104.47895520996;52480.95038099293;54687.710913245486;56213.718931405085;57045.28864134083;53002.734986326366;68072.65963670348;75178.8723169142;77026;78560.21439785758;10883.346999180074;11004.889951100387;11080.501377437873;11190.440477976232;11409.657710268706;11941.52233910634;11948.223365481215;12064.75870482603;12090.576829810914;12352.4441400139;11685.64976798425;11806.291622502677;11838.940805295919;12195.451204695988;12201.267923924594;11649.767004660029;11778.17552771332;11864.11019173548;12156.939215303866;12172.39138043112;11134.443277835913;11421.428928553372;11613.825792612948;11942.522299107939;11943.402829858645;9568.61725530971;9581.568829402555;9732.951335243279;9960.1533869619;10094.293399461967;8174.346052315682;8424.495151566398;8749.737507874774;9343.345965782602;9952 14:11:06 INFO - PROCESS | 1657 | __end_tp_report 14:11:06 INFO - PROCESS | 1657 | __start_cc_report 14:11:06 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1620 14:11:06 INFO - PROCESS | 1657 | __end_cc_report 14:11:06 INFO - PROCESS | 1657 | __startTimestamp1477516265989__endTimestamp 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | ------- Summary: start ------- 14:11:06 INFO - PROCESS | 1657 | Number of tests: 6 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5696.44 Median:5984.34 stddev:684.94 (11.4%) stddev-sans-first:642.26 14:11:06 INFO - PROCESS | 1657 | Values: 2591.2 3050.2 3327.1 3366.7 3373.6 5590.6 5637.8 5683.6 5711.0 5734.9 5664.3 5700.9 5753.6 5787.9 5789.7 5076.4 5077.7 5131.7 5179.9 5189.8 5255.9 5259.9 5281.7 5282.6 5297.6 5087.6 5252.4 5264.3 5296.0 5343.1 5148.4 5192.6 5202.1 5203.3 5207.8 4334.0 5074.5 5164.3 5167.8 5182.9 5673.1 5676.3 5685.1 5689.3 5712.5 6146.8 6147.3 6147.8 6153.4 6160.1 6130.4 6151.8 6169.0 6174.6 6228.1 5113.6 5605.3 5793.2 5803.9 5807.4 6236.3 6260.5 6293.9 6302.2 6312.9 5997.1 6054.5 6064.0 6101.7 6147.7 6162.0 6199.8 6206.5 6221.9 6237.4 6201.7 6208.3 6217.2 6218.0 6228.5 6076.9 6143.7 6215.0 6223.3 6232.7 4844.7 4847.5 4848.2 4853.2 4855.9 4259.2 4412.2 4416.2 4457.6 4459.8 5703.1 5727.6 5747.8 5747.9 5771.5 6160.0 6160.8 6162.9 6165.7 6169.8 5724.3 5735.5 5795.1 5801.9 5819.6 4043.3 4548.6 5403.6 5444.5 5452.3 6220.2 6235.5 6258.6 6261.8 6265.4 6158.1 6196.8 6211.3 6217.0 6223.6 6121.1 6159.0 6173.5 6183.5 6206.8 6198.9 6200.2 6203.1 6205.8 6216.0 6206.9 6222.3 6257.6 6258.4 6259.3 5984.3 6056.4 6069.9 6098.2 6133.4 6039.7 6066.6 6108.4 6143.6 6146.5 5355.5 5870.0 5992.1 5996.5 6042.5 5988.8 6086.2 6092.9 6121.1 6127.4 5896.4 5899.3 5958.5 5961.0 5966.6 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:68217.38 Median:40565.30 stddev:147374.58 (363.3%) stddev-sans-first:147700.22 14:11:06 INFO - PROCESS | 1657 | Values: 468.2 469.7 515.5 516.9 535.5 29608.6 31432.5 31454.5 33407.7 42315.6 42592.8 43148.8 43263.4 43280.8 43287.8 9512.2 9606.0 9698.3 9714.9 9726.3 9582.6 9612.9 9629.8 9737.7 9757.6 9672.2 9740.5 9742.8 9761.7 9771.8 9676.2 9728.3 9734.0 9736.5 9746.8 8242.7 9430.5 9509.7 9511.2 9531.0 40417.4 40730.8 40848.6 40934.8 41092.6 3371.4 3392.8 3413.3 3426.8 3437.4 30432.9 30717.8 30904.4 31234.0 31695.7 3153.2 3188.4 3188.7 3214.7 3321.6 476527.0 476938.0 476982.6 479894.0 480064.0 60595.7 60896.4 60923.7 61011.8 61019.7 34218.1 34562.0 34987.3 63985.7 64289.0 15709.3 16104.4 16143.0 16154.8 16168.4 12388.6 12481.1 12483.4 12487.0 12503.6 19412.8 19479.3 19513.0 19607.6 19646.0 6762.6 7925.6 7967.6 8031.5 8042.8 830.8 890.3 960.9 962.3 1067.8 29133.8 30165.8 30284.7 30971.8 31000.7 995.5 1013.4 1025.2 1033.9 1151.2 15198.2 15825.0 16034.5 16035.5 16194.0 546282.0 628989.0 631635.0 633238.0 633242.0 57879.7 58798.0 58833.0 58844.8 58882.7 1330.6 1383.1 1391.6 1397.8 1400.0 29073.9 29439.7 29613.0 30162.8 30387.0 51599.7 51683.2 51699.5 51833.5 51840.7 551496.0 553727.0 553828.0 554878.0 555461.0 26352.6 26769.7 26773.6 26789.9 26810.7 45697.5 47752.0 48833.5 48918.0 48958.8 38450.8 38920.2 39240.8 40695.0 40763.4 39354.0 40115.8 40224.0 40390.4 40435.6 38091.4 38244.0 38732.4 38738.4 39289.4 33235.7 34012.3 34561.0 34615.1 34804.0 24703.0 25366.1 25399.0 25803.4 25824.5 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34180.49 Median:14083.44 stddev:96330.16 (684.0%) stddev-sans-first:96566.84 14:11:06 INFO - PROCESS | 1657 | Values: 321.3 349.9 368.1 376.1 403.0 14781.6 15019.3 15726.2 19808.5 20152.3 19257.9 20198.3 20198.4 20447.5 20698.0 5709.8 6065.0 6077.4 6078.0 6082.8 4818.9 5994.1 6047.4 6057.9 6066.2 5692.5 5996.4 6003.1 6010.7 6022.9 5834.3 5953.6 5966.1 5973.7 5986.2 4906.4 5004.6 5039.7 5111.3 5196.2 25751.1 25790.0 25805.8 25992.4 26042.3 2237.8 2237.9 2385.5 2391.9 2415.8 14932.9 15466.4 15546.0 15817.9 16217.2 1804.2 1821.5 1847.4 1849.1 1898.2 111323.4 113779.2 116163.0 116305.0 119757.4 11297.0 11394.5 11540.7 11604.8 11652.0 14640.3 14649.3 14650.1 14658.0 14692.0 8247.0 8410.8 8445.0 8463.8 8576.9 7035.9 8256.8 8274.0 8425.6 8480.5 4309.8 4574.6 4608.7 4612.9 4624.9 1653.5 1892.4 1928.3 1939.5 1942.8 818.0 905.2 912.0 961.5 962.4 20500.7 21144.3 21205.5 21279.9 21286.7 942.6 945.3 969.6 1003.2 1013.6 8299.7 9600.9 10349.6 11028.6 11154.0 571697.0 573945.0 576329.0 576912.7 584264.1 121068.8 125992.5 128598.0 130510.0 132041.0 892.6 940.4 959.3 1017.8 1027.3 16151.1 18300.3 19162.0 19346.1 19516.9 34095.0 44847.1 50633.0 53917.2 54756.7 60244.0 75191.6 79683.2 79914.8 82529.0 6822.8 7957.9 8254.5 8339.6 8562.6 11929.7 12278.3 12835.0 13484.0 13660.8 10528.3 11297.5 11546.9 11900.4 11952.0 11220.9 11224.9 11546.9 11548.2 11743.4 9586.7 11662.8 11728.4 11771.3 12014.4 7031.8 7304.4 7476.3 7515.7 7741.9 10652.1 11536.0 11550.4 11788.6 11862.6 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5537.53 Median:5029.34 stddev:3136.74 (62.4%) stddev-sans-first:3129.72 14:11:06 INFO - PROCESS | 1657 | Values: 1345.2 1394.7 1502.0 1674.3 1868.2 7714.4 8084.1 8244.5 8655.1 8692.3 8514.9 8601.2 8612.2 8622.5 8656.4 2321.4 2339.4 2345.4 2347.8 2348.2 2321.5 2365.4 2381.1 2383.7 2386.5 2098.4 2189.9 2320.0 2343.1 2344.5 2294.4 2295.9 2324.0 2326.8 2330.2 2004.6 2328.2 2341.8 2345.2 2351.2 8580.0 8664.0 8665.3 8695.3 8697.4 5122.2 5324.6 5325.5 5357.0 5369.8 3471.5 3592.5 3654.3 3659.7 3704.6 921.4 1036.3 1038.6 1082.8 1086.2 11392.6 11427.4 11502.5 11515.4 11529.7 4202.0 4441.7 4510.8 4532.3 4538.7 8745.5 8814.4 8881.2 8892.8 8903.3 5161.8 5163.7 5173.3 5173.6 5190.8 3851.7 4362.3 4498.0 4852.9 4865.6 3188.6 3345.8 3621.6 3659.5 3722.0 1021.4 1138.7 1142.3 1143.7 1164.1 903.7 904.6 915.3 952.8 958.7 5603.4 5718.8 5902.1 6039.6 6067.7 364.8 400.4 429.1 432.3 443.8 3835.0 3836.9 3843.7 3933.1 3958.2 10240.6 10571.9 10685.1 10704.6 10706.9 10620.4 10622.1 10647.3 10651.3 10653.0 7625.4 8048.8 8113.8 8227.0 8230.6 5438.7 5723.9 5993.9 6037.4 6078.4 9362.5 9647.2 9688.4 9729.6 9849.2 9051.6 9802.1 9939.4 9967.2 9974.1 6734.5 6905.7 7113.0 7120.1 7410.2 7839.1 8145.2 8199.2 8228.5 8316.8 7290.6 7330.1 7349.3 7382.1 7437.3 5805.8 6942.3 7214.0 7321.2 7420.5 6815.0 6816.7 6902.2 6926.3 6930.7 4229.5 4863.1 4948.7 4998.7 5129.7 4315.3 4901.8 4989.5 5060.0 5065.4 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4450.38 Median:5054.11 stddev:1359.45 (26.9%) stddev-sans-first:1326.57 14:11:06 INFO - PROCESS | 1657 | Values: 270.4 297.9 297.9 306.1 312.0 4657.5 4954.0 4974.6 5038.2 5236.4 4206.1 4567.8 5004.2 5084.8 5149.3 3472.8 3527.7 3997.5 4015.1 4015.2 3177.5 4005.4 4023.6 4033.9 4055.7 3291.8 3703.7 3955.0 3976.0 4020.5 3900.2 3914.4 3958.2 3970.8 4007.5 3173.0 3219.4 3439.7 3456.9 3463.3 4075.8 5085.1 5145.3 5159.8 5162.4 3958.8 4516.5 4517.8 4532.8 4559.0 5409.8 5425.8 5515.6 5517.6 5532.4 3308.8 3463.9 3737.5 3757.4 3771.2 5660.5 5719.3 5728.9 5755.7 5757.4 3967.9 3977.2 3990.5 3990.9 3992.5 3842.9 3991.6 4016.2 4042.5 4048.8 4574.9 4621.7 4626.7 4633.9 4634.6 5534.6 5545.5 5550.3 5561.3 5572.6 1204.5 1286.0 1325.1 1346.3 1354.4 807.5 910.9 940.4 940.7 950.8 5113.2 5129.0 5132.4 5182.4 5200.2 5058.4 5635.6 5638.4 5643.0 5656.0 4329.8 4953.8 4967.8 5175.4 5221.5 2494.3 2636.8 2933.3 2951.5 2999.4 5068.5 5117.6 5653.7 5797.7 5821.5 4675.3 5476.6 5760.8 5761.7 5794.2 5173.5 5549.5 5793.4 5830.5 5844.4 4999.2 5020.0 5381.5 5622.1 5669.8 4827.5 5486.4 5570.7 5570.7 5575.3 4635.9 5430.3 5500.4 5746.7 5786.8 3585.3 3667.8 3778.9 3818.9 3826.6 5154.3 5613.9 5623.3 5639.9 5696.4 4885.7 5476.9 5480.3 5497.5 5497.8 4702.7 4737.8 5486.4 5535.4 5542.6 4328.5 5190.5 5271.4 5327.8 5352.9 5489.4 5493.2 5518.4 5525.0 5544.5 5049.8 5093.7 5141.7 5398.5 5408.8 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:19395.33 Median:55450.71 stddev:28207.84 (50.9%) stddev-sans-first:28252.33 14:11:06 INFO - PROCESS | 1657 | Values: 776.4 780.4 808.1 836.0 861.8 14619.8 14708.6 15113.8 15162.6 15347.6 13872.7 14126.9 14144.4 14172.6 14189.5 839.8 858.9 862.8 873.1 876.8 875.2 880.4 880.5 882.0 882.2 927.9 928.1 929.1 929.2 930.5 902.7 922.1 923.6 924.5 924.8 684.6 685.2 685.4 685.9 686.2 14470.9 14689.4 14876.6 14880.3 14995.7 13620.6 13693.0 13756.0 13882.3 13987.5 11317.9 11596.4 11807.7 11828.0 12253.9 3683.3 3688.2 3698.0 3702.8 3855.2 54343.5 57592.1 75796.6 77867.0 89930.6 10790.4 10879.9 10887.6 10936.8 11082.9 20686.5 20768.7 20774.7 20859.2 20938.8 6904.4 7666.6 8088.7 8090.2 8104.3 4199.9 4326.4 4395.8 4516.4 4544.7 3508.7 3581.6 3605.0 3637.5 3649.4 667.9 668.4 670.0 670.8 685.4 569.1 634.1 657.8 658.7 671.7 8676.6 9143.7 9174.1 9281.6 9297.6 581.8 617.5 631.4 654.5 666.4 4417.0 4549.9 4575.5 4582.7 4594.5 99368.5 109398.0 114509.4 116879.4 121361.0 64961.7 67123.0 75060.0 84693.0 104841.0 81699.0 82785.3 83460.6 83642.6 84521.0 8459.2 8594.0 8609.7 8811.5 8916.4 52104.5 52481.0 54687.7 56213.7 57045.3 53002.7 68072.7 75178.9 77026.0 78560.2 10883.3 11004.9 11080.5 11190.4 11409.7 11941.5 11948.2 12064.8 12090.6 12352.4 11685.6 11806.3 11838.9 12195.5 12201.3 11649.8 11778.2 11864.1 12156.9 12172.4 11134.4 11421.4 11613.8 11942.5 11943.4 9568.6 9581.6 9733.0 9960.2 10094.3 8174.3 8424.5 8749.7 9343.3 9952.0 14:11:06 INFO - PROCESS | 1657 | -------- Summary: end -------- 14:11:06 INFO - PROCESS | 1657 | 14:11:06 INFO - TEST-INFO | 1657: exit 0 14:11:06 INFO - TEST-OK | dromaeo_css | took 1119260ms 14:11:06 INFO - TEST-START | kraken 14:11:06 INFO - operating with platform_type : mac_ 14:11:06 INFO - Initialising browser for kraken test... 14:11:06 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpepcfRC/profile http://localhost:49273/getInfo.html) 14:11:08 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 14:11:08 INFO - PROCESS | 1662 | colorDepth:24 14:11:08 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 14:11:08 INFO - PROCESS | 1662 | __metrics 14:11:08 INFO - PROCESS | 1662 | 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:08 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:11:09 INFO - TEST-INFO | 1662: exit 0 14:11:09 INFO - Browser initialized. 14:11:09 INFO - Running cycle 1/1 for kraken test... 14:11:09 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpepcfRC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:21 INFO - PROCESS | 1663 | RSS: Main: 230391808 14:11:21 INFO - PROCESS | 1663 | 14:11:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:25 INFO - PROCESS | 1663 | RSS: Main: 290193408 14:11:25 INFO - PROCESS | 1663 | 14:11:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 14:11:28 INFO - PROCESS | 1663 | RSS: Main: 291020800 14:11:28 INFO - PROCESS | 1663 | 14:11:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 14:11:32 INFO - PROCESS | 1663 | RSS: Main: 381566976 14:11:32 INFO - PROCESS | 1663 | 14:11:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 14:11:35 INFO - PROCESS | 1663 | RSS: Main: 287006720 14:11:35 INFO - PROCESS | 1663 | 14:11:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:37 INFO - PROCESS | 1663 | RSS: Main: 288739328 14:11:37 INFO - PROCESS | 1663 | 14:11:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:41 INFO - PROCESS | 1663 | RSS: Main: 325652480 14:11:41 INFO - PROCESS | 1663 | 14:11:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:44 INFO - PROCESS | 1663 | RSS: Main: 327704576 14:11:44 INFO - PROCESS | 1663 | 14:11:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 14:11:48 INFO - PROCESS | 1663 | RSS: Main: 325521408 14:11:48 INFO - PROCESS | 1663 | 14:11:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:50 INFO - PROCESS | 1663 | RSS: Main: 302051328 14:11:50 INFO - PROCESS | 1663 | 14:11:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:53 INFO - PROCESS | 1663 | RSS: Main: 303218688 14:11:53 INFO - PROCESS | 1663 | 14:11:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:55 INFO - PROCESS | 1663 | RSS: Main: 313098240 14:11:55 INFO - PROCESS | 1663 | 14:11:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:59 INFO - PROCESS | 1663 | RSS: Main: 318324736 14:11:59 INFO - PROCESS | 1663 | 14:12:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:03 INFO - PROCESS | 1663 | RSS: Main: 318107648 14:12:03 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 14:12:05 INFO - PROCESS | 1663 | RSS: Main: 362237952 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | __start_tp_report 14:12:05 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 14:12:05 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 14:12:05 INFO - PROCESS | 1663 | |i|pagename|runs| 14:12:05 INFO - PROCESS | 1663 | |0;ai-astar;111;114;113;113;112;114;114;113;112;112 14:12:05 INFO - PROCESS | 1663 | |1;audio-beat-detection;151;110;112;154;142;112;112;109;130;118 14:12:05 INFO - PROCESS | 1663 | |2;audio-dft;181;182;184;187;184;186;182;186;182;182 14:12:05 INFO - PROCESS | 1663 | |3;audio-fft;80;63;82;113;62;60;58;60;85;58 14:12:05 INFO - PROCESS | 1663 | |4;audio-oscillator;90;71;96;68;67;69;93;67;68;90 14:12:05 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;91;86;93;92;92;87;91;88;91;87 14:12:05 INFO - PROCESS | 1663 | |6;imaging-darkroom;139;100;98;99;98;98;97;98;98;99 14:12:05 INFO - PROCESS | 1663 | |7;imaging-desaturate;82;84;79;83;85;87;129;130;80;87 14:12:05 INFO - PROCESS | 1663 | |8;json-parse-financial;57;55;55;55;55;56;57;55;56;55 14:12:05 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;74;68;66;76;74;67;71;68;68;70 14:12:05 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;91;91;91;89;85;88;84;91;88;88 14:12:05 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;144;147;148;141;146;145;144;145;181;146 14:12:05 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;174;170;172;178;172;173;173;170;171;173 14:12:05 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;70;69;69;69;68;69;84;84;85;84 14:12:05 INFO - PROCESS | 1663 | __end_tp_report 14:12:05 INFO - PROCESS | 1663 | __start_cc_report 14:12:05 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2078 14:12:05 INFO - PROCESS | 1663 | __end_cc_report 14:12:05 INFO - PROCESS | 1663 | __startTimestamp1477516325306__endTimestamp 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | ------- Summary: start ------- 14:12:05 INFO - PROCESS | 1663 | Number of tests: 14 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 14:12:05 INFO - PROCESS | 1663 | Values: 111.0 114.0 113.0 113.0 112.0 114.0 114.0 113.0 112.0 112.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:124.00 stddev:17.85 (14.4%) stddev-sans-first:16.27 14:12:05 INFO - PROCESS | 1663 | Values: 151.0 110.0 112.0 154.0 142.0 112.0 112.0 109.0 130.0 118.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:2.12 (1.2%) stddev-sans-first:2.03 14:12:05 INFO - PROCESS | 1663 | Values: 181.0 182.0 184.0 187.0 184.0 186.0 182.0 186.0 182.0 182.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:72.10 Median:62.50 stddev:17.87 (28.6%) stddev-sans-first:18.73 14:12:05 INFO - PROCESS | 1663 | Values: 80.0 63.0 82.0 113.0 62.0 60.0 58.0 60.0 85.0 58.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:80.50 stddev:12.51 (15.5%) stddev-sans-first:12.48 14:12:05 INFO - PROCESS | 1663 | Values: 90.0 71.0 96.0 68.0 67.0 69.0 93.0 67.0 68.0 90.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:91.00 stddev:2.53 (2.8%) stddev-sans-first:2.65 14:12:05 INFO - PROCESS | 1663 | Values: 91.0 86.0 93.0 92.0 92.0 87.0 91.0 88.0 91.0 87.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:102.40 Median:98.00 stddev:12.89 (13.1%) stddev-sans-first:0.87 14:12:05 INFO - PROCESS | 1663 | Values: 139.0 100.0 98.0 99.0 98.0 98.0 97.0 98.0 98.0 99.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:83.50 stddev:19.63 (23.5%) stddev-sans-first:20.44 14:12:05 INFO - PROCESS | 1663 | Values: 82.0 84.0 79.0 83.0 85.0 87.0 129.0 130.0 80.0 87.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.73 14:12:05 INFO - PROCESS | 1663 | Values: 57.0 55.0 55.0 55.0 55.0 56.0 57.0 55.0 56.0 55.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:3.43 (4.9%) stddev-sans-first:3.35 14:12:05 INFO - PROCESS | 1663 | Values: 74.0 68.0 66.0 76.0 74.0 67.0 71.0 68.0 68.0 70.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:90.00 stddev:2.55 (2.8%) stddev-sans-first:2.55 14:12:05 INFO - PROCESS | 1663 | Values: 91.0 91.0 91.0 89.0 85.0 88.0 84.0 91.0 88.0 88.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:146.00 stddev:11.51 (7.9%) stddev-sans-first:12.08 14:12:05 INFO - PROCESS | 1663 | Values: 144.0 147.0 148.0 141.0 146.0 145.0 144.0 145.0 181.0 146.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.00 stddev:2.32 (1.3%) stddev-sans-first:2.40 14:12:05 INFO - PROCESS | 1663 | Values: 174.0 170.0 172.0 178.0 172.0 173.0 173.0 170.0 171.0 173.0 14:12:05 INFO - PROCESS | 1663 | 14:12:05 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:77.00 stddev:7.89 (10.3%) stddev-sans-first:8.15 14:12:05 INFO - PROCESS | 1663 | Values: 70.0 69.0 69.0 69.0 68.0 69.0 84.0 84.0 85.0 84.0 14:12:05 INFO - PROCESS | 1663 | -------- Summary: end -------- 14:12:05 INFO - PROCESS | 1663 | 14:12:06 INFO - TEST-INFO | 1663: exit 0 14:12:06 INFO - TEST-OK | kraken | took 59601ms 14:12:06 INFO - SUITE-END | took 1178s 14:12:06 INFO - Completed test suite (00:19:39) 14:12:06 INFO - javascript benchmark 14:12:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.248537924002, 3050.1764523578636, 3327.0684208421635, 3366.747493937952, 3373.61203461602, 5590.608657393984, 5637.774489020434, 5683.630564013336, 5710.9714451427735, 5734.856628584287, 5664.291963504562, 5700.942990570093, 5753.626014309067, 5787.884242315151, 5789.652620842763, 5076.416212135597, 5077.695338279696, 5131.743412829363, 5179.948200517984, 5189.8183563575285, 5255.947440525584, 5259.947400526004, 5281.735913204344, 5282.603804714642, 5297.629165958385, 5087.592992560586, 5252.395974462909, 5264.341957255343, 5295.973520132394, 5343.145096784515, 5148.3564554430695, 5192.61055420845, 5202.08963431398, 5203.323567936182, 5207.791688332462, 4334.0, 5074.4671809460215, 5164.251183578398, 5167.7932882684645, 5182.870428239286, 5673.149027645845, 5676.2620859288445, 5685.147227915804, 5689.345725241609, 5712.485876271156, 6146.815595532141, 6147.309489890316, 6147.801178770142, 6153.4154255345675, 6160.1375807387, 6130.371434844235, 6151.846203844895, 6168.96915515424, 6174.629522228635, 6228.065790131516, 5113.565346945514, 5605.327360716699, 5793.246877905845, 5803.883922321615, 5807.448292412257, 6236.251649802053, 6260.530460215502, 6293.937060629427, 6302.212223472066, 6312.873742525124, 5997.070454079625, 6054.51563874889, 6063.969680151659, 6101.694915254219, 6147.72335244915, 6162.0, 6199.814005579839, 6206.503479721611, 6221.906671399933, 6237.376262373727, 6201.689915504297, 6208.286047104551, 6217.191765070512, 6218.0, 6228.5017198624, 6076.936536106164, 6143.692815359214, 6215.0, 6223.284322302993, 6232.719527621268, 4844.709317440965, 4847.491013443538, 4848.248521479177, 4853.150698627726, 4855.927161092586, 4259.190753756839, 4412.161689279091, 4416.205083085011, 4457.621102206349, 4459.843905463294, 5703.116017017369, 5727.5990680652785, 5747.792963477633, 5747.879163563149, 5771.451712087345, 6159.96920015406, 6160.845978850475, 6162.921488739453, 6165.722542485599, 6169.784057557964, 5724.284464441945, 5735.4551317624755, 5795.130730390475, 5801.9129713054335, 5819.563532734977, 4043.332850079763, 4548.56788605082, 5403.594730395236, 5444.537214336826, 5452.263944367539, 6220.191375121205, 6235.532335074888, 6258.561900666909, 6261.843453913598, 6265.373462653789, 6158.065320368985, 6196.752129914753, 6211.316755156839, 6217.036359364306, 6223.626582405071, 6121.087175196906, 6158.983767678283, 6173.47525460323, 6183.505319574513, 6206.751729930752, 6198.938010619836, 6200.193974783249, 6203.069539569101, 6205.751769929152, 6215.96892015537, 6206.937930620817, 6222.253329600477, 6257.624542527463, 6258.374162583706, 6259.311475737756, 5984.341722410444, 6056.394360563909, 6069.9089513656445, 6098.207233059674, 6133.355997620186, 6039.667818270037, 6066.605670631571, 6108.389161083856, 6143.603994442082, 6146.5248340398875, 5355.544778693855, 5870.031444811559, 5992.101184822312, 5996.520278377807, 6042.546808989431, 5988.790392336247, 6086.178365920721, 6092.8781424372155, 6121.081837724377, 6127.356627554221, 5896.410358964069, 5899.262592175978, 5958.523318134626, 5961.0, 5966.642001479925], "value": 5648.76733618499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.17367346633176, 469.72286351052884, 515.4664921805931, 516.9325343166358, 535.4859335038363, 29608.555871661916, 31432.52851207234, 31454.528182077258, 33407.66592334076, 42315.576844231546, 42592.78703606485, 43148.784256078674, 43263.35104973428, 43280.78359608205, 43287.78356108215, 9512.191463725574, 9606.039396060372, 9698.321117521777, 9714.854277185848, 9726.319157658967, 9582.616695332214, 9612.90387096127, 9629.807403851919, 9737.707868763948, 9757.560909759042, 9672.22622190223, 9740.51297435129, 9742.756431089208, 9761.707148785548, 9771.755706107333, 9676.225901927864, 9728.319017668766, 9733.951330243339, 9736.464494452803, 9746.75633109178, 8242.670293188265, 9430.528473576362, 9509.66716164931, 9511.239100871913, 9531.046895310483, 40417.39373909394, 40730.796346018375, 40848.59151408478, 40934.79532602348, 41092.58907410917, 3371.4268574342423, 3392.8473218705217, 3413.2661477782394, 3426.7601267911255, 3437.3812713711523, 30432.891559639385, 30717.846410767805, 30904.381912361852, 31234.0, 31695.683043169505, 3153.243221626816, 3188.3942051010467, 3188.6651901550467, 3214.6624604416434, 3321.5681961345113, 476527.0, 476938.0, 476982.61508692236, 479894.0, 480064.0, 60595.697021514614, 60896.39103608907, 60923.69538152281, 61011.81399581085, 61019.6949015261, 34218.14454638654, 34561.96314110581, 34987.30025399478, 63985.680071600276, 64289.0, 15709.293081811118, 16104.436344727877, 16143.0, 16154.838451615333, 16168.434104806276, 12388.56640017595, 12481.063920206021, 12483.438245278985, 12487.0, 12503.562375317002, 19412.804741389988, 19479.325578044165, 19513.024348782503, 19607.607907825462, 19646.0, 6762.560433571901, 7925.630176985872, 7967.601619918981, 8031.518108913484, 8042.758717238492, 830.7715378271024, 890.2610833008588, 960.8606752020918, 962.2879069488667, 1067.8307253557343, 29133.834646613897, 30165.849170754005, 30284.697153028188, 30971.845140774603, 31000.68999310023, 995.4773743784426, 1013.3869009249445, 1025.2413214221422, 1033.8862725100232, 1151.1999160583314, 15198.16248877586, 15825.0, 16034.469033593276, 16035.518934431986, 16194.0, 546282.0, 628989.0, 631635.0, 633238.0, 633242.0, 57879.710601447565, 58798.0, 58833.0, 58844.82310353769, 58882.70558647265, 1330.5941687785319, 1383.087162472763, 1391.6173052410668, 1397.804307396945, 1400.0199860097973, 29073.85463072671, 29439.705602943697, 29613.0, 30162.84918575393, 30387.0, 51599.742001291255, 51683.22475162951, 51699.483005169466, 51833.481665182866, 51840.703982400744, 551496.0, 553727.0, 553828.0, 554878.0, 555461.0, 26352.60471092897, 26769.732302676723, 26773.598396023684, 26789.86605066962, 26810.731892681604, 45697.54302456933, 47752.0, 48833.5116648829, 48918.0, 48958.75520622374, 38450.807745961094, 38920.221595568495, 39240.803795980835, 40695.0, 40763.38854917238, 39354.0, 40115.7940732505, 40224.0, 40390.39414408845, 40435.595644043184, 38091.42862857115, 38244.0, 38732.41901371425, 38738.4189237156, 39289.410658839566, 33235.66764332326, 34012.31975360528, 34561.0, 34615.13462163365, 34804.0, 24703.0, 25366.1121860734, 25399.0, 25803.354916126496, 25824.483510330065], "value": 19783.377184101068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.33804363012194, 349.8635532142466, 368.0798004987531, 376.1348897535667, 402.9677625789937, 14781.630459238524, 15019.32413041413, 15726.213689315531, 19808.504787380287, 20152.294669686566, 19257.903710481463, 20198.29305974291, 20198.39404817858, 20447.488812779688, 20697.96510174489, 5709.77160913564, 6065.029595264758, 6077.361877002917, 6078.0, 6082.756689732428, 4818.9157439576165, 5994.130851026599, 6047.3650266722025, 6057.939420605781, 6066.181065556159, 5692.487676109149, 5996.370381109986, 6003.0695242237525, 6010.729517171716, 6022.939770602282, 5834.329052159013, 5953.553483488712, 5966.134910438005, 5973.701314934257, 5986.2217911671205, 4906.411230652309, 5004.649674522785, 5039.697618142886, 5111.284420181178, 5196.194589838581, 25751.098711545194, 25789.968401263926, 25805.83873725668, 25992.37474930002, 26042.34894127643, 2237.8433509654333, 2237.865728056322, 2385.546746118232, 2391.868447235401, 2415.7825795678473, 14932.925335373253, 15466.381344746196, 15546.0, 15817.920910395489, 16217.189140542925, 1804.2151664026192, 1821.5355084453513, 1847.3534263007973, 1849.112426035497, 1898.2027548429692, 111323.44338278337, 113779.19744459938, 116163.0, 116304.99999999916, 119757.40121299424, 11297.039751621205, 11394.487248073856, 11540.653780386601, 11604.825927611093, 11652.0, 14640.267986600627, 14649.26753662334, 14650.120992740469, 14658.0, 14692.0, 8247.0, 8410.789730256793, 8445.0, 8463.788405289793, 8576.914230857736, 7035.874260118459, 8256.793580160544, 8273.958630206811, 8425.578721063923, 8480.491170529787, 4309.762963037063, 4574.627611716472, 4608.654350923627, 4612.86161415158, 4624.884377890579, 1653.4708893154316, 1892.3565987564293, 1928.2576208159678, 1939.4957311099215, 1942.7862935077412, 817.9836403271901, 905.212465155306, 911.9726408207764, 961.5144352102144, 962.3696478806393, 20500.69248961267, 21144.259950901644, 21205.469863253544, 21279.893600531897, 21286.680699789515, 942.6229508196639, 945.2626950978248, 969.6266937229218, 1003.19744204636, 1013.5692330759398, 8299.672052471575, 9600.903990960001, 10349.586016559404, 11028.613998510014, 11153.996140347408, 571697.0, 573945.0, 576329.0, 576912.6901479273, 584264.0786796039, 121068.78931210576, 125992.46912290562, 128598.0, 130510.0, 132041.0, 892.5804871710286, 940.4122423485321, 959.2565761534867, 1017.765913839821, 1027.2655051637964, 16151.111688857225, 18300.267989280812, 19162.0, 19346.129424176226, 19516.933238360172, 34095.0, 44847.10305793931, 50633.0, 53917.19124213218, 54756.72621636866, 60244.0, 75191.62404187943, 79683.2031679699, 79914.80127798204, 82529.0, 6822.829429264308, 7957.920420795718, 8254.463459875089, 8339.624716887633, 8562.57187140653, 11929.701757456132, 12278.263304201777, 12835.0, 13484.0, 13660.795088073886, 10528.263021588722, 11297.491612877604, 11546.94226528862, 11900.404979750805, 11952.043836493234, 11220.887791121984, 11224.887751122384, 11546.884531154918, 11548.153612325345, 11743.412829358327, 9586.712398628053, 11662.76674466489, 11728.41357932083, 11771.293722376684, 12014.399280036137, 7031.7890463286185, 7304.423925096142, 7476.327130558276, 7515.670142255918, 7741.92258077412, 10652.09457196147, 11535.957295586079, 11550.364729939934, 11788.646340609796, 11862.584809531625], "value": 9533.082235948064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.1996062342903, 1394.6931675031492, 1501.954941351759, 1674.3135314521048, 1868.2153495531884, 7714.382849372051, 8084.070331911832, 8244.505329680216, 8655.134486551342, 8692.261157801579, 8514.872276915852, 8601.225889669928, 8612.181842724947, 8622.482651040942, 8656.43733157346, 2321.3848330192513, 2339.438534751656, 2345.3784747042046, 2347.8004369628516, 2348.2368230325214, 2321.5008773113777, 2365.4033527368956, 2381.1189859751917, 2383.7497062808416, 2386.486905315357, 2098.3704888533457, 2189.9014544345464, 2319.9768002320016, 2343.121329501437, 2344.460774021976, 2294.44552563162, 2295.8507696999727, 2324.047140672333, 2326.8254880884, 2330.207729372013, 2004.6391649503084, 2328.2433209206906, 2341.8243631727687, 2345.2143531916827, 2351.2240960483173, 8580.013298470692, 8664.046954834963, 8665.263452606536, 8695.304375649996, 8697.391182617219, 5122.231665250205, 5324.627276090675, 5325.520703136736, 5356.973215133899, 5369.785208591652, 3471.461923401877, 3592.497050412944, 3654.305681920453, 3659.652333028358, 3704.555453345589, 921.3964853021282, 1036.3419228789774, 1038.6416686243233, 1082.837574363844, 1086.2450596835204, 11392.601258955896, 11427.428628568538, 11502.482388292547, 11515.36665483398, 11529.711757205969, 4202.0, 4441.733495990251, 4510.8424103127945, 4532.32015197723, 4538.704984176018, 8745.518996455128, 8814.427062240933, 8881.200691937756, 8892.777680558038, 8903.287736981156, 5161.819336323286, 5163.690178589297, 5173.32746742921, 5173.611979101583, 5190.766415511311, 3851.730378873452, 4362.323839804835, 4497.977510112429, 4852.927206091911, 4865.5864251539015, 3188.617365916105, 3345.815980121117, 3621.6378362163573, 3659.524261845996, 3721.962780372216, 1021.4484178543503, 1138.709629044605, 1142.2518250545907, 1143.7369405036723, 1164.0920082335792, 903.6520939438363, 904.5567671840882, 915.2632131134501, 952.766572189804, 958.6932181701928, 5603.439656034364, 5718.8070723709325, 5902.085176797603, 6039.577229593886, 6067.663949379433, 364.7629041123291, 400.35542776130404, 429.1181621767298, 432.2737800495198, 443.7537166872352, 3835.0, 3836.9040773980873, 3843.7309388343106, 3933.0757272041046, 3958.2083583283456, 10240.641577544899, 10571.94714026425, 10685.091767199876, 10704.625338113128, 10706.892931070746, 10620.362778233177, 10622.097121744739, 10647.307924985005, 10651.30766500175, 10652.987966143204, 7625.428092893055, 8048.839023219386, 8113.837723245502, 8227.0, 8230.62962166692, 5438.673679579238, 5723.885522289447, 5993.940060599512, 6037.366076561898, 6078.3921607838865, 9362.48506332131, 9647.228221742103, 9688.370255933341, 9729.562169702522, 9849.212063034796, 9051.637934482547, 9802.068803463659, 9939.403635781877, 9967.202623789934, 9974.102330790263, 6734.4612431004425, 6905.723771049102, 7112.964435177791, 7120.074390329224, 7410.2219266978345, 7839.137694853447, 8145.185481451807, 8199.22107399796, 8228.465149765247, 8316.750497485085, 7290.5625662460425, 7330.120385553768, 7349.338559529668, 7382.077240344957, 7437.330640242404, 5805.79679711225, 6942.271061538466, 7214.0, 7321.158066822383, 7420.480566360303, 6814.965925170541, 6816.659167041727, 6902.171739391305, 6926.341997510229, 6930.683170197646, 4229.471316085489, 4863.124637565272, 4948.653594248368, 4998.700077995332, 5129.74351282427, 4315.331123675835, 4901.779419926183, 4989.451160372429, 5059.974700126623, 5065.39215294167], "value": 4362.65459483617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.41590165243076, 297.90467050543833, 297.94339075575647, 306.0939618728564, 311.9500879859223, 4657.461683382556, 4954.0, 4974.552290293873, 5038.244263360498, 5236.371635403752, 4206.107251736716, 4567.802538223249, 5004.249362595612, 5084.847454576359, 5149.274992877381, 3472.826358682062, 3527.694752941415, 3997.4603428537066, 4015.1367455996956, 4015.156817068419, 3177.4916013437855, 4005.3591425371947, 4023.637872591466, 4033.910844072099, 4055.7363771354917, 3291.8189499577516, 3703.68519675203, 3954.9604503955024, 3975.9602403976023, 4020.5376381716037, 3900.219956008781, 3914.4324073009398, 3958.208358328317, 3970.82131304092, 4007.5391329997133, 3172.9851544269322, 3219.4205043092234, 3439.7420193485336, 3456.913577160566, 3463.2727127303297, 4075.7758323292205, 5085.143922468309, 5145.253938178943, 5159.793608255665, 5162.406323272834, 3958.841646334143, 4516.548345165457, 4517.819287228507, 4532.750698711569, 4559.0, 5409.810656627039, 5425.83722488326, 5515.641483303572, 5517.5585953124055, 5532.446755324476, 3308.834558272101, 3463.9480407793903, 3737.4767532545466, 3757.380032294668, 3771.151490914522, 5660.490555849952, 5719.342275638313, 5728.914066289009, 5755.712214389306, 5757.366689664133, 3967.920641587152, 3977.164795393, 3990.521137463523, 3990.940135897964, 3992.461017762565, 3842.9231415371537, 3991.560928297885, 4016.168601136192, 4042.4946881639794, 4048.8380464781667, 4574.931376029363, 4621.653375996813, 4626.676132670748, 4633.86098417048, 4634.629229661619, 5534.584906132056, 5545.473180047889, 5550.250716153349, 5561.304836895388, 5572.637778544382, 1204.4943820224719, 1285.977647770025, 1325.1447972838105, 1346.3201083452989, 1354.4040622126233, 807.5195258820992, 910.8633704944178, 940.4498368454531, 940.6519587752439, 950.8067375443774, 5113.210376368242, 5128.974355128275, 5132.435432102466, 5182.4299327073995, 5200.193969934666, 5058.367704036996, 5635.605507614509, 5638.36325570005, 5643.0, 5655.971720141373, 4329.848455304049, 4953.777080031407, 4967.751612419364, 5175.353080864892, 5221.503957124067, 2494.301595553212, 2636.8022398320204, 2933.3399985003202, 2951.5277555591, 2999.4451026560155, 5068.493150684902, 5117.641765076483, 5653.745581448845, 5797.651950959784, 5821.505172060422, 4675.322078298627, 5476.644018138808, 5760.798372057042, 5761.683107429048, 5794.21778059965, 5173.456787037382, 5549.472800083986, 5793.36273009977, 5830.533557315404, 5844.444777746107, 4999.225120106389, 5019.9880071958, 5381.461853814587, 5622.100463925753, 5669.829905102853, 4827.493113223061, 5486.396496385474, 5570.6657600544095, 5570.716006437341, 5575.327401779531, 4635.860924172281, 5430.321209848769, 5500.4499550044675, 5746.712664366849, 5786.797462088806, 3585.3367127081574, 3667.7529639922554, 3778.9433158502093, 3818.94271585932, 3826.559945606291, 5154.329937108152, 5613.943860561505, 5623.325200975909, 5639.885043108834, 5696.401877802771, 4885.706857588556, 5476.863078423071, 5480.26016487785, 5497.505224529811, 5497.780088796563, 4702.683248690372, 4737.763111844463, 5486.354093771933, 5535.418781027934, 5542.612017158922, 4328.48058233014, 5190.532852043334, 5271.393789714232, 5327.815595605938, 5352.9464705354, 5489.39616642161, 5493.203485494501, 5518.392976772632, 5525.044101405729, 5544.500994910478, 5049.84850454487, 5093.668911520739, 5141.665791723526, 5398.464006076027, 5408.837734867803], "value": 4017.6350938525125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.4409625069951, 780.4479352517269, 808.1312588966862, 835.9582020898955, 861.8448679237739, 14619.78070328946, 14708.558743237692, 15113.848861511382, 15162.620934476643, 15347.61630959228, 13872.722545549108, 14126.858731412683, 14144.434222631082, 14172.645683857909, 14189.503367382118, 839.7900524868783, 858.8797568340422, 862.8015556422026, 873.1443185678039, 876.7939534209455, 875.2210532625968, 880.3969281042474, 880.5113162194979, 882.0473888200728, 882.1575395497284, 927.9489628070453, 928.1136514628514, 929.1126973740062, 929.2426672262119, 930.50683137937, 902.7156445719643, 922.1147698209727, 923.5659240157115, 924.4915296586851, 924.8104138651561, 684.6200358800863, 685.2496516314627, 685.3763075601179, 685.8833998220315, 686.2314208086925, 14470.927645361706, 14689.412423503047, 14876.62808429787, 14880.255987200597, 14995.700085998327, 13620.591382258548, 13693.0, 13756.0, 13882.270846832458, 13987.510437134652, 11317.886821131848, 11596.4201789911, 11807.704807379798, 11828.0, 12253.877461225451, 3683.28176005679, 3688.188598508324, 3698.0, 3702.777833330009, 3855.151866589346, 54343.45656543424, 57592.13611795827, 75796.62101689511, 77867.0, 89930.5503472485, 10790.352578845295, 10879.891201088047, 10887.564497420173, 10936.781264374667, 11082.944585277022, 20686.482837929172, 20768.68846967297, 20774.688379674317, 20859.1656333748, 20938.790612093682, 6904.447644188453, 7666.578338191453, 8088.676452941934, 8090.190980901981, 8104.27061564462, 4199.874003779892, 4326.394304797331, 4395.846145384896, 4516.36770852081, 4544.727316361029, 3508.7193024557973, 3581.5702115746276, 3605.0, 3637.4907512948207, 3649.434337677664, 667.9265280819106, 668.4351722794231, 670.0384947600112, 670.7987603718963, 685.3968507713181, 569.1150261343568, 634.0932466572752, 657.7599176300616, 658.664081318531, 671.6876652356677, 8676.566171691391, 9143.725688229364, 9174.082591740773, 9281.628734850665, 9297.628094876129, 581.8109114537792, 617.5461036138435, 631.4474834519796, 654.4927681047132, 666.3902529185838, 4416.955830441719, 4549.863504094882, 4575.5424457554645, 4582.679212455096, 4594.531594844052, 99368.50315748375, 109398.0, 114509.4274528622, 116879.41560292144, 121361.0, 64961.67519162374, 67123.0, 75060.0, 84693.0, 104841.0, 81699.0, 82785.27466263912, 83460.58269708612, 83642.5817870919, 84521.0, 8459.238668519863, 8594.0, 8609.741707748777, 8811.515366654896, 8916.375853690179, 52104.47895520996, 52480.95038099293, 54687.710913245486, 56213.718931405085, 57045.28864134083, 53002.734986326366, 68072.65963670348, 75178.8723169142, 77026.0, 78560.21439785758, 10883.346999180074, 11004.889951100387, 11080.501377437873, 11190.440477976232, 11409.657710268706, 11941.52233910634, 11948.223365481215, 12064.75870482603, 12090.576829810914, 12352.4441400139, 11685.64976798425, 11806.291622502677, 11838.940805295919, 12195.451204695988, 12201.267923924594, 11649.767004660029, 11778.17552771332, 11864.11019173548, 12156.939215303866, 12172.39138043112, 11134.443277835913, 11421.428928553372, 11613.825792612948, 11942.522299107939, 11943.402829858645, 9568.61725530971, 9581.568829402555, 9732.951335243279, 9960.1533869619, 10094.293399461967, 8174.346052315682, 8424.495151566398, 8749.737507874774, 9343.345965782602, 9952.0], "value": 7200.415496498008, "unit": "score"}], "name": "dromaeo_css", "value": 7157.627669413631, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 112.0, 114.0, 114.0, 113.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 110.0, 112.0, 154.0, 142.0, 112.0, 112.0, 109.0, 130.0, 118.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 184.0, 187.0, 184.0, 186.0, 182.0, 186.0, 182.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 63.0, 82.0, 113.0, 62.0, 60.0, 58.0, 60.0, 85.0, 58.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 96.0, 68.0, 67.0, 69.0, 93.0, 67.0, 68.0, 90.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 93.0, 92.0, 92.0, 87.0, 91.0, 88.0, 91.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 100.0, 98.0, 99.0, 98.0, 98.0, 97.0, 98.0, 98.0, 99.0], "value": 102.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 79.0, 83.0, 85.0, 87.0, 129.0, 130.0, 80.0, 87.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 56.0, 57.0, 55.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 66.0, 76.0, 74.0, 67.0, 71.0, 68.0, 68.0, 70.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 91.0, 89.0, 85.0, 88.0, 84.0, 91.0, 88.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 148.0, 141.0, 146.0, 145.0, 144.0, 145.0, 181.0, 146.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 172.0, 178.0, 172.0, 173.0, 173.0, 170.0, 171.0, 173.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 84.0, 84.0, 85.0, 84.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1466.9999999999998, "alertThreshold": 2.0}]} 14:12:06 INFO - Return code: 0 14:12:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:06 INFO - # TBPL SUCCESS # 14:12:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:06 INFO - 2016-10-26 14:12:06.584 screenresolution[1667:10562] starting screenresolution argv=screenresolution get 14:12:06 INFO - 2016-10-26 14:12:06.587 screenresolution[1667:10562] Display 0: 1600x1200x32@60 14:12:06 INFO - 2016-10-26 14:12:06.593 screenresolution[1668:10565] starting screenresolution argv=screenresolution list 14:12:06 INFO - Available Modes on Display 0 14:12:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:06 INFO - Intel Iris: 14:12:06 INFO - Chipset Model: Intel Iris 14:12:06 INFO - Type: GPU 14:12:06 INFO - Bus: Built-In 14:12:06 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:06 INFO - Vendor: Intel (0x8086) 14:12:06 INFO - Device ID: 0x0a2e 14:12:06 INFO - Revision ID: 0x0009 14:12:06 INFO - Displays: 14:12:06 INFO - Display: 14:12:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:06 INFO - Display Serial Number: 1600x1200 60 14:12:06 INFO - Main Display: Yes 14:12:06 INFO - Mirror: Off 14:12:06 INFO - Online: Yes 14:12:06 INFO - Rotation: Supported 14:12:06 INFO - Return code: 0 14:12:06 INFO - Running post-action listener: _resource_record_post_action 14:12:06 INFO - [mozharness: 2016-10-26 21:12:06.830415Z] Finished run-tests step (success) 14:12:06 INFO - Running post-run listener: _resource_record_post_run 14:12:06 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 32951296; Write bytes: 708850176; Read time: 308; Write time: 2167 14:12:06 INFO - TinderboxPrint: CPU usage
53.7% 14:12:06 INFO - TinderboxPrint: I/O read bytes / time
32,951,296 / 308 14:12:06 INFO - TinderboxPrint: I/O write bytes / time
708,850,176 / 2,167 14:12:06 INFO - TinderboxPrint: CPU idle
2,252.9 (46.3%) 14:12:06 INFO - TinderboxPrint: CPU system
975.6 (20.1%) 14:12:06 INFO - TinderboxPrint: CPU user
1,633.2 (33.6%) 14:12:06 INFO - TinderboxPrint: Swap in / out
435,138,560 / 0 14:12:06 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401660416; Write bytes: 392927232; Read time: 30472; Write time: 679 14:12:06 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30944256; Write bytes: 298447872; Read time: 287; Write time: 1425 14:12:07 INFO - Running post-run listener: _upload_blobber_files 14:12:07 INFO - Blob upload gear active. 14:12:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:07 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:07 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:07 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:07 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: 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 - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:12:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:12:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:09 INFO - (blobuploader) - INFO - Done attempting. 14:12:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:12 INFO - (blobuploader) - INFO - Done attempting. 14:12:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:12 INFO - Return code: 0 14:12:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/682ac4db81dbc9a8f013219322483e444b6119cf1b5b92378b3ee2590abb734e825f55f35eaa7172d6c408127ffd6e6674641db56fb7bb3e3580615c5d19d456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f526c5d2967bd9d0f7a242238e277abfb0023a81b817f75ba997440f61986027133ea227d7dc7804e24d3b6c93ae2b9b7cc5eb88dd74eba80bfca127a0e7e0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31413bd85f9a5974d63f51a4dc92a7b896244301ce912b7843c78ff10a47371cc69b7d29672694b5258f820fdee27bed0c47c8e35866e043197f7641559b89a"} 14:12:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:12 INFO - Contents: 14:12:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/682ac4db81dbc9a8f013219322483e444b6119cf1b5b92378b3ee2590abb734e825f55f35eaa7172d6c408127ffd6e6674641db56fb7bb3e3580615c5d19d456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f526c5d2967bd9d0f7a242238e277abfb0023a81b817f75ba997440f61986027133ea227d7dc7804e24d3b6c93ae2b9b7cc5eb88dd74eba80bfca127a0e7e0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31413bd85f9a5974d63f51a4dc92a7b896244301ce912b7843c78ff10a47371cc69b7d29672694b5258f820fdee27bed0c47c8e35866e043197f7641559b89a"} 14:12:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:12 INFO - Copying logs to upload dir... 14:12:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.073662 ========= master_lag: 2.80 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-10-26 14:12:15.683972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-10-26 14:12:15.687418) ========= 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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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/682ac4db81dbc9a8f013219322483e444b6119cf1b5b92378b3ee2590abb734e825f55f35eaa7172d6c408127ffd6e6674641db56fb7bb3e3580615c5d19d456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f526c5d2967bd9d0f7a242238e277abfb0023a81b817f75ba997440f61986027133ea227d7dc7804e24d3b6c93ae2b9b7cc5eb88dd74eba80bfca127a0e7e0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31413bd85f9a5974d63f51a4dc92a7b896244301ce912b7843c78ff10a47371cc69b7d29672694b5258f820fdee27bed0c47c8e35866e043197f7641559b89a"} 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.011185 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/682ac4db81dbc9a8f013219322483e444b6119cf1b5b92378b3ee2590abb734e825f55f35eaa7172d6c408127ffd6e6674641db56fb7bb3e3580615c5d19d456", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f526c5d2967bd9d0f7a242238e277abfb0023a81b817f75ba997440f61986027133ea227d7dc7804e24d3b6c93ae2b9b7cc5eb88dd74eba80bfca127a0e7e0e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e31413bd85f9a5974d63f51a4dc92a7b896244301ce912b7843c78ff10a47371cc69b7d29672694b5258f820fdee27bed0c47c8e35866e043197f7641559b89a"}' ========= master_lag: 4.85 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-10-26 14:12:20.550894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:20.554359) ========= 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.1mahsMJMu2/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.Uk4WEsb9GY/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005267 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:12:20.598806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:20.599141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:12:20.602772) ========= ========= Total master_lag: 7.76 =========