builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0385 starttime: 1485532573.28 results: success (0) buildid: 20170127053121 builduid: 54b7665bc9ae4b7db9b34c497838fa03 revision: f28c092abe746a9c7b39fb5c715141810a9c87d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.276397) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.287170) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.287491) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.315547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.315913) ========= 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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 07:56:13-- 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% 21.3M=0.001s 2017-01-27 07:56:13 (21.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.531308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.871473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.871814) ========= 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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.025019 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.920727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:13.921150) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f28c092abe746a9c7b39fb5c715141810a9c87d4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f28c092abe746a9c7b39fb5c715141810a9c87d4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zqxWAl7uTC/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.m9rxBYcsEX/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 07:56:14,032 truncating revision to first 12 chars 2017-01-27 07:56:14,032 Setting DEBUG logging. 2017-01-27 07:56:14,032 attempt 1/10 2017-01-27 07:56:14,032 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f28c092abe74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 07:56:14,711 unpacking tar archive at: mozilla-beta-f28c092abe74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:14.898332) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:14.898658) ========= script_repo_revision: f28c092abe746a9c7b39fb5c715141810a9c87d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:14.899134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:14.899411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 07:56:14.919046) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-27 07:56:14.919339) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zqxWAl7uTC/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.m9rxBYcsEX/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56:15 INFO - MultiFileLogger online at 20170127 07:56:15 in /builds/slave/test 07:56:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:56:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:15 INFO - {'append_to_log': False, 07:56:15 INFO - 'base_work_dir': '/builds/slave/test', 07:56:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:56:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:15 INFO - 'branch': 'Mozilla-Beta', 07:56:15 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:15 INFO - 'config_files': ('talos/mac_config.py',), 07:56:15 INFO - 'default_actions': ('clobber', 07:56:15 INFO - 'read-buildbot-config', 07:56:15 INFO - 'download-and-extract', 07:56:15 INFO - 'populate-webroot', 07:56:15 INFO - 'create-virtualenv', 07:56:15 INFO - 'install', 07:56:15 INFO - 'run-tests'), 07:56:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:15 INFO - 'download_minidump_stackwalk': True, 07:56:15 INFO - 'download_symbols': 'ondemand', 07:56:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:15 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:15 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:15 INFO - 'installer_path': 'installer.exe', 07:56:15 INFO - 'log_level': 'info', 07:56:15 INFO - 'log_name': 'talos', 07:56:15 INFO - 'log_to_console': True, 07:56:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:15 INFO - 'opt_config_files': (), 07:56:15 INFO - 'pip_index': False, 07:56:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:15 INFO - 'cmd': ('bash', 07:56:15 INFO - '-c', 07:56:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:15 INFO - 'enabled': True, 07:56:15 INFO - 'halt_on_failure': False, 07:56:15 INFO - 'name': 'check_screen_resolution'},), 07:56:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:15 INFO - 'cmd': ('bash', 07:56:15 INFO - '-c', 07:56:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:15 INFO - 'enabled': True, 07:56:15 INFO - 'halt_on_failure': False, 07:56:15 INFO - 'name': 'check_screen_resolution'},), 07:56:15 INFO - 'run_cmd_checks_enabled': True, 07:56:15 INFO - 'sps_profile': False, 07:56:15 INFO - 'sps_profile_interval': 0, 07:56:15 INFO - 'suite': 'dromaeojs', 07:56:15 INFO - 'system_bits': '32', 07:56:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:15 INFO - 'title': 't-yosemite-r7-0385', 07:56:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:15 INFO - 'use_talos_json': True, 07:56:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:15 INFO - 'work_dir': 'build'} 07:56:15 INFO - [mozharness: 2017-01-27 15:56:15.138570Z] Running clobber step. 07:56:15 INFO - Running pre-action listener: _resource_record_pre_action 07:56:15 INFO - Running main action method: clobber 07:56:15 INFO - rmtree: /builds/slave/test/build 07:56:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:17 INFO - Running post-action listener: _resource_record_post_action 07:56:17 INFO - [mozharness: 2017-01-27 15:56:17.610096Z] Finished clobber step (success) 07:56:17 INFO - [mozharness: 2017-01-27 15:56:17.610283Z] Running read-buildbot-config step. 07:56:17 INFO - Running pre-action listener: _resource_record_pre_action 07:56:17 INFO - Running main action method: read_buildbot_config 07:56:17 INFO - Using buildbot properties: 07:56:17 INFO - { 07:56:17 INFO - "project": "", 07:56:17 INFO - "product": "firefox", 07:56:17 INFO - "script_repo_revision": "production", 07:56:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:56:17 INFO - "repository": "", 07:56:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:56:17 INFO - "buildid": "20170127053121", 07:56:17 INFO - "pgo_build": "False", 07:56:17 INFO - "basedir": "/builds/slave/test", 07:56:17 INFO - "buildnumber": 9, 07:56:17 INFO - "slavename": "t-yosemite-r7-0385", 07:56:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:56:17 INFO - "platform": "yosemite_r7", 07:56:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:56:17 INFO - "branch": "mozilla-beta", 07:56:17 INFO - "repo_path": "releases/mozilla-beta", 07:56:17 INFO - "revision": "f28c092abe746a9c7b39fb5c715141810a9c87d4", 07:56:17 INFO - "stage_platform": "macosx64", 07:56:17 INFO - "builduid": "54b7665bc9ae4b7db9b34c497838fa03", 07:56:17 INFO - "slavebuilddir": "test" 07:56:17 INFO - } 07:56:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 07:56:17 INFO - Running post-action listener: _resource_record_post_action 07:56:17 INFO - [mozharness: 2017-01-27 15:56:17.616030Z] Finished read-buildbot-config step (success) 07:56:17 INFO - [mozharness: 2017-01-27 15:56:17.616254Z] Running download-and-extract step. 07:56:17 INFO - Running pre-action listener: _resource_record_pre_action 07:56:17 INFO - Running main action method: download_and_extract 07:56:17 INFO - mkdir: /builds/slave/test/build/tests 07:56:17 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')]} 07:56:17 INFO - trying https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 07:56:17 INFO - Downloading https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 07:56:18 INFO - Downloaded 1165 bytes. 07:56:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 07:56:18 INFO - Using the following test package requirements: 07:56:18 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:56:18 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 07:56:18 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 07:56:18 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:56:18 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 07:56:18 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 07:56:18 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 07:56:18 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 07:56:18 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 07:56:18 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 07:56:18 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 07:56:18 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 07:56:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:56:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:56:18 INFO - Fetch https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:56:19 INFO - Http code: 200 07:56:19 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 07:56:19 INFO - x-amz-cf-id: IVKcpTreVh09UdbyDHcyZiT-80OApV7tumN7jC5TaZYzaGOVYrmp5g== 07:56:19 INFO - x-amz-version-id: hn2tBuvxaJcbN9R8Ql9FhhIqimoy8DKV 07:56:19 INFO - Expected file size: 16087628 07:56:19 INFO - Obtained file size: 16087628 07:56:25 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:56:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 07:56:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 07:56:25 INFO - Fetch https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 07:56:26 INFO - Http code: 200 07:56:26 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 07:56:26 INFO - x-amz-cf-id: wLach7YaEu3sp6O0ETP4753BxueWL6IwJZAz_O0RVZpB_VUIt7Hayg== 07:56:26 INFO - x-amz-version-id: hn2tBuvxaJcbN9R8Ql9FhhIqimoy8DKV 07:56:26 INFO - Expected file size: 16087628 07:56:26 INFO - Obtained file size: 16087628 07:56:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 07:56:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 07:56:33 INFO - Fetch https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 07:56:34 INFO - Http code: 200 07:56:34 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 07:56:34 INFO - x-amz-cf-id: V_3kCR34jOworXSteuUc3uy7zLWY_aRFNsthVK3u1vXnWyKpVhHdJg== 07:56:34 INFO - x-amz-version-id: z0gfiPGPqYNAOP3mLND.sIpEq0WGt4ry 07:56:34 INFO - Expected file size: 14402992 07:56:34 INFO - Obtained file size: 14402992 07:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:34 INFO - trying https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:56:34 INFO - Downloading https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 07:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 07:56:37 INFO - Downloaded 82137688 bytes. 07:56:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:56:37 INFO - mkdir: /builds/slave/test/properties 07:56:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:37 INFO - Contents: 07:56:37 INFO - build_url:https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg 07:56:38 INFO - Running post-action listener: _resource_record_post_action 07:56:38 INFO - Running post-action listener: set_extra_try_arguments 07:56:38 INFO - [mozharness: 2017-01-27 15:56:38.515533Z] Finished download-and-extract step (success) 07:56:38 INFO - [mozharness: 2017-01-27 15:56:38.515663Z] Running populate-webroot step. 07:56:38 INFO - Running pre-action listener: _resource_record_pre_action 07:56:38 INFO - Running main action method: populate_webroot 07:56:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:38 INFO - '--tppagecycles', 07:56:38 INFO - '7'], 07:56:38 INFO - 'tests': ['tsvgm']}}, 07:56:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['damp', 'tps']}, 07:56:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'tests': ['damp', 'tps']}, 07:56:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['dromaeo_dom']}, 07:56:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['basic_compositor_video']}, 07:56:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['a11yr', 07:56:38 INFO - 'ts_paint', 07:56:38 INFO - 'tpaint', 07:56:38 INFO - 'sessionrestore', 07:56:38 INFO - 'sessionrestore_no_auto_restore', 07:56:38 INFO - 'tabpaint']}, 07:56:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:38 INFO - 'ts_paint', 07:56:38 INFO - 'tpaint', 07:56:38 INFO - 'sessionrestore', 07:56:38 INFO - 'sessionrestore_no_auto_restore', 07:56:38 INFO - 'tabpaint']}, 07:56:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:38 INFO - 'ts_paint', 07:56:38 INFO - 'tpaint', 07:56:38 INFO - 'sessionrestore', 07:56:38 INFO - 'sessionrestore_no_auto_restore', 07:56:38 INFO - 'tabpaint']}, 07:56:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:38 INFO - 'ts_paint', 07:56:38 INFO - 'tpaint', 07:56:38 INFO - 'sessionrestore', 07:56:38 INFO - 'sessionrestore_no_auto_restore', 07:56:38 INFO - 'tabpaint']}, 07:56:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['a11yr', 07:56:38 INFO - 'ts_paint', 07:56:38 INFO - 'tpaint', 07:56:38 INFO - 'sessionrestore', 07:56:38 INFO - 'sessionrestore_no_auto_restore', 07:56:38 INFO - 'tabpaint']}, 07:56:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['a11yr', 07:56:38 INFO - 'ts_paint', 07:56:38 INFO - 'tpaint', 07:56:38 INFO - 'sessionrestore', 07:56:38 INFO - 'sessionrestore_no_auto_restore', 07:56:38 INFO - 'tabpaint']}, 07:56:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['tsvgx', 07:56:38 INFO - 'tsvgr_opacity', 07:56:38 INFO - 'tart', 07:56:38 INFO - 'tscrollx', 07:56:38 INFO - 'cart']}, 07:56:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:38 INFO - 'tsvgr_opacity', 07:56:38 INFO - 'tart', 07:56:38 INFO - 'tscrollx', 07:56:38 INFO - 'cart']}, 07:56:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'talos_options': ['--disable-e10s'], 07:56:38 INFO - 'tests': ['tp5o']}, 07:56:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'tests': ['tp5o']}, 07:56:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'talos_options': ['--disable-e10s', 07:56:38 INFO - '--xperf_path', 07:56:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:38 INFO - 'tests': ['tp5n']}, 07:56:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:38 INFO - 'talos_options': ['--xperf_path', 07:56:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:38 INFO - 'tests': ['tp5n']}}, 07:56:38 INFO - 'talos.zip': {'path': '', 07:56:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:38 INFO - Running post-action listener: _resource_record_post_action 07:56:38 INFO - [mozharness: 2017-01-27 15:56:38.534611Z] Finished populate-webroot step (success) 07:56:38 INFO - [mozharness: 2017-01-27 15:56:38.534755Z] Running create-virtualenv step. 07:56:38 INFO - Running pre-action listener: _resource_record_pre_action 07:56:38 INFO - Running main action method: create_virtualenv 07:56:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:38 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 07:56:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:38 INFO - Using real prefix '/tools/python27' 07:56:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:42 INFO - Installing pip.................done. 07:56:42 INFO - Return code: 0 07:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:56:42 INFO - Reading from file tmpfile_stdout 07:56:42 INFO - Output received: 07:56:42 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) 07:56:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:42 INFO - 'HOME': '/Users/cltbld', 07:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:42 INFO - 'LOGNAME': 'cltbld', 07:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:42 INFO - 'MOZ_NO_REMOTE': '1', 07:56:42 INFO - 'NO_EM_RESTART': '1', 07:56:42 INFO - 'PAGER': '/bin/cat', 07:56:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:42 INFO - 'PWD': '/builds/slave/test', 07:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:42 INFO - 'SHELL': '/bin/bash', 07:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:56:42 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:42 INFO - 'USER': 'cltbld', 07:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:42 INFO - 'XPC_FLAGS': '0x0', 07:56:42 INFO - 'XPC_SERVICE_NAME': '0', 07:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:56:42 INFO - Cleaning up... 07:56:42 INFO - Return code: 0 07:56:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:42 INFO - 'HOME': '/Users/cltbld', 07:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:42 INFO - 'LOGNAME': 'cltbld', 07:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:42 INFO - 'MOZ_NO_REMOTE': '1', 07:56:42 INFO - 'NO_EM_RESTART': '1', 07:56:42 INFO - 'PAGER': '/bin/cat', 07:56:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:42 INFO - 'PWD': '/builds/slave/test', 07:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:42 INFO - 'SHELL': '/bin/bash', 07:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:56:42 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:42 INFO - 'USER': 'cltbld', 07:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:42 INFO - 'XPC_FLAGS': '0x0', 07:56:42 INFO - 'XPC_SERVICE_NAME': '0', 07:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:43 INFO - Downloading/unpacking psutil>=3.1.1 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:46 INFO - Installing collected packages: psutil 07:56:46 INFO - Running setup.py install for psutil 07:56:46 INFO - building 'psutil._psutil_osx' extension 07:56:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:56:47 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 07:56:47 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 07:56:47 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 07:56:47 INFO - building 'psutil._psutil_posix' extension 07:56:47 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 07:56:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:56:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:56:47 INFO - ^ 07:56:47 INFO - 1 warning generated. 07:56:47 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 07:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:47 INFO - Successfully installed psutil 07:56:47 INFO - Cleaning up... 07:56:48 INFO - Return code: 0 07:56:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56:48 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')]} 07:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:48 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')]} 07:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:48 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56:48 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 07:56:48 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 07:56:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:56:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:48 INFO - 'HOME': '/Users/cltbld', 07:56:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:48 INFO - 'LOGNAME': 'cltbld', 07:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:48 INFO - 'MOZ_NO_REMOTE': '1', 07:56:48 INFO - 'NO_EM_RESTART': '1', 07:56:48 INFO - 'PAGER': '/bin/cat', 07:56:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:48 INFO - 'PWD': '/builds/slave/test', 07:56:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:48 INFO - 'SHELL': '/bin/bash', 07:56:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:56:48 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:56:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:48 INFO - 'USER': 'cltbld', 07:56:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:48 INFO - 'XPC_FLAGS': '0x0', 07:56:48 INFO - 'XPC_SERVICE_NAME': '0', 07:56:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56:48 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 07:56:48 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 07:56:48 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 07:56:48 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 07:56:48 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 07:56:48 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 07:56:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:50 INFO - Installing collected packages: mozsystemmonitor 07:56:50 INFO - Running setup.py install for mozsystemmonitor 07:56:51 INFO - Successfully installed mozsystemmonitor 07:56:51 INFO - Cleaning up... 07:56:51 INFO - Return code: 0 07:56:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56: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==2.5.1'] in /builds/slave/test/build 07:56: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==2.5.1 07:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:51 INFO - 'HOME': '/Users/cltbld', 07:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:51 INFO - 'LOGNAME': 'cltbld', 07:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:51 INFO - 'MOZ_NO_REMOTE': '1', 07:56:51 INFO - 'NO_EM_RESTART': '1', 07:56:51 INFO - 'PAGER': '/bin/cat', 07:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:51 INFO - 'PWD': '/builds/slave/test', 07:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:51 INFO - 'SHELL': '/bin/bash', 07:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:56:51 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:51 INFO - 'USER': 'cltbld', 07:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:51 INFO - 'XPC_FLAGS': '0x0', 07:56:51 INFO - 'XPC_SERVICE_NAME': '0', 07:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:51 INFO - Downloading/unpacking jsonschema==2.5.1 07:56:51 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 07:56:51 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 07:56:51 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 07:56:51 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 07:56:51 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 07:56:51 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 07:56:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56:54 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 07:56:54 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 07:56:54 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 07:56:54 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 07:56:54 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 07:56:54 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 07:56:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:54 INFO - warning: no files found matching '*.txt' 07:56:54 INFO - no previously-included directories found matching 'build' 07:56:54 INFO - no previously-included directories found matching 'dist' 07:56:54 INFO - no previously-included directories found matching '.git*' 07:56:54 INFO - Installing collected packages: jsonschema, functools32 07:56:54 INFO - Running setup.py install for functools32 07:56:54 INFO - warning: no files found matching '*.txt' 07:56:54 INFO - no previously-included directories found matching 'build' 07:56:54 INFO - no previously-included directories found matching 'dist' 07:56:54 INFO - no previously-included directories found matching '.git*' 07:56:54 INFO - Successfully installed jsonschema functools32 07:56:54 INFO - Cleaning up... 07:56:54 INFO - Return code: 0 07:56:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:56:54 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')]} 07:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:54 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')]} 07:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:54 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56:54 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 07:56:54 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 07:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:54 INFO - 'HOME': '/Users/cltbld', 07:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:54 INFO - 'LOGNAME': 'cltbld', 07:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:54 INFO - 'MOZ_NO_REMOTE': '1', 07:56:54 INFO - 'NO_EM_RESTART': '1', 07:56:54 INFO - 'PAGER': '/bin/cat', 07:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:54 INFO - 'PWD': '/builds/slave/test', 07:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:54 INFO - 'SHELL': '/bin/bash', 07:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:56:54 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:54 INFO - 'USER': 'cltbld', 07:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:54 INFO - 'XPC_FLAGS': '0x0', 07:56:54 INFO - 'XPC_SERVICE_NAME': '0', 07:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:56:55 INFO - Cleaning up... 07:56:55 INFO - Return code: 0 07:56:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:55 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:56:55 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 07:56:55 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 07:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:55 INFO - 'HOME': '/Users/cltbld', 07:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:55 INFO - 'LOGNAME': 'cltbld', 07:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:55 INFO - 'MOZ_NO_REMOTE': '1', 07:56:55 INFO - 'NO_EM_RESTART': '1', 07:56:55 INFO - 'PAGER': '/bin/cat', 07:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:55 INFO - 'PWD': '/builds/slave/test', 07:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:55 INFO - 'SHELL': '/bin/bash', 07:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:56:55 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:55 INFO - 'USER': 'cltbld', 07:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:55 INFO - 'XPC_FLAGS': '0x0', 07:56:55 INFO - 'XPC_SERVICE_NAME': '0', 07:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:55 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 07:56:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:56:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 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 07:56:58 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 07:56:59 INFO - Downloading docopt-0.6.1.tar.gz 07:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:59 INFO - Running setup.py install for blobuploader 07:56:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:56:59 INFO - Running setup.py install for requests 07:56:59 INFO - Running setup.py install for docopt 07:57:00 INFO - Successfully installed blobuploader requests docopt 07:57:00 INFO - Cleaning up... 07:57:00 INFO - Return code: 0 07:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:00 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')]} 07:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:00 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')]} 07:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:00 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:57:00 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 07:57:00 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 07:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:00 INFO - 'HOME': '/Users/cltbld', 07:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:00 INFO - 'LOGNAME': 'cltbld', 07:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:00 INFO - 'MOZ_NO_REMOTE': '1', 07:57:00 INFO - 'NO_EM_RESTART': '1', 07:57:00 INFO - 'PAGER': '/bin/cat', 07:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:00 INFO - 'PWD': '/builds/slave/test', 07:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:00 INFO - 'SHELL': '/bin/bash', 07:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:57:00 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:00 INFO - 'USER': 'cltbld', 07:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:00 INFO - 'XPC_FLAGS': '0x0', 07:57:00 INFO - 'XPC_SERVICE_NAME': '0', 07:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-gG1FEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-DnzPX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Asleeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1eOc3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-vf72s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-RI0bvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-4zKizq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-HmwVYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-xVxhug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-eItphe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-ErLYZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-PZprV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-IObnAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-4wqi7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-tpXkN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Qb1s88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-BObOR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:02 INFO - Running setup.py install for manifestparser 07:57:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:02 INFO - Running setup.py install for mozcrash 07:57:02 INFO - Running setup.py install for mozdebug 07:57:02 INFO - Running setup.py install for mozdevice 07:57:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:57:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:02 INFO - Running setup.py install for mozfile 07:57:02 INFO - Running setup.py install for mozhttpd 07:57:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Running setup.py install for mozinfo 07:57:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Running setup.py install for mozInstall 07:57:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Running setup.py install for mozleak 07:57:03 INFO - Running setup.py install for mozlog 07:57:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Running setup.py install for moznetwork 07:57:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:03 INFO - Running setup.py install for mozprocess 07:57:04 INFO - Running setup.py install for mozprofile 07:57:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:04 INFO - Running setup.py install for mozrunner 07:57:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:04 INFO - Running setup.py install for mozscreenshot 07:57:04 INFO - Running setup.py install for moztest 07:57:04 INFO - Running setup.py install for mozversion 07:57:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:04 INFO - Cleaning up... 07:57:04 INFO - Return code: 0 07:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:04 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:57:04 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 07:57:04 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 07:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:04 INFO - 'HOME': '/Users/cltbld', 07:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:04 INFO - 'LOGNAME': 'cltbld', 07:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:04 INFO - 'MOZ_NO_REMOTE': '1', 07:57:04 INFO - 'NO_EM_RESTART': '1', 07:57:04 INFO - 'PAGER': '/bin/cat', 07:57:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:04 INFO - 'PWD': '/builds/slave/test', 07:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:04 INFO - 'SHELL': '/bin/bash', 07:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:57:04 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:04 INFO - 'USER': 'cltbld', 07:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:04 INFO - 'XPC_FLAGS': '0x0', 07:57:04 INFO - 'XPC_SERVICE_NAME': '0', 07:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-fDqjzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:05 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)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-rWwBsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-083imN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:05 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)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-36V8tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:05 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)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-xfKUVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:05 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)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-NhPwiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:05 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)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-vs381z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:05 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)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-8sTnyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:05 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-iC2owO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:06 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)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-NnhESV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:06 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)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-_BtAEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:06 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)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-YHdryo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:06 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)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-aJs1jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:06 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)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-3xBdeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-wRp60m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:06 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)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-cQV8UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:06 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-uxGfQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:06 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)) 07:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:06 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)) 07:57:06 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)) 07:57:06 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)) 07:57:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:06 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 07:57:06 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 07:57:06 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 07:57:06 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 07:57:06 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 07:57:06 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 07:57:09 INFO - Downloading blessings-1.6.tar.gz 07:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:09 INFO - Installing collected packages: blessings 07:57:09 INFO - Running setup.py install for blessings 07:57:09 INFO - Successfully installed blessings 07:57:09 INFO - Cleaning up... 07:57:09 INFO - Return code: 0 07:57:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:10 INFO - Reading from file tmpfile_stdout 07:57:10 INFO - Current package versions: 07:57:10 INFO - blessings == 1.6 07:57:10 INFO - blobuploader == 1.2.4 07:57:10 INFO - docopt == 0.6.1 07:57:10 INFO - functools32 == 3.2.3-2 07:57:10 INFO - jsonschema == 2.5.1 07:57:10 INFO - manifestparser == 1.1 07:57:10 INFO - mozInstall == 1.12 07:57:10 INFO - mozcrash == 1.0 07:57:10 INFO - mozdebug == 0.1 07:57:10 INFO - mozdevice == 0.48 07:57:10 INFO - mozfile == 1.2 07:57:10 INFO - mozhttpd == 0.7 07:57:10 INFO - mozinfo == 0.9 07:57:10 INFO - mozleak == 0.1 07:57:10 INFO - mozlog == 3.4 07:57:10 INFO - moznetwork == 0.27 07:57:10 INFO - mozprocess == 0.23 07:57:10 INFO - mozprofile == 0.28 07:57:10 INFO - mozrunner == 6.13 07:57:10 INFO - mozscreenshot == 0.1 07:57:10 INFO - mozsystemmonitor == 0.3 07:57:10 INFO - moztest == 0.8 07:57:10 INFO - mozversion == 1.4 07:57:10 INFO - psutil == 3.1.1 07:57:10 INFO - requests == 1.2.3 07:57:10 INFO - wsgiref == 0.1.2 07:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:10 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')]} 07:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:10 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')]} 07:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:10 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:57:10 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 07:57:10 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 07:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:10 INFO - 'HOME': '/Users/cltbld', 07:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:10 INFO - 'LOGNAME': 'cltbld', 07:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:10 INFO - 'MOZ_NO_REMOTE': '1', 07:57:10 INFO - 'NO_EM_RESTART': '1', 07:57:10 INFO - 'PAGER': '/bin/cat', 07:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:10 INFO - 'PWD': '/builds/slave/test', 07:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:10 INFO - 'SHELL': '/bin/bash', 07:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:57:10 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:10 INFO - 'USER': 'cltbld', 07:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:10 INFO - 'XPC_FLAGS': '0x0', 07:57:10 INFO - 'XPC_SERVICE_NAME': '0', 07:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 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)) 07:57:10 INFO - Cleaning up... 07:57:10 INFO - Return code: 0 07:57:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:10 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')]} 07:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:10 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')]} 07:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:10 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 0x10f233490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1a9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcebad7d0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, '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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 07:57:10 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 07:57:10 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 07:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:10 INFO - 'HOME': '/Users/cltbld', 07:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:10 INFO - 'LOGNAME': 'cltbld', 07:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:10 INFO - 'MOZ_NO_REMOTE': '1', 07:57:10 INFO - 'NO_EM_RESTART': '1', 07:57:10 INFO - 'PAGER': '/bin/cat', 07:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:10 INFO - 'PWD': '/builds/slave/test', 07:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:10 INFO - 'SHELL': '/bin/bash', 07:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:57:10 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:10 INFO - 'USER': 'cltbld', 07:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:10 INFO - 'XPC_FLAGS': '0x0', 07:57:10 INFO - 'XPC_SERVICE_NAME': '0', 07:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:57:10 INFO - Cleaning up... 07:57:10 INFO - Return code: 0 07:57:10 INFO - Running post-action listener: _resource_record_post_action 07:57:10 INFO - Running post-action listener: _start_resource_monitoring 07:57:10 INFO - Starting resource monitoring. 07:57:10 INFO - [mozharness: 2017-01-27 15:57:10.703539Z] Finished create-virtualenv step (success) 07:57:10 INFO - [mozharness: 2017-01-27 15:57:10.704530Z] Running install step. 07:57:10 INFO - Running pre-action listener: _resource_record_pre_action 07:57:10 INFO - Running main action method: install 07:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:10 INFO - Reading from file tmpfile_stdout 07:57:10 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:11 INFO - Reading from file tmpfile_stdout 07:57:11 INFO - Output received: 07:57:11 INFO - Usage: mozinstall [options] installer 07:57:11 INFO - Options: 07:57:11 INFO - -h, --help show this help message and exit 07:57:11 INFO - -d DEST, --destination=DEST 07:57:11 INFO - Directory to install application into. [default: 07:57:11 INFO - "/builds/slave/test"] 07:57:11 INFO - --app=APP Application being installed. [default: firefox] 07:57:11 INFO - mkdir: /builds/slave/test/build/application 07:57:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:57:32 INFO - Reading from file tmpfile_stdout 07:57:32 INFO - Output received: 07:57:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:57:32 INFO - Running post-action listener: _resource_record_post_action 07:57:32 INFO - [mozharness: 2017-01-27 15:57:32.175089Z] Finished install step (success) 07:57:32 INFO - [mozharness: 2017-01-27 15:57:32.175217Z] Running run-tests step. 07:57:32 INFO - Running pre-action listener: _resource_record_pre_action 07:57:32 INFO - Running main action method: run_tests 07:57:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:32 INFO - 2017-01-27 07:57:32.189 screenresolution[1628:7808] starting screenresolution argv=screenresolution get 07:57:32 INFO - 2017-01-27 07:57:32.192 screenresolution[1628:7808] Display 0: 1600x1200x32@60 07:57:32 INFO - 2017-01-27 07:57:32.197 screenresolution[1629:7811] starting screenresolution argv=screenresolution list 07:57:32 INFO - Available Modes on Display 0 07:57:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:32 INFO - Intel Iris: 07:57:32 INFO - Chipset Model: Intel Iris 07:57:32 INFO - Type: GPU 07:57:32 INFO - Bus: Built-In 07:57:32 INFO - VRAM (Dynamic, Max): 1536 MB 07:57:32 INFO - Vendor: Intel (0x8086) 07:57:32 INFO - Device ID: 0x0a2e 07:57:32 INFO - Revision ID: 0x0009 07:57:32 INFO - Displays: 07:57:32 INFO - Display: 07:57:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:32 INFO - Display Serial Number: 1600x1200 60 07:57:32 INFO - Main Display: Yes 07:57:32 INFO - Mirror: Off 07:57:32 INFO - Online: Yes 07:57:32 INFO - Rotation: Supported 07:57:32 INFO - Return code: 0 07:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:32 INFO - Python 2.7.3 07:57:32 INFO - Return code: 0 07:57:32 INFO - grabbing minidump binary from tooltool 07:57: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')]} 07:57:32 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 0x10f047d30>, '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 0x10eeaddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f03fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57:32 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 07:57:32 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 07:57:32 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 07:57:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:32 INFO - Return code: 0 07:57:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:57:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:57:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 07:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0385 --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 07:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zqxWAl7uTC/Render', 07:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:32 INFO - 'HOME': '/Users/cltbld', 07:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:32 INFO - 'LOGNAME': 'cltbld', 07:57:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:32 INFO - 'MOZ_NO_REMOTE': '1', 07:57:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:32 INFO - 'NO_EM_RESTART': '1', 07:57:32 INFO - 'PAGER': '/bin/cat', 07:57:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:32 INFO - 'PWD': '/builds/slave/test', 07:57:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:32 INFO - 'SHELL': '/bin/bash', 07:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m9rxBYcsEX/Listeners', 07:57:32 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 07:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:32 INFO - 'USER': 'cltbld', 07:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:32 INFO - 'XPC_FLAGS': '0x0', 07:57:32 INFO - 'XPC_SERVICE_NAME': '0', 07:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 07:57:32 INFO - mozversion application_buildid: 20170127053121 07:57:32 INFO - mozversion application_changeset: f28c092abe746a9c7b39fb5c715141810a9c87d4 07:57:32 INFO - mozversion application_display_name: Firefox 07:57:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:32 INFO - mozversion application_name: Firefox 07:57:32 INFO - mozversion application_remotingname: firefox 07:57:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:57:32 INFO - mozversion application_vendor: Mozilla 07:57:32 INFO - mozversion application_version: 52.0 07:57:32 INFO - mozversion platform_buildid: 20170127053121 07:57:32 INFO - mozversion platform_changeset: f28c092abe746a9c7b39fb5c715141810a9c87d4 07:57:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:57:32 INFO - mozversion platform_version: 52.0 07:57:32 INFO - using testdate: 1485532652 07:57:32 INFO - actual date: 1485532652 07:57:32 INFO - starting webserver on 'localhost:49236' 07:57:32 INFO - SUITE-START | Running 2 tests 07:57:32 INFO - TEST-START | dromaeo_css 07:57:32 INFO - operating with platform_type : mac_ 07:57:32 INFO - Initialising browser for dromaeo_css test... 07:57:32 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmplLo0f7/profile http://localhost:49236/getInfo.html) 07:57:35 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 07:57:35 INFO - PROCESS | 1639 | colorDepth:24 07:57:35 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 07:57:35 INFO - PROCESS | 1639 | __metrics 07:57:35 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:35 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:36 INFO - TEST-INFO | 1639: exit 0 07:57:36 INFO - Browser initialized. 07:57:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:36 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmplLo0f7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:48 INFO - PROCESS | 1643 | RSS: Main: 171909120 07:57:48 INFO - PROCESS | 1643 | 08:00:51 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:00:52 INFO - PROCESS | 1643 | RSS: Main: 280166400 08:00:52 INFO - PROCESS | 1643 | 08:03:55 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:03:56 INFO - PROCESS | 1643 | RSS: Main: 299433984 08:03:56 INFO - PROCESS | 1643 | 08:06:58 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:06:59 INFO - PROCESS | 1643 | RSS: Main: 269807616 08:06:59 INFO - PROCESS | 1643 | 08:10:01 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:10:01 INFO - PROCESS | 1643 | RSS: Main: 274276352 08:10:01 INFO - PROCESS | 1643 | 08:13:05 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:13:05 INFO - PROCESS | 1643 | RSS: Main: 260517888 08:13:05 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:16:08 INFO - PROCESS | 1643 | RSS: Main: 410820608 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | __start_tp_report 08:16:08 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 08:16:08 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 08:16:08 INFO - PROCESS | 1643 | |i|pagename|runs| 08:16:08 INFO - PROCESS | 1643 | |0;dojo.html;3419.247765491592;3430.965690343096;3431.8627254909807;3442.363162814878;3487.860485580577;5536.972315138423;5597.524210442107;5598.440155984399;5617.269754931853;5621.213030175773;5760.7407666655;5772.971135144318;5850.795222167214;5852.824415267549;5867;5268.5521730652945;5282.973585132078;5294.100002999499;5312.760925758331;5352.785888564453;5247.081760691883;5254.658447200939;5264.052470555299;5385.542228910528;5402.189671549259;5340.866478338054;5344.331958505187;5346.705931173784;5360.678359298435;5364.865878353034;5313.415524292324;5322.4411436799355;5337.519623233928;5371.946280537184;5396.622236443451;5195.714235717034;5246.475352464761;5267.762950667229;5315.229291752713;5327.920081198785;5871.412858714094;5914.4676979071655;5973;5984.132300816401;5989.760409583611;6174.629522228681;6256.311805701369;6257.155284036642;6285.968570157165;6376.234851817811;6270.184875966141;6304.810855674337;6321.399467050669;6331.430171284606;6343.968280158616;5954.10688396744;5963.522918166623;5967;5973.223480947492;5995;6278.843028924313;6302.086197501337;6329.556931014785;6341.048842673636;6361.713722882481;6144.662043587557;6151.72317245725;6163.753449862045;6179.351168127372;6181.258249010058;6298.307186209513;6299.055141728777;6306.085617585516;6308.621482711052;6334.968325158345;6139.461473530765;6177.505799536027;6218.160548325918;6219.844503887349;6288.213973253343;6316.842078948063;6339.746410143634;6362.427381535684;6371.426571608577;6374.298827129012;4997.725125118153;5067.138586440314;5069.822556210515;5072.442031376546;5098.719570423662;4503.68474206809;4532.614727748112;4571.428571428572;4594.33382159585;4612.0545288215835;5846.7076646167525;5855.414458554195;5856.531477481792;5859.765609375662;5861.824145275648;6301.149344838388;6307.873842523124;6321.905171422432;6322.209723784527;6324.3991820776955;4751.548602882721;5685;5708.40061793514;5846.327672317653;5859;5365.3293338332705;5386.946130538645;5393.83818485446;5405.459454054641;5410.188471729193;6285.937140628535;6288.276848162428;6301.716422761078;6304.5271604628915;6307.684615769193;6183.783567575113;6265.028920517327;6285.59143655661;6294;6331.271903730945;6358.300586935526;6360.363963603602;6364.77723279683;6374.553781235454;6375.4262116409745;6139.8465038372615;6329.810105696836;6336.778212762531;6344.9048264277;6356.491480681627;5784.363719990713;6229.56393052482;6262.812115636538;6345.428911397997;6355.809325720235;6162.198914141312;6255.218097737783;6263.404976527223;6277.18396608438;6288.151099601679;6212.440880320612;6237.25152981627;6246.46905013079;6251.812445626639;6265.655388953652;5739.971300143473;5958.314793798769;6005.309389420273;6086.847828804315;6162.445379915829;6137.346341658241;6139.400144844221;6180.103884936749;6228.128062071223;6246.625202487865;6108.847278817887;6114.969425152845;6118.510519158545;6129.570930034854;6134.325224225242 08:16:08 INFO - PROCESS | 1643 | |1;ext.html;512.5950499105707;538.2948337677642;553.0156321747289;582.9390509273125;590.7253127295807;40125.799371003144;41436.47789937855;41438.37842432366;43556.56443435573;43635.3454698179;42798.786006070004;43300;43324.91687707809;43351.56648433515;43438;8994.325425593073;9450.385724927857;9610.990845961178;9615.711528654152;9626.951865240664;9131.634734610607;11579.015783658399;11788.351640659803;11813.99581035613;12020.51917923282;11820.763584728344;11865.52537898483;11884.940575297154;11891.167618266725;11894.405279735978;11754.823677644843;11808.704782380424;11819.645410637695;11829.349385783778;11851.814818518165;11615.419229038598;11645.825312620318;11691.7077073073;11696.064314854792;11702.005329546999;40515.797421013;40840.978975525555;40879.591204087876;40911;40956.79521602373;3277.705006549422;3327.750418718606;3497.8600855965733;3527.8236088195486;3775.9056023599355;30261.394772104653;30471.23821904448;30770.23074423135;31097;31633.367332653448;3239.6922292382187;3243.497257925025;3278.47544392896;3293.7035666789866;3412.3175364927115;519220;523440;525692;525910;525956.9999999962;27801.86099069532;32904.506432403534;33190;59197;59446.70276648589;34293.485597716055;35679.92960211198;35735.82132089323;35741.8212908939;35826;14948.252587370587;15135.394584216729;15144.01563898343;15173;15184.392624294904;11212.831807522894;11436.771264574661;12613.495460181673;12707.491700331882;12841;7746.341560967268;8010.959945200353;8029.397795165386;8043.638036288381;8102.716404925799;3292.785968912061;3302.78531895426;3309.7683162178896;3321;3325.900222993314;958.8609651600478;976.8144052629978;1077.1275267033727;1082.8592283003159;1145.2212495502972;29763.279445727552;30006.849965750032;30126.84936575303;30141.945031923777;30197.69802301993;1050.3435352904435;1089.9182561307935;1100.2573263047411;1121.4897221764077;1161.3206274329611;15444;15562.91059625838;15662.765058524132;16002.359905603878;16070.875038747175;708183;708935;710771;711000;711668;58291;58695.70652146712;58721.70639146862;58820;58857.41142588605;1255.460152134591;1314.4610709609015;1383.667919699285;1384.7230553889262;1417.9503717369842;29413;30805.38389232158;31079.223019424695;31397.686023139475;32014.83992580022;57027;57734.711326443095;57737.42262577488;57838.42161578331;57879.71060144672;646793.7660311669;661553;661927;664314;665109.674451644;34820.82589587036;42617.36073958955;42618.57381426146;43288;44293.778531107135;46319.53680463152;46340.536594633624;46421.07157856892;46639;47044.529554704015;34715.784947526714;37460.62539374681;38583.42124868185;39218.80390598029;40656.59343406646;34005;34994.47508287428;38623.42064869085;38920.80539597284;40062.79968600138;37068.814655926544;38351;38788.41817372685;38818.6118138815;38888.222235555695;30556.694433056273;31769.682303176673;34416.311673765886;34770.30459390747;34867.82566087153;20833.374998750063;25525.3618659535;25946;25959.61060584055;26090.956361745317 08:16:08 INFO - PROCESS | 1643 | |2;jquery.html;383.62404843253626;388.5318191579147;395.76452011053414;399.4367941202905;410.3352568838482;13885.861141388608;19744.506387340323;20580;21052.15791368345;21097.894510527443;16271.755923661154;17379.391721289758;19835.702464463044;20326.491837704063;20459.48851278719;5740.454656807597;6032.306284777263;6044.486218671396;6050.697465126748;6063.120847477113;5860.619059761102;5890.911636325437;5911.083782013795;5928.733207005674;6012.428819262163;5919.49684276837;5920.289565252176;5932.37710040446;5932.584719069667;5934.64392136471;5757.193992841006;5769.596128271001;5895.292564892197;5899.380565040652;5925.4963328117165;5166.948330516722;5194.896102077937;5197.974010129963;5198.376194856603;5210.583153347723;25453;25733;25792.74207257922;25952;26101.608475872687;2061.3815855243515;2430.611102223636;2440.6095024795945;2560.7695307422237;2944.175630823373;15663.686726265525;15856.682866342724;15860.127692976881;16057.116858572774;16502.33990640373;1908.2557802457052;1911.3405874973112;1915;1942.359021522894;2018.7981201879695;106777;107742;109404.4529777346;112673;113601.43199284033;9203.677871274607;10606.628767993083;10751;11342.659720208407;11399.373034483184;13891.374888130058;13902.51341203053;14024.509142180179;14030.508932187324;14067.366968486444;6899.448044156456;7235.6020418876415;7934.761957141295;8055.154208808108;8637;7274.345308922222;8430.578471076422;8554.61504232311;8698.086700896441;8811.339149563808;6663.633500157441;6663.633955039205;6675.699593518303;6676.766313179015;6682.832929176712;1520.4070412539118;1576.0779943733044;1692.069361850977;1741.2425594866274;1782.2336395350123;921.953902304882;942.359195746885;1009.4347165587294;1012.1599072769731;1067.551807661243;20840;22321.55356892853;22326.441838954157;22480.988355523714;22493.875306234622;948.4925564822787;955.6559638530124;963.9855402168973;970.5050424283667;1012.5139932832282;11166.497507612177;11782.528698852122;11800.70498237551;11823.940880295544;11831.704207394712;581845;591265;593364;608966;608997;105725;111805.44097279462;112997.35013249304;113190;118483;881.378628067211;1032.4528000159778;1035.7151783259512;1056.6196169379018;1060.4909643371225;12914.22514649124;13199.604011879659;18717.71923421177;20305.79694203039;20368.388948331572;51698.74150629223;52425.47574524206;52465;52702;54024.18963715626;59507.70246148915;75284.62357688395;82419;82579;83567.5821620888;5598.10430331145;5655;8020.598970051357;8270.669173233004;8678.479291242546;12501.06242031833;12859.29273889945;12992.220466772023;13317.267550284827;13393;11144.387058711849;11432.428378581204;11475.655730328104;11650.184487085822;11698.35659038761;4644.93032604518;8887.289016878505;9297.72106836796;11278.210525263154;11574.47914843851;11517.193796434169;11558.94220528892;11773;11837.76324473523;11882.584109556125;7481.17707052213;7974;8217.055038670629;8452.873206901779;8546.188112129337;10194.235432342455;11165.553377865119;11412.372319522174;11456.427178641201;11676.94161529187 08:16:08 INFO - PROCESS | 1643 | |3;mootools.html;1514.7879296898432;1534.831168571457;1709.4017094017095;1850.2691436882433;1861.097367776629;8086.150954149811;8532;8542.359323050765;8546.91453085469;8550.40147189697;7592.27873352032;7799.961000195005;8091.393145514081;8279.172082791732;8312.91687083129;2324.860508369499;2358.021421110237;2361.752016038317;2365.5860224460735;2367.6922000139957;2363;2401.7238017627933;2408.157144999254;2411.770881766229;2418.5646583614944;2358.433975845802;2360.5868972929757;2382.9880850595723;2384.666146739458;2385.3917251100943;2335.871527066011;2339.836211465198;2357.1867705641525;2360.6104992676187;2360.988195059031;2365.5741966446035;2373.8219633527556;2394.2936833633944;2396.676448679423;2397.616381378971;8365.665373385058;8416.452930559555;8483.490990540588;8492.065872753992;8504.489730616182;5114.488551144893;5263.763130659129;5267.604929630293;5271.077561426735;5272.367315922075;3023.3046399328277;3526.9118272043147;3536.416491278936;3566.1262990567216;3614.819259037064;1065.169168048923;1090.7619851468562;1112.8998390144925;1120.098320851714;1126.4142645824209;10884.07485363745;10996.340219586851;11004.229703920728;11010.889891101067;11011.394373309466;4489.730616162975;4643.141018911512;4717.599004084623;4718.3158442025715;4781.737004464719;9533;9535.61857525705;9540.856887146698;9546.856797148048;9556.569954352071;5280.075986702312;5285.312909321764;5289.603279754034;5290.365156181283;5300.734963251822;4373.125374925028;4392.956070439319;4809;4868.196747536687;4874.8537543873035;3833.616638336144;3882.107115363482;3934.5278566572197;3969.1069509360163;3982.024404021033;1272.821804947308;1276.9808452873215;1277.3549357574366;1287.7939529675207;1292.1019891175542;778.3656320099101;794.06697130871;914.2914241462787;918.5453200665713;919.2094798473307;5523.226748255248;5543.52880005196;5616.522595579421;5886.175935369051;5894.646321220741;838.2037064788475;935.1209862729013;984.3552473130111;1038.2939601071344;1060.4379678770265;3071.892483763102;3818.3508803503473;3835.5589107252463;3954.5254569451276;3993.341098718737;8140.389470789714;10062.899371006197;10171.389716616879;10173.84739228912;10203.03071208249;9594.520273986273;9831.606735730633;10117.190624750003;10124.34191777532;10129.746756331151;7743.5353878767455;7970.840583188304;7975.4018448615425;7975.800604984805;7985.041794984523;5575.553955683617;5695.544356451391;5782.161586570008;5819.010768169506;5961.7615295387695;9387.061293870558;9443.961164272063;9492.762680932756;9526.428414295164;9556.139947404767;9153.954230228806;9678.322517423712;9782.021797820162;9791.608335666493;9794.559244834141;6772.153480814898;6949.166100068024;6958.408535274559;7190.280971902768;7359.742409015659;7675.309222170032;7714.15144334134;7734.92265077342;7789.688412463438;7999.360051196007;6066.272047354346;7044.506884518035;7287.161976372573;7338.70645174187;7382.52013619113;7040.894386584103;7103.857922841411;7137.464690148364;7172.318629730167;7233.674484648309;5695.601307908407;6761.830954225987;6846.281140480377;6846.349596788297;6866.690998905161;4767.118083154627;4838.540338667821;4870.683405578768;4877.853664390074;4930.531599498042;4770.28445733129;4779.928301075417;4844.612431005582;4939.950600493949;4950.6039516837845 08:16:08 INFO - PROCESS | 1643 | |4;prototype.html;284.2651745238559;314.23954031244386;319.2481705583351;323.7296857124301;327.7984039815514;4464.776761161941;5261.501416289075;5411.594130440218;5447.155690867917;5473.945260547393;3778.9811050944777;4420.872677467241;4466;4616.930746038812;4657.6972496787685;3711.257748450307;3865.8260378282976;3976.483057202574;4111.527174374955;4137.606927341898;4111.218868415007;4111.48606424197;4112;4112.622271539023;4151;3340.632530421664;3665.321915445638;3826.617338266179;4101.610347017028;4106.384042393635;3362.57090736436;3689.3728066228673;4047.6964227682747;4084.530279017921;4103.379165229748;3305.3389322135667;3309.3381323735107;3508.7894626385214;3533.3463309287863;3539.663731945461;5161.483851614846;5255.872755710347;5257.579393648499;5281.623269528727;5320.787168513293;4053.8783836484954;4271;4431.711938723973;4654.418197725285;4669.599120263942;5193.065248255312;5416.025115479212;5672.432756724335;5676.574256930747;5684.602077854552;3719.5350581177354;3893.76637401754;3898.919853315877;3901.590333015021;3904.531456225243;5045.344105266292;5259.606878870105;5364;5509.393966663663;5974.864775692605;2991.880324786984;3002.316386437165;3565.5721313442036;3637.0725465006253;3865.16898866745;3370.76404651672;3604.8104125638474;3968.250003746432;4015.799210039545;4018.8392464301687;3690.612485689018;4234.491860976703;4258.659307255412;4625.941456052092;4675.246782456578;5172.568892620462;5504.091824848935;5638.4925356718095;5719.7140142992685;5728.567858035492;1071.5874388360537;1098.6102580236009;1275.7051592633484;1282.9095269021257;1296.6110166949877;818.6397984886631;846.7967687754895;852.2202185000655;874.9762777550281;881.6164968238709;4321.546237645002;4593.035462552834;4820.084184005098;5140.871478213075;5156.948430515722;4553.772311384418;4848.8787780305065;5579.776808927598;5585.636933599303;5602.943970560243;4302.763348015889;4701.271302948048;4810.22021851917;4817.567128600104;5023.19628859388;2527.5703130467864;2554.9105781297567;2560.2959186223566;2899.913002609925;2904.6514418269944;4966.882451448395;5068.898622027539;5707.74315155819;5714.771324165241;5755.769769209185;4786.856394308176;4883.731394773322;5145.407316263334;5477.945220547823;5651.463111004448;4816.590589799906;5176.689398636018;5668.8866222675315;5671.773129074873;5687.744051517691;4532.471138969339;4572.291294849304;5160.09698302788;5231.136862417658;5525.557955363642;4254.702170848011;4620.237660786067;5284.709340986283;5392.622516423813;5461.5357694596405;5134.614903882149;5237.119584228735;5424.945750542444;5720.48515633595;5729.598928074995;3417.846196921095;3522.330757156132;3693.7045036396485;3697.963020369762;3716.554013518395;4978.3820258415435;5073.579397768631;5122.436531981404;5493.176023596492;5508.3114610673665;5335.559398962336;5335.973320133529;5342.839714808562;5371.543418809289;5393.892122157614;4579.885502862455;4597.7241365518175;4691.835785747482;5295.735213239245;5336.079011555915;4972.204447288416;5182.585393168612;5213.556847667991;5290.232916227049;5309.283246761638;4633.745144016976;5577.358603760457;5583.720813959367;5747.568932330176;5872.29532456108;5447.992121457543;5676.517496012885;5696.658200507983;5699.51554117888;5749.770009199585 08:16:08 INFO - PROCESS | 1643 | |5;yui.html;705.6330708031824;727.3272223193542;748.2928632442342;805.2551389964282;837.6816809612346;14806.925965370185;15560.53318400447;15669.529914102566;15677.921610391932;15692.529224123266;13954.162750234993;14137.36381862816;14165.220912849814;14168.008239423245;14170.645733856658;718.6981467783518;737.7159793479523;858.5578427110028;863.7754183912197;885.2298500304744;836.6946064686376;858.5664239559014;875.1073904617286;875.7285241575132;878.925291350236;945.0502245243521;945.4043952310035;945.7493764152505;945.9574319155655;947.3889341374809;933.8459154239542;935.7333160049353;936.8828896387952;938.3290946972947;944.593824655398;703.7501686901128;704.594857956677;704.7075463682565;704.8555046215514;706.9819459977616;14408;14409.351579178961;14439.278036098152;14445.638859028504;14455.638609034753;13903.531370139935;14427.71144577113;14482;14513.492027779082;14667.413303467954;10932;11224.045956093742;11379.772404551946;11753.706157346049;11768.764624707457;4586.908261834778;4606.56237657422;4639.582437580634;4721.268203428474;4780.569748722597;81979.59010204971;82819.343613128;98676;99558.0044199556;100326.4983675077;10246.53890574926;10413.809832624693;10867.184961127947;10885.292455990335;11010.90792749375;19776.70334944977;19788.70316945247;19793.30723424673;19800.108995095256;19869.801301986794;7378.114626244885;7532.585707786125;7772;7783.4162437817395;7926.167752385916;4400;4406.228909940747;4410.29435290352;4566.680332376768;4600.033992861537;3307.5534802801794;3402.2344972381015;3402.4726167444087;3408.454647256427;3421.161815355204;591.3052163707712;606.9757209711562;608.4159207161086;615.7813976038532;634.3276127305071;579.7709904587664;604.0168608975948;618.3322012226785;622.5704264057786;649.655682488282;7316.853662926712;9042.003206809266;9115.270778337717;9257.305702072372;9408.341416100808;555.4806256150512;602.3554796367845;622.819382379114;625.4808508937571;647.8671872266174;4214.452121224222;4415.337699345059;4466.173757854807;4489.551044895549;4539.251023581072;115089.27366089515;116912;117204;118227.40886295686;124539;69237;70965.93551096738;85569.57215213885;103459.482702586;107140;68872;89865.65201521982;90881.09118908859;95253.52373238228;97896.51051744695;7887.974563306963;8178.959105204436;8429.704960326359;8949.927782858913;8964.955175224082;47079.76460117677;55718;58498.75128105636;58550.82898342094;58728.70635646794;83061.58469207615;83886.64453421795;85081;86583.70124448012;86812.56593716991;10944.781104378028;11036.834447483134;11123.888761112285;11304.886951130713;11320.433978300887;12085.697857553632;12150.57472988441;12306.384680765746;12372.381380931098;12566.623001309976;11170.553177872795;11203.271787333797;11520.481578328827;11565.537378504765;12476.563320283747;11486.770264594828;11660.12549058807;12121.090918181348;12290.631281061582;12304.507819687113;11547.769044618892;12063.517459301529;12203.389830508617;12299.815502767287;12350.691232719253;8007.639656215601;9592.08875156859;9857.35927164732;10485.737856553647;10628.309159904582;8712.433691810013;9330.766730831783;10002;10129.696109116738;10137.543810528692 08:16:08 INFO - PROCESS | 1643 | __end_tp_report 08:16:08 INFO - PROCESS | 1643 | __start_cc_report 08:16:08 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1573 08:16:08 INFO - PROCESS | 1643 | __end_cc_report 08:16:08 INFO - PROCESS | 1643 | __startTimestamp1485533768939__endTimestamp 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | ------- Summary: start ------- 08:16:08 INFO - PROCESS | 1643 | Number of tests: 6 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5826.72 Median:6118.51 stddev:633.23 (10.3%) stddev-sans-first:606.36 08:16:08 INFO - PROCESS | 1643 | Values: 3419.2 3431.0 3431.9 3442.4 3487.9 5537.0 5597.5 5598.4 5617.3 5621.2 5760.7 5773.0 5850.8 5852.8 5867.0 5268.6 5283.0 5294.1 5312.8 5352.8 5247.1 5254.7 5264.1 5385.5 5402.2 5340.9 5344.3 5346.7 5360.7 5364.9 5313.4 5322.4 5337.5 5371.9 5396.6 5195.7 5246.5 5267.8 5315.2 5327.9 5871.4 5914.5 5973.0 5984.1 5989.8 6174.6 6256.3 6257.2 6286.0 6376.2 6270.2 6304.8 6321.4 6331.4 6344.0 5954.1 5963.5 5967.0 5973.2 5995.0 6278.8 6302.1 6329.6 6341.0 6361.7 6144.7 6151.7 6163.8 6179.4 6181.3 6298.3 6299.1 6306.1 6308.6 6335.0 6139.5 6177.5 6218.2 6219.8 6288.2 6316.8 6339.7 6362.4 6371.4 6374.3 4997.7 5067.1 5069.8 5072.4 5098.7 4503.7 4532.6 4571.4 4594.3 4612.1 5846.7 5855.4 5856.5 5859.8 5861.8 6301.1 6307.9 6321.9 6322.2 6324.4 4751.5 5685.0 5708.4 5846.3 5859.0 5365.3 5386.9 5393.8 5405.5 5410.2 6285.9 6288.3 6301.7 6304.5 6307.7 6183.8 6265.0 6285.6 6294.0 6331.3 6358.3 6360.4 6364.8 6374.6 6375.4 6139.8 6329.8 6336.8 6344.9 6356.5 5784.4 6229.6 6262.8 6345.4 6355.8 6162.2 6255.2 6263.4 6277.2 6288.2 6212.4 6237.3 6246.5 6251.8 6265.7 5740.0 5958.3 6005.3 6086.8 6162.4 6137.3 6139.4 6180.1 6228.1 6246.6 6108.8 6115.0 6118.5 6129.6 6134.3 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:74656.01 Median:19182.84 stddev:170709.63 (889.9%) stddev-sans-first:171097.75 08:16:08 INFO - PROCESS | 1643 | Values: 512.6 538.3 553.0 582.9 590.7 40125.8 41436.5 41438.4 43556.6 43635.3 42798.8 43300.0 43324.9 43351.6 43438.0 8994.3 9450.4 9611.0 9615.7 9627.0 9131.6 11579.0 11788.4 11814.0 12020.5 11820.8 11865.5 11884.9 11891.2 11894.4 11754.8 11808.7 11819.6 11829.3 11851.8 11615.4 11645.8 11691.7 11696.1 11702.0 40515.8 40841.0 40879.6 40911.0 40956.8 3277.7 3327.8 3497.9 3527.8 3775.9 30261.4 30471.2 30770.2 31097.0 31633.4 3239.7 3243.5 3278.5 3293.7 3412.3 519220.0 523440.0 525692.0 525910.0 525957.0 27801.9 32904.5 33190.0 59197.0 59446.7 34293.5 35679.9 35735.8 35741.8 35826.0 14948.3 15135.4 15144.0 15173.0 15184.4 11212.8 11436.8 12613.5 12707.5 12841.0 7746.3 8011.0 8029.4 8043.6 8102.7 3292.8 3302.8 3309.8 3321.0 3325.9 958.9 976.8 1077.1 1082.9 1145.2 29763.3 30006.8 30126.8 30141.9 30197.7 1050.3 1089.9 1100.3 1121.5 1161.3 15444.0 15562.9 15662.8 16002.4 16070.9 708183.0 708935.0 710771.0 711000.0 711668.0 58291.0 58695.7 58721.7 58820.0 58857.4 1255.5 1314.5 1383.7 1384.7 1418.0 29413.0 30805.4 31079.2 31397.7 32014.8 57027.0 57734.7 57737.4 57838.4 57879.7 646793.8 661553.0 661927.0 664314.0 665109.7 34820.8 42617.4 42618.6 43288.0 44293.8 46319.5 46340.5 46421.1 46639.0 47044.5 34715.8 37460.6 38583.4 39218.8 40656.6 34005.0 34994.5 38623.4 38920.8 40062.8 37068.8 38351.0 38788.4 38818.6 38888.2 30556.7 31769.7 34416.3 34770.3 34867.8 20833.4 25525.4 25946.0 25959.6 26091.0 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:34365.56 Median:2435.61 stddev:99075.53 (4067.8%) stddev-sans-first:99320.61 08:16:08 INFO - PROCESS | 1643 | Values: 383.6 388.5 395.8 399.4 410.3 13885.9 19744.5 20580.0 21052.2 21097.9 16271.8 17379.4 19835.7 20326.5 20459.5 5740.5 6032.3 6044.5 6050.7 6063.1 5860.6 5890.9 5911.1 5928.7 6012.4 5919.5 5920.3 5932.4 5932.6 5934.6 5757.2 5769.6 5895.3 5899.4 5925.5 5166.9 5194.9 5198.0 5198.4 5210.6 25453.0 25733.0 25792.7 25952.0 26101.6 2061.4 2430.6 2440.6 2560.8 2944.2 15663.7 15856.7 15860.1 16057.1 16502.3 1908.3 1911.3 1915.0 1942.4 2018.8 106777.0 107742.0 109404.5 112673.0 113601.4 9203.7 10606.6 10751.0 11342.7 11399.4 13891.4 13902.5 14024.5 14030.5 14067.4 6899.4 7235.6 7934.8 8055.2 8637.0 7274.3 8430.6 8554.6 8698.1 8811.3 6663.6 6663.6 6675.7 6676.8 6682.8 1520.4 1576.1 1692.1 1741.2 1782.2 922.0 942.4 1009.4 1012.2 1067.6 20840.0 22321.6 22326.4 22481.0 22493.9 948.5 955.7 964.0 970.5 1012.5 11166.5 11782.5 11800.7 11823.9 11831.7 581845.0 591265.0 593364.0 608966.0 608997.0 105725.0 111805.4 112997.4 113190.0 118483.0 881.4 1032.5 1035.7 1056.6 1060.5 12914.2 13199.6 18717.7 20305.8 20368.4 51698.7 52425.5 52465.0 52702.0 54024.2 59507.7 75284.6 82419.0 82579.0 83567.6 5598.1 5655.0 8020.6 8270.7 8678.5 12501.1 12859.3 12992.2 13317.3 13393.0 11144.4 11432.4 11475.7 11650.2 11698.4 4644.9 8887.3 9297.7 11278.2 11574.5 11517.2 11558.9 11773.0 11837.8 11882.6 7481.2 7974.0 8217.1 8452.9 8546.2 10194.2 11165.6 11412.4 11456.4 11676.9 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5492.30 Median:5265.68 stddev:2976.86 (56.5%) stddev-sans-first:2970.20 08:16:08 INFO - PROCESS | 1643 | Values: 1514.8 1534.8 1709.4 1850.3 1861.1 8086.2 8532.0 8542.4 8546.9 8550.4 7592.3 7800.0 8091.4 8279.2 8312.9 2324.9 2358.0 2361.8 2365.6 2367.7 2363.0 2401.7 2408.2 2411.8 2418.6 2358.4 2360.6 2383.0 2384.7 2385.4 2335.9 2339.8 2357.2 2360.6 2361.0 2365.6 2373.8 2394.3 2396.7 2397.6 8365.7 8416.5 8483.5 8492.1 8504.5 5114.5 5263.8 5267.6 5271.1 5272.4 3023.3 3526.9 3536.4 3566.1 3614.8 1065.2 1090.8 1112.9 1120.1 1126.4 10884.1 10996.3 11004.2 11010.9 11011.4 4489.7 4643.1 4717.6 4718.3 4781.7 9533.0 9535.6 9540.9 9546.9 9556.6 5280.1 5285.3 5289.6 5290.4 5300.7 4373.1 4393.0 4809.0 4868.2 4874.9 3833.6 3882.1 3934.5 3969.1 3982.0 1272.8 1277.0 1277.4 1287.8 1292.1 778.4 794.1 914.3 918.5 919.2 5523.2 5543.5 5616.5 5886.2 5894.6 838.2 935.1 984.4 1038.3 1060.4 3071.9 3818.4 3835.6 3954.5 3993.3 8140.4 10062.9 10171.4 10173.8 10203.0 9594.5 9831.6 10117.2 10124.3 10129.7 7743.5 7970.8 7975.4 7975.8 7985.0 5575.6 5695.5 5782.2 5819.0 5961.8 9387.1 9444.0 9492.8 9526.4 9556.1 9154.0 9678.3 9782.0 9791.6 9794.6 6772.2 6949.2 6958.4 7190.3 7359.7 7675.3 7714.2 7734.9 7789.7 7999.4 6066.3 7044.5 7287.2 7338.7 7382.5 7040.9 7103.9 7137.5 7172.3 7233.7 5695.6 6761.8 6846.3 6846.3 6866.7 4767.1 4838.5 4870.7 4877.9 4930.5 4770.3 4779.9 4844.6 4940.0 4950.6 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4363.79 Median:4813.41 stddev:1346.09 (28.0%) stddev-sans-first:1314.58 08:16:08 INFO - PROCESS | 1643 | Values: 284.3 314.2 319.2 323.7 327.8 4464.8 5261.5 5411.6 5447.2 5473.9 3779.0 4420.9 4466.0 4616.9 4657.7 3711.3 3865.8 3976.5 4111.5 4137.6 4111.2 4111.5 4112.0 4112.6 4151.0 3340.6 3665.3 3826.6 4101.6 4106.4 3362.6 3689.4 4047.7 4084.5 4103.4 3305.3 3309.3 3508.8 3533.3 3539.7 5161.5 5255.9 5257.6 5281.6 5320.8 4053.9 4271.0 4431.7 4654.4 4669.6 5193.1 5416.0 5672.4 5676.6 5684.6 3719.5 3893.8 3898.9 3901.6 3904.5 5045.3 5259.6 5364.0 5509.4 5974.9 2991.9 3002.3 3565.6 3637.1 3865.2 3370.8 3604.8 3968.3 4015.8 4018.8 3690.6 4234.5 4258.7 4625.9 4675.2 5172.6 5504.1 5638.5 5719.7 5728.6 1071.6 1098.6 1275.7 1282.9 1296.6 818.6 846.8 852.2 875.0 881.6 4321.5 4593.0 4820.1 5140.9 5156.9 4553.8 4848.9 5579.8 5585.6 5602.9 4302.8 4701.3 4810.2 4817.6 5023.2 2527.6 2554.9 2560.3 2899.9 2904.7 4966.9 5068.9 5707.7 5714.8 5755.8 4786.9 4883.7 5145.4 5477.9 5651.5 4816.6 5176.7 5668.9 5671.8 5687.7 4532.5 4572.3 5160.1 5231.1 5525.6 4254.7 4620.2 5284.7 5392.6 5461.5 5134.6 5237.1 5424.9 5720.5 5729.6 3417.8 3522.3 3693.7 3698.0 3716.6 4978.4 5073.6 5122.4 5493.2 5508.3 5335.6 5336.0 5342.8 5371.5 5393.9 4579.9 4597.7 4691.8 5295.7 5336.1 4972.2 5182.6 5213.6 5290.2 5309.3 4633.7 5577.4 5583.7 5747.6 5872.3 5448.0 5676.5 5696.7 5699.5 5749.8 08:16:08 INFO - PROCESS | 1643 | 08:16:08 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20980.95 Median:25859.67 stddev:31572.98 (122.1%) stddev-sans-first:31624.84 08:16:08 INFO - PROCESS | 1643 | Values: 705.6 727.3 748.3 805.3 837.7 14806.9 15560.5 15669.5 15677.9 15692.5 13954.2 14137.4 14165.2 14168.0 14170.6 718.7 737.7 858.6 863.8 885.2 836.7 858.6 875.1 875.7 878.9 945.1 945.4 945.7 946.0 947.4 933.8 935.7 936.9 938.3 944.6 703.8 704.6 704.7 704.9 707.0 14408.0 14409.4 14439.3 14445.6 14455.6 13903.5 14427.7 14482.0 14513.5 14667.4 10932.0 11224.0 11379.8 11753.7 11768.8 4586.9 4606.6 4639.6 4721.3 4780.6 81979.6 82819.3 98676.0 99558.0 100326.5 10246.5 10413.8 10867.2 10885.3 11010.9 19776.7 19788.7 19793.3 19800.1 19869.8 7378.1 7532.6 7772.0 7783.4 7926.2 4400.0 4406.2 4410.3 4566.7 4600.0 3307.6 3402.2 3402.5 3408.5 3421.2 591.3 607.0 608.4 615.8 634.3 579.8 604.0 618.3 622.6 649.7 7316.9 9042.0 9115.3 9257.3 9408.3 555.5 602.4 622.8 625.5 647.9 4214.5 4415.3 4466.2 4489.6 4539.3 115089.3 116912.0 117204.0 118227.4 124539.0 69237.0 70965.9 85569.6 103459.5 107140.0 68872.0 89865.7 90881.1 95253.5 97896.5 7888.0 8179.0 8429.7 8949.9 8965.0 47079.8 55718.0 58498.8 58550.8 58728.7 83061.6 83886.6 85081.0 86583.7 86812.6 10944.8 11036.8 11123.9 11304.9 11320.4 12085.7 12150.6 12306.4 12372.4 12566.6 11170.6 11203.3 11520.5 11565.5 12476.6 11486.8 11660.1 12121.1 12290.6 12304.5 11547.8 12063.5 12203.4 12299.8 12350.7 8007.6 9592.1 9857.4 10485.7 10628.3 8712.4 9330.8 10002.0 10129.7 10137.5 08:16:08 INFO - PROCESS | 1643 | -------- Summary: end -------- 08:16:08 INFO - PROCESS | 1643 | 08:16:09 INFO - TEST-INFO | 1643: exit 0 08:16:09 INFO - TEST-OK | dromaeo_css | took 1116924ms 08:16:09 INFO - TEST-START | kraken 08:16:09 INFO - operating with platform_type : mac_ 08:16:09 INFO - Initialising browser for kraken test... 08:16:09 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpBTDhW_/profile http://localhost:49236/getInfo.html) 08:16:11 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:16:11 INFO - PROCESS | 1649 | colorDepth:24 08:16:11 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:16:11 INFO - PROCESS | 1649 | __metrics 08:16:12 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:12 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:12 INFO - TEST-INFO | 1649: exit 0 08:16:12 INFO - Browser initialized. 08:16:12 INFO - Running cycle 1/1 for kraken test... 08:16:12 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpBTDhW_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:25 INFO - PROCESS | 1651 | RSS: Main: 167641088 08:16:25 INFO - PROCESS | 1651 | 08:16:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:28 INFO - PROCESS | 1651 | RSS: Main: 219398144 08:16:28 INFO - PROCESS | 1651 | 08:16:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:16:31 INFO - PROCESS | 1651 | RSS: Main: 232660992 08:16:31 INFO - PROCESS | 1651 | 08:16:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:16:35 INFO - PROCESS | 1651 | RSS: Main: 328208384 08:16:35 INFO - PROCESS | 1651 | 08:16:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:16:38 INFO - PROCESS | 1651 | RSS: Main: 232435712 08:16:38 INFO - PROCESS | 1651 | 08:16:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:40 INFO - PROCESS | 1651 | RSS: Main: 233525248 08:16:40 INFO - PROCESS | 1651 | 08:16:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:43 INFO - PROCESS | 1651 | RSS: Main: 273870848 08:16:43 INFO - PROCESS | 1651 | 08:16:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:47 INFO - PROCESS | 1651 | RSS: Main: 272969728 08:16:47 INFO - PROCESS | 1651 | 08:16:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:16:50 INFO - PROCESS | 1651 | RSS: Main: 269770752 08:16:50 INFO - PROCESS | 1651 | 08:16:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:52 INFO - PROCESS | 1651 | RSS: Main: 247070720 08:16:52 INFO - PROCESS | 1651 | 08:16:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:55 INFO - PROCESS | 1651 | RSS: Main: 250769408 08:16:55 INFO - PROCESS | 1651 | 08:16:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:58 INFO - PROCESS | 1651 | RSS: Main: 252481536 08:16:58 INFO - PROCESS | 1651 | 08:17:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:01 INFO - PROCESS | 1651 | RSS: Main: 269426688 08:17:01 INFO - PROCESS | 1651 | 08:17:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:05 INFO - PROCESS | 1651 | RSS: Main: 263213056 08:17:05 INFO - PROCESS | 1651 | 08:17:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:17:07 INFO - PROCESS | 1651 | RSS: Main: 307539968 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | __start_tp_report 08:17:07 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:17:07 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:17:07 INFO - PROCESS | 1651 | |i|pagename|runs| 08:17:07 INFO - PROCESS | 1651 | |0;ai-astar;102;111;115;158;168;113;113;112;113;113 08:17:07 INFO - PROCESS | 1651 | |1;audio-beat-detection;140;108;110;140;112;111;109;110;133;108 08:17:07 INFO - PROCESS | 1651 | |2;audio-dft;194;181;185;183;182;183;182;183;180;182 08:17:07 INFO - PROCESS | 1651 | |3;audio-fft;79;59;58;87;60;58;58;60;95;82 08:17:07 INFO - PROCESS | 1651 | |4;audio-oscillator;86;70;93;70;67;69;87;67;69;90 08:17:07 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;86;83;86;86;86;82;87;84;86;83 08:17:07 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;93;94;94;122;167;107;95;94;94 08:17:07 INFO - PROCESS | 1651 | |7;imaging-desaturate;83;83;81;83;84;83;82;85;84;80 08:17:07 INFO - PROCESS | 1651 | |8;json-parse-financial;56;57;52;55;58;59;56;57;57;56 08:17:07 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;65;72;73;66;71;69;67;67;69;69 08:17:07 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;79;84;98;80;82;83;82;82;83;81 08:17:07 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;140;137;137;144;146;152;143;137;183;136 08:17:07 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;163;159;158;167;160;163;161;161;158;159 08:17:07 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;65;65;65;66;65;64;64;63;66 08:17:07 INFO - PROCESS | 1651 | __end_tp_report 08:17:07 INFO - PROCESS | 1651 | __start_cc_report 08:17:07 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1824 08:17:07 INFO - PROCESS | 1651 | __end_cc_report 08:17:07 INFO - PROCESS | 1651 | __startTimestamp1485533826998__endTimestamp 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:17:07 INFO - PROCESS | 1651 | Number of tests: 14 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:121.80 Median:113.00 stddev:22.12 (19.6%) stddev-sans-first:22.28 08:17:07 INFO - PROCESS | 1651 | Values: 102.0 111.0 115.0 158.0 168.0 113.0 113.0 112.0 113.0 113.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:111.50 stddev:13.69 (12.3%) stddev-sans-first:12.01 08:17:07 INFO - PROCESS | 1651 | Values: 140.0 108.0 110.0 140.0 112.0 111.0 109.0 110.0 133.0 108.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.00 stddev:3.92 (2.1%) stddev-sans-first:1.41 08:17:07 INFO - PROCESS | 1651 | Values: 194.0 181.0 185.0 183.0 182.0 183.0 182.0 183.0 180.0 182.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:69.60 Median:69.50 stddev:14.49 (20.9%) stddev-sans-first:14.97 08:17:07 INFO - PROCESS | 1651 | Values: 79.0 59.0 58.0 87.0 60.0 58.0 58.0 60.0 95.0 82.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.00 stddev:10.71 (13.7%) stddev-sans-first:10.83 08:17:07 INFO - PROCESS | 1651 | Values: 86.0 70.0 93.0 70.0 67.0 69.0 87.0 67.0 69.0 90.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.73 (2.0%) stddev-sans-first:1.79 08:17:07 INFO - PROCESS | 1651 | Values: 86.0 83.0 86.0 86.0 86.0 82.0 87.0 84.0 86.0 83.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:105.40 Median:94.00 stddev:23.53 (25.0%) stddev-sans-first:24.60 08:17:07 INFO - PROCESS | 1651 | Values: 94.0 93.0 94.0 94.0 122.0 167.0 107.0 95.0 94.0 94.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:82.80 Median:83.00 stddev:1.48 (1.8%) stddev-sans-first:1.56 08:17:07 INFO - PROCESS | 1651 | Values: 83.0 83.0 81.0 83.0 84.0 83.0 82.0 85.0 84.0 80.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.89 (3.3%) stddev-sans-first:2.00 08:17:07 INFO - PROCESS | 1651 | Values: 56.0 57.0 52.0 55.0 58.0 59.0 56.0 57.0 57.0 56.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:2.62 (3.8%) stddev-sans-first:2.39 08:17:07 INFO - PROCESS | 1651 | Values: 65.0 72.0 73.0 66.0 71.0 69.0 67.0 67.0 69.0 69.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:5.34 (6.5%) stddev-sans-first:5.42 08:17:07 INFO - PROCESS | 1651 | Values: 79.0 84.0 98.0 80.0 82.0 83.0 82.0 82.0 83.0 81.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:143.50 stddev:14.12 (9.8%) stddev-sans-first:14.84 08:17:07 INFO - PROCESS | 1651 | Values: 140.0 137.0 137.0 144.0 146.0 152.0 143.0 137.0 183.0 136.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:2.81 (1.7%) stddev-sans-first:2.87 08:17:07 INFO - PROCESS | 1651 | Values: 163.0 159.0 158.0 167.0 160.0 163.0 161.0 161.0 158.0 159.0 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 08:17:07 INFO - PROCESS | 1651 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 64.0 64.0 63.0 66.0 08:17:07 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:17:07 INFO - PROCESS | 1651 | 08:17:07 INFO - TEST-INFO | 1651: exit 0 08:17:08 INFO - TEST-OK | kraken | took 58325ms 08:17:08 INFO - SUITE-END | took 1175s 08:17:08 INFO - Completed test suite (00:19:35) 08:17:08 INFO - javascript benchmark 08:17:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.247765491592, 3430.965690343096, 3431.8627254909807, 3442.363162814878, 3487.860485580577, 5536.972315138423, 5597.524210442107, 5598.440155984399, 5617.269754931853, 5621.213030175773, 5760.7407666655, 5772.971135144318, 5850.795222167214, 5852.824415267549, 5867.0, 5268.5521730652945, 5282.973585132078, 5294.100002999499, 5312.760925758331, 5352.785888564453, 5247.081760691883, 5254.658447200939, 5264.052470555299, 5385.542228910528, 5402.189671549259, 5340.866478338054, 5344.331958505187, 5346.705931173784, 5360.678359298435, 5364.865878353034, 5313.415524292324, 5322.4411436799355, 5337.519623233928, 5371.946280537184, 5396.622236443451, 5195.714235717034, 5246.475352464761, 5267.762950667229, 5315.229291752713, 5327.920081198785, 5871.412858714094, 5914.4676979071655, 5973.0, 5984.132300816401, 5989.760409583611, 6174.629522228681, 6256.311805701369, 6257.155284036642, 6285.968570157165, 6376.234851817811, 6270.184875966141, 6304.810855674337, 6321.399467050669, 6331.430171284606, 6343.968280158616, 5954.10688396744, 5963.522918166623, 5967.0, 5973.223480947492, 5995.0, 6278.843028924313, 6302.086197501337, 6329.556931014785, 6341.048842673636, 6361.713722882481, 6144.662043587557, 6151.72317245725, 6163.753449862045, 6179.351168127372, 6181.258249010058, 6298.307186209513, 6299.055141728777, 6306.085617585516, 6308.621482711052, 6334.968325158345, 6139.461473530765, 6177.505799536027, 6218.160548325918, 6219.844503887349, 6288.213973253343, 6316.842078948063, 6339.746410143634, 6362.427381535684, 6371.426571608577, 6374.298827129012, 4997.725125118153, 5067.138586440314, 5069.822556210515, 5072.442031376546, 5098.719570423662, 4503.68474206809, 4532.614727748112, 4571.428571428572, 4594.33382159585, 4612.0545288215835, 5846.7076646167525, 5855.414458554195, 5856.531477481792, 5859.765609375662, 5861.824145275648, 6301.149344838388, 6307.873842523124, 6321.905171422432, 6322.209723784527, 6324.3991820776955, 4751.548602882721, 5685.0, 5708.40061793514, 5846.327672317653, 5859.0, 5365.3293338332705, 5386.946130538645, 5393.83818485446, 5405.459454054641, 5410.188471729193, 6285.937140628535, 6288.276848162428, 6301.716422761078, 6304.5271604628915, 6307.684615769193, 6183.783567575113, 6265.028920517327, 6285.59143655661, 6294.0, 6331.271903730945, 6358.300586935526, 6360.363963603602, 6364.77723279683, 6374.553781235454, 6375.4262116409745, 6139.8465038372615, 6329.810105696836, 6336.778212762531, 6344.9048264277, 6356.491480681627, 5784.363719990713, 6229.56393052482, 6262.812115636538, 6345.428911397997, 6355.809325720235, 6162.198914141312, 6255.218097737783, 6263.404976527223, 6277.18396608438, 6288.151099601679, 6212.440880320612, 6237.25152981627, 6246.46905013079, 6251.812445626639, 6265.655388953652, 5739.971300143473, 5958.314793798769, 6005.309389420273, 6086.847828804315, 6162.445379915829, 6137.346341658241, 6139.400144844221, 6180.103884936749, 6228.128062071223, 6246.625202487865, 6108.847278817887, 6114.969425152845, 6118.510519158545, 6129.570930034854, 6134.325224225242], "value": 5786.815339849638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.5950499105707, 538.2948337677642, 553.0156321747289, 582.9390509273125, 590.7253127295807, 40125.799371003144, 41436.47789937855, 41438.37842432366, 43556.56443435573, 43635.3454698179, 42798.786006070004, 43300.0, 43324.91687707809, 43351.56648433515, 43438.0, 8994.325425593073, 9450.385724927857, 9610.990845961178, 9615.711528654152, 9626.951865240664, 9131.634734610607, 11579.015783658399, 11788.351640659803, 11813.99581035613, 12020.51917923282, 11820.763584728344, 11865.52537898483, 11884.940575297154, 11891.167618266725, 11894.405279735978, 11754.823677644843, 11808.704782380424, 11819.645410637695, 11829.349385783778, 11851.814818518165, 11615.419229038598, 11645.825312620318, 11691.7077073073, 11696.064314854792, 11702.005329546999, 40515.797421013, 40840.978975525555, 40879.591204087876, 40911.0, 40956.79521602373, 3277.705006549422, 3327.750418718606, 3497.8600855965733, 3527.8236088195486, 3775.9056023599355, 30261.394772104653, 30471.23821904448, 30770.23074423135, 31097.0, 31633.367332653448, 3239.6922292382187, 3243.497257925025, 3278.47544392896, 3293.7035666789866, 3412.3175364927115, 519220.0, 523440.0, 525692.0, 525910.0, 525956.9999999962, 27801.86099069532, 32904.506432403534, 33190.0, 59197.0, 59446.70276648589, 34293.485597716055, 35679.92960211198, 35735.82132089323, 35741.8212908939, 35826.0, 14948.252587370587, 15135.394584216729, 15144.01563898343, 15173.0, 15184.392624294904, 11212.831807522894, 11436.771264574661, 12613.495460181673, 12707.491700331882, 12841.0, 7746.341560967268, 8010.959945200353, 8029.397795165386, 8043.638036288381, 8102.716404925799, 3292.785968912061, 3302.78531895426, 3309.7683162178896, 3321.0, 3325.900222993314, 958.8609651600478, 976.8144052629978, 1077.1275267033727, 1082.8592283003159, 1145.2212495502972, 29763.279445727552, 30006.849965750032, 30126.84936575303, 30141.945031923777, 30197.69802301993, 1050.3435352904435, 1089.9182561307935, 1100.2573263047411, 1121.4897221764077, 1161.3206274329611, 15444.0, 15562.91059625838, 15662.765058524132, 16002.359905603878, 16070.875038747175, 708183.0, 708935.0, 710771.0, 711000.0, 711668.0, 58291.0, 58695.70652146712, 58721.70639146862, 58820.0, 58857.41142588605, 1255.460152134591, 1314.4610709609015, 1383.667919699285, 1384.7230553889262, 1417.9503717369842, 29413.0, 30805.38389232158, 31079.223019424695, 31397.686023139475, 32014.83992580022, 57027.0, 57734.711326443095, 57737.42262577488, 57838.42161578331, 57879.71060144672, 646793.7660311669, 661553.0, 661927.0, 664314.0, 665109.674451644, 34820.82589587036, 42617.36073958955, 42618.57381426146, 43288.0, 44293.778531107135, 46319.53680463152, 46340.536594633624, 46421.07157856892, 46639.0, 47044.529554704015, 34715.784947526714, 37460.62539374681, 38583.42124868185, 39218.80390598029, 40656.59343406646, 34005.0, 34994.47508287428, 38623.42064869085, 38920.80539597284, 40062.79968600138, 37068.814655926544, 38351.0, 38788.41817372685, 38818.6118138815, 38888.222235555695, 30556.694433056273, 31769.682303176673, 34416.311673765886, 34770.30459390747, 34867.82566087153, 20833.374998750063, 25525.3618659535, 25946.0, 25959.61060584055, 26090.956361745317], "value": 19564.84194764248, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.62404843253626, 388.5318191579147, 395.76452011053414, 399.4367941202905, 410.3352568838482, 13885.861141388608, 19744.506387340323, 20580.0, 21052.15791368345, 21097.894510527443, 16271.755923661154, 17379.391721289758, 19835.702464463044, 20326.491837704063, 20459.48851278719, 5740.454656807597, 6032.306284777263, 6044.486218671396, 6050.697465126748, 6063.120847477113, 5860.619059761102, 5890.911636325437, 5911.083782013795, 5928.733207005674, 6012.428819262163, 5919.49684276837, 5920.289565252176, 5932.37710040446, 5932.584719069667, 5934.64392136471, 5757.193992841006, 5769.596128271001, 5895.292564892197, 5899.380565040652, 5925.4963328117165, 5166.948330516722, 5194.896102077937, 5197.974010129963, 5198.376194856603, 5210.583153347723, 25453.0, 25733.0, 25792.74207257922, 25952.0, 26101.608475872687, 2061.3815855243515, 2430.611102223636, 2440.6095024795945, 2560.7695307422237, 2944.175630823373, 15663.686726265525, 15856.682866342724, 15860.127692976881, 16057.116858572774, 16502.33990640373, 1908.2557802457052, 1911.3405874973112, 1915.0, 1942.359021522894, 2018.7981201879695, 106777.0, 107742.0, 109404.4529777346, 112673.0, 113601.43199284033, 9203.677871274607, 10606.628767993083, 10751.0, 11342.659720208407, 11399.373034483184, 13891.374888130058, 13902.51341203053, 14024.509142180179, 14030.508932187324, 14067.366968486444, 6899.448044156456, 7235.6020418876415, 7934.761957141295, 8055.154208808108, 8637.0, 7274.345308922222, 8430.578471076422, 8554.61504232311, 8698.086700896441, 8811.339149563808, 6663.633500157441, 6663.633955039205, 6675.699593518303, 6676.766313179015, 6682.832929176712, 1520.4070412539118, 1576.0779943733044, 1692.069361850977, 1741.2425594866274, 1782.2336395350123, 921.953902304882, 942.359195746885, 1009.4347165587294, 1012.1599072769731, 1067.551807661243, 20840.0, 22321.55356892853, 22326.441838954157, 22480.988355523714, 22493.875306234622, 948.4925564822787, 955.6559638530124, 963.9855402168973, 970.5050424283667, 1012.5139932832282, 11166.497507612177, 11782.528698852122, 11800.70498237551, 11823.940880295544, 11831.704207394712, 581845.0, 591265.0, 593364.0, 608966.0, 608997.0, 105725.0, 111805.44097279462, 112997.35013249304, 113190.0, 118483.0, 881.378628067211, 1032.4528000159778, 1035.7151783259512, 1056.6196169379018, 1060.4909643371225, 12914.22514649124, 13199.604011879659, 18717.71923421177, 20305.79694203039, 20368.388948331572, 51698.74150629223, 52425.47574524206, 52465.0, 52702.0, 54024.18963715626, 59507.70246148915, 75284.62357688395, 82419.0, 82579.0, 83567.5821620888, 5598.10430331145, 5655.0, 8020.598970051357, 8270.669173233004, 8678.479291242546, 12501.06242031833, 12859.29273889945, 12992.220466772023, 13317.267550284827, 13393.0, 11144.387058711849, 11432.428378581204, 11475.655730328104, 11650.184487085822, 11698.35659038761, 4644.93032604518, 8887.289016878505, 9297.72106836796, 11278.210525263154, 11574.47914843851, 11517.193796434169, 11558.94220528892, 11773.0, 11837.76324473523, 11882.584109556125, 7481.17707052213, 7974.0, 8217.055038670629, 8452.873206901779, 8546.188112129337, 10194.235432342455, 11165.553377865119, 11412.372319522174, 11456.427178641201, 11676.94161529187], "value": 9638.412212754658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.7879296898432, 1534.831168571457, 1709.4017094017095, 1850.2691436882433, 1861.097367776629, 8086.150954149811, 8532.0, 8542.359323050765, 8546.91453085469, 8550.40147189697, 7592.27873352032, 7799.961000195005, 8091.393145514081, 8279.172082791732, 8312.91687083129, 2324.860508369499, 2358.021421110237, 2361.752016038317, 2365.5860224460735, 2367.6922000139957, 2363.0, 2401.7238017627933, 2408.157144999254, 2411.770881766229, 2418.5646583614944, 2358.433975845802, 2360.5868972929757, 2382.9880850595723, 2384.666146739458, 2385.3917251100943, 2335.871527066011, 2339.836211465198, 2357.1867705641525, 2360.6104992676187, 2360.988195059031, 2365.5741966446035, 2373.8219633527556, 2394.2936833633944, 2396.676448679423, 2397.616381378971, 8365.665373385058, 8416.452930559555, 8483.490990540588, 8492.065872753992, 8504.489730616182, 5114.488551144893, 5263.763130659129, 5267.604929630293, 5271.077561426735, 5272.367315922075, 3023.3046399328277, 3526.9118272043147, 3536.416491278936, 3566.1262990567216, 3614.819259037064, 1065.169168048923, 1090.7619851468562, 1112.8998390144925, 1120.098320851714, 1126.4142645824209, 10884.07485363745, 10996.340219586851, 11004.229703920728, 11010.889891101067, 11011.394373309466, 4489.730616162975, 4643.141018911512, 4717.599004084623, 4718.3158442025715, 4781.737004464719, 9533.0, 9535.61857525705, 9540.856887146698, 9546.856797148048, 9556.569954352071, 5280.075986702312, 5285.312909321764, 5289.603279754034, 5290.365156181283, 5300.734963251822, 4373.125374925028, 4392.956070439319, 4809.0, 4868.196747536687, 4874.8537543873035, 3833.616638336144, 3882.107115363482, 3934.5278566572197, 3969.1069509360163, 3982.024404021033, 1272.821804947308, 1276.9808452873215, 1277.3549357574366, 1287.7939529675207, 1292.1019891175542, 778.3656320099101, 794.06697130871, 914.2914241462787, 918.5453200665713, 919.2094798473307, 5523.226748255248, 5543.52880005196, 5616.522595579421, 5886.175935369051, 5894.646321220741, 838.2037064788475, 935.1209862729013, 984.3552473130111, 1038.2939601071344, 1060.4379678770265, 3071.892483763102, 3818.3508803503473, 3835.5589107252463, 3954.5254569451276, 3993.341098718737, 8140.389470789714, 10062.899371006197, 10171.389716616879, 10173.84739228912, 10203.03071208249, 9594.520273986273, 9831.606735730633, 10117.190624750003, 10124.34191777532, 10129.746756331151, 7743.5353878767455, 7970.840583188304, 7975.4018448615425, 7975.800604984805, 7985.041794984523, 5575.553955683617, 5695.544356451391, 5782.161586570008, 5819.010768169506, 5961.7615295387695, 9387.061293870558, 9443.961164272063, 9492.762680932756, 9526.428414295164, 9556.139947404767, 9153.954230228806, 9678.322517423712, 9782.021797820162, 9791.608335666493, 9794.559244834141, 6772.153480814898, 6949.166100068024, 6958.408535274559, 7190.280971902768, 7359.742409015659, 7675.309222170032, 7714.15144334134, 7734.92265077342, 7789.688412463438, 7999.360051196007, 6066.272047354346, 7044.506884518035, 7287.161976372573, 7338.70645174187, 7382.52013619113, 7040.894386584103, 7103.857922841411, 7137.464690148364, 7172.318629730167, 7233.674484648309, 5695.601307908407, 6761.830954225987, 6846.281140480377, 6846.349596788297, 6866.690998905161, 4767.118083154627, 4838.540338667821, 4870.683405578768, 4877.853664390074, 4930.531599498042, 4770.28445733129, 4779.928301075417, 4844.612431005582, 4939.950600493949, 4950.6039516837845], "value": 4478.151709905525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2651745238559, 314.23954031244386, 319.2481705583351, 323.7296857124301, 327.7984039815514, 4464.776761161941, 5261.501416289075, 5411.594130440218, 5447.155690867917, 5473.945260547393, 3778.9811050944777, 4420.872677467241, 4466.0, 4616.930746038812, 4657.6972496787685, 3711.257748450307, 3865.8260378282976, 3976.483057202574, 4111.527174374955, 4137.606927341898, 4111.218868415007, 4111.48606424197, 4112.0, 4112.622271539023, 4151.0, 3340.632530421664, 3665.321915445638, 3826.617338266179, 4101.610347017028, 4106.384042393635, 3362.57090736436, 3689.3728066228673, 4047.6964227682747, 4084.530279017921, 4103.379165229748, 3305.3389322135667, 3309.3381323735107, 3508.7894626385214, 3533.3463309287863, 3539.663731945461, 5161.483851614846, 5255.872755710347, 5257.579393648499, 5281.623269528727, 5320.787168513293, 4053.8783836484954, 4271.0, 4431.711938723973, 4654.418197725285, 4669.599120263942, 5193.065248255312, 5416.025115479212, 5672.432756724335, 5676.574256930747, 5684.602077854552, 3719.5350581177354, 3893.76637401754, 3898.919853315877, 3901.590333015021, 3904.531456225243, 5045.344105266292, 5259.606878870105, 5364.0, 5509.393966663663, 5974.864775692605, 2991.880324786984, 3002.316386437165, 3565.5721313442036, 3637.0725465006253, 3865.16898866745, 3370.76404651672, 3604.8104125638474, 3968.250003746432, 4015.799210039545, 4018.8392464301687, 3690.612485689018, 4234.491860976703, 4258.659307255412, 4625.941456052092, 4675.246782456578, 5172.568892620462, 5504.091824848935, 5638.4925356718095, 5719.7140142992685, 5728.567858035492, 1071.5874388360537, 1098.6102580236009, 1275.7051592633484, 1282.9095269021257, 1296.6110166949877, 818.6397984886631, 846.7967687754895, 852.2202185000655, 874.9762777550281, 881.6164968238709, 4321.546237645002, 4593.035462552834, 4820.084184005098, 5140.871478213075, 5156.948430515722, 4553.772311384418, 4848.8787780305065, 5579.776808927598, 5585.636933599303, 5602.943970560243, 4302.763348015889, 4701.271302948048, 4810.22021851917, 4817.567128600104, 5023.19628859388, 2527.5703130467864, 2554.9105781297567, 2560.2959186223566, 2899.913002609925, 2904.6514418269944, 4966.882451448395, 5068.898622027539, 5707.74315155819, 5714.771324165241, 5755.769769209185, 4786.856394308176, 4883.731394773322, 5145.407316263334, 5477.945220547823, 5651.463111004448, 4816.590589799906, 5176.689398636018, 5668.8866222675315, 5671.773129074873, 5687.744051517691, 4532.471138969339, 4572.291294849304, 5160.09698302788, 5231.136862417658, 5525.557955363642, 4254.702170848011, 4620.237660786067, 5284.709340986283, 5392.622516423813, 5461.5357694596405, 5134.614903882149, 5237.119584228735, 5424.945750542444, 5720.48515633595, 5729.598928074995, 3417.846196921095, 3522.330757156132, 3693.7045036396485, 3697.963020369762, 3716.554013518395, 4978.3820258415435, 5073.579397768631, 5122.436531981404, 5493.176023596492, 5508.3114610673665, 5335.559398962336, 5335.973320133529, 5342.839714808562, 5371.543418809289, 5393.892122157614, 4579.885502862455, 4597.7241365518175, 4691.835785747482, 5295.735213239245, 5336.079011555915, 4972.204447288416, 5182.585393168612, 5213.556847667991, 5290.232916227049, 5309.283246761638, 4633.745144016976, 5577.358603760457, 5583.720813959367, 5747.568932330176, 5872.29532456108, 5447.992121457543, 5676.517496012885, 5696.658200507983, 5699.51554117888, 5749.770009199585], "value": 3938.7062097488433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6330708031824, 727.3272223193542, 748.2928632442342, 805.2551389964282, 837.6816809612346, 14806.925965370185, 15560.53318400447, 15669.529914102566, 15677.921610391932, 15692.529224123266, 13954.162750234993, 14137.36381862816, 14165.220912849814, 14168.008239423245, 14170.645733856658, 718.6981467783518, 737.7159793479523, 858.5578427110028, 863.7754183912197, 885.2298500304744, 836.6946064686376, 858.5664239559014, 875.1073904617286, 875.7285241575132, 878.925291350236, 945.0502245243521, 945.4043952310035, 945.7493764152505, 945.9574319155655, 947.3889341374809, 933.8459154239542, 935.7333160049353, 936.8828896387952, 938.3290946972947, 944.593824655398, 703.7501686901128, 704.594857956677, 704.7075463682565, 704.8555046215514, 706.9819459977616, 14408.0, 14409.351579178961, 14439.278036098152, 14445.638859028504, 14455.638609034753, 13903.531370139935, 14427.71144577113, 14482.0, 14513.492027779082, 14667.413303467954, 10932.0, 11224.045956093742, 11379.772404551946, 11753.706157346049, 11768.764624707457, 4586.908261834778, 4606.56237657422, 4639.582437580634, 4721.268203428474, 4780.569748722597, 81979.59010204971, 82819.343613128, 98676.0, 99558.0044199556, 100326.4983675077, 10246.53890574926, 10413.809832624693, 10867.184961127947, 10885.292455990335, 11010.90792749375, 19776.70334944977, 19788.70316945247, 19793.30723424673, 19800.108995095256, 19869.801301986794, 7378.114626244885, 7532.585707786125, 7772.0, 7783.4162437817395, 7926.167752385916, 4400.0, 4406.228909940747, 4410.29435290352, 4566.680332376768, 4600.033992861537, 3307.5534802801794, 3402.2344972381015, 3402.4726167444087, 3408.454647256427, 3421.161815355204, 591.3052163707712, 606.9757209711562, 608.4159207161086, 615.7813976038532, 634.3276127305071, 579.7709904587664, 604.0168608975948, 618.3322012226785, 622.5704264057786, 649.655682488282, 7316.853662926712, 9042.003206809266, 9115.270778337717, 9257.305702072372, 9408.341416100808, 555.4806256150512, 602.3554796367845, 622.819382379114, 625.4808508937571, 647.8671872266174, 4214.452121224222, 4415.337699345059, 4466.173757854807, 4489.551044895549, 4539.251023581072, 115089.27366089515, 116912.0, 117204.0, 118227.40886295686, 124539.0, 69237.0, 70965.93551096738, 85569.57215213885, 103459.482702586, 107140.0, 68872.0, 89865.65201521982, 90881.09118908859, 95253.52373238228, 97896.51051744695, 7887.974563306963, 8178.959105204436, 8429.704960326359, 8949.927782858913, 8964.955175224082, 47079.76460117677, 55718.0, 58498.75128105636, 58550.82898342094, 58728.70635646794, 83061.58469207615, 83886.64453421795, 85081.0, 86583.70124448012, 86812.56593716991, 10944.781104378028, 11036.834447483134, 11123.888761112285, 11304.886951130713, 11320.433978300887, 12085.697857553632, 12150.57472988441, 12306.384680765746, 12372.381380931098, 12566.623001309976, 11170.553177872795, 11203.271787333797, 11520.481578328827, 11565.537378504765, 12476.563320283747, 11486.770264594828, 11660.12549058807, 12121.090918181348, 12290.631281061582, 12304.507819687113, 11547.769044618892, 12063.517459301529, 12203.389830508617, 12299.815502767287, 12350.691232719253, 8007.639656215601, 9592.08875156859, 9857.35927164732, 10485.737856553647, 10628.309159904582, 8712.433691810013, 9330.766730831783, 10002.0, 10129.696109116738, 10137.543810528692], "value": 7321.665050298122, "unit": "score"}], "name": "dromaeo_css", "value": 7213.929466680304, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 115.0, 158.0, 168.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 110.0, 140.0, 112.0, 111.0, 109.0, 110.0, 133.0, 108.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 181.0, 185.0, 183.0, 182.0, 183.0, 182.0, 183.0, 180.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 87.0, 60.0, 58.0, 58.0, 60.0, 95.0, 82.0], "value": 69.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 93.0, 70.0, 67.0, 69.0, 87.0, 67.0, 69.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 86.0, 86.0, 82.0, 87.0, 84.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 122.0, 167.0, 107.0, 95.0, 94.0, 94.0], "value": 105.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 83.0, 84.0, 83.0, 82.0, 85.0, 84.0, 80.0], "value": 82.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 52.0, 55.0, 58.0, 59.0, 56.0, 57.0, 57.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 73.0, 66.0, 71.0, 69.0, 67.0, 67.0, 69.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 98.0, 80.0, 82.0, 83.0, 82.0, 82.0, 83.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 137.0, 144.0, 146.0, 152.0, 143.0, 137.0, 183.0, 136.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 158.0, 167.0, 160.0, 163.0, 161.0, 161.0, 158.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 64.0, 63.0, 66.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1422.6, "alertThreshold": 2.0}]} 08:17:08 INFO - Return code: 0 08:17:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:17:08 INFO - # TBPL SUCCESS # 08:17:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:08 INFO - 2017-01-27 08:17:08.304 screenresolution[1655:10099] starting screenresolution argv=screenresolution get 08:17:08 INFO - 2017-01-27 08:17:08.309 screenresolution[1655:10099] Display 0: 1600x1200x32@60 08:17:08 INFO - 2017-01-27 08:17:08.315 screenresolution[1656:10102] starting screenresolution argv=screenresolution list 08:17:08 INFO - Available Modes on Display 0 08:17:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:08 INFO - Intel Iris: 08:17:08 INFO - Chipset Model: Intel Iris 08:17:08 INFO - Type: GPU 08:17:08 INFO - Bus: Built-In 08:17:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:08 INFO - Vendor: Intel (0x8086) 08:17:08 INFO - Device ID: 0x0a2e 08:17:08 INFO - Revision ID: 0x0009 08:17:08 INFO - Displays: 08:17:08 INFO - Display: 08:17:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:08 INFO - Display Serial Number: 1600x1200 60 08:17:08 INFO - Main Display: Yes 08:17:08 INFO - Mirror: Off 08:17:08 INFO - Online: Yes 08:17:08 INFO - Rotation: Supported 08:17:08 INFO - Return code: 0 08:17:08 INFO - Running post-action listener: _resource_record_post_action 08:17:08 INFO - [mozharness: 2017-01-27 16:17:08.554058Z] Finished run-tests step (success) 08:17:08 INFO - Running post-run listener: _resource_record_post_run 08:17:08 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 32615424; Write bytes: 501285888; Read time: 196; Write time: 1578 08:17:08 INFO - TinderboxPrint: CPU usage
53.6% 08:17:08 INFO - TinderboxPrint: I/O read bytes / time
32,615,424 / 196 08:17:08 INFO - TinderboxPrint: I/O write bytes / time
501,285,888 / 1,578 08:17:08 INFO - TinderboxPrint: CPU idle
2,224.4 (46.4%) 08:17:08 INFO - TinderboxPrint: CPU system
963.7 (20.1%) 08:17:08 INFO - TinderboxPrint: CPU user
1,601.7 (33.4%) 08:17:08 INFO - TinderboxPrint: Swap in / out
220,045,312 / 0 08:17:08 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187517440; Write bytes: 186114048; Read time: 16807; Write time: 393 08:17:08 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30653440; Write bytes: 306270720; Read time: 179; Write time: 1153 08:17:09 INFO - Running post-run listener: _upload_blobber_files 08:17:09 INFO - Blob upload gear active. 08:17:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:17:09 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 08:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:17:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:10 INFO - (blobuploader) - INFO - Done attempting. 08:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:11 INFO - (blobuploader) - INFO - Done attempting. 08:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:13 INFO - (blobuploader) - INFO - Done attempting. 08:17:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:13 INFO - Return code: 0 08:17:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:17:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e92fbf26cf2a9f25d2f481a0c1524570cfb7282b475d2aec1c392749adbc24a6c8577ac1a6ff79a413f7813e2480b7a555bda0bf322c9aa3c56dc5b589b106a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df84f3d4d9fe10e3cc662fa355ee0a177c27e4166a84e53c98975fe77ae9977513170bd7c54c28d201beb8f6b407c0666f5776262f48db90deade6619bb2805d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1333d223a9d6ae7ee48ed74dce7056ebcf463c3ddae2c4639cb30c309fa5bc81ade3cf56c4d6ff5b90376964b4011935d77991f05b5942eb9369054afb31d5a"} 08:17:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:17:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:17:13 INFO - Contents: 08:17:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e92fbf26cf2a9f25d2f481a0c1524570cfb7282b475d2aec1c392749adbc24a6c8577ac1a6ff79a413f7813e2480b7a555bda0bf322c9aa3c56dc5b589b106a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df84f3d4d9fe10e3cc662fa355ee0a177c27e4166a84e53c98975fe77ae9977513170bd7c54c28d201beb8f6b407c0666f5776262f48db90deade6619bb2805d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1333d223a9d6ae7ee48ed74dce7056ebcf463c3ddae2c4639cb30c309fa5bc81ade3cf56c4d6ff5b90376964b4011935d77991f05b5942eb9369054afb31d5a"} 08:17:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:17:13 INFO - Copying logs to upload dir... 08:17:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:17:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.905857 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-27 08:17:13.864935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 08:17:13.868234) ========= 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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e92fbf26cf2a9f25d2f481a0c1524570cfb7282b475d2aec1c392749adbc24a6c8577ac1a6ff79a413f7813e2480b7a555bda0bf322c9aa3c56dc5b589b106a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df84f3d4d9fe10e3cc662fa355ee0a177c27e4166a84e53c98975fe77ae9977513170bd7c54c28d201beb8f6b407c0666f5776262f48db90deade6619bb2805d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1333d223a9d6ae7ee48ed74dce7056ebcf463c3ddae2c4639cb30c309fa5bc81ade3cf56c4d6ff5b90376964b4011935d77991f05b5942eb9369054afb31d5a"} build_url:https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/TySwGgQjQSanWiefSwhz1Q/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e92fbf26cf2a9f25d2f481a0c1524570cfb7282b475d2aec1c392749adbc24a6c8577ac1a6ff79a413f7813e2480b7a555bda0bf322c9aa3c56dc5b589b106a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/df84f3d4d9fe10e3cc662fa355ee0a177c27e4166a84e53c98975fe77ae9977513170bd7c54c28d201beb8f6b407c0666f5776262f48db90deade6619bb2805d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1333d223a9d6ae7ee48ed74dce7056ebcf463c3ddae2c4639cb30c309fa5bc81ade3cf56c4d6ff5b90376964b4011935d77991f05b5942eb9369054afb31d5a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 08:17:13.903935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 08:17:13.904266) ========= 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.zqxWAl7uTC/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.m9rxBYcsEX/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.004859 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 08:17:13.952715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 08:17:13.953043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 08:17:13.953371) ========= ========= Total master_lag: 0.18 =========