builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1488215383.03 results: success (0) buildid: 20170227073937 builduid: dc9292f741e049859b863aa7f7a7533e revision: 0aa9bc696bc9f0335e8c7531c28c238286eeba43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.028257) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.029065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.029621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.059626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.060142) ========= 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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-02-27 09:09:43-- 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% 13.5M=0.001s 2017-02-27 09:09:43 (13.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176412 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.262639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.263004) ========= 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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.026341 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:43.315229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-27 09:09:43.316115) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0aa9bc696bc9f0335e8c7531c28c238286eeba43 --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-aurora --rev 0aa9bc696bc9f0335e8c7531c28c238286eeba43 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QCUZjjQCLj/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.UiOJnUrHSA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-02-27 09:09:43,546 truncating revision to first 12 chars 2017-02-27 09:09:43,546 Setting DEBUG logging. 2017-02-27 09:09:43,546 attempt 1/10 2017-02-27 09:09:43,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0aa9bc696bc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 09:09:45,829 unpacking tar archive at: mozilla-aurora-0aa9bc696bc9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.580936 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-27 09:09:45.925670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:45.926148) ========= script_repo_revision: 0aa9bc696bc9f0335e8c7531c28c238286eeba43 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:45.926727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:45.927212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 09:09:45.948541) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-27 09:09:45.949054) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QCUZjjQCLj/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.UiOJnUrHSA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:09:46 INFO - MultiFileLogger online at 20170227 09:09:46 in /builds/slave/test 09:09:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:09:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:46 INFO - {'append_to_log': False, 09:09:46 INFO - 'base_work_dir': '/builds/slave/test', 09:09:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:09:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:46 INFO - 'branch': 'Mozilla-Aurora', 09:09:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:46 INFO - 'config_files': ('talos/mac_config.py',), 09:09:46 INFO - 'default_actions': ('clobber', 09:09:46 INFO - 'read-buildbot-config', 09:09:46 INFO - 'download-and-extract', 09:09:46 INFO - 'populate-webroot', 09:09:46 INFO - 'create-virtualenv', 09:09:46 INFO - 'install', 09:09:46 INFO - 'run-tests'), 09:09:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:46 INFO - 'download_minidump_stackwalk': True, 09:09:46 INFO - 'download_symbols': 'ondemand', 09:09:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:46 INFO - 'installer_path': 'installer.exe', 09:09:46 INFO - 'log_level': 'info', 09:09:46 INFO - 'log_name': 'talos', 09:09:46 INFO - 'log_to_console': True, 09:09:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:09:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:09:46 INFO - 'opt_config_files': (), 09:09:46 INFO - 'pip_index': False, 09:09:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:09:46 INFO - 'cmd': ('bash', 09:09:46 INFO - '-c', 09:09:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:09:46 INFO - 'enabled': True, 09:09:46 INFO - 'halt_on_failure': False, 09:09:46 INFO - 'name': 'check_screen_resolution'},), 09:09:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:09:46 INFO - 'cmd': ('bash', 09:09:46 INFO - '-c', 09:09:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:09:46 INFO - 'enabled': True, 09:09:46 INFO - 'halt_on_failure': False, 09:09:46 INFO - 'name': 'check_screen_resolution'},), 09:09:46 INFO - 'run_cmd_checks_enabled': True, 09:09:46 INFO - 'sps_profile': False, 09:09:46 INFO - 'sps_profile_interval': 0, 09:09:46 INFO - 'suite': 'dromaeojs', 09:09:46 INFO - 'system_bits': '32', 09:09:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:46 INFO - 'title': 't-yosemite-r7-0030', 09:09:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:46 INFO - 'use_talos_json': True, 09:09:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:46 INFO - 'work_dir': 'build'} 09:09:46 INFO - [mozharness: 2017-02-27 17:09:46.287113Z] Running clobber step. 09:09:46 INFO - Running pre-action listener: _resource_record_pre_action 09:09:46 INFO - Running main action method: clobber 09:09:46 INFO - rmtree: /builds/slave/test/build 09:09:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:48 INFO - Running post-action listener: _resource_record_post_action 09:09:48 INFO - [mozharness: 2017-02-27 17:09:48.801560Z] Finished clobber step (success) 09:09:48 INFO - [mozharness: 2017-02-27 17:09:48.801703Z] Running read-buildbot-config step. 09:09:48 INFO - Running pre-action listener: _resource_record_pre_action 09:09:48 INFO - Running main action method: read_buildbot_config 09:09:48 INFO - Using buildbot properties: 09:09:48 INFO - { 09:09:48 INFO - "project": "", 09:09:48 INFO - "product": "firefox", 09:09:48 INFO - "script_repo_revision": "production", 09:09:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:09:48 INFO - "repository": "", 09:09:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:09:48 INFO - "buildid": "20170227073937", 09:09:48 INFO - "pgo_build": "False", 09:09:48 INFO - "basedir": "/builds/slave/test", 09:09:48 INFO - "buildnumber": 14, 09:09:48 INFO - "slavename": "t-yosemite-r7-0030", 09:09:48 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:09:48 INFO - "platform": "yosemite_r7", 09:09:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:09:48 INFO - "branch": "mozilla-aurora", 09:09:48 INFO - "repo_path": "releases/mozilla-aurora", 09:09:48 INFO - "revision": "0aa9bc696bc9f0335e8c7531c28c238286eeba43", 09:09:48 INFO - "stage_platform": "macosx64", 09:09:48 INFO - "builduid": "dc9292f741e049859b863aa7f7a7533e", 09:09:48 INFO - "slavebuilddir": "test" 09:09:48 INFO - } 09:09:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:09:48 INFO - Running post-action listener: _resource_record_post_action 09:09:48 INFO - [mozharness: 2017-02-27 17:09:48.805028Z] Finished read-buildbot-config step (success) 09:09:48 INFO - [mozharness: 2017-02-27 17:09:48.805162Z] Running download-and-extract step. 09:09:48 INFO - Running pre-action listener: _resource_record_pre_action 09:09:48 INFO - Running main action method: download_and_extract 09:09:48 INFO - mkdir: /builds/slave/test/build/tests 09:09: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')]} 09:09:48 INFO - trying https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:09:48 INFO - Downloading https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:09:50 INFO - Downloaded 1199 bytes. 09:09:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:09:50 INFO - Using the following test package requirements: 09:09:50 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:09:50 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:09:50 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:09:50 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'jsshell-mac.zip'], 09:09:50 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:09:50 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:09:50 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:09:50 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:09:50 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:09:50 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:09:50 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:09:50 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:09:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:09:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:09:50 INFO - Fetch https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:09:51 INFO - Expected file size: 16357707 09:09:51 INFO - Obtained file size: 16357707 09:09:57 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:09:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:09:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:09:57 INFO - Fetch https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:09:58 INFO - Expected file size: 16357707 09:09:58 INFO - Obtained file size: 16357707 09:10:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:10:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:10:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:10:06 INFO - Expected file size: 14403472 09:10:06 INFO - Obtained file size: 14403472 09:10:06 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')]} 09:10:06 INFO - trying https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:10:08 INFO - Downloaded 73924016 bytes. 09:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:10:08 INFO - mkdir: /builds/slave/test/properties 09:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:10:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:10:08 INFO - Contents: 09:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:10:09 INFO - Running post-action listener: _resource_record_post_action 09:10:09 INFO - Running post-action listener: set_extra_try_arguments 09:10:09 INFO - [mozharness: 2017-02-27 17:10:09.589077Z] Finished download-and-extract step (success) 09:10:09 INFO - [mozharness: 2017-02-27 17:10:09.589214Z] Running populate-webroot step. 09:10:09 INFO - Running pre-action listener: _resource_record_pre_action 09:10:09 INFO - Running main action method: populate_webroot 09:10:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:10:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:10:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:10:09 INFO - '--tppagecycles', 09:10:09 INFO - '7'], 09:10:09 INFO - 'tests': ['tsvgm']}}, 09:10:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:10:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:10:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:10:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:10:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['damp', 'tps']}, 09:10:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'tests': ['damp', 'tps']}, 09:10:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['dromaeo_dom']}, 09:10:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:10:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['basic_compositor_video']}, 09:10:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:10:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['a11yr', 09:10:09 INFO - 'ts_paint', 09:10:09 INFO - 'tpaint', 09:10:09 INFO - 'sessionrestore', 09:10:09 INFO - 'sessionrestore_no_auto_restore', 09:10:09 INFO - 'tabpaint']}, 09:10:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:10:09 INFO - 'ts_paint', 09:10:09 INFO - 'tpaint', 09:10:09 INFO - 'sessionrestore', 09:10:09 INFO - 'sessionrestore_no_auto_restore', 09:10:09 INFO - 'tabpaint']}, 09:10:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:10:09 INFO - 'ts_paint', 09:10:09 INFO - 'tpaint', 09:10:09 INFO - 'sessionrestore', 09:10:09 INFO - 'sessionrestore_no_auto_restore', 09:10:09 INFO - 'tabpaint']}, 09:10:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:10:09 INFO - 'ts_paint', 09:10:09 INFO - 'tpaint', 09:10:09 INFO - 'sessionrestore', 09:10:09 INFO - 'sessionrestore_no_auto_restore', 09:10:09 INFO - 'tabpaint']}, 09:10:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['a11yr', 09:10:09 INFO - 'ts_paint', 09:10:09 INFO - 'tpaint', 09:10:09 INFO - 'sessionrestore', 09:10:09 INFO - 'sessionrestore_no_auto_restore', 09:10:09 INFO - 'tabpaint']}, 09:10:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['a11yr', 09:10:09 INFO - 'ts_paint', 09:10:09 INFO - 'tpaint', 09:10:09 INFO - 'sessionrestore', 09:10:09 INFO - 'sessionrestore_no_auto_restore', 09:10:09 INFO - 'tabpaint']}, 09:10:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['tsvgx', 09:10:09 INFO - 'tsvgr_opacity', 09:10:09 INFO - 'tart', 09:10:09 INFO - 'tscrollx', 09:10:09 INFO - 'cart', 09:10:09 INFO - 'tsvg_static']}, 09:10:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:10:09 INFO - 'tsvgr_opacity', 09:10:09 INFO - 'tart', 09:10:09 INFO - 'tscrollx', 09:10:09 INFO - 'cart', 09:10:09 INFO - 'tsvg_static']}, 09:10:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'talos_options': ['--disable-e10s'], 09:10:09 INFO - 'tests': ['tp5o']}, 09:10:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:10:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'talos_options': ['--disable-e10s', 09:10:09 INFO - '--xperf_path', 09:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:09 INFO - 'tests': ['tp5n']}, 09:10:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:10:09 INFO - 'talos_options': ['--xperf_path', 09:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:09 INFO - 'tests': ['tp5n']}}, 09:10:09 INFO - 'talos.zip': {'path': '', 09:10:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:10:09 INFO - Running post-action listener: _resource_record_post_action 09:10:09 INFO - [mozharness: 2017-02-27 17:10:09.607535Z] Finished populate-webroot step (success) 09:10:09 INFO - [mozharness: 2017-02-27 17:10:09.607681Z] Running create-virtualenv step. 09:10:09 INFO - Running pre-action listener: _resource_record_pre_action 09:10:09 INFO - Running main action method: create_virtualenv 09:10:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:10:09 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 09:10:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:10:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:10:09 INFO - Using real prefix '/tools/python27' 09:10:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:10:13 INFO - Installing pip.................done. 09:10:13 INFO - Return code: 0 09:10:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:10:13 INFO - Reading from file tmpfile_stdout 09:10:13 INFO - Output received: 09:10:13 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) 09:10:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:10:13 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')]} 09:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:13 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')]} 09:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:13 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:13 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 09:10:13 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 09:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:13 INFO - 'HOME': '/Users/cltbld', 09:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:13 INFO - 'LOGNAME': 'cltbld', 09:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:13 INFO - 'MOZ_NO_REMOTE': '1', 09:10:13 INFO - 'NO_EM_RESTART': '1', 09:10:13 INFO - 'PAGER': '/bin/cat', 09:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:13 INFO - 'PWD': '/builds/slave/test', 09:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:13 INFO - 'SHELL': '/bin/bash', 09:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:13 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:13 INFO - 'USER': 'cltbld', 09:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:13 INFO - 'XPC_FLAGS': '0x0', 09:10:13 INFO - 'XPC_SERVICE_NAME': '0', 09:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:13 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 09:10:13 INFO - Cleaning up... 09:10:13 INFO - Return code: 0 09:10:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:10:13 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')]} 09:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:13 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')]} 09:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:13 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:13 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 09:10:13 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 09:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:13 INFO - 'HOME': '/Users/cltbld', 09:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:13 INFO - 'LOGNAME': 'cltbld', 09:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:13 INFO - 'MOZ_NO_REMOTE': '1', 09:10:13 INFO - 'NO_EM_RESTART': '1', 09:10:13 INFO - 'PAGER': '/bin/cat', 09:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:13 INFO - 'PWD': '/builds/slave/test', 09:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:13 INFO - 'SHELL': '/bin/bash', 09:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:13 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:13 INFO - 'USER': 'cltbld', 09:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:13 INFO - 'XPC_FLAGS': '0x0', 09:10:13 INFO - 'XPC_SERVICE_NAME': '0', 09:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:14 INFO - Downloading/unpacking psutil>=3.1.1 09:10:14 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 09:10:14 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 09:10:14 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 09:10:14 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 09:10:14 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 09:10:14 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 09:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:17 INFO - Installing collected packages: psutil 09:10:17 INFO - Running setup.py install for psutil 09:10:17 INFO - building 'psutil._psutil_osx' extension 09:10:17 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 09:10:18 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 09:10:18 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 09:10:18 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 09:10:18 INFO - building 'psutil._psutil_posix' extension 09:10:18 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 09:10:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:10:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:10:18 INFO - ^ 09:10:18 INFO - 1 warning generated. 09:10:18 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 09:10:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:18 INFO - Successfully installed psutil 09:10:18 INFO - Cleaning up... 09:10:18 INFO - Return code: 0 09:10:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:10:18 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')]} 09:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:18 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')]} 09:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:18 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:18 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 09:10:18 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 09:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:18 INFO - 'HOME': '/Users/cltbld', 09:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:18 INFO - 'LOGNAME': 'cltbld', 09:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:18 INFO - 'MOZ_NO_REMOTE': '1', 09:10:18 INFO - 'NO_EM_RESTART': '1', 09:10:18 INFO - 'PAGER': '/bin/cat', 09:10:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:18 INFO - 'PWD': '/builds/slave/test', 09:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:18 INFO - 'SHELL': '/bin/bash', 09:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:18 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:18 INFO - 'USER': 'cltbld', 09:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:18 INFO - 'XPC_FLAGS': '0x0', 09:10:18 INFO - 'XPC_SERVICE_NAME': '0', 09:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:10:21 INFO - Installing collected packages: mozsystemmonitor 09:10:21 INFO - Running setup.py install for mozsystemmonitor 09:10:22 INFO - Successfully installed mozsystemmonitor 09:10:22 INFO - Cleaning up... 09:10:22 INFO - Return code: 0 09:10:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:22 INFO - 'HOME': '/Users/cltbld', 09:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:22 INFO - 'LOGNAME': 'cltbld', 09:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:22 INFO - 'MOZ_NO_REMOTE': '1', 09:10:22 INFO - 'NO_EM_RESTART': '1', 09:10:22 INFO - 'PAGER': '/bin/cat', 09:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:22 INFO - 'PWD': '/builds/slave/test', 09:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:22 INFO - 'SHELL': '/bin/bash', 09:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:22 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:22 INFO - 'USER': 'cltbld', 09:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:22 INFO - 'XPC_FLAGS': '0x0', 09:10:22 INFO - 'XPC_SERVICE_NAME': '0', 09:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:10:22 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 09:10:22 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 09:10:22 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 09:10:22 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 09:10:22 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 09:10:22 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 09:10:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:10:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:10:25 INFO - warning: no files found matching '*.txt' 09:10:25 INFO - no previously-included directories found matching 'build' 09:10:25 INFO - no previously-included directories found matching 'dist' 09:10:25 INFO - no previously-included directories found matching '.git*' 09:10:25 INFO - Installing collected packages: jsonschema, functools32 09:10:25 INFO - Running setup.py install for functools32 09:10:25 INFO - warning: no files found matching '*.txt' 09:10:25 INFO - no previously-included directories found matching 'build' 09:10:25 INFO - no previously-included directories found matching 'dist' 09:10:25 INFO - no previously-included directories found matching '.git*' 09:10:25 INFO - Successfully installed jsonschema functools32 09:10:25 INFO - Cleaning up... 09:10:25 INFO - Return code: 0 09:10:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:10:25 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')]} 09:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:25 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')]} 09:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:25 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:25 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 09:10:25 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 09:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:25 INFO - 'HOME': '/Users/cltbld', 09:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:25 INFO - 'LOGNAME': 'cltbld', 09:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:25 INFO - 'MOZ_NO_REMOTE': '1', 09:10:25 INFO - 'NO_EM_RESTART': '1', 09:10:25 INFO - 'PAGER': '/bin/cat', 09:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:25 INFO - 'PWD': '/builds/slave/test', 09:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:25 INFO - 'SHELL': '/bin/bash', 09:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:25 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:25 INFO - 'USER': 'cltbld', 09:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:25 INFO - 'XPC_FLAGS': '0x0', 09:10:25 INFO - 'XPC_SERVICE_NAME': '0', 09:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:10:26 INFO - Cleaning up... 09:10:26 INFO - Return code: 0 09:10:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:10:26 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')]} 09:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:26 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')]} 09:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:26 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:26 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 09:10:26 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 09:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:26 INFO - 'HOME': '/Users/cltbld', 09:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:26 INFO - 'LOGNAME': 'cltbld', 09:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:26 INFO - 'MOZ_NO_REMOTE': '1', 09:10:26 INFO - 'NO_EM_RESTART': '1', 09:10:26 INFO - 'PAGER': '/bin/cat', 09:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:26 INFO - 'PWD': '/builds/slave/test', 09:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:26 INFO - 'SHELL': '/bin/bash', 09:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:26 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:26 INFO - 'USER': 'cltbld', 09:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:26 INFO - 'XPC_FLAGS': '0x0', 09:10:26 INFO - 'XPC_SERVICE_NAME': '0', 09:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:10:26 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 09:10:26 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 09:10:26 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 09:10:26 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 09:10:26 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 09:10:26 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 09:10:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:10:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:10:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 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 09:10:29 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 09:10:30 INFO - Downloading docopt-0.6.1.tar.gz 09:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:10:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:10:30 INFO - Running setup.py install for blobuploader 09:10:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:10:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:10:30 INFO - Running setup.py install for requests 09:10:31 INFO - Running setup.py install for docopt 09:10:31 INFO - Successfully installed blobuploader requests docopt 09:10:31 INFO - Cleaning up... 09:10:31 INFO - Return code: 0 09:10:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:31 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:31 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 09:10:31 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 09:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:31 INFO - 'HOME': '/Users/cltbld', 09:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:31 INFO - 'LOGNAME': 'cltbld', 09:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:31 INFO - 'MOZ_NO_REMOTE': '1', 09:10:31 INFO - 'NO_EM_RESTART': '1', 09:10:31 INFO - 'PAGER': '/bin/cat', 09:10:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:31 INFO - 'PWD': '/builds/slave/test', 09:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:31 INFO - 'SHELL': '/bin/bash', 09:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:31 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:31 INFO - 'USER': 'cltbld', 09:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:31 INFO - 'XPC_FLAGS': '0x0', 09:10:31 INFO - 'XPC_SERVICE_NAME': '0', 09:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:31 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mqL7Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:31 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-f_bZpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:31 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-7EuFbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:31 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-65huhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:31 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kVFChE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-KAwb3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ai1rjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-xnfUZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-i6KmWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-14R_47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-WcMM9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jEh1JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-DKLMz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-5D9ie5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-q6H9z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QPbOKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QoJJ2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:10:33 INFO - Running setup.py install for manifestparser 09:10:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:10:33 INFO - Running setup.py install for mozcrash 09:10:33 INFO - Running setup.py install for mozdebug 09:10:33 INFO - Running setup.py install for mozdevice 09:10:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:10:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:10:33 INFO - Running setup.py install for mozfile 09:10:34 INFO - Running setup.py install for mozhttpd 09:10:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Running setup.py install for mozinfo 09:10:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Running setup.py install for mozInstall 09:10:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Running setup.py install for mozleak 09:10:34 INFO - Running setup.py install for mozlog 09:10:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Running setup.py install for moznetwork 09:10:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:10:34 INFO - Running setup.py install for mozprocess 09:10:35 INFO - Running setup.py install for mozprofile 09:10:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:10:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:10:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:10:35 INFO - Running setup.py install for mozrunner 09:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:10:35 INFO - Running setup.py install for mozscreenshot 09:10:35 INFO - Running setup.py install for moztest 09:10:35 INFO - Running setup.py install for mozversion 09:10:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:10:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:10:35 INFO - Cleaning up... 09:10:35 INFO - Return code: 0 09:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:35 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:35 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 09:10:35 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 09:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:35 INFO - 'HOME': '/Users/cltbld', 09:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:35 INFO - 'LOGNAME': 'cltbld', 09:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:35 INFO - 'MOZ_NO_REMOTE': '1', 09:10:35 INFO - 'NO_EM_RESTART': '1', 09:10:35 INFO - 'PAGER': '/bin/cat', 09:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:35 INFO - 'PWD': '/builds/slave/test', 09:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:35 INFO - 'SHELL': '/bin/bash', 09:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:35 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:35 INFO - 'USER': 'cltbld', 09:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:35 INFO - 'XPC_FLAGS': '0x0', 09:10:35 INFO - 'XPC_SERVICE_NAME': '0', 09:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-pZNHDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:36 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jVE195-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:36 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-aWFOkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:36 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wT5GvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Uud7Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:36 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-p0U6yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:36 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-j0n8Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:36 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)) 09:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-d9C1Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-MCTa08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-NeW3Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-HEkhmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jmPLde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oatMal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-3xPgsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ZdKB_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-LWIS1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:37 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)) 09:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-b8psuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:38 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)) 09:10:38 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)) 09:10:38 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)) 09:10:38 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)) 09:10:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:10:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:41 INFO - Downloading blessings-1.6.tar.gz 09:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:10:41 INFO - Installing collected packages: blessings 09:10:41 INFO - Running setup.py install for blessings 09:10:41 INFO - Successfully installed blessings 09:10:41 INFO - Cleaning up... 09:10:41 INFO - Return code: 0 09:10:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:10:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:41 INFO - Reading from file tmpfile_stdout 09:10:41 INFO - Current package versions: 09:10:41 INFO - blessings == 1.6 09:10:41 INFO - blobuploader == 1.2.4 09:10:41 INFO - docopt == 0.6.1 09:10:41 INFO - functools32 == 3.2.3-2 09:10:41 INFO - jsonschema == 2.5.1 09:10:41 INFO - manifestparser == 1.1 09:10:41 INFO - mozInstall == 1.12 09:10:41 INFO - mozcrash == 1.0 09:10:41 INFO - mozdebug == 0.1 09:10:41 INFO - mozdevice == 0.49 09:10:41 INFO - mozfile == 1.2 09:10:41 INFO - mozhttpd == 0.7 09:10:41 INFO - mozinfo == 0.9 09:10:41 INFO - mozleak == 0.1 09:10:41 INFO - mozlog == 3.4 09:10:41 INFO - moznetwork == 0.27 09:10:41 INFO - mozprocess == 0.24 09:10:41 INFO - mozprofile == 0.28 09:10:41 INFO - mozrunner == 6.13 09:10:41 INFO - mozscreenshot == 0.1 09:10:41 INFO - mozsystemmonitor == 0.3 09:10:41 INFO - moztest == 0.8 09:10:41 INFO - mozversion == 1.4 09:10:41 INFO - psutil == 3.1.1 09:10:41 INFO - requests == 1.2.3 09:10:41 INFO - wsgiref == 0.1.2 09:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:42 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 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10:42 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 09:10:42 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 09:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:42 INFO - 'HOME': '/Users/cltbld', 09:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:42 INFO - 'LOGNAME': 'cltbld', 09:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:42 INFO - 'MOZ_NO_REMOTE': '1', 09:10:42 INFO - 'NO_EM_RESTART': '1', 09:10:42 INFO - 'PAGER': '/bin/cat', 09:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:42 INFO - 'PWD': '/builds/slave/test', 09:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:42 INFO - 'SHELL': '/bin/bash', 09:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:42 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:42 INFO - 'USER': 'cltbld', 09:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:42 INFO - 'XPC_FLAGS': '0x0', 09:10:42 INFO - 'XPC_SERVICE_NAME': '0', 09:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 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)) 09:10:42 INFO - Cleaning up... 09:10:42 INFO - Return code: 0 09:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c42b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c45768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0134adcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, '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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 09:10: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', 'jsonschema'] in /builds/slave/test/build 09:10: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 jsonschema 09:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:42 INFO - 'HOME': '/Users/cltbld', 09:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:42 INFO - 'LOGNAME': 'cltbld', 09:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:42 INFO - 'MOZ_NO_REMOTE': '1', 09:10:42 INFO - 'NO_EM_RESTART': '1', 09:10:42 INFO - 'PAGER': '/bin/cat', 09:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:42 INFO - 'PWD': '/builds/slave/test', 09:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:42 INFO - 'SHELL': '/bin/bash', 09:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:10:42 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:42 INFO - 'USER': 'cltbld', 09:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:42 INFO - 'XPC_FLAGS': '0x0', 09:10:42 INFO - 'XPC_SERVICE_NAME': '0', 09:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:10:42 INFO - Cleaning up... 09:10:42 INFO - Return code: 0 09:10:42 INFO - Running post-action listener: _resource_record_post_action 09:10:42 INFO - Running post-action listener: _start_resource_monitoring 09:10:42 INFO - Starting resource monitoring. 09:10:42 INFO - [mozharness: 2017-02-27 17:10:42.622418Z] Finished create-virtualenv step (success) 09:10:42 INFO - [mozharness: 2017-02-27 17:10:42.623377Z] Running install step. 09:10:42 INFO - Running pre-action listener: _resource_record_pre_action 09:10:42 INFO - Running main action method: install 09:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:42 INFO - Reading from file tmpfile_stdout 09:10:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:10:42 INFO - Reading from file tmpfile_stdout 09:10:42 INFO - Output received: 09:10:42 INFO - Usage: mozinstall [options] installer 09:10:42 INFO - Options: 09:10:42 INFO - -h, --help show this help message and exit 09:10:42 INFO - -d DEST, --destination=DEST 09:10:42 INFO - Directory to install application into. [default: 09:10:42 INFO - "/builds/slave/test"] 09:10:42 INFO - --app=APP Application being installed. [default: firefox] 09:10:42 INFO - mkdir: /builds/slave/test/build/application 09:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:11:02 INFO - Reading from file tmpfile_stdout 09:11:02 INFO - Output received: 09:11:02 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:11:02 INFO - Running post-action listener: _resource_record_post_action 09:11:02 INFO - [mozharness: 2017-02-27 17:11:02.717409Z] Finished install step (success) 09:11:02 INFO - [mozharness: 2017-02-27 17:11:02.717577Z] Running run-tests step. 09:11:02 INFO - Running pre-action listener: _resource_record_pre_action 09:11:02 INFO - Running main action method: run_tests 09:11:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:02 INFO - 2017-02-27 09:11:02.732 screenresolution[1622:7224] starting screenresolution argv=screenresolution get 09:11:02 INFO - 2017-02-27 09:11:02.735 screenresolution[1622:7224] Display 0: 1600x1200x32@60 09:11:02 INFO - 2017-02-27 09:11:02.741 screenresolution[1623:7226] starting screenresolution argv=screenresolution list 09:11:02 INFO - Available Modes on Display 0 09:11:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:02 INFO - Intel Iris: 09:11:02 INFO - Chipset Model: Intel Iris 09:11:02 INFO - Type: GPU 09:11:02 INFO - Bus: Built-In 09:11:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:02 INFO - Vendor: Intel (0x8086) 09:11:02 INFO - Device ID: 0x0a2e 09:11:02 INFO - Revision ID: 0x0009 09:11:02 INFO - Displays: 09:11:02 INFO - Display: 09:11:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:02 INFO - Display Serial Number: 1600x1200 60 09:11:02 INFO - Main Display: Yes 09:11:02 INFO - Mirror: Off 09:11:02 INFO - Online: Yes 09:11:02 INFO - Rotation: Supported 09:11:02 INFO - Return code: 0 09:11:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:02 INFO - Python 2.7.3 09:11:02 INFO - Return code: 0 09:11:02 INFO - grabbing minidump binary from tooltool 09:11:02 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')]} 09:11:02 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 0x106a20d30>, '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 0x106947db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a15be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:02 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 09:11:02 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 09:11:02 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 09:11:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:03 INFO - Return code: 0 09:11:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:11:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:11:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 09:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --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 09:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QCUZjjQCLj/Render', 09:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:11:03 INFO - 'HOME': '/Users/cltbld', 09:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:11:03 INFO - 'LOGNAME': 'cltbld', 09:11:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:03 INFO - 'MOZ_NO_REMOTE': '1', 09:11:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:03 INFO - 'NO_EM_RESTART': '1', 09:11:03 INFO - 'PAGER': '/bin/cat', 09:11:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:03 INFO - 'PWD': '/builds/slave/test', 09:11:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:11:03 INFO - 'SHELL': '/bin/bash', 09:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UiOJnUrHSA/Listeners', 09:11:03 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 09:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:11:03 INFO - 'USER': 'cltbld', 09:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:03 INFO - 'XPC_FLAGS': '0x0', 09:11:03 INFO - 'XPC_SERVICE_NAME': '0', 09:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:11:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 09:11:03 INFO - mozversion application_buildid: 20170227073937 09:11:03 INFO - mozversion application_changeset: 0aa9bc696bc9f0335e8c7531c28c238286eeba43 09:11:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:11:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:03 INFO - mozversion application_name: Firefox 09:11:03 INFO - mozversion application_remotingname: firefox-dev 09:11:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:03 INFO - mozversion application_vendor: Mozilla 09:11:03 INFO - mozversion application_version: 53.0a2 09:11:03 INFO - mozversion platform_buildid: 20170227073937 09:11:03 INFO - mozversion platform_changeset: 0aa9bc696bc9f0335e8c7531c28c238286eeba43 09:11:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:03 INFO - mozversion platform_version: 53.0a2 09:11:03 INFO - using testdate: 1488215463 09:11:03 INFO - actual date: 1488215463 09:11:03 INFO - starting webserver on 'localhost:49240' 09:11:03 INFO - SUITE-START | Running 2 tests 09:11:03 INFO - TEST-START | dromaeo_css 09:11:03 INFO - operating with platform_type : mac_ 09:11:03 INFO - Initialising browser for dromaeo_css test... 09:11:03 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpVaN6aG/profile http://localhost:49240/getInfo.html) 09:11:05 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 09:11:05 INFO - PROCESS | 1633 | colorDepth:24 09:11:05 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 09:11:05 INFO - PROCESS | 1633 | __metrics 09:11:06 INFO - PROCESS | 1633 | 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" 09:11:06 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:06 INFO - TEST-INFO | 1633: exit 0 09:11:06 INFO - Browser initialized. 09:11:06 INFO - Running cycle 1/1 for dromaeo_css test... 09:11:06 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpVaN6aG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:18 INFO - PROCESS | 1634 | RSS: Main: 212709376 09:11:18 INFO - PROCESS | 1634 | 09:14:22 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 09:14:23 INFO - PROCESS | 1634 | RSS: Main: 340705280 09:14:23 INFO - PROCESS | 1634 | 09:16:08 INFO - PROCESS | 1634 | ************************* 09:16:08 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 09:16:08 INFO - PROCESS | 1634 | 09:16:08 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:16:08 INFO - PROCESS | 1634 | Full stack: 09:16:08 INFO - PROCESS | 1634 | ************************* 09:17:26 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 09:17:27 INFO - PROCESS | 1634 | RSS: Main: 379748352 09:17:27 INFO - PROCESS | 1634 | 09:20:29 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 09:20:30 INFO - PROCESS | 1634 | RSS: Main: 325001216 09:20:30 INFO - PROCESS | 1634 | 09:23:32 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 09:23:33 INFO - PROCESS | 1634 | RSS: Main: 324272128 09:23:33 INFO - PROCESS | 1634 | 09:26:36 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 09:26:37 INFO - PROCESS | 1634 | RSS: Main: 311607296 09:26:37 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 09:29:41 INFO - PROCESS | 1634 | RSS: Main: 405127168 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | __start_tp_report 09:29:41 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 09:29:41 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 09:29:41 INFO - PROCESS | 1634 | |i|pagename|runs| 09:29:41 INFO - PROCESS | 1634 | |0;dojo.html;2904.651441826981;3331.083951913224;3367.6969072783445;3369.6798804113614;3426.9890382337207;5763.884722305556;5805.535557155428;5824.621399609023;5829.125631155323;5842.532597392204;5718.342390625079;5828.1549175369655;5830.970845145768;5843.620164689292;5858.091995740657;4285.657147428214;5175.197844334134;5175.689458632475;5253.4221235664045;5267.710275934822;5189.7405129743365;5214.061468935609;5217.426083130853;5294.232336311233;5339.22581225722;5225.503577160182;5270.341207349082;5276.894462110756;5302.681839089648;5304.443033481487;5318.414974352818;5321.467853214667;5328.813491527778;5334.733263336818;5361.463853614647;5185.6888586684545;5242.711650859202;5273.077211487975;5275.261463395128;5324.041672498949;5042.596592272609;5609.158626206061;5634.4365563443735;5677.744501497401;5686.857828554319;6254.499640028786;6290.245170579514;6293.2762732285455;6295.5907865988565;6333.68331583419;5312;6160.599561028519;6248.656323902183;6268.341824108448;6272.466840318532;4631.235846085358;5744.080947048536;5772.740226689809;5930.436608522184;5931.406859314034;6184.350643182401;6207.503399728011;6227.221597300338;6270.31026587075;6274.686265686789;6232.220972378453;6234.750609975641;6250.874982500324;6252.968735156295;6253.187085678833;6116.366205733216;6171.907421388682;6197.287311959182;6240.126382306481;6253.5622506424115;6142.416470435391;6181.165542651775;6228.532860035425;6238;6272.310045895039;6282.748690052438;6292.276388215414;6300.684965751694;6315.842103947438;6319.684015799192;5015.724135172528;5019.749012549358;5061.924071138936;5064.873378165576;5116.897662046738;4397.6042156206095;4423.977880110643;4430.025394413224;4438.911221775546;4534.954650453519;5758.568107391962;5864.179014937912;5874.735636896265;5882.323532793784;5883.17635531026;6186.4741496972365;6221.96889015552;6240.184482038859;6270;6275.403836635513;4582.24392975162;5740.770369185186;5824.417558244227;5827.271591051119;5845.386234445407;5457.263269458652;5529;5553.777848885999;5555.2778138841695;5555.472230138131;4851.46633870281;6000.249968753906;6176.9073463897175;6184.8763024738355;6264.34224406449;5318.255444237732;6198.380161983766;6216.968915155395;6230.6884655766125;6252.218472690914;6347.0479428086155;6365.013422919455;6365.299817020216;6387.105805187184;6389.808305750835;6075.878482430415;6086.452219300107;6243.094751261133;6252.843678907881;6268.435840774352;6173.783917563043;6199.690015499297;6212.97485914819;6235.282942461494;6262.46769024638;5966.284045914518;5966.642001479925;6008.519318454426;6177.444030037318;6199.535034872493;5967.492763115184;5983.431574000463;6145.8156255312415;6203.627782333075;6219.906701399392;5873.970630146822;5984.970075149597;6049.18336024631;6058.787942421994;6104.4505994460715;6170.136180934763;6181.3200547938795;6198.132261483306;6213.844653883508;6217.409346112112;5749.885002299847;6002.87994240104;6016.8796624068145;6023.27720673522;6029.728662210299 09:29:41 INFO - PROCESS | 1634 | |1;ext.html;441.96464282857374;494.76745929413164;508.4813490239955;516.1457787361917;519.8466452396542;30566.847165764168;40740.79629601852;42074.948126296855;42112;42361.57638423623;36772.81613591935;43162.13675726484;43553.78223108888;43839.34240986388;44059.55940440595;8385.748427547152;9224.492652904088;9400.529973501332;9411.764705882339;9423.528823558829;8372.790680233013;11041.668749937515;11270.267432616894;11304.434778261095;11518.712032199179;11200.439978001108;11282;11308.37803920784;11316.547338106508;11322.886771132265;11228.775424491505;11288.435578221139;11321.716957076056;11326.660200194008;11357.602483913106;8335.124811894784;8568.143185681445;10936.835947460795;11208.495617697223;11216;40517;40738.9815254618;40767.7961610193;40881.182376352306;41118.76643700694;3924.843006279774;3958.5249770027494;3960.2277555876617;3966.5240171179644;4013.9764360088284;28674.713252867412;30256.84871575628;30774;30966.69033309683;31686.207844803834;3114.9065528034193;3209.646938836726;3217.8560823517673;3264.6408895021527;3270.3622793555264;378701;379870;380160.0991995022;380382.0980895078;381084;61609;61980;62073.37926620676;62228.37771622226;62319.6884015577;65018;65090.67454662791;65209.02186467207;65216;65238.02142967859;16435.83564164343;16492.25784839661;16725.83274167267;16743.497695069167;16796.244169012425;11769.293842369485;13073.803892941614;13161;13173.736525269442;13174.47302107924;14268.714625707635;14608.707825843423;16115.677686446206;16504.83495165033;16533.33866645345;5936.910946335808;7003.894941575881;7060.399866011344;7094.858102838018;7121.252268511836;845.3659755183612;871.9084496127942;891.6745387933487;905.3571963905569;908.4549270437817;28867.845286188738;29815;29817.701822981926;30295;30492.085237442912;936.9859452108224;1081.7782354617284;1101.388729255271;1108.6563165418745;1182.343799191457;14861.331240094221;15419.151946643042;15466;15664.295106720225;15804.446844360393;619679;626524;630898;632095;634549;59621.40378596245;59759.40240597625;59823;59932.70033649804;60043;1357.5248662967883;1415.5116484812722;1422.4239183130849;1422.9644258893197;1433.6845893903323;24256.393590160387;28119.57820632651;29170.854145729136;29856.552151718177;29956.251093722833;50543.73640658866;51328.48671513386;51339.48660513347;51364.74317628388;51430;579941;581989;582678;583410;584535;24773.25680229596;24950.251492455256;25152.874235628704;25220.873895630404;26319;34530.65469345274;41043.589564103975;44146.117077658906;44292.778536107115;44379.77810110929;33551.328973419906;35693.82153089218;36711.816440917624;36837.81581092077;37390;35238.823805880806;35386;36323;36703.449448258834;36738;34649.82675086609;35533.64466355303;35574.64425355713;36354;37579.624203757616;28049.811071501677;30969.8508536922;32000.839995799874;32268.838655806572;32456.188595284362;23645.280792709058;23929.401764956016;23934.597841529514;24028.87985560061;24217.273481795575 09:29:41 INFO - PROCESS | 1634 | |2;jquery.html;381.40120011581826;383.73138802838014;391.4910616198941;394.1466724541369;417.76813868303077;14305.92705547083;20388.286409975655;21281.148754049857;21648.567028659436;21769.12923483061;16379.061119917049;18283.725744113817;21285.25501607444;21474;21860;5483.506484416402;5811;5811.941880581204;5812.128180772876;5826.766929322822;5664.235328230698;5709.286339207599;5789.797357092502;5803.883922321551;5954.077118046688;6016.488598469114;6032.276126864783;6037.456628903398;6048.123022161784;6064;5789.305283365981;5923.881522369572;5971.462568368825;5977.402259774031;6016.27804663441;5032.6477146599755;5789.681567513785;5829.8251052468495;5840.123981402781;5841.766329346821;21965.450863728376;24186.637200442008;25373;26044.218673439827;26148.215553533424;2878.596996420503;2918.255844759594;2925.254060214632;2973.6728959814404;3042.4675681755825;9982.80034399308;10010.849837252446;10141.594336226543;10555.630552930686;10576.68269951895;1751.6846967545837;1787.9106044697844;1801.4595621313554;1813.5738101546258;1816.9091545422675;107228;115989;123546;135186.32406838002;139471;11359.943200283946;11572;11821.822672659917;11956.641300760992;11986.34075125859;15748.606284842741;15755.44855930037;15809.604759881095;15809.762853557206;15810.893237473496;7682.961585192038;8012.399070069651;8030.598470076589;8382.329413646894;8477.298116820959;8481.830363392697;8541.957290213633;8657;8665.263452606472;8769.561521923879;4194.0563373240775;4655.162070827216;4754.429468463737;4754.667173297905;4782.617390608743;1984.880907145576;2023.494126468383;2029.7970202979584;2029.8985050747403;2032.2074390987527;970.2819913264134;970.2868391732071;992.3748038735695;999.1357475783541;1041.630221271453;21187.47031324229;21922.89038554829;21944;22007.449813754785;22033;979.2313034268066;1023.0638965346625;1041.3189375557367;1047.989520104789;1063.4842101580728;10096.545655445523;10865.130789536817;11175.24546265989;11232.697297054085;11320.528571000648;750055.2497237478;764309;767066;772557;775148;119661;122830.38584807019;139836;144967;146611;974.6198982397012;1011.1253765492796;1045.4406892312577;1048.7063622185801;1049.8162821506205;19015.42953711391;19215.615687686448;20226.39320820378;20246.898765506077;20327.28854490145;58222.12666809917;58755.706221468616;61655;61817.690911545156;62197.37802621916;86459.56770216109;87462;90212;91232;93899.06100938903;11438.82841757391;12518.24890506536;12600.306983116017;12836.973042156418;12930.806037909628;11967.281963082243;13801.861981380058;13909.51316703951;13911.513097041556;14442.855571444152;10715.693366926747;11379.317240965238;11600.825987610362;11605.709857253636;11617;11659.708507287385;11693.707657308636;11965.820512692142;12023.63929082129;12148.453319600463;6263.467605253604;8283.420160588701;11392.54429822831;11895.055299310687;11984.880151198726;13058.542950996669;13172.012099092799;13267.535636252685;13387.933060334635;13406.061575689608;11543.307401555934;11563.132765042823;11862.58480953197;11906.642800715992;11998.880011199777 09:29:41 INFO - PROCESS | 1634 | |3;mootools.html;1415.457103083048;1425.4227038049594;1444.2778610694652;1451.8693317601421;1465.3698909468928;6562.376574225453;7751.992241008668;7976.92023079769;8584.442011269262;8638.136186381358;7715.922840771591;8144.959275203616;8336.416450848443;8346.91653083469;8481.109483504235;2296.7243930728337;2335.2643917166124;2339.321596736953;2343.1330407749156;2345;2074.834013278934;2340.4499942513494;2361.752016038317;2377;2382.1424287256573;2085.5620319732875;2122.4693826543366;2127.617028934799;2131.2860191835675;2133.7226160599103;2140.6039882621767;2169.3491952414292;2237.093976939342;2246.4159318577126;2250.189931624614;2265.524239909621;2324.012294774731;2325.9651105233434;2327.5461285049423;2332.661764044204;8448.366372522023;8554.401191916568;8562.48625082497;8577.228049475578;8599;5018.64869459138;5177.922331165036;5186.092433824066;5191.662541934762;5194.0131375039;3468.0809585459874;3490.4764285357146;3497.090756403353;3569.8750543731103;3573.5533058367705;1193.081327377923;1199.4062938845327;1214.9635510934686;1246.1028059796931;1249.6001279590535;10949.890501095046;11007.394593297366;11010.779784404347;11031.669049928514;11056.944715276453;4345.391645169679;4630.884227894262;4706.529347065266;4713.764311784397;4729.4797572267025;9609.663661771945;9652.710418687451;9676.9032309676;9679.274054445945;9683.370580912218;5223.791048358099;5270.393904701008;5271.604629652791;5276.604254680914;5302.098643230583;4203.579642035772;4447.6212374164115;4712.24604063355;4811.663183577186;4824.614030877521;3508.6842184203542;3842.289176502356;3922.4508568800393;3971.801409929492;4008.8797336079965;1284.8650891656428;1292.2246652008719;1294;1302.2707283921034;1307.941142648583;708.5146674527965;759.4038679636459;873.6287077991828;882.7748924024461;908.0193391137556;5039.672421292605;5328.600354973392;5513.641613295123;5747.25285712863;5797.739101740432;929.4330458420358;939.6053657463882;950.2825366847985;955.1690029674089;961.5432669481941;3558.5551806024246;3743;3832.9616703832603;3849.480320156743;3855.0169706724605;9916.553755081039;10087.49562521871;10210.846837297446;10223.693289201336;10226.437545935045;9489.38319009276;10053.246006549538;10064.446455444875;10067.647632332833;10136.746581335525;7699.884501732478;7985.480943738638;7992.880106798402;8009.439339246197;8034.116247212802;5584.46947539983;5623.891040859678;5643;5869.092544923003;5887.969605319137;9337.439753614804;9455.24358051368;9458.716238512856;9480.336376453582;9498;9170.220531254918;9476.099770521789;9559.091886271071;9700.660476883275;9715;7023.578585284899;7184.245654206442;7251.746188883364;7358.521696089737;7410.703571857281;6891.173059232924;6908.3437073477935;8100.9873765779275;8123.79690507742;8138.715144969898;6381.680915954276;6987.860242795217;7021.613811240431;7180.640967951686;7328.1938986712485;6707.5975441473665;6839.316068393121;6971.47713921468;7044.823879403056;7173.569585824867;6321.146645203023;6340.556161068681;6440.0983862260255;6447.9355206447335;6456.192975878015;4933.1613625683;4958.652894297509;4992.600591952562;5013.924791128063;5016.1221786188;4471.329300604935;4499.437570303712;4527.524609915911;4641.094986477605;4705.294205869147 09:29:41 INFO - PROCESS | 1634 | |4;prototype.html;321.69760425200315;330.5785123966942;333.55470446953314;347.94085005549056;350.20852872508124;4485.936469224157;5124.666896651715;5259.815906443266;5408.864778380537;5423.701696406696;5178.922316165251;5211.5049070338355;5226.529612334889;5265.815696450625;5312.814051508198;3343.916402089955;3634.491171236029;4148.979255103728;4160.8959776005695;4224.767637779921;3243.96756032439;3317.6018877734705;4224.662027037845;4242.666533406629;4257.850975215868;3879.8554426444125;4060.7563546187175;4152.2733521633745;4153.691587150053;4184.581541845821;3636.5999740028574;4063.817128229237;4134.937975930364;4137.689673274486;4138.482689663777;3633.963660363389;3638.890833275006;3653.926921461556;3656.780593164419;3682.208325210066;4568.817247310104;4869.220924652074;4877.3903262092235;5101.795928162869;5204.42751297357;4510.774461276923;4529.954700452986;4576.839810606646;4591.95408045922;4652.464966528859;5610.410906854762;5638.40796716343;5639.2668953035845;5677.630953987978;5692.17850287908;3507.6492350764975;3631;3736.4582135590185;3763.8682646107527;3775.0751065988734;5267.736613169326;5755.884882302331;5799.333076696192;5856.619319744203;5906.586538942319;3233.8221397823345;3863.130795570974;3864.9613503864603;3873.6177250990436;3881.204353107606;3605.2789442111684;3760.699144068468;3869.090763670535;3912.771963130429;3919.6864250860435;4129.421880936671;4334.7399156050105;4506.977465112654;4513.5486451355255;4582.175208462442;5419.561197461158;5710.229119068956;5722.341930678025;5769.480746732815;5784.8596019472225;1068.7755571329951;1098.8626421697288;1152.6369193703956;1234.2902830872285;1261.1928365845865;825.6078362777632;836.8117173636005;847.1570787066908;849.609179777297;856.8029353248663;4369.563043695669;4851.51484851512;4984.975075124601;4992.775325110379;5084.593232541388;5134.12604399399;5157;5258;5360.517553420211;5679.375268720438;4742.976285118552;5214.713190774468;5306.575473962073;5307.310049693592;5309.7345132743985;2478.392793765539;2537.4544472938405;2907.956380654292;2909.941801163965;2931.2232258451527;5006.023825354094;5137.897242055138;5272.70274726097;5284.445133260952;5390.838274851761;4813.989062296957;5139.946311006235;5205.453427390145;5247.658902171346;5642.401442824167;5016.398032236082;5295.602829787781;5642.463965923231;5696.8860622787315;5724.656520608777;4846.625153674603;5099.898002039864;5258.842234732964;5285.207218917039;5519.475649813261;4783.521647835189;5275.8129420879995;5431.891362172655;5474.562035037267;5495.972520137374;5486.421381950477;5655.406182350794;5731.770729170787;5736.963378000916;5742.827715168384;3320.5019247113128;3393.9151521212166;3879.4568760374136;3907.316219661605;3963.7225394223283;5060.873478163076;5218.03429393656;5392.299001129828;5531.446855314597;5558.694271815089;5029.245613158056;5250.923560669977;5405.999890020359;5414.242006119068;5443.564514838883;5043.62172837046;5103.948960510347;5161.238737275539;5232.947670523246;5238.371395432572;4460.977695111504;4691.34075421172;5153.510416510426;5182.637215395037;5297.735113244399;4926.310316555613;5538.280023596906;5542.97228513871;5548.639338442988;5560.694161821139;4643.210654188729;5011.924821127613;5226.843194704165;5399.379071406838;5445.346558413015 09:29:41 INFO - PROCESS | 1634 | |5;yui.html;715.946304027198;737.6643627149648;752.7892190186747;769.4114002787868;832.4089896173717;14570.56288311351;15324.693506129885;15715.135667538281;15720.685586288268;15780;13933.37299821508;13945.442182312721;14052.718945621082;14149.151050936925;14216.360263788129;859.6905114158914;872.1322284327103;873.7771868173606;876.1851478125341;876.7545087375545;685.7462738786656;710.882704353781;846.4794151596785;874.7987962768567;883.3419102768446;939.3565407695717;942.3215284994793;944.4097439100562;944.773254418938;945.997242922501;937.6530683647094;937.9484128372936;939.4504215034214;940.1538615246264;945.465811816325;537.2585831552433;553.4272028450534;556.6520924422236;561.2871653000666;563.2311894264341;13868.514601988882;14363.640908977359;14399.78400323996;14701.55895323142;14734.852651473562;14285.85714142866;14289.785653215211;14345.497907573184;14371.928140359336;14373.340931927627;11149.498272577672;11195.776084478346;11239.60661376848;11500.907413795676;11808.822867656992;3573.6069032406413;3678.0620941659704;3896.298666240076;3910.159315747128;3912.686985041218;98832.50583747106;106107.46946265297;108171;109599;110449;10557.524911379007;10848.186386020921;11003.834942475869;11024.283421577571;11235.775284494264;21834.672479912813;22197;22412.32763017112;22482.100715971505;22555.436114096952;7479.513831601037;7552.509086909334;7632.80917977055;7663.31030207284;7795.337396321376;4164.583541645872;4216.91566168681;4302.569743025672;4305.806238719202;4446.688731788744;3518.1908161123083;3527.188746588299;3626.5829429615405;3633.8728144514816;3639.3631114554846;547.2338725783854;653.1085068880943;658.887989041864;659.0229312063808;663.7577284291199;631.3528633151057;652.807421810567;661.5127122021235;671.4594751225213;689.7310049080862;9167.312451566026;9587.234340184474;9882.752931176778;10778.838317425245;10875.891241087646;550.8540236837241;562.1946487029693;587.811900191943;594.5362617158623;716.7957132217293;4624.560666736655;4999.675021123615;5007.924881126786;5013.473585273494;5020.171671674133;89121;95853;97036;97577.51211244041;98788.50605747069;84916;85591;86867.56566217128;89235.55382223047;90760;72429.2757072433;73473;74213;75049.62475187589;75402.24597753953;9552.856707149538;9555.426674399558;9622.663206787729;9625.470599117116;9680.27397945143;49105;49431;49575.50424495709;50888;51102;55626;64798.676006619666;65700.67149664222;66167;68775.31224687689;11273.736546794245;11384.715382115513;11653;11835.171537992257;11954.068797170537;12173.513059477522;12181.817272740738;12370.62888113358;12763.425645845773;12793.232406055666;11472.483738231633;11938.1046421517;12141.271523708605;12185.268883866996;12307.507699691912;11079.50142243585;11873.643790686294;12015.038796896402;12234.632961011184;12253.326067066397;11296.661100167008;11713.531458741554;11913.880861191277;11941.82087268709;12111.394430278275;9657.32398732082;10021.749456263651;10392.012758787903;10450.216233782648;10453.32053416556;7962.442629015914;9471;9678.17735492491;9689.273304502332;9806.607735690492 09:29:41 INFO - PROCESS | 1634 | __end_tp_report 09:29:41 INFO - PROCESS | 1634 | __start_cc_report 09:29:41 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1315 09:29:41 INFO - PROCESS | 1634 | __end_cc_report 09:29:41 INFO - PROCESS | 1634 | __startTimestamp1488216581400__endTimestamp 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | ------- Summary: start ------- 09:29:41 INFO - PROCESS | 1634 | Number of tests: 6 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5741.45 Median:5967.49 stddev:664.06 (11.1%) stddev-sans-first:627.70 09:29:41 INFO - PROCESS | 1634 | Values: 2904.7 3331.1 3367.7 3369.7 3427.0 5763.9 5805.5 5824.6 5829.1 5842.5 5718.3 5828.2 5831.0 5843.6 5858.1 4285.7 5175.2 5175.7 5253.4 5267.7 5189.7 5214.1 5217.4 5294.2 5339.2 5225.5 5270.3 5276.9 5302.7 5304.4 5318.4 5321.5 5328.8 5334.7 5361.5 5185.7 5242.7 5273.1 5275.3 5324.0 5042.6 5609.2 5634.4 5677.7 5686.9 6254.5 6290.2 6293.3 6295.6 6333.7 5312.0 6160.6 6248.7 6268.3 6272.5 4631.2 5744.1 5772.7 5930.4 5931.4 6184.4 6207.5 6227.2 6270.3 6274.7 6232.2 6234.8 6250.9 6253.0 6253.2 6116.4 6171.9 6197.3 6240.1 6253.6 6142.4 6181.2 6228.5 6238.0 6272.3 6282.7 6292.3 6300.7 6315.8 6319.7 5015.7 5019.7 5061.9 5064.9 5116.9 4397.6 4424.0 4430.0 4438.9 4535.0 5758.6 5864.2 5874.7 5882.3 5883.2 6186.5 6222.0 6240.2 6270.0 6275.4 4582.2 5740.8 5824.4 5827.3 5845.4 5457.3 5529.0 5553.8 5555.3 5555.5 4851.5 6000.2 6176.9 6184.9 6264.3 5318.3 6198.4 6217.0 6230.7 6252.2 6347.0 6365.0 6365.3 6387.1 6389.8 6075.9 6086.5 6243.1 6252.8 6268.4 6173.8 6199.7 6213.0 6235.3 6262.5 5966.3 5966.6 6008.5 6177.4 6199.5 5967.5 5983.4 6145.8 6203.6 6219.9 5874.0 5985.0 6049.2 6058.8 6104.5 6170.1 6181.3 6198.1 6213.8 6217.4 5749.9 6002.9 6016.9 6023.3 6029.7 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:66718.68 Median:36338.50 stddev:144761.07 (398.4%) stddev-sans-first:145081.64 09:29:41 INFO - PROCESS | 1634 | Values: 442.0 494.8 508.5 516.1 519.8 30566.8 40740.8 42074.9 42112.0 42361.6 36772.8 43162.1 43553.8 43839.3 44059.6 8385.7 9224.5 9400.5 9411.8 9423.5 8372.8 11041.7 11270.3 11304.4 11518.7 11200.4 11282.0 11308.4 11316.5 11322.9 11228.8 11288.4 11321.7 11326.7 11357.6 8335.1 8568.1 10936.8 11208.5 11216.0 40517.0 40739.0 40767.8 40881.2 41118.8 3924.8 3958.5 3960.2 3966.5 4014.0 28674.7 30256.8 30774.0 30966.7 31686.2 3114.9 3209.6 3217.9 3264.6 3270.4 378701.0 379870.0 380160.1 380382.1 381084.0 61609.0 61980.0 62073.4 62228.4 62319.7 65018.0 65090.7 65209.0 65216.0 65238.0 16435.8 16492.3 16725.8 16743.5 16796.2 11769.3 13073.8 13161.0 13173.7 13174.5 14268.7 14608.7 16115.7 16504.8 16533.3 5936.9 7003.9 7060.4 7094.9 7121.3 845.4 871.9 891.7 905.4 908.5 28867.8 29815.0 29817.7 30295.0 30492.1 937.0 1081.8 1101.4 1108.7 1182.3 14861.3 15419.2 15466.0 15664.3 15804.4 619679.0 626524.0 630898.0 632095.0 634549.0 59621.4 59759.4 59823.0 59932.7 60043.0 1357.5 1415.5 1422.4 1423.0 1433.7 24256.4 28119.6 29170.9 29856.6 29956.3 50543.7 51328.5 51339.5 51364.7 51430.0 579941.0 581989.0 582678.0 583410.0 584535.0 24773.3 24950.3 25152.9 25220.9 26319.0 34530.7 41043.6 44146.1 44292.8 44379.8 33551.3 35693.8 36711.8 36837.8 37390.0 35238.8 35386.0 36323.0 36703.4 36738.0 34649.8 35533.6 35574.6 36354.0 37579.6 28049.8 30969.9 32000.8 32268.8 32456.2 23645.3 23929.4 23934.6 24028.9 24217.3 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:40977.73 Median:21234.31 stddev:126847.10 (597.4%) stddev-sans-first:127166.31 09:29:41 INFO - PROCESS | 1634 | Values: 381.4 383.7 391.5 394.1 417.8 14305.9 20388.3 21281.1 21648.6 21769.1 16379.1 18283.7 21285.3 21474.0 21860.0 5483.5 5811.0 5811.9 5812.1 5826.8 5664.2 5709.3 5789.8 5803.9 5954.1 6016.5 6032.3 6037.5 6048.1 6064.0 5789.3 5923.9 5971.5 5977.4 6016.3 5032.6 5789.7 5829.8 5840.1 5841.8 21965.5 24186.6 25373.0 26044.2 26148.2 2878.6 2918.3 2925.3 2973.7 3042.5 9982.8 10010.8 10141.6 10555.6 10576.7 1751.7 1787.9 1801.5 1813.6 1816.9 107228.0 115989.0 123546.0 135186.3 139471.0 11359.9 11572.0 11821.8 11956.6 11986.3 15748.6 15755.4 15809.6 15809.8 15810.9 7683.0 8012.4 8030.6 8382.3 8477.3 8481.8 8542.0 8657.0 8665.3 8769.6 4194.1 4655.2 4754.4 4754.7 4782.6 1984.9 2023.5 2029.8 2029.9 2032.2 970.3 970.3 992.4 999.1 1041.6 21187.5 21922.9 21944.0 22007.4 22033.0 979.2 1023.1 1041.3 1048.0 1063.5 10096.5 10865.1 11175.2 11232.7 11320.5 750055.2 764309.0 767066.0 772557.0 775148.0 119661.0 122830.4 139836.0 144967.0 146611.0 974.6 1011.1 1045.4 1048.7 1049.8 19015.4 19215.6 20226.4 20246.9 20327.3 58222.1 58755.7 61655.0 61817.7 62197.4 86459.6 87462.0 90212.0 91232.0 93899.1 11438.8 12518.2 12600.3 12837.0 12930.8 11967.3 13801.9 13909.5 13911.5 14442.9 10715.7 11379.3 11600.8 11605.7 11617.0 11659.7 11693.7 11965.8 12023.6 12148.5 6263.5 8283.4 11392.5 11895.1 11984.9 13058.5 13172.0 13267.5 13387.9 13406.1 11543.3 11563.1 11862.6 11906.6 11998.9 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5447.33 Median:5182.01 stddev:3006.30 (58.0%) stddev-sans-first:2999.46 09:29:41 INFO - PROCESS | 1634 | Values: 1415.5 1425.4 1444.3 1451.9 1465.4 6562.4 7752.0 7976.9 8584.4 8638.1 7715.9 8145.0 8336.4 8346.9 8481.1 2296.7 2335.3 2339.3 2343.1 2345.0 2074.8 2340.4 2361.8 2377.0 2382.1 2085.6 2122.5 2127.6 2131.3 2133.7 2140.6 2169.3 2237.1 2246.4 2250.2 2265.5 2324.0 2326.0 2327.5 2332.7 8448.4 8554.4 8562.5 8577.2 8599.0 5018.6 5177.9 5186.1 5191.7 5194.0 3468.1 3490.5 3497.1 3569.9 3573.6 1193.1 1199.4 1215.0 1246.1 1249.6 10949.9 11007.4 11010.8 11031.7 11056.9 4345.4 4630.9 4706.5 4713.8 4729.5 9609.7 9652.7 9676.9 9679.3 9683.4 5223.8 5270.4 5271.6 5276.6 5302.1 4203.6 4447.6 4712.2 4811.7 4824.6 3508.7 3842.3 3922.5 3971.8 4008.9 1284.9 1292.2 1294.0 1302.3 1307.9 708.5 759.4 873.6 882.8 908.0 5039.7 5328.6 5513.6 5747.3 5797.7 929.4 939.6 950.3 955.2 961.5 3558.6 3743.0 3833.0 3849.5 3855.0 9916.6 10087.5 10210.8 10223.7 10226.4 9489.4 10053.2 10064.4 10067.6 10136.7 7699.9 7985.5 7992.9 8009.4 8034.1 5584.5 5623.9 5643.0 5869.1 5888.0 9337.4 9455.2 9458.7 9480.3 9498.0 9170.2 9476.1 9559.1 9700.7 9715.0 7023.6 7184.2 7251.7 7358.5 7410.7 6891.2 6908.3 8101.0 8123.8 8138.7 6381.7 6987.9 7021.6 7180.6 7328.2 6707.6 6839.3 6971.5 7044.8 7173.6 6321.1 6340.6 6440.1 6447.9 6456.2 4933.2 4958.7 4992.6 5013.9 5016.1 4471.3 4499.4 4527.5 4641.1 4705.3 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4434.80 Median:5052.25 stddev:1347.33 (26.7%) stddev-sans-first:1315.26 09:29:41 INFO - PROCESS | 1634 | Values: 321.7 330.6 333.6 347.9 350.2 4485.9 5124.7 5259.8 5408.9 5423.7 5178.9 5211.5 5226.5 5265.8 5312.8 3343.9 3634.5 4149.0 4160.9 4224.8 3244.0 3317.6 4224.7 4242.7 4257.9 3879.9 4060.8 4152.3 4153.7 4184.6 3636.6 4063.8 4134.9 4137.7 4138.5 3634.0 3638.9 3653.9 3656.8 3682.2 4568.8 4869.2 4877.4 5101.8 5204.4 4510.8 4530.0 4576.8 4592.0 4652.5 5610.4 5638.4 5639.3 5677.6 5692.2 3507.6 3631.0 3736.5 3763.9 3775.1 5267.7 5755.9 5799.3 5856.6 5906.6 3233.8 3863.1 3865.0 3873.6 3881.2 3605.3 3760.7 3869.1 3912.8 3919.7 4129.4 4334.7 4507.0 4513.5 4582.2 5419.6 5710.2 5722.3 5769.5 5784.9 1068.8 1098.9 1152.6 1234.3 1261.2 825.6 836.8 847.2 849.6 856.8 4369.6 4851.5 4985.0 4992.8 5084.6 5134.1 5157.0 5258.0 5360.5 5679.4 4743.0 5214.7 5306.6 5307.3 5309.7 2478.4 2537.5 2908.0 2909.9 2931.2 5006.0 5137.9 5272.7 5284.4 5390.8 4814.0 5139.9 5205.5 5247.7 5642.4 5016.4 5295.6 5642.5 5696.9 5724.7 4846.6 5099.9 5258.8 5285.2 5519.5 4783.5 5275.8 5431.9 5474.6 5496.0 5486.4 5655.4 5731.8 5737.0 5742.8 3320.5 3393.9 3879.5 3907.3 3963.7 5060.9 5218.0 5392.3 5531.4 5558.7 5029.2 5250.9 5406.0 5414.2 5443.6 5043.6 5103.9 5161.2 5232.9 5238.4 4461.0 4691.3 5153.5 5182.6 5297.7 4926.3 5538.3 5543.0 5548.6 5560.7 4643.2 5011.9 5226.8 5399.4 5445.3 09:29:41 INFO - PROCESS | 1634 | 09:29:41 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:19747.79 Median:5010.70 stddev:28530.27 (569.4%) stddev-sans-first:28574.52 09:29:41 INFO - PROCESS | 1634 | Values: 715.9 737.7 752.8 769.4 832.4 14570.6 15324.7 15715.1 15720.7 15780.0 13933.4 13945.4 14052.7 14149.2 14216.4 859.7 872.1 873.8 876.2 876.8 685.7 710.9 846.5 874.8 883.3 939.4 942.3 944.4 944.8 946.0 937.7 937.9 939.5 940.2 945.5 537.3 553.4 556.7 561.3 563.2 13868.5 14363.6 14399.8 14701.6 14734.9 14285.9 14289.8 14345.5 14371.9 14373.3 11149.5 11195.8 11239.6 11500.9 11808.8 3573.6 3678.1 3896.3 3910.2 3912.7 98832.5 106107.5 108171.0 109599.0 110449.0 10557.5 10848.2 11003.8 11024.3 11235.8 21834.7 22197.0 22412.3 22482.1 22555.4 7479.5 7552.5 7632.8 7663.3 7795.3 4164.6 4216.9 4302.6 4305.8 4446.7 3518.2 3527.2 3626.6 3633.9 3639.4 547.2 653.1 658.9 659.0 663.8 631.4 652.8 661.5 671.5 689.7 9167.3 9587.2 9882.8 10778.8 10875.9 550.9 562.2 587.8 594.5 716.8 4624.6 4999.7 5007.9 5013.5 5020.2 89121.0 95853.0 97036.0 97577.5 98788.5 84916.0 85591.0 86867.6 89235.6 90760.0 72429.3 73473.0 74213.0 75049.6 75402.2 9552.9 9555.4 9622.7 9625.5 9680.3 49105.0 49431.0 49575.5 50888.0 51102.0 55626.0 64798.7 65700.7 66167.0 68775.3 11273.7 11384.7 11653.0 11835.2 11954.1 12173.5 12181.8 12370.6 12763.4 12793.2 11472.5 11938.1 12141.3 12185.3 12307.5 11079.5 11873.6 12015.0 12234.6 12253.3 11296.7 11713.5 11913.9 11941.8 12111.4 9657.3 10021.7 10392.0 10450.2 10453.3 7962.4 9471.0 9678.2 9689.3 9806.6 09:29:41 INFO - PROCESS | 1634 | -------- Summary: end -------- 09:29:41 INFO - PROCESS | 1634 | 09:29:42 INFO - TEST-INFO | 1634: exit 0 09:29:42 INFO - TEST-OK | dromaeo_css | took 1118667ms 09:29:42 INFO - TEST-START | kraken 09:29:42 INFO - operating with platform_type : mac_ 09:29:42 INFO - Initialising browser for kraken test... 09:29:42 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpsvx4in/profile http://localhost:49240/getInfo.html) 09:29:44 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 09:29:44 INFO - PROCESS | 1644 | colorDepth:24 09:29:44 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 09:29:44 INFO - PROCESS | 1644 | __metrics 09:29:44 INFO - PROCESS | 1644 | 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" 09:29:44 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:45 INFO - TEST-INFO | 1644: exit 0 09:29:45 INFO - Browser initialized. 09:29:45 INFO - Running cycle 1/1 for kraken test... 09:29:45 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpsvx4in/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:57 INFO - PROCESS | 1645 | RSS: Main: 213069824 09:29:57 INFO - PROCESS | 1645 | 09:30:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:00 INFO - PROCESS | 1645 | RSS: Main: 265596928 09:30:00 INFO - PROCESS | 1645 | 09:30:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 09:30:04 INFO - PROCESS | 1645 | RSS: Main: 274698240 09:30:04 INFO - PROCESS | 1645 | 09:30:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 09:30:08 INFO - PROCESS | 1645 | RSS: Main: 371277824 09:30:08 INFO - PROCESS | 1645 | 09:30:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 09:30:10 INFO - PROCESS | 1645 | RSS: Main: 276676608 09:30:10 INFO - PROCESS | 1645 | 09:30:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:13 INFO - PROCESS | 1645 | RSS: Main: 278269952 09:30:13 INFO - PROCESS | 1645 | 09:30:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 09:30:16 INFO - PROCESS | 1645 | RSS: Main: 318599168 09:30:16 INFO - PROCESS | 1645 | 09:30:19 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 09:30:20 INFO - PROCESS | 1645 | RSS: Main: 319623168 09:30:20 INFO - PROCESS | 1645 | 09:30:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 09:30:23 INFO - PROCESS | 1645 | RSS: Main: 317190144 09:30:23 INFO - PROCESS | 1645 | 09:30:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:30:25 INFO - PROCESS | 1645 | RSS: Main: 295464960 09:30:25 INFO - PROCESS | 1645 | 09:30:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:30:28 INFO - PROCESS | 1645 | RSS: Main: 298332160 09:30:28 INFO - PROCESS | 1645 | 09:30:30 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:30:31 INFO - PROCESS | 1645 | RSS: Main: 305831936 09:30:31 INFO - PROCESS | 1645 | 09:30:34 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:30:35 INFO - PROCESS | 1645 | RSS: Main: 318529536 09:30:35 INFO - PROCESS | 1645 | 09:30:38 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:38 INFO - PROCESS | 1645 | RSS: Main: 312565760 09:30:38 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 09:30:40 INFO - PROCESS | 1645 | RSS: Main: 357367808 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | __start_tp_report 09:30:40 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 09:30:40 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 09:30:40 INFO - PROCESS | 1645 | |i|pagename|runs| 09:30:40 INFO - PROCESS | 1645 | |0;ai-astar;115;115;116;113;113;116;113;116;114;113 09:30:40 INFO - PROCESS | 1645 | |1;audio-beat-detection;146;109;110;147;137;121;110;113;129;109 09:30:40 INFO - PROCESS | 1645 | |2;audio-dft;188;185;187;183;195;213;198;263;194;185 09:30:40 INFO - PROCESS | 1645 | |3;audio-fft;80;58;58;89;66;58;58;60;72;58 09:30:40 INFO - PROCESS | 1645 | |4;audio-oscillator;87;70;89;70;68;69;81;67;69;82 09:30:40 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;89;85;89;86;89;85;88;86;88;84 09:30:40 INFO - PROCESS | 1645 | |6;imaging-darkroom;94;110;152;101;96;96;96;96;95;95 09:30:40 INFO - PROCESS | 1645 | |7;imaging-desaturate;86;86;92;87;84;84;86;86;85;85 09:30:40 INFO - PROCESS | 1645 | |8;json-parse-financial;56;52;53;53;56;57;56;55;58;57 09:30:40 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;65;67;75;74;72;68;69;69;69;70 09:30:40 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;85;86;83;86;86;85;86;95;86;106 09:30:40 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;139;135;152;144;136;136;144;147;220;178 09:30:40 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;169;168;168;169;168;173;169;170;165;174 09:30:40 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;66;67;68;65;65;64;65;65;65;65 09:30:40 INFO - PROCESS | 1645 | __end_tp_report 09:30:40 INFO - PROCESS | 1645 | __start_cc_report 09:30:40 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2038 09:30:40 INFO - PROCESS | 1645 | __end_cc_report 09:30:40 INFO - PROCESS | 1645 | __startTimestamp1488216640611__endTimestamp 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | ------- Summary: start ------- 09:30:40 INFO - PROCESS | 1645 | Number of tests: 14 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 09:30:40 INFO - PROCESS | 1645 | Values: 115.0 115.0 116.0 113.0 113.0 116.0 113.0 116.0 114.0 113.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:125.00 stddev:15.53 (12.4%) stddev-sans-first:14.09 09:30:40 INFO - PROCESS | 1645 | Values: 146.0 109.0 110.0 147.0 137.0 121.0 110.0 113.0 129.0 109.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:199.10 Median:194.50 stddev:24.15 (12.4%) stddev-sans-first:25.27 09:30:40 INFO - PROCESS | 1645 | Values: 188.0 185.0 187.0 183.0 195.0 213.0 198.0 263.0 194.0 185.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:65.70 Median:63.00 stddev:11.14 (17.7%) stddev-sans-first:10.54 09:30:40 INFO - PROCESS | 1645 | Values: 80.0 58.0 58.0 89.0 66.0 58.0 58.0 60.0 72.0 58.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:75.50 stddev:8.56 (11.3%) stddev-sans-first:7.94 09:30:40 INFO - PROCESS | 1645 | Values: 87.0 70.0 89.0 70.0 68.0 69.0 81.0 67.0 69.0 82.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:1.91 (2.2%) stddev-sans-first:1.87 09:30:40 INFO - PROCESS | 1645 | Values: 89.0 85.0 89.0 86.0 89.0 85.0 88.0 86.0 88.0 84.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:95.50 stddev:17.82 (18.7%) stddev-sans-first:18.60 09:30:40 INFO - PROCESS | 1645 | Values: 94.0 110.0 152.0 101.0 96.0 96.0 96.0 96.0 95.0 95.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:2.28 (2.7%) stddev-sans-first:2.42 09:30:40 INFO - PROCESS | 1645 | Values: 86.0 86.0 92.0 87.0 84.0 84.0 86.0 86.0 85.0 85.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:2.00 (3.6%) stddev-sans-first:2.11 09:30:40 INFO - PROCESS | 1645 | Values: 56.0 52.0 53.0 53.0 56.0 57.0 56.0 55.0 58.0 57.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.50 stddev:3.08 (4.4%) stddev-sans-first:2.74 09:30:40 INFO - PROCESS | 1645 | Values: 65.0 67.0 75.0 74.0 72.0 68.0 69.0 69.0 69.0 70.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:86.00 stddev:6.95 (8.1%) stddev-sans-first:7.26 09:30:40 INFO - PROCESS | 1645 | Values: 85.0 86.0 83.0 86.0 86.0 85.0 86.0 95.0 86.0 106.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:145.50 stddev:26.69 (18.3%) stddev-sans-first:27.82 09:30:40 INFO - PROCESS | 1645 | Values: 139.0 135.0 152.0 144.0 136.0 136.0 144.0 147.0 220.0 178.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:2.58 (1.5%) stddev-sans-first:2.74 09:30:40 INFO - PROCESS | 1645 | Values: 169.0 168.0 168.0 169.0 168.0 173.0 169.0 170.0 165.0 174.0 09:30:40 INFO - PROCESS | 1645 | 09:30:40 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 09:30:40 INFO - PROCESS | 1645 | Values: 66.0 67.0 68.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 09:30:40 INFO - PROCESS | 1645 | -------- Summary: end -------- 09:30:40 INFO - PROCESS | 1645 | 09:30:41 INFO - TEST-INFO | 1645: exit 0 09:30:41 INFO - TEST-OK | kraken | took 59481ms 09:30:41 INFO - SUITE-END | took 1178s 09:30:41 INFO - Completed test suite (00:19:38) 09:30:41 INFO - javascript benchmark 09:30:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2904.651441826981, 3331.083951913224, 3367.6969072783445, 3369.6798804113614, 3426.9890382337207, 5763.884722305556, 5805.535557155428, 5824.621399609023, 5829.125631155323, 5842.532597392204, 5718.342390625079, 5828.1549175369655, 5830.970845145768, 5843.620164689292, 5858.091995740657, 4285.657147428214, 5175.197844334134, 5175.689458632475, 5253.4221235664045, 5267.710275934822, 5189.7405129743365, 5214.061468935609, 5217.426083130853, 5294.232336311233, 5339.22581225722, 5225.503577160182, 5270.341207349082, 5276.894462110756, 5302.681839089648, 5304.443033481487, 5318.414974352818, 5321.467853214667, 5328.813491527778, 5334.733263336818, 5361.463853614647, 5185.6888586684545, 5242.711650859202, 5273.077211487975, 5275.261463395128, 5324.041672498949, 5042.596592272609, 5609.158626206061, 5634.4365563443735, 5677.744501497401, 5686.857828554319, 6254.499640028786, 6290.245170579514, 6293.2762732285455, 6295.5907865988565, 6333.68331583419, 5312.0, 6160.599561028519, 6248.656323902183, 6268.341824108448, 6272.466840318532, 4631.235846085358, 5744.080947048536, 5772.740226689809, 5930.436608522184, 5931.406859314034, 6184.350643182401, 6207.503399728011, 6227.221597300338, 6270.31026587075, 6274.686265686789, 6232.220972378453, 6234.750609975641, 6250.874982500324, 6252.968735156295, 6253.187085678833, 6116.366205733216, 6171.907421388682, 6197.287311959182, 6240.126382306481, 6253.5622506424115, 6142.416470435391, 6181.165542651775, 6228.532860035425, 6238.0, 6272.310045895039, 6282.748690052438, 6292.276388215414, 6300.684965751694, 6315.842103947438, 6319.684015799192, 5015.724135172528, 5019.749012549358, 5061.924071138936, 5064.873378165576, 5116.897662046738, 4397.6042156206095, 4423.977880110643, 4430.025394413224, 4438.911221775546, 4534.954650453519, 5758.568107391962, 5864.179014937912, 5874.735636896265, 5882.323532793784, 5883.17635531026, 6186.4741496972365, 6221.96889015552, 6240.184482038859, 6270.0, 6275.403836635513, 4582.24392975162, 5740.770369185186, 5824.417558244227, 5827.271591051119, 5845.386234445407, 5457.263269458652, 5529.0, 5553.777848885999, 5555.2778138841695, 5555.472230138131, 4851.46633870281, 6000.249968753906, 6176.9073463897175, 6184.8763024738355, 6264.34224406449, 5318.255444237732, 6198.380161983766, 6216.968915155395, 6230.6884655766125, 6252.218472690914, 6347.0479428086155, 6365.013422919455, 6365.299817020216, 6387.105805187184, 6389.808305750835, 6075.878482430415, 6086.452219300107, 6243.094751261133, 6252.843678907881, 6268.435840774352, 6173.783917563043, 6199.690015499297, 6212.97485914819, 6235.282942461494, 6262.46769024638, 5966.284045914518, 5966.642001479925, 6008.519318454426, 6177.444030037318, 6199.535034872493, 5967.492763115184, 5983.431574000463, 6145.8156255312415, 6203.627782333075, 6219.906701399392, 5873.970630146822, 5984.970075149597, 6049.18336024631, 6058.787942421994, 6104.4505994460715, 6170.136180934763, 6181.3200547938795, 6198.132261483306, 6213.844653883508, 6217.409346112112, 5749.885002299847, 6002.87994240104, 6016.8796624068145, 6023.27720673522, 6029.728662210299], "value": 5699.459511508909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.96464282857374, 494.76745929413164, 508.4813490239955, 516.1457787361917, 519.8466452396542, 30566.847165764168, 40740.79629601852, 42074.948126296855, 42112.0, 42361.57638423623, 36772.81613591935, 43162.13675726484, 43553.78223108888, 43839.34240986388, 44059.55940440595, 8385.748427547152, 9224.492652904088, 9400.529973501332, 9411.764705882339, 9423.528823558829, 8372.790680233013, 11041.668749937515, 11270.267432616894, 11304.434778261095, 11518.712032199179, 11200.439978001108, 11282.0, 11308.37803920784, 11316.547338106508, 11322.886771132265, 11228.775424491505, 11288.435578221139, 11321.716957076056, 11326.660200194008, 11357.602483913106, 8335.124811894784, 8568.143185681445, 10936.835947460795, 11208.495617697223, 11216.0, 40517.0, 40738.9815254618, 40767.7961610193, 40881.182376352306, 41118.76643700694, 3924.843006279774, 3958.5249770027494, 3960.2277555876617, 3966.5240171179644, 4013.9764360088284, 28674.713252867412, 30256.84871575628, 30774.0, 30966.69033309683, 31686.207844803834, 3114.9065528034193, 3209.646938836726, 3217.8560823517673, 3264.6408895021527, 3270.3622793555264, 378701.0, 379870.0, 380160.0991995022, 380382.0980895078, 381084.0, 61609.0, 61980.0, 62073.37926620676, 62228.37771622226, 62319.6884015577, 65018.0, 65090.67454662791, 65209.02186467207, 65216.0, 65238.02142967859, 16435.83564164343, 16492.25784839661, 16725.83274167267, 16743.497695069167, 16796.244169012425, 11769.293842369485, 13073.803892941614, 13161.0, 13173.736525269442, 13174.47302107924, 14268.714625707635, 14608.707825843423, 16115.677686446206, 16504.83495165033, 16533.33866645345, 5936.910946335808, 7003.894941575881, 7060.399866011344, 7094.858102838018, 7121.252268511836, 845.3659755183612, 871.9084496127942, 891.6745387933487, 905.3571963905569, 908.4549270437817, 28867.845286188738, 29815.0, 29817.701822981926, 30295.0, 30492.085237442912, 936.9859452108224, 1081.7782354617284, 1101.388729255271, 1108.6563165418745, 1182.343799191457, 14861.331240094221, 15419.151946643042, 15466.0, 15664.295106720225, 15804.446844360393, 619679.0, 626524.0, 630898.0, 632095.0, 634549.0, 59621.40378596245, 59759.40240597625, 59823.0, 59932.70033649804, 60043.0, 1357.5248662967883, 1415.5116484812722, 1422.4239183130849, 1422.9644258893197, 1433.6845893903323, 24256.393590160387, 28119.57820632651, 29170.854145729136, 29856.552151718177, 29956.251093722833, 50543.73640658866, 51328.48671513386, 51339.48660513347, 51364.74317628388, 51430.0, 579941.0, 581989.0, 582678.0, 583410.0, 584535.0, 24773.25680229596, 24950.251492455256, 25152.874235628704, 25220.873895630404, 26319.0, 34530.65469345274, 41043.589564103975, 44146.117077658906, 44292.778536107115, 44379.77810110929, 33551.328973419906, 35693.82153089218, 36711.816440917624, 36837.81581092077, 37390.0, 35238.823805880806, 35386.0, 36323.0, 36703.449448258834, 36738.0, 34649.82675086609, 35533.64466355303, 35574.64425355713, 36354.0, 37579.624203757616, 28049.811071501677, 30969.8508536922, 32000.839995799874, 32268.838655806572, 32456.188595284362, 23645.280792709058, 23929.401764956016, 23934.597841529514, 24028.87985560061, 24217.273481795575], "value": 19733.838108244203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.40120011581826, 383.73138802838014, 391.4910616198941, 394.1466724541369, 417.76813868303077, 14305.92705547083, 20388.286409975655, 21281.148754049857, 21648.567028659436, 21769.12923483061, 16379.061119917049, 18283.725744113817, 21285.25501607444, 21474.0, 21860.0, 5483.506484416402, 5811.0, 5811.941880581204, 5812.128180772876, 5826.766929322822, 5664.235328230698, 5709.286339207599, 5789.797357092502, 5803.883922321551, 5954.077118046688, 6016.488598469114, 6032.276126864783, 6037.456628903398, 6048.123022161784, 6064.0, 5789.305283365981, 5923.881522369572, 5971.462568368825, 5977.402259774031, 6016.27804663441, 5032.6477146599755, 5789.681567513785, 5829.8251052468495, 5840.123981402781, 5841.766329346821, 21965.450863728376, 24186.637200442008, 25373.0, 26044.218673439827, 26148.215553533424, 2878.596996420503, 2918.255844759594, 2925.254060214632, 2973.6728959814404, 3042.4675681755825, 9982.80034399308, 10010.849837252446, 10141.594336226543, 10555.630552930686, 10576.68269951895, 1751.6846967545837, 1787.9106044697844, 1801.4595621313554, 1813.5738101546258, 1816.9091545422675, 107228.0, 115989.0, 123546.0, 135186.32406838002, 139471.0, 11359.943200283946, 11572.0, 11821.822672659917, 11956.641300760992, 11986.34075125859, 15748.606284842741, 15755.44855930037, 15809.604759881095, 15809.762853557206, 15810.893237473496, 7682.961585192038, 8012.399070069651, 8030.598470076589, 8382.329413646894, 8477.298116820959, 8481.830363392697, 8541.957290213633, 8657.0, 8665.263452606472, 8769.561521923879, 4194.0563373240775, 4655.162070827216, 4754.429468463737, 4754.667173297905, 4782.617390608743, 1984.880907145576, 2023.494126468383, 2029.7970202979584, 2029.8985050747403, 2032.2074390987527, 970.2819913264134, 970.2868391732071, 992.3748038735695, 999.1357475783541, 1041.630221271453, 21187.47031324229, 21922.89038554829, 21944.0, 22007.449813754785, 22033.0, 979.2313034268066, 1023.0638965346625, 1041.3189375557367, 1047.989520104789, 1063.4842101580728, 10096.545655445523, 10865.130789536817, 11175.24546265989, 11232.697297054085, 11320.528571000648, 750055.2497237478, 764309.0, 767066.0, 772557.0, 775148.0, 119661.0, 122830.38584807019, 139836.0, 144967.0, 146611.0, 974.6198982397012, 1011.1253765492796, 1045.4406892312577, 1048.7063622185801, 1049.8162821506205, 19015.42953711391, 19215.615687686448, 20226.39320820378, 20246.898765506077, 20327.28854490145, 58222.12666809917, 58755.706221468616, 61655.0, 61817.690911545156, 62197.37802621916, 86459.56770216109, 87462.0, 90212.0, 91232.0, 93899.06100938903, 11438.82841757391, 12518.24890506536, 12600.306983116017, 12836.973042156418, 12930.806037909628, 11967.281963082243, 13801.861981380058, 13909.51316703951, 13911.513097041556, 14442.855571444152, 10715.693366926747, 11379.317240965238, 11600.825987610362, 11605.709857253636, 11617.0, 11659.708507287385, 11693.707657308636, 11965.820512692142, 12023.63929082129, 12148.453319600463, 6263.467605253604, 8283.420160588701, 11392.54429822831, 11895.055299310687, 11984.880151198726, 13058.542950996669, 13172.012099092799, 13267.535636252685, 13387.933060334635, 13406.061575689608, 11543.307401555934, 11563.132765042823, 11862.58480953197, 11906.642800715992, 11998.880011199777], "value": 10212.400558189162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.457103083048, 1425.4227038049594, 1444.2778610694652, 1451.8693317601421, 1465.3698909468928, 6562.376574225453, 7751.992241008668, 7976.92023079769, 8584.442011269262, 8638.136186381358, 7715.922840771591, 8144.959275203616, 8336.416450848443, 8346.91653083469, 8481.109483504235, 2296.7243930728337, 2335.2643917166124, 2339.321596736953, 2343.1330407749156, 2345.0, 2074.834013278934, 2340.4499942513494, 2361.752016038317, 2377.0, 2382.1424287256573, 2085.5620319732875, 2122.4693826543366, 2127.617028934799, 2131.2860191835675, 2133.7226160599103, 2140.6039882621767, 2169.3491952414292, 2237.093976939342, 2246.4159318577126, 2250.189931624614, 2265.524239909621, 2324.012294774731, 2325.9651105233434, 2327.5461285049423, 2332.661764044204, 8448.366372522023, 8554.401191916568, 8562.48625082497, 8577.228049475578, 8599.0, 5018.64869459138, 5177.922331165036, 5186.092433824066, 5191.662541934762, 5194.0131375039, 3468.0809585459874, 3490.4764285357146, 3497.090756403353, 3569.8750543731103, 3573.5533058367705, 1193.081327377923, 1199.4062938845327, 1214.9635510934686, 1246.1028059796931, 1249.6001279590535, 10949.890501095046, 11007.394593297366, 11010.779784404347, 11031.669049928514, 11056.944715276453, 4345.391645169679, 4630.884227894262, 4706.529347065266, 4713.764311784397, 4729.4797572267025, 9609.663661771945, 9652.710418687451, 9676.9032309676, 9679.274054445945, 9683.370580912218, 5223.791048358099, 5270.393904701008, 5271.604629652791, 5276.604254680914, 5302.098643230583, 4203.579642035772, 4447.6212374164115, 4712.24604063355, 4811.663183577186, 4824.614030877521, 3508.6842184203542, 3842.289176502356, 3922.4508568800393, 3971.801409929492, 4008.8797336079965, 1284.8650891656428, 1292.2246652008719, 1294.0, 1302.2707283921034, 1307.941142648583, 708.5146674527965, 759.4038679636459, 873.6287077991828, 882.7748924024461, 908.0193391137556, 5039.672421292605, 5328.600354973392, 5513.641613295123, 5747.25285712863, 5797.739101740432, 929.4330458420358, 939.6053657463882, 950.2825366847985, 955.1690029674089, 961.5432669481941, 3558.5551806024246, 3743.0, 3832.9616703832603, 3849.480320156743, 3855.0169706724605, 9916.553755081039, 10087.49562521871, 10210.846837297446, 10223.693289201336, 10226.437545935045, 9489.38319009276, 10053.246006549538, 10064.446455444875, 10067.647632332833, 10136.746581335525, 7699.884501732478, 7985.480943738638, 7992.880106798402, 8009.439339246197, 8034.116247212802, 5584.46947539983, 5623.891040859678, 5643.0, 5869.092544923003, 5887.969605319137, 9337.439753614804, 9455.24358051368, 9458.716238512856, 9480.336376453582, 9498.0, 9170.220531254918, 9476.099770521789, 9559.091886271071, 9700.660476883275, 9715.0, 7023.578585284899, 7184.245654206442, 7251.746188883364, 7358.521696089737, 7410.703571857281, 6891.173059232924, 6908.3437073477935, 8100.9873765779275, 8123.79690507742, 8138.715144969898, 6381.680915954276, 6987.860242795217, 7021.613811240431, 7180.640967951686, 7328.1938986712485, 6707.5975441473665, 6839.316068393121, 6971.47713921468, 7044.823879403056, 7173.569585824867, 6321.146645203023, 6340.556161068681, 6440.0983862260255, 6447.9355206447335, 6456.192975878015, 4933.1613625683, 4958.652894297509, 4992.600591952562, 5013.924791128063, 5016.1221786188, 4471.329300604935, 4499.437570303712, 4527.524609915911, 4641.094986477605, 4705.294205869147], "value": 4411.743502325589, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.69760425200315, 330.5785123966942, 333.55470446953314, 347.94085005549056, 350.20852872508124, 4485.936469224157, 5124.666896651715, 5259.815906443266, 5408.864778380537, 5423.701696406696, 5178.922316165251, 5211.5049070338355, 5226.529612334889, 5265.815696450625, 5312.814051508198, 3343.916402089955, 3634.491171236029, 4148.979255103728, 4160.8959776005695, 4224.767637779921, 3243.96756032439, 3317.6018877734705, 4224.662027037845, 4242.666533406629, 4257.850975215868, 3879.8554426444125, 4060.7563546187175, 4152.2733521633745, 4153.691587150053, 4184.581541845821, 3636.5999740028574, 4063.817128229237, 4134.937975930364, 4137.689673274486, 4138.482689663777, 3633.963660363389, 3638.890833275006, 3653.926921461556, 3656.780593164419, 3682.208325210066, 4568.817247310104, 4869.220924652074, 4877.3903262092235, 5101.795928162869, 5204.42751297357, 4510.774461276923, 4529.954700452986, 4576.839810606646, 4591.95408045922, 4652.464966528859, 5610.410906854762, 5638.40796716343, 5639.2668953035845, 5677.630953987978, 5692.17850287908, 3507.6492350764975, 3631.0, 3736.4582135590185, 3763.8682646107527, 3775.0751065988734, 5267.736613169326, 5755.884882302331, 5799.333076696192, 5856.619319744203, 5906.586538942319, 3233.8221397823345, 3863.130795570974, 3864.9613503864603, 3873.6177250990436, 3881.204353107606, 3605.2789442111684, 3760.699144068468, 3869.090763670535, 3912.771963130429, 3919.6864250860435, 4129.421880936671, 4334.7399156050105, 4506.977465112654, 4513.5486451355255, 4582.175208462442, 5419.561197461158, 5710.229119068956, 5722.341930678025, 5769.480746732815, 5784.8596019472225, 1068.7755571329951, 1098.8626421697288, 1152.6369193703956, 1234.2902830872285, 1261.1928365845865, 825.6078362777632, 836.8117173636005, 847.1570787066908, 849.609179777297, 856.8029353248663, 4369.563043695669, 4851.51484851512, 4984.975075124601, 4992.775325110379, 5084.593232541388, 5134.12604399399, 5157.0, 5258.0, 5360.517553420211, 5679.375268720438, 4742.976285118552, 5214.713190774468, 5306.575473962073, 5307.310049693592, 5309.7345132743985, 2478.392793765539, 2537.4544472938405, 2907.956380654292, 2909.941801163965, 2931.2232258451527, 5006.023825354094, 5137.897242055138, 5272.70274726097, 5284.445133260952, 5390.838274851761, 4813.989062296957, 5139.946311006235, 5205.453427390145, 5247.658902171346, 5642.401442824167, 5016.398032236082, 5295.602829787781, 5642.463965923231, 5696.8860622787315, 5724.656520608777, 4846.625153674603, 5099.898002039864, 5258.842234732964, 5285.207218917039, 5519.475649813261, 4783.521647835189, 5275.8129420879995, 5431.891362172655, 5474.562035037267, 5495.972520137374, 5486.421381950477, 5655.406182350794, 5731.770729170787, 5736.963378000916, 5742.827715168384, 3320.5019247113128, 3393.9151521212166, 3879.4568760374136, 3907.316219661605, 3963.7225394223283, 5060.873478163076, 5218.03429393656, 5392.299001129828, 5531.446855314597, 5558.694271815089, 5029.245613158056, 5250.923560669977, 5405.999890020359, 5414.242006119068, 5443.564514838883, 5043.62172837046, 5103.948960510347, 5161.238737275539, 5232.947670523246, 5238.371395432572, 4460.977695111504, 4691.34075421172, 5153.510416510426, 5182.637215395037, 5297.735113244399, 4926.310316555613, 5538.280023596906, 5542.97228513871, 5548.639338442988, 5560.694161821139, 4643.210654188729, 5011.924821127613, 5226.843194704165, 5399.379071406838, 5445.346558413015], "value": 4005.2788851353484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.946304027198, 737.6643627149648, 752.7892190186747, 769.4114002787868, 832.4089896173717, 14570.56288311351, 15324.693506129885, 15715.135667538281, 15720.685586288268, 15780.0, 13933.37299821508, 13945.442182312721, 14052.718945621082, 14149.151050936925, 14216.360263788129, 859.6905114158914, 872.1322284327103, 873.7771868173606, 876.1851478125341, 876.7545087375545, 685.7462738786656, 710.882704353781, 846.4794151596785, 874.7987962768567, 883.3419102768446, 939.3565407695717, 942.3215284994793, 944.4097439100562, 944.773254418938, 945.997242922501, 937.6530683647094, 937.9484128372936, 939.4504215034214, 940.1538615246264, 945.465811816325, 537.2585831552433, 553.4272028450534, 556.6520924422236, 561.2871653000666, 563.2311894264341, 13868.514601988882, 14363.640908977359, 14399.78400323996, 14701.55895323142, 14734.852651473562, 14285.85714142866, 14289.785653215211, 14345.497907573184, 14371.928140359336, 14373.340931927627, 11149.498272577672, 11195.776084478346, 11239.60661376848, 11500.907413795676, 11808.822867656992, 3573.6069032406413, 3678.0620941659704, 3896.298666240076, 3910.159315747128, 3912.686985041218, 98832.50583747106, 106107.46946265297, 108171.0, 109599.0, 110449.0, 10557.524911379007, 10848.186386020921, 11003.834942475869, 11024.283421577571, 11235.775284494264, 21834.672479912813, 22197.0, 22412.32763017112, 22482.100715971505, 22555.436114096952, 7479.513831601037, 7552.509086909334, 7632.80917977055, 7663.31030207284, 7795.337396321376, 4164.583541645872, 4216.91566168681, 4302.569743025672, 4305.806238719202, 4446.688731788744, 3518.1908161123083, 3527.188746588299, 3626.5829429615405, 3633.8728144514816, 3639.3631114554846, 547.2338725783854, 653.1085068880943, 658.887989041864, 659.0229312063808, 663.7577284291199, 631.3528633151057, 652.807421810567, 661.5127122021235, 671.4594751225213, 689.7310049080862, 9167.312451566026, 9587.234340184474, 9882.752931176778, 10778.838317425245, 10875.891241087646, 550.8540236837241, 562.1946487029693, 587.811900191943, 594.5362617158623, 716.7957132217293, 4624.560666736655, 4999.675021123615, 5007.924881126786, 5013.473585273494, 5020.171671674133, 89121.0, 95853.0, 97036.0, 97577.51211244041, 98788.50605747069, 84916.0, 85591.0, 86867.56566217128, 89235.55382223047, 90760.0, 72429.2757072433, 73473.0, 74213.0, 75049.62475187589, 75402.24597753953, 9552.856707149538, 9555.426674399558, 9622.663206787729, 9625.470599117116, 9680.27397945143, 49105.0, 49431.0, 49575.50424495709, 50888.0, 51102.0, 55626.0, 64798.676006619666, 65700.67149664222, 66167.0, 68775.31224687689, 11273.736546794245, 11384.715382115513, 11653.0, 11835.171537992257, 11954.068797170537, 12173.513059477522, 12181.817272740738, 12370.62888113358, 12763.425645845773, 12793.232406055666, 11472.483738231633, 11938.1046421517, 12141.271523708605, 12185.268883866996, 12307.507699691912, 11079.50142243585, 11873.643790686294, 12015.038796896402, 12234.632961011184, 12253.326067066397, 11296.661100167008, 11713.531458741554, 11913.880861191277, 11941.82087268709, 12111.394430278275, 9657.32398732082, 10021.749456263651, 10392.012758787903, 10450.216233782648, 10453.32053416556, 7962.442629015914, 9471.0, 9678.17735492491, 9689.273304502332, 9806.607735690492], "value": 7234.487479072028, "unit": "score"}], "name": "dromaeo_css", "value": 7263.491882298999, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 113.0, 113.0, 116.0, 113.0, 116.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 110.0, 147.0, 137.0, 121.0, 110.0, 113.0, 129.0, 109.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 187.0, 183.0, 195.0, 213.0, 198.0, 263.0, 194.0, 185.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 89.0, 66.0, 58.0, 58.0, 60.0, 72.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 89.0, 70.0, 68.0, 69.0, 81.0, 67.0, 69.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 88.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 110.0, 152.0, 101.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 92.0, 87.0, 84.0, 84.0, 86.0, 86.0, 85.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 53.0, 56.0, 57.0, 56.0, 55.0, 58.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 75.0, 74.0, 72.0, 68.0, 69.0, 69.0, 69.0, 70.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 86.0, 86.0, 85.0, 86.0, 95.0, 86.0, 106.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 152.0, 144.0, 136.0, 136.0, 144.0, 147.0, 220.0, 178.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 168.0, 169.0, 168.0, 173.0, 169.0, 170.0, 165.0, 174.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1454.9999999999998, "alertThreshold": 2.0}]} 09:30:41 INFO - Return code: 0 09:30:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:30:41 ERROR - # TBPL SUCCESS # 09:30:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:41 INFO - 2017-02-27 09:30:41.905 screenresolution[1650:9684] starting screenresolution argv=screenresolution get 09:30:41 INFO - 2017-02-27 09:30:41.910 screenresolution[1650:9684] Display 0: 1600x1200x32@60 09:30:41 INFO - 2017-02-27 09:30:41.916 screenresolution[1651:9687] starting screenresolution argv=screenresolution list 09:30:41 INFO - Available Modes on Display 0 09:30:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:42 INFO - Intel Iris: 09:30:42 INFO - Chipset Model: Intel Iris 09:30:42 INFO - Type: GPU 09:30:42 INFO - Bus: Built-In 09:30:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:30:42 INFO - Vendor: Intel (0x8086) 09:30:42 INFO - Device ID: 0x0a2e 09:30:42 INFO - Revision ID: 0x0009 09:30:42 INFO - Displays: 09:30:42 INFO - Display: 09:30:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:42 INFO - Display Serial Number: 1600x1200 60 09:30:42 INFO - Main Display: Yes 09:30:42 INFO - Mirror: Off 09:30:42 INFO - Online: Yes 09:30:42 INFO - Rotation: Supported 09:30:42 INFO - Return code: 0 09:30:42 INFO - Running post-action listener: _resource_record_post_action 09:30:42 INFO - [mozharness: 2017-02-27 17:30:42.159428Z] Finished run-tests step (success) 09:30:42 INFO - Running post-run listener: _resource_record_post_run 09:30:42 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 37499904; Write bytes: 508475904; Read time: 445; Write time: 1602 09:30:42 INFO - TinderboxPrint: CPU usage
54.1% 09:30:42 INFO - TinderboxPrint: I/O read bytes / time
37,499,904 / 445 09:30:42 INFO - TinderboxPrint: I/O write bytes / time
508,475,904 / 1,602 09:30:42 INFO - TinderboxPrint: CPU idle
2,200.2 (45.9%) 09:30:42 INFO - TinderboxPrint: CPU system
968.1 (20.2%) 09:30:42 INFO - TinderboxPrint: CPU user
1,629.5 (34.0%) 09:30:42 INFO - TinderboxPrint: Swap in / out
244,391,936 / 0 09:30:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209019392; Write bytes: 208703488; Read time: 15887; Write time: 431 09:30:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35234816; Write bytes: 298449408; Read time: 357; Write time: 1165 09:30:42 INFO - Running post-run listener: _upload_blobber_files 09:30:42 INFO - Blob upload gear active. 09:30:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:42 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 09:30:42 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:30:42 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:30:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:44 INFO - (blobuploader) - INFO - Done attempting. 09:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:46 INFO - (blobuploader) - INFO - Done attempting. 09:30:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:30:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:30:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:47 INFO - (blobuploader) - INFO - Done attempting. 09:30:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:30:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:49 INFO - (blobuploader) - INFO - Done attempting. 09:30:49 INFO - (blobuploader) - INFO - Iteration through files over. 09:30:49 INFO - Return code: 0 09:30:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:30:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:30:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a9eac82dccdbc747a8076940805e147c60806ed39ac61ae73ddfd823d4419055a2b824af4214b0b5ebb43e2645b037df99649951fbdf059ef59ead6fd5a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7509f4464e879b20945ddbfb1890c2693ddc703357baf577b9fa9f2a1126113029c84dd63834c871aba56abbd87d3f5c5481e302b580d95dd621ba7c2423d255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a16d9812507eace5b66b18df48b53484201ff9685e379ca1957b9be704ba79261d17a414efcd40e73def24abab0ac3827a243558197a9a6bc98599467bbdcfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d140d16848b05e10faf4ba7b4af645c3b4e1197abba62081c4f50fbdd2b3f72affdab578c7daf7bd377661020ae1234cdea28e19fbf4f996e7b1857424c458ad"} 09:30:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:30:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:30:49 INFO - Contents: 09:30:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a9eac82dccdbc747a8076940805e147c60806ed39ac61ae73ddfd823d4419055a2b824af4214b0b5ebb43e2645b037df99649951fbdf059ef59ead6fd5a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7509f4464e879b20945ddbfb1890c2693ddc703357baf577b9fa9f2a1126113029c84dd63834c871aba56abbd87d3f5c5481e302b580d95dd621ba7c2423d255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a16d9812507eace5b66b18df48b53484201ff9685e379ca1957b9be704ba79261d17a414efcd40e73def24abab0ac3827a243558197a9a6bc98599467bbdcfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d140d16848b05e10faf4ba7b4af645c3b4e1197abba62081c4f50fbdd2b3f72affdab578c7daf7bd377661020ae1234cdea28e19fbf4f996e7b1857424c458ad"} 09:30:49 INFO - Running post-run listener: copy_logs_to_upload_dir 09:30:49 INFO - Copying logs to upload dir... 09:30:49 INFO - mkdir: /builds/slave/test/build/upload/logs 09:30:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.619693 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-27 09:30:49.624568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:30:49.627822) ========= 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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-Aurora/sha512/11a9eac82dccdbc747a8076940805e147c60806ed39ac61ae73ddfd823d4419055a2b824af4214b0b5ebb43e2645b037df99649951fbdf059ef59ead6fd5a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7509f4464e879b20945ddbfb1890c2693ddc703357baf577b9fa9f2a1126113029c84dd63834c871aba56abbd87d3f5c5481e302b580d95dd621ba7c2423d255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a16d9812507eace5b66b18df48b53484201ff9685e379ca1957b9be704ba79261d17a414efcd40e73def24abab0ac3827a243558197a9a6bc98599467bbdcfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d140d16848b05e10faf4ba7b4af645c3b4e1197abba62081c4f50fbdd2b3f72affdab578c7daf7bd377661020ae1234cdea28e19fbf4f996e7b1857424c458ad"} build_url:https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/FUAXjMhpQS-Xrc159j3wAQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a9eac82dccdbc747a8076940805e147c60806ed39ac61ae73ddfd823d4419055a2b824af4214b0b5ebb43e2645b037df99649951fbdf059ef59ead6fd5a975", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7509f4464e879b20945ddbfb1890c2693ddc703357baf577b9fa9f2a1126113029c84dd63834c871aba56abbd87d3f5c5481e302b580d95dd621ba7c2423d255", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a16d9812507eace5b66b18df48b53484201ff9685e379ca1957b9be704ba79261d17a414efcd40e73def24abab0ac3827a243558197a9a6bc98599467bbdcfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d140d16848b05e10faf4ba7b4af645c3b4e1197abba62081c4f50fbdd2b3f72affdab578c7daf7bd377661020ae1234cdea28e19fbf4f996e7b1857424c458ad"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:30:49.665963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:30:49.666289) ========= 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.QCUZjjQCLj/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.UiOJnUrHSA/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005118 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:30:49.714432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:30:49.714746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:30:49.715055) ========= ========= Total master_lag: 0.21 =========