builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0301 starttime: 1488557385.88 results: success (0) buildid: 20170303070751 builduid: b04c11619b59477ba36ae4c31c0c7d40 revision: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:45.880226) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:45.880943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:45.881414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:45.910082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:45.910500) ========= 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.0MPkxstwpK/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.xnvXO2Cywy/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-03-03 08:09:45-- 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% 6.87M=0.002s 2017-03-03 08:09:46 (6.87 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.483009 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.420444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.420775) ========= 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.0MPkxstwpK/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.xnvXO2Cywy/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.023142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.470436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 08:09:46.470795) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9d91d6e389ef19bd48eb5153c9e32a122a1eecc --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 d9d91d6e389ef19bd48eb5153c9e32a122a1eecc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0MPkxstwpK/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.xnvXO2Cywy/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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-03-03 08:09:46,567 truncating revision to first 12 chars 2017-03-03 08:09:46,567 Setting DEBUG logging. 2017-03-03 08:09:46,568 attempt 1/10 2017-03-03 08:09:46,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9d91d6e389e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 08:09:47,616 unpacking tar archive at: mozilla-aurora-d9d91d6e389e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313086 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 08:09:47.807746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:47.808047) ========= script_repo_revision: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:47.808419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:47.808700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:47.828922) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-03 08:09:47.829307) ========= /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.0MPkxstwpK/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.xnvXO2Cywy/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:09:48 INFO - MultiFileLogger online at 20170303 08:09:48 in /builds/slave/test 08:09:48 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 08:09:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:48 INFO - {'append_to_log': False, 08:09:48 INFO - 'base_work_dir': '/builds/slave/test', 08:09:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:09:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:48 INFO - 'branch': 'Mozilla-Aurora', 08:09:48 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:48 INFO - 'config_files': ('talos/mac_config.py',), 08:09:48 INFO - 'default_actions': ('clobber', 08:09:48 INFO - 'read-buildbot-config', 08:09:48 INFO - 'download-and-extract', 08:09:48 INFO - 'populate-webroot', 08:09:48 INFO - 'create-virtualenv', 08:09:48 INFO - 'install', 08:09:48 INFO - 'run-tests'), 08:09:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:48 INFO - 'download_minidump_stackwalk': True, 08:09:48 INFO - 'download_symbols': 'ondemand', 08:09:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:48 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:48 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:48 INFO - 'installer_path': 'installer.exe', 08:09:48 INFO - 'log_level': 'info', 08:09:48 INFO - 'log_name': 'talos', 08:09:48 INFO - 'log_to_console': True, 08:09:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:09:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:09:48 INFO - 'opt_config_files': (), 08:09:48 INFO - 'pip_index': False, 08:09:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:48 INFO - 'cmd': ('bash', 08:09:48 INFO - '-c', 08:09:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:48 INFO - 'enabled': True, 08:09:48 INFO - 'halt_on_failure': False, 08:09:48 INFO - 'name': 'check_screen_resolution'},), 08:09:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:48 INFO - 'cmd': ('bash', 08:09:48 INFO - '-c', 08:09:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:48 INFO - 'enabled': True, 08:09:48 INFO - 'halt_on_failure': False, 08:09:48 INFO - 'name': 'check_screen_resolution'},), 08:09:48 INFO - 'run_cmd_checks_enabled': True, 08:09:48 INFO - 'sps_profile': False, 08:09:48 INFO - 'sps_profile_interval': 0, 08:09:48 INFO - 'suite': 'dromaeojs', 08:09:48 INFO - 'system_bits': '32', 08:09:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:48 INFO - 'title': 't-yosemite-r7-0301', 08:09:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:48 INFO - 'use_talos_json': True, 08:09:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:48 INFO - 'work_dir': 'build'} 08:09:48 INFO - [mozharness: 2017-03-03 16:09:48.044961Z] Running clobber step. 08:09:48 INFO - Running pre-action listener: _resource_record_pre_action 08:09:48 INFO - Running main action method: clobber 08:09:48 INFO - rmtree: /builds/slave/test/build 08:09:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:50 INFO - Running post-action listener: _resource_record_post_action 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.068346Z] Finished clobber step (success) 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.068493Z] Running read-buildbot-config step. 08:09:50 INFO - Running pre-action listener: _resource_record_pre_action 08:09:50 INFO - Running main action method: read_buildbot_config 08:09:50 INFO - Using buildbot properties: 08:09:50 INFO - { 08:09:50 INFO - "project": "", 08:09:50 INFO - "product": "firefox", 08:09:50 INFO - "script_repo_revision": "production", 08:09:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:09:50 INFO - "repository": "", 08:09:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:09:50 INFO - "buildid": "20170303070751", 08:09:50 INFO - "pgo_build": "False", 08:09:50 INFO - "basedir": "/builds/slave/test", 08:09:50 INFO - "buildnumber": 1, 08:09:50 INFO - "slavename": "t-yosemite-r7-0301", 08:09:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:09:50 INFO - "platform": "yosemite_r7", 08:09:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:09:50 INFO - "branch": "mozilla-aurora", 08:09:50 INFO - "repo_path": "releases/mozilla-aurora", 08:09:50 INFO - "revision": "d9d91d6e389ef19bd48eb5153c9e32a122a1eecc", 08:09:50 INFO - "stage_platform": "macosx64", 08:09:50 INFO - "builduid": "b04c11619b59477ba36ae4c31c0c7d40", 08:09:50 INFO - "slavebuilddir": "test" 08:09:50 INFO - } 08:09:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:09:50 INFO - Running post-action listener: _resource_record_post_action 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.072653Z] Finished read-buildbot-config step (success) 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.072763Z] Running download-and-extract step. 08:09:50 INFO - Running pre-action listener: _resource_record_pre_action 08:09:50 INFO - Running main action method: download_and_extract 08:09:50 INFO - mkdir: /builds/slave/test/build/tests 08:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:50 INFO - trying https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:09:50 INFO - Downloading https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/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 08:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/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 08:09:51 INFO - Downloaded 1199 bytes. 08:09:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:09:51 INFO - Using the following test package requirements: 08:09:51 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:09:51 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:09:51 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:09:51 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'jsshell-mac.zip'], 08:09:51 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:09:51 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:09:51 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:09:51 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:09:51 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:09:51 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:09:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:09:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:09:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:09:51 INFO - Fetch https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:09:52 INFO - Expected file size: 16357779 08:09:52 INFO - Obtained file size: 16357779 08:09:59 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 08:09:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:09:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:09:59 INFO - Fetch https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:10:00 INFO - Expected file size: 16357779 08:10:00 INFO - Obtained file size: 16357779 08:10:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:10:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:10:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:10:07 INFO - Expected file size: 14403650 08:10:07 INFO - Obtained file size: 14403650 08:10:07 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')]} 08:10:07 INFO - trying https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:07 INFO - Downloading https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/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 08:10:09 INFO - Downloaded 73905780 bytes. 08:10:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:09 INFO - mkdir: /builds/slave/test/properties 08:10:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:09 INFO - Contents: 08:10:09 INFO - build_url:https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:10 INFO - Running post-action listener: _resource_record_post_action 08:10:10 INFO - Running post-action listener: set_extra_try_arguments 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.427927Z] Finished download-and-extract step (success) 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.428027Z] Running populate-webroot step. 08:10:10 INFO - Running pre-action listener: _resource_record_pre_action 08:10:10 INFO - Running main action method: populate_webroot 08:10:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:10 INFO - '--tppagecycles', 08:10:10 INFO - '7'], 08:10:10 INFO - 'tests': ['tsvgm']}}, 08:10:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['damp', 'tps']}, 08:10:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'tests': ['damp', 'tps']}, 08:10:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['dromaeo_dom']}, 08:10:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['basic_compositor_video']}, 08:10:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tsvgx', 08:10:10 INFO - 'tsvgr_opacity', 08:10:10 INFO - 'tart', 08:10:10 INFO - 'tscrollx', 08:10:10 INFO - 'cart', 08:10:10 INFO - 'tsvg_static']}, 08:10:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:10 INFO - 'tsvgr_opacity', 08:10:10 INFO - 'tart', 08:10:10 INFO - 'tscrollx', 08:10:10 INFO - 'cart', 08:10:10 INFO - 'tsvg_static']}, 08:10:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tp5o']}, 08:10:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:10:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s', 08:10:10 INFO - '--xperf_path', 08:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:10 INFO - 'tests': ['tp5n']}, 08:10:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--xperf_path', 08:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:10 INFO - 'tests': ['tp5n']}}, 08:10:10 INFO - 'talos.zip': {'path': '', 08:10:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:10 INFO - Running post-action listener: _resource_record_post_action 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.446176Z] Finished populate-webroot step (success) 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.446305Z] Running create-virtualenv step. 08:10:10 INFO - Running pre-action listener: _resource_record_pre_action 08:10:10 INFO - Running main action method: create_virtualenv 08:10:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:10 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 08:10:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:10 INFO - Using real prefix '/tools/python27' 08:10:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:14 INFO - Installing pip.................done. 08:10:14 INFO - Return code: 0 08:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:10:14 INFO - Reading from file tmpfile_stdout 08:10:14 INFO - Output received: 08:10:14 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) 08:10:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:14 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 08:10:14 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 08:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:14 INFO - 'HOME': '/Users/cltbld', 08:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:14 INFO - 'LOGNAME': 'cltbld', 08:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:14 INFO - 'MOZ_NO_REMOTE': '1', 08:10:14 INFO - 'NO_EM_RESTART': '1', 08:10:14 INFO - 'PAGER': '/bin/cat', 08:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:14 INFO - 'PWD': '/builds/slave/test', 08:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:14 INFO - 'SHELL': '/bin/bash', 08:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:14 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:14 INFO - 'USER': 'cltbld', 08:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:14 INFO - 'XPC_FLAGS': '0x0', 08:10:14 INFO - 'XPC_SERVICE_NAME': '0', 08:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:14 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 08:10:14 INFO - Cleaning up... 08:10:14 INFO - Return code: 0 08:10:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:14 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 08:10:14 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 08:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:14 INFO - 'HOME': '/Users/cltbld', 08:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:14 INFO - 'LOGNAME': 'cltbld', 08:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:14 INFO - 'MOZ_NO_REMOTE': '1', 08:10:14 INFO - 'NO_EM_RESTART': '1', 08:10:14 INFO - 'PAGER': '/bin/cat', 08:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:14 INFO - 'PWD': '/builds/slave/test', 08:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:14 INFO - 'SHELL': '/bin/bash', 08:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:14 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:14 INFO - 'USER': 'cltbld', 08:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:14 INFO - 'XPC_FLAGS': '0x0', 08:10:14 INFO - 'XPC_SERVICE_NAME': '0', 08:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:14 INFO - Downloading/unpacking psutil>=3.1.1 08: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 08: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 08: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 08: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 08: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 08: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 08:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:19 INFO - Installing collected packages: psutil 08:10:19 INFO - Running setup.py install for psutil 08:10:19 INFO - building 'psutil._psutil_osx' extension 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 INFO - building 'psutil._psutil_posix' extension 08:10:19 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 08:10:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:10:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:10:19 INFO - ^ 08:10:19 INFO - 1 warning generated. 08:10:19 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 08:10:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:19 INFO - Successfully installed psutil 08:10:19 INFO - Cleaning up... 08:10:20 INFO - Return code: 0 08:10:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:20 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')]} 08:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:20 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')]} 08:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:20 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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:20 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 08:10:20 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 08:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:20 INFO - 'HOME': '/Users/cltbld', 08:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:20 INFO - 'LOGNAME': 'cltbld', 08:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:20 INFO - 'MOZ_NO_REMOTE': '1', 08:10:20 INFO - 'NO_EM_RESTART': '1', 08:10:20 INFO - 'PAGER': '/bin/cat', 08:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:20 INFO - 'PWD': '/builds/slave/test', 08:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:20 INFO - 'SHELL': '/bin/bash', 08:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:20 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:20 INFO - 'USER': 'cltbld', 08:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:20 INFO - 'XPC_FLAGS': '0x0', 08:10:20 INFO - 'XPC_SERVICE_NAME': '0', 08:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:23 INFO - Installing collected packages: mozsystemmonitor 08:10:23 INFO - Running setup.py install for mozsystemmonitor 08:10:23 INFO - Successfully installed mozsystemmonitor 08:10:23 INFO - Cleaning up... 08:10:23 INFO - Return code: 0 08:10:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:23 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')]} 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:23 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')]} 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:23 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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:23 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 08:10:23 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 08:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:23 INFO - 'HOME': '/Users/cltbld', 08:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:23 INFO - 'LOGNAME': 'cltbld', 08:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:23 INFO - 'MOZ_NO_REMOTE': '1', 08:10:23 INFO - 'NO_EM_RESTART': '1', 08:10:23 INFO - 'PAGER': '/bin/cat', 08:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:23 INFO - 'PWD': '/builds/slave/test', 08:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:23 INFO - 'SHELL': '/bin/bash', 08:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:23 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:23 INFO - 'USER': 'cltbld', 08:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:23 INFO - 'XPC_FLAGS': '0x0', 08:10:23 INFO - 'XPC_SERVICE_NAME': '0', 08:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08: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 08: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 08: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 08: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 08: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 08: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 08:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:26 INFO - warning: no files found matching '*.txt' 08:10:26 INFO - no previously-included directories found matching 'build' 08:10:26 INFO - no previously-included directories found matching 'dist' 08:10:26 INFO - no previously-included directories found matching '.git*' 08:10:26 INFO - Installing collected packages: jsonschema, functools32 08:10:26 INFO - Running setup.py install for functools32 08:10:26 INFO - warning: no files found matching '*.txt' 08:10:26 INFO - no previously-included directories found matching 'build' 08:10:26 INFO - no previously-included directories found matching 'dist' 08:10:26 INFO - no previously-included directories found matching '.git*' 08:10:26 INFO - Successfully installed jsonschema functools32 08:10:26 INFO - Cleaning up... 08:10:27 INFO - Return code: 0 08:10:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:27 INFO - 'HOME': '/Users/cltbld', 08:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:27 INFO - 'LOGNAME': 'cltbld', 08:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:27 INFO - 'MOZ_NO_REMOTE': '1', 08:10:27 INFO - 'NO_EM_RESTART': '1', 08:10:27 INFO - 'PAGER': '/bin/cat', 08:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:27 INFO - 'PWD': '/builds/slave/test', 08:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:27 INFO - 'SHELL': '/bin/bash', 08:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:27 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:27 INFO - 'USER': 'cltbld', 08:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:27 INFO - 'XPC_FLAGS': '0x0', 08:10:27 INFO - 'XPC_SERVICE_NAME': '0', 08:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:10:27 INFO - Cleaning up... 08:10:27 INFO - Return code: 0 08:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:27 INFO - 'HOME': '/Users/cltbld', 08:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:27 INFO - 'LOGNAME': 'cltbld', 08:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:27 INFO - 'MOZ_NO_REMOTE': '1', 08:10:27 INFO - 'NO_EM_RESTART': '1', 08:10:27 INFO - 'PAGER': '/bin/cat', 08:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:27 INFO - 'PWD': '/builds/slave/test', 08:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:27 INFO - 'SHELL': '/bin/bash', 08:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:27 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:27 INFO - 'USER': 'cltbld', 08:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:27 INFO - 'XPC_FLAGS': '0x0', 08:10:27 INFO - 'XPC_SERVICE_NAME': '0', 08:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:27 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 08:10:27 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 08:10:27 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 08:10:27 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 08:10:27 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 08:10:27 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 08:10:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:31 INFO - Downloading docopt-0.6.1.tar.gz 08:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:31 INFO - Running setup.py install for blobuploader 08:10:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:31 INFO - Running setup.py install for requests 08:10:32 INFO - Running setup.py install for docopt 08:10:32 INFO - Successfully installed blobuploader requests docopt 08:10:32 INFO - Cleaning up... 08:10:32 INFO - Return code: 0 08:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:32 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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:32 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 08:10:32 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 08:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:32 INFO - 'HOME': '/Users/cltbld', 08:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:32 INFO - 'LOGNAME': 'cltbld', 08:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:32 INFO - 'MOZ_NO_REMOTE': '1', 08:10:32 INFO - 'NO_EM_RESTART': '1', 08:10:32 INFO - 'PAGER': '/bin/cat', 08:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:32 INFO - 'PWD': '/builds/slave/test', 08:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:32 INFO - 'SHELL': '/bin/bash', 08:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:32 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:32 INFO - 'USER': 'cltbld', 08:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:32 INFO - 'XPC_FLAGS': '0x0', 08:10:32 INFO - 'XPC_SERVICE_NAME': '0', 08:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-W_zhly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-pJ5kgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:32 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-O8IwsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-DkUvjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-dUc0Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-DimTjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-wc7cq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-hwHduj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-HsxA75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Uxryay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-o6w9o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-B9duCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:33 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Q2qAAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:34 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-CTgQ1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:34 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-9sUOiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:34 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-R3cZVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:34 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-M4LS3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:34 INFO - Running setup.py install for manifestparser 08:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:34 INFO - Running setup.py install for mozcrash 08:10:34 INFO - Running setup.py install for mozdebug 08:10:34 INFO - Running setup.py install for mozdevice 08:10:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozfile 08:10:35 INFO - Running setup.py install for mozhttpd 08:10:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozinfo 08:10:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozInstall 08:10:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozleak 08:10:35 INFO - Running setup.py install for mozlog 08:10:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for moznetwork 08:10:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for mozprocess 08:10:36 INFO - Running setup.py install for mozprofile 08:10:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for mozrunner 08:10:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for mozscreenshot 08:10:36 INFO - Running setup.py install for moztest 08:10:36 INFO - Running setup.py install for mozversion 08:10:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:37 INFO - Cleaning up... 08:10:37 INFO - Return code: 0 08:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:37 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')]} 08:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:37 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')]} 08:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:37 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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08:10:37 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 08:10:37 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 08:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:37 INFO - 'HOME': '/Users/cltbld', 08:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:37 INFO - 'LOGNAME': 'cltbld', 08:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:37 INFO - 'MOZ_NO_REMOTE': '1', 08:10:37 INFO - 'NO_EM_RESTART': '1', 08:10:37 INFO - 'PAGER': '/bin/cat', 08:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:37 INFO - 'PWD': '/builds/slave/test', 08:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:37 INFO - 'SHELL': '/bin/bash', 08:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:37 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:37 INFO - 'USER': 'cltbld', 08:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:37 INFO - 'XPC_FLAGS': '0x0', 08:10:37 INFO - 'XPC_SERVICE_NAME': '0', 08:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-PyTIx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-vxkwLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-4ihJPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-ObfTkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-TDGN3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:37 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-DUV4P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-egQ06a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-LcN84H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-uKG1N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-3OY06E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-Dw5PvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-7TQKlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-wY_3oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-y6LFTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:38 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-dKBPqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:39 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)) 08:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:39 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-KdOQo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:39 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)) 08:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:39 INFO - Running setup.py (path:/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/pip-t_jnWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:41 INFO - Downloading blessings-1.6.tar.gz 08:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:41 INFO - Installing collected packages: blessings 08:10:41 INFO - Running setup.py install for blessings 08:10:42 INFO - Successfully installed blessings 08:10:42 INFO - Cleaning up... 08:10:42 INFO - Return code: 0 08:10:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:42 INFO - Reading from file tmpfile_stdout 08:10:42 INFO - Current package versions: 08:10:42 INFO - blessings == 1.6 08:10:42 INFO - blobuploader == 1.2.4 08:10:42 INFO - docopt == 0.6.1 08:10:42 INFO - functools32 == 3.2.3-2 08:10:42 INFO - jsonschema == 2.5.1 08:10:42 INFO - manifestparser == 1.1 08:10:42 INFO - mozInstall == 1.12 08:10:42 INFO - mozcrash == 1.0 08:10:42 INFO - mozdebug == 0.1 08:10:42 INFO - mozdevice == 0.49 08:10:42 INFO - mozfile == 1.2 08:10:42 INFO - mozhttpd == 0.7 08:10:42 INFO - mozinfo == 0.9 08:10:42 INFO - mozleak == 0.1 08:10:42 INFO - mozlog == 3.4 08:10:42 INFO - moznetwork == 0.27 08:10:42 INFO - mozprocess == 0.24 08:10:42 INFO - mozprofile == 0.28 08:10:42 INFO - mozrunner == 6.13 08:10:42 INFO - mozscreenshot == 0.1 08:10:42 INFO - mozsystemmonitor == 0.3 08:10:42 INFO - moztest == 0.8 08:10:42 INFO - mozversion == 1.4 08:10:42 INFO - psutil == 3.1.1 08:10:42 INFO - requests == 1.2.3 08:10:42 INFO - wsgiref == 0.1.2 08:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08: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 08: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 08:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:42 INFO - 'HOME': '/Users/cltbld', 08:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:42 INFO - 'LOGNAME': 'cltbld', 08:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:42 INFO - 'MOZ_NO_REMOTE': '1', 08:10:42 INFO - 'NO_EM_RESTART': '1', 08:10:42 INFO - 'PAGER': '/bin/cat', 08:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:42 INFO - 'PWD': '/builds/slave/test', 08:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:42 INFO - 'SHELL': '/bin/bash', 08:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:42 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:42 INFO - 'USER': 'cltbld', 08:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:42 INFO - 'XPC_FLAGS': '0x0', 08:10:42 INFO - 'XPC_SERVICE_NAME': '0', 08:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08: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)) 08:10:42 INFO - Cleaning up... 08:10:42 INFO - Return code: 0 08:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08: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')]} 08:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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 0x101b96b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b99768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0224b9e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, '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.0MPkxstwpK/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.xnvXO2Cywy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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 08: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 08: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 08:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:42 INFO - 'HOME': '/Users/cltbld', 08:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:42 INFO - 'LOGNAME': 'cltbld', 08:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:42 INFO - 'MOZ_NO_REMOTE': '1', 08:10:42 INFO - 'NO_EM_RESTART': '1', 08:10:42 INFO - 'PAGER': '/bin/cat', 08:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:42 INFO - 'PWD': '/builds/slave/test', 08:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:42 INFO - 'SHELL': '/bin/bash', 08:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:10:42 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:42 INFO - 'USER': 'cltbld', 08:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:42 INFO - 'XPC_FLAGS': '0x0', 08:10:42 INFO - 'XPC_SERVICE_NAME': '0', 08:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:10:43 INFO - Cleaning up... 08:10:43 INFO - Return code: 0 08:10:43 INFO - Running post-action listener: _resource_record_post_action 08:10:43 INFO - Running post-action listener: _start_resource_monitoring 08:10:43 INFO - Starting resource monitoring. 08:10:43 INFO - [mozharness: 2017-03-03 16:10:43.099229Z] Finished create-virtualenv step (success) 08:10:43 INFO - [mozharness: 2017-03-03 16:10:43.100228Z] Running install step. 08:10:43 INFO - Running pre-action listener: _resource_record_pre_action 08:10:43 INFO - Running main action method: install 08:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:43 INFO - Reading from file tmpfile_stdout 08:10:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:43 INFO - Reading from file tmpfile_stdout 08:10:43 INFO - Output received: 08:10:43 INFO - Usage: mozinstall [options] installer 08:10:43 INFO - Options: 08:10:43 INFO - -h, --help show this help message and exit 08:10:43 INFO - -d DEST, --destination=DEST 08:10:43 INFO - Directory to install application into. [default: 08:10:43 INFO - "/builds/slave/test"] 08:10:43 INFO - --app=APP Application being installed. [default: firefox] 08:10:43 INFO - mkdir: /builds/slave/test/build/application 08:10:43 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'] 08:10:43 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 08:11:03 INFO - Reading from file tmpfile_stdout 08:11:03 INFO - Output received: 08:11:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:11:03 INFO - Running post-action listener: _resource_record_post_action 08:11:03 INFO - [mozharness: 2017-03-03 16:11:03.367125Z] Finished install step (success) 08:11:03 INFO - [mozharness: 2017-03-03 16:11:03.367257Z] Running run-tests step. 08:11:03 INFO - Running pre-action listener: _resource_record_pre_action 08:11:03 INFO - Running main action method: run_tests 08:11:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:03 INFO - 2017-03-03 08:11:03.382 screenresolution[7347:155902] starting screenresolution argv=screenresolution get 08:11:03 INFO - 2017-03-03 08:11:03.384 screenresolution[7347:155902] Display 0: 1600x1200x32@60 08:11:03 INFO - 2017-03-03 08:11:03.390 screenresolution[7348:155905] starting screenresolution argv=screenresolution list 08:11:03 INFO - Available Modes on Display 0 08:11:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:03 INFO - Intel Iris: 08:11:03 INFO - Chipset Model: Intel Iris 08:11:03 INFO - Type: GPU 08:11:03 INFO - Bus: Built-In 08:11:03 INFO - VRAM (Dynamic, Max): 1536 MB 08:11:03 INFO - Vendor: Intel (0x8086) 08:11:03 INFO - Device ID: 0x0a2e 08:11:03 INFO - Revision ID: 0x0009 08:11:03 INFO - Displays: 08:11:03 INFO - Display: 08:11:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:03 INFO - Display Serial Number: 1600x1200 60 08:11:03 INFO - Main Display: Yes 08:11:03 INFO - Mirror: Off 08:11:03 INFO - Online: Yes 08:11:03 INFO - Rotation: Supported 08:11:03 INFO - Return code: 0 08:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:03 INFO - Python 2.7.3 08:11:03 INFO - Return code: 0 08:11:03 INFO - grabbing minidump binary from tooltool 08:11:03 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')]} 08:11:03 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 0x101974d30>, '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 0x10189bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101969be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:03 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 08:11:03 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 08:11:03 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 08:11:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:03 INFO - Return code: 0 08:11:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:11:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:11:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08: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/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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 08: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/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0301 --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 08:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0MPkxstwpK/Render', 08:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:03 INFO - 'HOME': '/Users/cltbld', 08:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:03 INFO - 'LOGNAME': 'cltbld', 08:11:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:03 INFO - 'MOZ_NO_REMOTE': '1', 08:11:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:03 INFO - 'NO_EM_RESTART': '1', 08:11:03 INFO - 'PAGER': '/bin/cat', 08: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', 08:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:03 INFO - 'PWD': '/builds/slave/test', 08:11:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:03 INFO - 'SHELL': '/bin/bash', 08:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnvXO2Cywy/Listeners', 08:11:03 INFO - 'TMPDIR': '/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/', 08:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:03 INFO - 'USER': 'cltbld', 08:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:03 INFO - 'XPC_FLAGS': '0x0', 08:11:03 INFO - 'XPC_SERVICE_NAME': '0', 08:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08: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/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0301', '--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 08:11:03 INFO - mozversion application_buildid: 20170303070751 08:11:03 INFO - mozversion application_changeset: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc 08:11:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:11:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:03 INFO - mozversion application_name: Firefox 08:11:03 INFO - mozversion application_remotingname: firefox-dev 08:11:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:11:03 INFO - mozversion application_vendor: Mozilla 08:11:03 INFO - mozversion application_version: 53.0a2 08:11:03 INFO - mozversion platform_buildid: 20170303070751 08:11:03 INFO - mozversion platform_changeset: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc 08:11:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:11:03 INFO - mozversion platform_version: 53.0a2 08:11:03 INFO - using testdate: 1488557463 08:11:03 INFO - actual date: 1488557463 08:11:03 INFO - starting webserver on 'localhost:58834' 08:11:03 INFO - SUITE-START | Running 2 tests 08:11:03 INFO - TEST-START | dromaeo_css 08:11:03 INFO - operating with platform_type : mac_ 08:11:03 INFO - Initialising browser for dromaeo_css test... 08:11:03 INFO - TEST-INFO | started process 7358 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpb0mQ9Z/profile http://localhost:58834/getInfo.html) 08:11:06 INFO - PROCESS | 7358 | __metrics Screen width/height:1600/1200 08:11:06 INFO - PROCESS | 7358 | colorDepth:24 08:11:06 INFO - PROCESS | 7358 | Browser inner width/height: 1024/689 08:11:06 INFO - PROCESS | 7358 | __metrics 08:11:06 INFO - PROCESS | 7358 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:11:06 INFO - PROCESS | 7358 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:07 INFO - TEST-INFO | 7358: exit 0 08:11:07 INFO - Browser initialized. 08:11:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:07 INFO - TEST-INFO | started process 7360 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmpb0mQ9Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:19 INFO - PROCESS | 7360 | RSS: Main: 213417984 08:11:19 INFO - PROCESS | 7360 | 08:14:22 INFO - PROCESS | 7360 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58834/tests/dromaeo/cssquery-ext.html) 08:14:23 INFO - PROCESS | 7360 | RSS: Main: 335937536 08:14:23 INFO - PROCESS | 7360 | 08:16:08 INFO - PROCESS | 7360 | ************************* 08:16:08 INFO - PROCESS | 7360 | A coding exception was thrown and uncaught in a Task. 08:16:08 INFO - PROCESS | 7360 | 08:16:08 ERROR - PROCESS | 7360 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:16:08 INFO - PROCESS | 7360 | Full stack: 08:16:08 INFO - PROCESS | 7360 | ************************* 08:17:26 INFO - PROCESS | 7360 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-ext.html (next: http://localhost:58834/tests/dromaeo/cssquery-jquery.html) 08:17:27 INFO - PROCESS | 7360 | RSS: Main: 355852288 08:17:27 INFO - PROCESS | 7360 | 08:20:29 INFO - PROCESS | 7360 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58834/tests/dromaeo/cssquery-mootools.html) 08:20:30 INFO - PROCESS | 7360 | RSS: Main: 317571072 08:20:30 INFO - PROCESS | 7360 | 08:23:32 INFO - PROCESS | 7360 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58834/tests/dromaeo/cssquery-prototype.html) 08:23:33 INFO - PROCESS | 7360 | RSS: Main: 325263360 08:23:33 INFO - PROCESS | 7360 | 08:26:36 INFO - PROCESS | 7360 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58834/tests/dromaeo/cssquery-yui.html) 08:26:37 INFO - PROCESS | 7360 | RSS: Main: 311312384 08:26:37 INFO - PROCESS | 7360 | 08:29:40 INFO - PROCESS | 7360 | Cycle 1(1): loaded http://localhost:58834/tests/dromaeo/cssquery-yui.html (next: http://localhost:58834/tests/dromaeo/cssquery-dojo.html) 08:29:40 INFO - PROCESS | 7360 | RSS: Main: 386711552 08:29:40 INFO - PROCESS | 7360 | 08:29:40 INFO - PROCESS | 7360 | __start_tp_report 08:29:40 INFO - PROCESS | 7360 | _x_x_mozilla_page_load 08:29:40 INFO - PROCESS | 7360 | _x_x_mozilla_page_load_details 08:29:40 INFO - PROCESS | 7360 | |i|pagename|runs| 08:29:40 INFO - PROCESS | 7360 | |0;dojo.html;3246.2209069823243;3252.1706964724;3285.507173923911;3308.7022168004873;3347;5619.241402410678;5635.436456354368;5673.659580425177;5693.459121383467;5698.857528561788;5570.2480165177685;5628.746706398211;5679.488846003859;5697;5747.080467125261;5130.256112863642;5168.715720635363;5201.349831271091;5224.791008359661;5251.76367063483;5108.48915108488;5124.052050370693;5126.820561280356;5139.665921715076;5323.467653234665;5141.948580514184;5182.222666600002;5230.189320655286;5241.633085683985;5258.6581872178185;5214.983078299752;5220.556252718486;5222.321098257221;5237.6071794615555;5261.973690131525;4099.549049604541;5092.465291144414;5175.301334319894;5176.870578235536;5179.119549676564;4177.603127702863;5600.215969764236;5602.24369710088;5642.887142257173;5698.572607054488;6142.447179753799;6182.227221597301;6184.659843708594;6191.040388739752;6212.782552610682;5172.741362931838;5695.34503532095;6234;6258;6276.184096067527;5488.4237155098135;5542.39033706292;5674.716264186774;5810.186573879702;5833.212516310286;6140.938590614126;6154.261488621394;6160.168377269011;6166.075088736726;6167.013277875519;5776.855578610568;5790.276215473066;5794.420557944172;5800.9129863052085;5825.912611310834;5887.5289976802605;5948.375420580864;5969.074793407029;6103.542234332443;6118.385025140603;6113.841195312599;6117.541184411098;6162.075688646739;6192.845178870564;6228.314885362606;6240.469560087444;6243.313235544178;6252.624842509464;6255.78104766331;6257.9687101564205;4812.109759694467;4988.825391111366;4999.275105109738;5007.899842003139;5034.194528875362;4261.382099595541;4376.452943382077;4386.846460373871;4461.977690111594;4507.5943165115295;5768.74040668171;5774.249347584871;5778.017736984722;5780.913286300624;5784.074548072288;6111.865232675468;6124.234470691164;6142.498775697809;6199.504039676905;6216.813495595139;5736.971315143481;5785.132230165509;5791.449812267828;5835.212246346774;5860.150278209636;5380.811671591476;5410.729463526808;5414.7021913795115;5417.864553386197;5437.755301011464;6119.472088496418;6296.212973378328;6305;6307.463865571478;6315.652639104802;6103.298120715996;6111.602745821508;6142.938570614237;6165.568410211242;6214.689265536615;6234.844128896814;6247.96876015617;6252.968735156477;6257.7184026718;6259.186305780401;6133.202683651097;6177.320494745484;6182.258129024546;6199;6199.411055949858;6123.648682309606;6124.785632502841;6129.358790882775;6140.964409184426;6175.505959523138;6003.90994135097;6023.397660233942;6027.969860150672;6057.273127224761;6077.939220607737;4609.700369476108;5984.072468767348;6005.489533389711;6029.638221706711;6031.638101713911;5707.571932105026;5856.824295271149;5866.325372582037;5935.169076329404;5976.820695379146;5010.348654675015;6103.7558497661375;6107.877842443215;6118.357572454828;6129.877402452015;5949.881002380015;5970;5970.58205925581;5970.641761494324;5974.551908606959 08:29:41 INFO - PROCESS | 7360 | |1;ext.html;477.3102866358114;493.555799780198;494.132796941368;504.27888119988427;510.5558164396974;28087.719122808765;32778.50832237516;32782;40084.19831603366;42683;44441.777791111;45024;45123.32315015269;45151.0969780605;45155.87110322244;9086.95456522718;9272.536373181347;9304.395214311047;9312.30157738169;9315.115064068903;8501.447405918596;8706.390552661316;9422;9562.091601297865;9584.424934503952;11384.829227561593;11670.94961453469;11699.883001170007;11848.407579621027;11878.821817672742;11511.539538418454;11537.884621153766;11606;11636.069114470822;11643.883561164364;8432.241098301183;8621.31029517637;11011.504482298236;11385;11483.770324593545;40249.59750402488;42517.36223956643;42518.93702657428;42558.57441425608;42618.934526636775;3940.271049855786;3950.348192548226;3963.663088637469;3983.5618082010956;4044.4539987101657;28437.00470483544;30308.54537181944;30998.690013099807;31481.842590787128;32278.677213227802;2903.8094381303777;3109.657937626859;3150.716435520791;3192.8563214655396;3226.58054452922;376232.99999999726;377483;382706;382907;383089;65866.67066664732;66077.33922660808;66415;66452.6709465808;66489.00266496006;70169;70203.94694079593;70276;70367;70608.94086588705;16378.426755063516;17017.91491042537;17040.744388834177;17062.74405883913;17063.744043839353;13011.414486347947;13079.934600326937;13097.017723670762;13122.212667239995;13149.342532873317;15803.525894223192;16142.515724528283;16180.43368482121;17919.641607167785;18363.888152862324;6759.864802703918;6912.032315475837;7462.403007759366;7517.285857843496;7601.923980760233;866.2074202105003;885.6538062145503;896.9192772650492;900.1628485508539;923.007766650853;29242.85378573136;29617.25956851053;30503.627336769456;30621.46892655403;31534.36931261408;1074.8011617850723;1076.2304951959386;1079.3092420850662;1081.464674985887;1203.1397550751255;15474.458393956158;15950.840491594936;15975.440859570092;16028.839711602735;16273.674526509403;606156;606709.9329006742;610609;612043;612197;60498.395016050155;60662.69668651628;61030.69484652548;61074.64089475122;61246.38753612496;1264.2919964819546;1422.267532220907;1424.1526291856328;1460.0436713952379;1466.5453709350136;26058.087966921066;28750.7124928748;29292.70707292985;29517.557236641896;30786.69213307928;52586.737066314425;53125;53127.468725312254;53127.734361327944;53278;587649;593414;594353;594904;595989;21118.155273788878;25136.62295065539;25460.363490912874;25477.490450191264;25532.23403297904;43553.12893742171;43693;44220;45008.549914500436;46099.84750381267;34473.827630861684;36435.635643643225;36497.63502365049;37006.88979330625;37736.62263377331;36063;36318.91043268706;37143.814280928425;37560.624393755716;37604.81197593995;35077.47383789194;35865.64134358623;36037;36323.81838090793;36754;30692.846535767178;32763.180920477178;32934;32970;33010.33979320352;23890.761092388853;24326.51346973086;24546.631800523362;24622.630660539748;24667.38331541654 08:29:41 INFO - PROCESS | 7360 | |2;jquery.html;364.9361361761691;390.35786131813165;390.74015779506647;401.6264873667489;426.7716771527233;13899.513517026906;15045.849541504582;18555.907220463894;21032.8948355258;21691.240806571772;21786.89106554465;21841.453963650918;22386.776132238672;22725.772742272573;22749.203777867777;5553.666779993193;5686.658800471985;5687.090065589507;5778.653280803165;5804.390538993387;4120.443740095094;4336.804843782022;5686;5803.796867109652;5813.244278243822;6076.179715738363;6357;6383.585066970655;6389.105525226449;6426.903596446057;6233.906491402588;6352.809415717536;6354.17395738551;6400.679966001728;6411.8397040073905;5633.887322253573;5644.322681278273;5650.463205995424;5653.067243904751;5657.264555607786;26295.474090518273;27149.185524434102;27261.318467038283;27274.318142046606;27374.17877463679;2721.5237333466566;2738.589211618253;2741.7121202273875;2745.3548416122194;2752.6008728734223;7683.692652293901;11080.670319561705;15623.921880390639;16149.434769783002;16680.916595417068;1544.2201688147527;1806.2594336322177;1856.1623396001273;1867.962640747191;1869.8223668751448;125132.37433812863;127239;127924.36037819751;131070.3446482771;131353;7950.4832185907735;10385.740356491147;10470.267081304388;10511.421871796972;10578.735531611772;12769.233845969271;12877.162984405984;12881.355932203352;12881.677958051123;12884.162529435744;6772.93227067723;8186.222308880647;8281.668733250723;8387.280607475454;8424.705135320235;8458.873116903129;8494.06565277819;8505.829883402297;8667.869981950276;8672.60973256205;3991.06210040646;4033.921162336251;4064.695147863863;4116.608922152391;4143.79281035953;1731.8181590933023;2000.5898790747863;2028.3407892435018;2040.6122836660986;2049.3134799841923;953.9332246742662;965.9668640468933;985.5023213277392;996.5848495136923;997.3915911294105;21414;21772;21954.121835126734;22009.779902201095;22061.00725467358;924.9917589827121;1013.4546558684295;1016.4155610523978;1026.4867566216892;1050.821360368739;10492.527836247387;11133.777324453466;11142.27575207609;11216.270942388719;11219.943900280447;702794;738957;749424;751846.2407687927;756140;145647.5435245634;149761;151203.24398378158;152569;169661;421.7069136949852;451.1405772004337;452.0574601954895;455.2533844495031;455.4580049740864;10709.357438553712;11032.28290161169;11184.993350598485;11205.271657342246;11406.20156589064;61747;62951.79668711573;63315.68342158444;63389.68305158445;64627;71055;88246.55876720576;89073.10926890648;89712.10287897037;91398.08601914161;7959.442839001446;8058.970514742628;8217.54803485814;8256.83486330258;8259.132791056853;12564.743525647362;12582.30797306157;12604.30676312775;12712.427940742873;13090.869091309345;10744.570217191538;10928.726781830517;10953.83569246446;11132.165087618623;11359.204855660024;10620.681379558626;10643.148548116287;10842.674719758419;10960.725981850517;11171.832422513506;9982.652341933746;11011.61459348919;11368.62308011405;11373.260738052;11375.943120284346;8042.03495580534;8230.300424463987;8363.581820908808;8519.872201916853;8559.871601925852;8326.45878017927;10780.353178809297;10830.945845270724;10919.890801091888;10954.671359859218 08:29:41 INFO - PROCESS | 7360 | |3;mootools.html;1439.4530078570142;1439.9352029158688;1462.122726364181;1466.3035058347286;1466.9193194374309;8001;8427.452215605981;8437.409381343308;8446.239838414542;8446.704365347214;7404.555726656405;7648.770536883889;7648.885266721004;7894.763157105282;8222.506649601028;2273.2043784675357;2312.167619656922;2315.4558678710573;2319.3969567912295;2325.2559181062065;2010.979890201094;2319.8840057997118;2341.3912382780513;2350.8471949323325;2360.8701521416315;2276.499170182557;2293.587154312223;2296.1045192374986;2334.9766502335015;2338.6608941703444;2281.863088214704;2300.654901764732;2307.088699963522;2313.1210140146804;2314.259436980167;2233.7096177496983;2335.3344296875307;2336.906523739048;2342.5666251743482;2344.5310937812505;8250.257476827115;8337.249647531751;8344.165583441669;8351.37364697644;8352.707655232098;4947.50524947506;5093.719845408501;5099.235114732783;5102.948970510284;5115.2071428928575;3076.50775875861;3284.2117891706057;3414.607320158189;3453.740969427303;3490.2321489272317;1141.5833220874322;1156.410230782307;1183.597576823884;1191.8927296543266;1225.136278923357;10577.576896924114;10704.625338113128;10711.143108551298;10715.08921741653;10726;3752.512173417438;4397.582229688174;4596.195665758546;4612.60792832613;4624.606908412756;9441.339106262632;9444.197243234403;9446.29152813528;9461.05389461062;9485.810283794286;5094.949050509447;5172.7155006475;5186.092433824066;5188.092083885381;5201.817936372209;3723.6276372362545;4208.242516347087;4664.930026049612;4710.6702530823195;4747.382840230748;3320.5351250824906;3826.827792749333;3882.2429626222615;3954.2882281189663;3987.8205480753436;1255.9246445213316;1269.4674125120443;1271.3389037700344;1283.165942137618;1283.3968035023524;890.283321925856;913.4639226382345;918.1644703319947;920.0845159066638;950.9809803803885;5538.695371754511;5666.546676265972;5770;5795.478406943395;6086.513078953673;885.9468431894107;952.9047095290554;959.5586030426082;981.2297346583041;997.9750506237257;3546.131197856542;3703.500027496307;3722.16251343451;3861.227754449121;3888.6111388861455;9547.665831695856;9643.758906027266;9697.563609637584;9955.55200016001;9956.352837065713;9565.569549370295;9709.126178643955;9819.459929703791;9823.607055717834;9842.409455432553;5985;7732.149463559004;7741.806454838674;7753.418493613001;7836.255555722198;5550.4727050931715;5656.462636049569;5706.629069110494;5832.183494310715;5838.182654428469;7812.1797211292;8413.663453462037;8654.264387527131;9252.444853308823;9319.534023298673;9081.77295567616;9256;9306.162445379949;9357.39176953496;9405.918319393357;6593.967030164818;6772.55978361405;6983.860322793414;7001.754938577125;7118.430525558047;7779.688812447439;7884.369250459835;7958.761237162895;7964.402669799904;7964.800879978047;6917.342852429011;7097.609631470319;7100.325469080429;7164.9641751793;7229.638518074181;6910.98539456561;6961.199462061928;6975.8256043597285;7062.046623705939;7096.183938847099;6339.524535659936;6341;6362.395572420613;6426.646534440651;6429.517786165963;4885.462599114024;4896.143174944442;4943;4943.728094954668;4957.801687932442;4664.533546645308;4890.119778439915;4920.31115643803;5049.116404629249;5059.569936555434 08:29:41 INFO - PROCESS | 7360 | |4;prototype.html;334.98492567834444;360.27404779369556;364.4420104055164;374.9175181460078;376.52745804015956;4149.585041495849;4285.978570107149;5274.367075950881;5380.435054319299;5385.515303622673;4533;5103.897922041557;5132.589392848563;5176.745603212742;5245.396779370373;3497.89506314811;3744.8876533704033;4143.689223308249;4145.6162706443765;4191.958080419203;4029.355303151496;4133.181400183925;4202.117555313388;4229.619334259916;4230.640395566381;4097.770668799363;4101.308822060155;4118.423420721101;4131.607497287753;4166.937495937564;3509.824508774551;4023.786917195531;4101.999999999985;4108.958910410887;4138.6482149017365;3500.2824420993634;3534.4168212245204;3552.2185119273718;3670.761400508985;3683.3001729671278;4824.6863953842885;5093.955739073481;5138.383393992707;5205.817796377147;5239.973800130975;3963.5243770747406;4727.361806156159;4736.4316282046375;4742.857714268577;4753.572178503917;5090.065775005512;5553.888922221573;5607.775688972436;5621.915671264935;5640.0823719935415;3487.1118702646622;3758.342290099222;3791.545014598238;3858.5562660294145;4019.974906398879;4866.51334866514;5755.22304488897;5805.970970145165;5822.679752613604;5835.44563266489;3268.607767067967;3282.917927051843;3554.360215161244;3666.871659491905;3846.9230615387537;3697.0387699197863;3747.662710356081;3881.3789793633446;3881.670058045098;3894.337962546374;3956.742811717229;4201.243776120266;4403.405540252025;4565.246734288805;4568.817247310137;4695.812167513262;4883.413990321184;5249.921251181236;5620.667423019483;5665.971670141623;1023.5036007536339;1168.9362679961193;1185.9466324015268;1216.8965637920699;1229.9262044277373;805.3557154276556;838.4172999765104;864.8529749942525;867.6746220167437;869.6130222051127;4989.775460104304;5053.519915608012;5063.772130254148;5070.797168113234;5104.464031276737;4974.925376119361;5434.83695489136;5452.372977107604;5468.91796623051;5524.392316845144;4257.808398622069;4837.87133661195;4895.559399654048;4992.675476094042;5010;2535.8858851351733;2644.008496813695;2756.338478765122;2774.7940387392073;2827.448647513756;5078.593712503065;5165.638405311667;5639.943600563942;5693.28833895763;5719.542436605062;4900.166971614834;5167.948320516747;5408.242321245611;5592.993261213021;5676.517496012885;4945.8346658139535;5302.398513850281;5545.750441230154;5669.914951275651;5728;4172.395002724648;4896.681715688469;5287.836675931289;5355.4376790436445;5488.69812160335;4874.5405146235025;5157.375426740565;5307.6284660073425;5405.486478784509;5416.7562459688625;4663.650226232979;5291.842649284414;5486.79290556077;5500.202470641814;5546.83673367379;3076.630804303498;3171.8255495947947;3567.250877315793;3620.2397496524973;3628.818559071983;4722.433308003062;5163.896722065613;5357.8392648220615;5434.592405569519;5447.1829225616475;4641.257398816173;4721.22099853534;5172.861970366514;5273.78904843802;5317.787288508416;4647.65142614312;4682.2508398656055;4952.257161425815;5176.482351764794;5232.9738351308;4139.503259608866;4594.540545945379;5142.845714628567;5153.871153221199;5330.653507521999;5509.228707980806;5515.7865269640615;5520.558355331644;5522.199281104297;5536.335639723259;4777.0207107543565;5238.842834714965;5257.500537449089;5380;5468.343798744176 08:29:41 INFO - PROCESS | 7360 | |5;yui.html;668.3216535216754;712.7378277898168;713.464901324007;714.7105422303962;756.3873262657246;14285.285735713212;14808.334499790033;15241.085534867916;15251.771223431644;15262.465813696523;11763.647090587274;14273;14384.640383990405;14395.496157634485;14415.85584144161;662.7481557008355;833.3832963606933;849.6643825688849;851.948883067018;852.927501162402;681.6319187638694;690.9032735417046;820.3191351178508;834.8664213725805;848.855694531928;904.1184844776324;908.554808144008;908.7137551671202;910.3536489092752;910.7085732565581;747.2079595628651;897.9999999999967;898.5282726568538;900.2527901841456;903.0202230579829;520.0664806671995;535.5581645142772;539.1104677282476;539.7328322480397;541.7183064806318;14063;14661.973661843675;14678.192699401528;14950.177740224392;15009.949303548756;11553.826692599618;13968.301584920713;14030.95106627465;14051.929740351234;14150.646233844236;10996.505157267942;11137.721556961142;11163.776724465546;11585.36280504572;12061.939690301493;3631.479454780624;3676.4301533262387;3686.225892562565;3703.6851867591286;3714.3499887519574;92370.5381473095;95058.52470737603;95624;96272;96402.03597964;10622.521986510626;10802.459877006275;10830.566777328977;10871.402072886067;11447.656570302905;22066.66899996501;22480;22491.437714056952;22621.773782262295;22744.65883011756;7514.398848092249;7562;7575.924240757632;7704.537727736354;7865.606719663994;4098.221337945781;4165.958340416557;4270.636995855387;4345.652347812231;4373.671974601918;3392.881249156317;3478.565179352581;3502.439609662442;3519.9648003519637;3529.5588051493564;639.047818750059;642.3512252624882;667.3226674924955;702.9086218791626;706.0327351528439;658.4205898809017;659.66686823154;683.8016975077271;702.6205848841671;721.6608194148741;10061.664749970329;10146.340487868265;10160.542775575117;10343.172546196287;10524.210684198715;657.1719633262124;674.6660403100399;675.7702381190419;693.5630552751734;698.9580625162506;4411.338299255138;4725.337294219582;4981.452040275567;4983.750812459362;4993.275974983607;106582.46708766406;107276;108003;108051;109695;76069;76087;76812.61593691996;85317.72023419653;85778.14221857826;64348.356516434236;65766.55700611824;74971;77212;77803.99999999886;9434.433933963985;10374.740631484274;10560.788784224425;10796.406197659204;11061.668149955514;48857.755711221216;49875;50157.498425015285;50214;50434;61357.38642613695;61809.76380472456;62902.11293661197;63139.36860631335;63817;12269.69325766863;12313.753724925631;12591.24452532851;12662.493500259887;13030.08789384734;13905.513307034205;14146.363413646204;14167.787483187967;14394.640133996734;14424.711505769616;12799.744005120032;13167.407466663832;13299.335033248492;13379.862711669617;13823.585292441243;12705.872941270469;12868.935655321664;13157.88158006542;13349.132306400441;13394.598162055154;12748.936255318664;12965.675858103623;13111.40998655082;13260.07179497426;13690;10944.781104378028;11277.492512837107;11550.711232219262;11741.29552226869;11787.351695656822;10090.293679442662;10888.346699198073;10903.34579925207;10914.290571112851;10946.17903657213 08:29:41 INFO - PROCESS | 7360 | __end_tp_report 08:29:41 INFO - PROCESS | 7360 | __start_cc_report 08:29:41 INFO - PROCESS | 7360 | _x_x_mozilla_cycle_collect,1233 08:29:41 INFO - PROCESS | 7360 | __end_cc_report 08:29:41 INFO - PROCESS | 7360 | __startTimestamp1488558580994__endTimestamp 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | ------- Summary: start ------- 08:29:41 INFO - PROCESS | 7360 | Number of tests: 6 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | [#0] dojo.html Cycles:165 Average:5662.51 Median:5833.21 stddev:651.63 (11.2%) stddev-sans-first:625.45 08:29:41 INFO - PROCESS | 7360 | Values: 3246.2 3252.2 3285.5 3308.7 3347.0 5619.2 5635.4 5673.7 5693.5 5698.9 5570.2 5628.7 5679.5 5697.0 5747.1 5130.3 5168.7 5201.3 5224.8 5251.8 5108.5 5124.1 5126.8 5139.7 5323.5 5141.9 5182.2 5230.2 5241.6 5258.7 5215.0 5220.6 5222.3 5237.6 5262.0 4099.5 5092.5 5175.3 5176.9 5179.1 4177.6 5600.2 5602.2 5642.9 5698.6 6142.4 6182.2 6184.7 6191.0 6212.8 5172.7 5695.3 6234.0 6258.0 6276.2 5488.4 5542.4 5674.7 5810.2 5833.2 6140.9 6154.3 6160.2 6166.1 6167.0 5776.9 5790.3 5794.4 5800.9 5825.9 5887.5 5948.4 5969.1 6103.5 6118.4 6113.8 6117.5 6162.1 6192.8 6228.3 6240.5 6243.3 6252.6 6255.8 6258.0 4812.1 4988.8 4999.3 5007.9 5034.2 4261.4 4376.5 4386.8 4462.0 4507.6 5768.7 5774.2 5778.0 5780.9 5784.1 6111.9 6124.2 6142.5 6199.5 6216.8 5737.0 5785.1 5791.4 5835.2 5860.2 5380.8 5410.7 5414.7 5417.9 5437.8 6119.5 6296.2 6305.0 6307.5 6315.7 6103.3 6111.6 6142.9 6165.6 6214.7 6234.8 6248.0 6253.0 6257.7 6259.2 6133.2 6177.3 6182.3 6199.0 6199.4 6123.6 6124.8 6129.4 6141.0 6175.5 6003.9 6023.4 6028.0 6057.3 6077.9 4609.7 5984.1 6005.5 6029.6 6031.6 5707.6 5856.8 5866.3 5935.2 5976.8 5010.3 6103.8 6107.9 6118.4 6129.9 5949.9 5970.0 5970.6 5970.6 5974.6 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | [#1] ext.html Cycles:180 Average:67065.19 Median:36880.44 stddev:143758.45 (389.8%) stddev-sans-first:144074.80 08:29:41 INFO - PROCESS | 7360 | Values: 477.3 493.6 494.1 504.3 510.6 28087.7 32778.5 32782.0 40084.2 42683.0 44441.8 45024.0 45123.3 45151.1 45155.9 9087.0 9272.5 9304.4 9312.3 9315.1 8501.4 8706.4 9422.0 9562.1 9584.4 11384.8 11670.9 11699.9 11848.4 11878.8 11511.5 11537.9 11606.0 11636.1 11643.9 8432.2 8621.3 11011.5 11385.0 11483.8 40249.6 42517.4 42518.9 42558.6 42618.9 3940.3 3950.3 3963.7 3983.6 4044.5 28437.0 30308.5 30998.7 31481.8 32278.7 2903.8 3109.7 3150.7 3192.9 3226.6 376233.0 377483.0 382706.0 382907.0 383089.0 65866.7 66077.3 66415.0 66452.7 66489.0 70169.0 70203.9 70276.0 70367.0 70608.9 16378.4 17017.9 17040.7 17062.7 17063.7 13011.4 13079.9 13097.0 13122.2 13149.3 15803.5 16142.5 16180.4 17919.6 18363.9 6759.9 6912.0 7462.4 7517.3 7601.9 866.2 885.7 896.9 900.2 923.0 29242.9 29617.3 30503.6 30621.5 31534.4 1074.8 1076.2 1079.3 1081.5 1203.1 15474.5 15950.8 15975.4 16028.8 16273.7 606156.0 606709.9 610609.0 612043.0 612197.0 60498.4 60662.7 61030.7 61074.6 61246.4 1264.3 1422.3 1424.2 1460.0 1466.5 26058.1 28750.7 29292.7 29517.6 30786.7 52586.7 53125.0 53127.5 53127.7 53278.0 587649.0 593414.0 594353.0 594904.0 595989.0 21118.2 25136.6 25460.4 25477.5 25532.2 43553.1 43693.0 44220.0 45008.5 46099.8 34473.8 36435.6 36497.6 37006.9 37736.6 36063.0 36318.9 37143.8 37560.6 37604.8 35077.5 35865.6 36037.0 36323.8 36754.0 30692.8 32763.2 32934.0 32970.0 33010.3 23890.8 24326.5 24546.6 24622.6 24667.4 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | [#2] jquery.html Cycles:180 Average:40292.83 Median:15056.38 stddev:123361.96 (819.3%) stddev-sans-first:123671.59 08:29:41 INFO - PROCESS | 7360 | Values: 364.9 390.4 390.7 401.6 426.8 13899.5 15045.8 18555.9 21032.9 21691.2 21786.9 21841.5 22386.8 22725.8 22749.2 5553.7 5686.7 5687.1 5778.7 5804.4 4120.4 4336.8 5686.0 5803.8 5813.2 6076.2 6357.0 6383.6 6389.1 6426.9 6233.9 6352.8 6354.2 6400.7 6411.8 5633.9 5644.3 5650.5 5653.1 5657.3 26295.5 27149.2 27261.3 27274.3 27374.2 2721.5 2738.6 2741.7 2745.4 2752.6 7683.7 11080.7 15623.9 16149.4 16680.9 1544.2 1806.3 1856.2 1868.0 1869.8 125132.4 127239.0 127924.4 131070.3 131353.0 7950.5 10385.7 10470.3 10511.4 10578.7 12769.2 12877.2 12881.4 12881.7 12884.2 6772.9 8186.2 8281.7 8387.3 8424.7 8458.9 8494.1 8505.8 8667.9 8672.6 3991.1 4033.9 4064.7 4116.6 4143.8 1731.8 2000.6 2028.3 2040.6 2049.3 953.9 966.0 985.5 996.6 997.4 21414.0 21772.0 21954.1 22009.8 22061.0 925.0 1013.5 1016.4 1026.5 1050.8 10492.5 11133.8 11142.3 11216.3 11219.9 702794.0 738957.0 749424.0 751846.2 756140.0 145647.5 149761.0 151203.2 152569.0 169661.0 421.7 451.1 452.1 455.3 455.5 10709.4 11032.3 11185.0 11205.3 11406.2 61747.0 62951.8 63315.7 63389.7 64627.0 71055.0 88246.6 89073.1 89712.1 91398.1 7959.4 8059.0 8217.5 8256.8 8259.1 12564.7 12582.3 12604.3 12712.4 13090.9 10744.6 10928.7 10953.8 11132.2 11359.2 10620.7 10643.1 10842.7 10960.7 11171.8 9982.7 11011.6 11368.6 11373.3 11375.9 8042.0 8230.3 8363.6 8519.9 8559.9 8326.5 10780.4 10830.9 10919.9 10954.7 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | [#3] mootools.html Cycles:180 Average:5370.14 Median:5544.58 stddev:2905.23 (52.4%) stddev-sans-first:2898.36 08:29:41 INFO - PROCESS | 7360 | Values: 1439.5 1439.9 1462.1 1466.3 1466.9 8001.0 8427.5 8437.4 8446.2 8446.7 7404.6 7648.8 7648.9 7894.8 8222.5 2273.2 2312.2 2315.5 2319.4 2325.3 2011.0 2319.9 2341.4 2350.8 2360.9 2276.5 2293.6 2296.1 2335.0 2338.7 2281.9 2300.7 2307.1 2313.1 2314.3 2233.7 2335.3 2336.9 2342.6 2344.5 8250.3 8337.2 8344.2 8351.4 8352.7 4947.5 5093.7 5099.2 5102.9 5115.2 3076.5 3284.2 3414.6 3453.7 3490.2 1141.6 1156.4 1183.6 1191.9 1225.1 10577.6 10704.6 10711.1 10715.1 10726.0 3752.5 4397.6 4596.2 4612.6 4624.6 9441.3 9444.2 9446.3 9461.1 9485.8 5094.9 5172.7 5186.1 5188.1 5201.8 3723.6 4208.2 4664.9 4710.7 4747.4 3320.5 3826.8 3882.2 3954.3 3987.8 1255.9 1269.5 1271.3 1283.2 1283.4 890.3 913.5 918.2 920.1 951.0 5538.7 5666.5 5770.0 5795.5 6086.5 885.9 952.9 959.6 981.2 998.0 3546.1 3703.5 3722.2 3861.2 3888.6 9547.7 9643.8 9697.6 9955.6 9956.4 9565.6 9709.1 9819.5 9823.6 9842.4 5985.0 7732.1 7741.8 7753.4 7836.3 5550.5 5656.5 5706.6 5832.2 5838.2 7812.2 8413.7 8654.3 9252.4 9319.5 9081.8 9256.0 9306.2 9357.4 9405.9 6594.0 6772.6 6983.9 7001.8 7118.4 7779.7 7884.4 7958.8 7964.4 7964.8 6917.3 7097.6 7100.3 7165.0 7229.6 6911.0 6961.2 6975.8 7062.0 7096.2 6339.5 6341.0 6362.4 6426.6 6429.5 4885.5 4896.1 4943.0 4943.7 4957.8 4664.5 4890.1 4920.3 5049.1 5059.6 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | [#4] prototype.html Cycles:180 Average:4377.04 Median:4896.12 stddev:1325.16 (27.1%) stddev-sans-first:1293.68 08:29:41 INFO - PROCESS | 7360 | Values: 335.0 360.3 364.4 374.9 376.5 4149.6 4286.0 5274.4 5380.4 5385.5 4533.0 5103.9 5132.6 5176.7 5245.4 3497.9 3744.9 4143.7 4145.6 4192.0 4029.4 4133.2 4202.1 4229.6 4230.6 4097.8 4101.3 4118.4 4131.6 4166.9 3509.8 4023.8 4102.0 4109.0 4138.6 3500.3 3534.4 3552.2 3670.8 3683.3 4824.7 5094.0 5138.4 5205.8 5240.0 3963.5 4727.4 4736.4 4742.9 4753.6 5090.1 5553.9 5607.8 5621.9 5640.1 3487.1 3758.3 3791.5 3858.6 4020.0 4866.5 5755.2 5806.0 5822.7 5835.4 3268.6 3282.9 3554.4 3666.9 3846.9 3697.0 3747.7 3881.4 3881.7 3894.3 3956.7 4201.2 4403.4 4565.2 4568.8 4695.8 4883.4 5249.9 5620.7 5666.0 1023.5 1168.9 1185.9 1216.9 1229.9 805.4 838.4 864.9 867.7 869.6 4989.8 5053.5 5063.8 5070.8 5104.5 4974.9 5434.8 5452.4 5468.9 5524.4 4257.8 4837.9 4895.6 4992.7 5010.0 2535.9 2644.0 2756.3 2774.8 2827.4 5078.6 5165.6 5639.9 5693.3 5719.5 4900.2 5167.9 5408.2 5593.0 5676.5 4945.8 5302.4 5545.8 5669.9 5728.0 4172.4 4896.7 5287.8 5355.4 5488.7 4874.5 5157.4 5307.6 5405.5 5416.8 4663.7 5291.8 5486.8 5500.2 5546.8 3076.6 3171.8 3567.3 3620.2 3628.8 4722.4 5163.9 5357.8 5434.6 5447.2 4641.3 4721.2 5172.9 5273.8 5317.8 4647.7 4682.3 4952.3 5176.5 5233.0 4139.5 4594.5 5142.8 5153.9 5330.7 5509.2 5515.8 5520.6 5522.2 5536.3 4777.0 5238.8 5257.5 5380.0 5468.3 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - PROCESS | 7360 | [#5] yui.html Cycles:180 Average:19699.87 Median:3681.33 stddev:27882.14 (757.4%) stddev-sans-first:27923.73 08:29:41 INFO - PROCESS | 7360 | Values: 668.3 712.7 713.5 714.7 756.4 14285.3 14808.3 15241.1 15251.8 15262.5 11763.6 14273.0 14384.6 14395.5 14415.9 662.7 833.4 849.7 851.9 852.9 681.6 690.9 820.3 834.9 848.9 904.1 908.6 908.7 910.4 910.7 747.2 898.0 898.5 900.3 903.0 520.1 535.6 539.1 539.7 541.7 14063.0 14662.0 14678.2 14950.2 15009.9 11553.8 13968.3 14031.0 14051.9 14150.6 10996.5 11137.7 11163.8 11585.4 12061.9 3631.5 3676.4 3686.2 3703.7 3714.3 92370.5 95058.5 95624.0 96272.0 96402.0 10622.5 10802.5 10830.6 10871.4 11447.7 22066.7 22480.0 22491.4 22621.8 22744.7 7514.4 7562.0 7575.9 7704.5 7865.6 4098.2 4166.0 4270.6 4345.7 4373.7 3392.9 3478.6 3502.4 3520.0 3529.6 639.0 642.4 667.3 702.9 706.0 658.4 659.7 683.8 702.6 721.7 10061.7 10146.3 10160.5 10343.2 10524.2 657.2 674.7 675.8 693.6 699.0 4411.3 4725.3 4981.5 4983.8 4993.3 106582.5 107276.0 108003.0 108051.0 109695.0 76069.0 76087.0 76812.6 85317.7 85778.1 64348.4 65766.6 74971.0 77212.0 77804.0 9434.4 10374.7 10560.8 10796.4 11061.7 48857.8 49875.0 50157.5 50214.0 50434.0 61357.4 61809.8 62902.1 63139.4 63817.0 12269.7 12313.8 12591.2 12662.5 13030.1 13905.5 14146.4 14167.8 14394.6 14424.7 12799.7 13167.4 13299.3 13379.9 13823.6 12705.9 12868.9 13157.9 13349.1 13394.6 12748.9 12965.7 13111.4 13260.1 13690.0 10944.8 11277.5 11550.7 11741.3 11787.4 10090.3 10888.3 10903.3 10914.3 10946.2 08:29:41 INFO - PROCESS | 7360 | -------- Summary: end -------- 08:29:41 INFO - PROCESS | 7360 | 08:29:41 INFO - TEST-INFO | 7360: exit 0 08:29:41 INFO - TEST-OK | dromaeo_css | took 1117722ms 08:29:41 INFO - TEST-START | kraken 08:29:41 INFO - operating with platform_type : mac_ 08:29:41 INFO - Initialising browser for kraken test... 08:29:41 INFO - TEST-INFO | started process 7362 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmp7WTxtU/profile http://localhost:58834/getInfo.html) 08:29:44 INFO - PROCESS | 7362 | __metrics Screen width/height:1600/1200 08:29:44 INFO - PROCESS | 7362 | colorDepth:24 08:29:44 INFO - PROCESS | 7362 | Browser inner width/height: 1024/689 08:29:44 INFO - PROCESS | 7362 | __metrics 08:29:44 INFO - PROCESS | 7362 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:29:44 INFO - PROCESS | 7362 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:45 INFO - TEST-INFO | 7362: exit 0 08:29:45 INFO - Browser initialized. 08:29:45 INFO - Running cycle 1/1 for kraken test... 08:29:45 INFO - TEST-INFO | started process 7363 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/T/tmp7WTxtU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:57 INFO - PROCESS | 7363 | RSS: Main: 212987904 08:29:57 INFO - PROCESS | 7363 | 08:29:59 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:00 INFO - PROCESS | 7363 | RSS: Main: 266006528 08:30:00 INFO - PROCESS | 7363 | 08:30:03 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-dft) 08:30:03 INFO - PROCESS | 7363 | RSS: Main: 274927616 08:30:03 INFO - PROCESS | 7363 | 08:30:07 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-fft) 08:30:07 INFO - PROCESS | 7363 | RSS: Main: 372379648 08:30:07 INFO - PROCESS | 7363 | 08:30:09 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58834/tests/kraken/driver.html?testName=audio-oscillator) 08:30:10 INFO - PROCESS | 7363 | RSS: Main: 277237760 08:30:10 INFO - PROCESS | 7363 | 08:30:12 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58834/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:13 INFO - PROCESS | 7363 | RSS: Main: 278257664 08:30:13 INFO - PROCESS | 7363 | 08:30:15 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58834/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:16 INFO - PROCESS | 7363 | RSS: Main: 317911040 08:30:16 INFO - PROCESS | 7363 | 08:30:19 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58834/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:20 INFO - PROCESS | 7363 | RSS: Main: 319168512 08:30:20 INFO - PROCESS | 7363 | 08:30:22 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58834/tests/kraken/driver.html?testName=json-parse-financial) 08:30:23 INFO - PROCESS | 7363 | RSS: Main: 318038016 08:30:23 INFO - PROCESS | 7363 | 08:30:25 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58834/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:25 INFO - PROCESS | 7363 | RSS: Main: 295141376 08:30:25 INFO - PROCESS | 7363 | 08:30:27 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:28 INFO - PROCESS | 7363 | RSS: Main: 298844160 08:30:28 INFO - PROCESS | 7363 | 08:30:30 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:31 INFO - PROCESS | 7363 | RSS: Main: 303136768 08:30:31 INFO - PROCESS | 7363 | 08:30:34 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:34 INFO - PROCESS | 7363 | RSS: Main: 319246336 08:30:34 INFO - PROCESS | 7363 | 08:30:37 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:38 INFO - PROCESS | 7363 | RSS: Main: 313241600 08:30:38 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | Cycle 1(1): loaded http://localhost:58834/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58834/tests/kraken/driver.html?testName=ai-astar) 08:30:40 INFO - PROCESS | 7363 | RSS: Main: 357806080 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | __start_tp_report 08:30:40 INFO - PROCESS | 7363 | _x_x_mozilla_page_load 08:30:40 INFO - PROCESS | 7363 | _x_x_mozilla_page_load_details 08:30:40 INFO - PROCESS | 7363 | |i|pagename|runs| 08:30:40 INFO - PROCESS | 7363 | |0;ai-astar;115;114;115;112;113;115;113;111;114;114 08:30:40 INFO - PROCESS | 7363 | |1;audio-beat-detection;146;107;109;145;110;110;92;110;160;138 08:30:40 INFO - PROCESS | 7363 | |2;audio-dft;186;187;187;185;184;187;185;188;237;183 08:30:40 INFO - PROCESS | 7363 | |3;audio-fft;83;58;82;78;74;82;82;82;75;57 08:30:40 INFO - PROCESS | 7363 | |4;audio-oscillator;87;70;86;70;67;68;83;68;68;82 08:30:40 INFO - PROCESS | 7363 | |5;imaging-gaussian-blur;88;86;135;86;88;84;88;86;87;84 08:30:40 INFO - PROCESS | 7363 | |6;imaging-darkroom;97;98;98;99;99;98;98;98;98;97 08:30:40 INFO - PROCESS | 7363 | |7;imaging-desaturate;88;88;86;85;87;87;88;87;85;87 08:30:40 INFO - PROCESS | 7363 | |8;json-parse-financial;54;55;53;53;54;57;56;57;56;58 08:30:40 INFO - PROCESS | 7363 | |9;json-stringify-tinderbox;64;75;79;76;72;70;68;91;89;97 08:30:40 INFO - PROCESS | 7363 | |10;stanford-crypto-aes;81;84;83;83;82;83;84;83;85;86 08:30:40 INFO - PROCESS | 7363 | |11;stanford-crypto-ccm;136;136;136;135;135;149;152;159;205;145 08:30:40 INFO - PROCESS | 7363 | |12;stanford-crypto-pbkdf2;166;168;168;165;166;167;165;168;168;166 08:30:40 INFO - PROCESS | 7363 | |13;stanford-crypto-sha256-iterative;66;67;65;65;64;63;69;63;83;63 08:30:40 INFO - PROCESS | 7363 | __end_tp_report 08:30:40 INFO - PROCESS | 7363 | __start_cc_report 08:30:40 INFO - PROCESS | 7363 | _x_x_mozilla_cycle_collect,2189 08:30:40 INFO - PROCESS | 7363 | __end_cc_report 08:30:40 INFO - PROCESS | 7363 | __startTimestamp1488558640414__endTimestamp 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | ------- Summary: start ------- 08:30:40 INFO - PROCESS | 7363 | Number of tests: 14 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.33 08:30:40 INFO - PROCESS | 7363 | Values: 115.0 114.0 115.0 112.0 113.0 115.0 113.0 111.0 114.0 114.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:141.50 stddev:22.43 (15.8%) stddev-sans-first:22.14 08:30:40 INFO - PROCESS | 7363 | Values: 146.0 107.0 109.0 145.0 110.0 110.0 92.0 110.0 160.0 138.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#2] audio-dft Cycles:10 Average:190.90 Median:187.00 stddev:16.27 (8.7%) stddev-sans-first:17.16 08:30:40 INFO - PROCESS | 7363 | Values: 186.0 187.0 187.0 185.0 184.0 187.0 185.0 188.0 237.0 183.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#3] audio-fft Cycles:10 Average:75.30 Median:82.00 stddev:9.90 (12.1%) stddev-sans-first:10.10 08:30:40 INFO - PROCESS | 7363 | Values: 83.0 58.0 82.0 78.0 74.0 82.0 82.0 82.0 75.0 57.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:76.00 stddev:8.43 (11.1%) stddev-sans-first:7.72 08:30:40 INFO - PROCESS | 7363 | Values: 87.0 70.0 86.0 70.0 67.0 68.0 83.0 68.0 68.0 82.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:86.50 stddev:15.46 (17.9%) stddev-sans-first:16.36 08:30:40 INFO - PROCESS | 7363 | Values: 88.0 86.0 135.0 86.0 88.0 84.0 88.0 86.0 87.0 84.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#6] imaging-darkroom Cycles:10 Average:98.00 Median:98.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 08:30:40 INFO - PROCESS | 7363 | Values: 97.0 98.0 98.0 99.0 99.0 98.0 98.0 98.0 98.0 97.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 08:30:40 INFO - PROCESS | 7363 | Values: 88.0 88.0 86.0 85.0 87.0 87.0 88.0 87.0 85.0 87.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.77 (3.2%) stddev-sans-first:1.81 08:30:40 INFO - PROCESS | 7363 | Values: 54.0 55.0 53.0 53.0 54.0 57.0 56.0 57.0 56.0 58.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:77.50 stddev:10.86 (14.0%) stddev-sans-first:10.25 08:30:40 INFO - PROCESS | 7363 | Values: 64.0 75.0 79.0 76.0 72.0 70.0 68.0 91.0 89.0 97.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:1.43 (1.7%) stddev-sans-first:1.22 08:30:40 INFO - PROCESS | 7363 | Values: 81.0 84.0 83.0 83.0 82.0 83.0 84.0 83.0 85.0 86.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:147.00 stddev:21.50 (14.6%) stddev-sans-first:22.30 08:30:40 INFO - PROCESS | 7363 | Values: 136.0 136.0 136.0 135.0 135.0 149.0 152.0 159.0 205.0 145.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.50 stddev:1.25 (0.7%) stddev-sans-first:1.30 08:30:40 INFO - PROCESS | 7363 | Values: 166.0 168.0 168.0 165.0 166.0 167.0 165.0 168.0 168.0 166.0 08:30:40 INFO - PROCESS | 7363 | 08:30:40 INFO - PROCESS | 7363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:65.50 stddev:6.01 (9.2%) stddev-sans-first:6.37 08:30:40 INFO - PROCESS | 7363 | Values: 66.0 67.0 65.0 65.0 64.0 63.0 69.0 63.0 83.0 63.0 08:30:40 INFO - PROCESS | 7363 | -------- Summary: end -------- 08:30:40 INFO - PROCESS | 7363 | 08:30:41 INFO - TEST-INFO | 7363: exit 0 08:30:41 INFO - TEST-OK | kraken | took 59641ms 08:30:41 INFO - SUITE-END | took 1177s 08:30:41 INFO - Completed test suite (00:19:37) 08:30:41 INFO - javascript benchmark 08:30:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.2209069823243, 3252.1706964724, 3285.507173923911, 3308.7022168004873, 3347.0, 5619.241402410678, 5635.436456354368, 5673.659580425177, 5693.459121383467, 5698.857528561788, 5570.2480165177685, 5628.746706398211, 5679.488846003859, 5697.0, 5747.080467125261, 5130.256112863642, 5168.715720635363, 5201.349831271091, 5224.791008359661, 5251.76367063483, 5108.48915108488, 5124.052050370693, 5126.820561280356, 5139.665921715076, 5323.467653234665, 5141.948580514184, 5182.222666600002, 5230.189320655286, 5241.633085683985, 5258.6581872178185, 5214.983078299752, 5220.556252718486, 5222.321098257221, 5237.6071794615555, 5261.973690131525, 4099.549049604541, 5092.465291144414, 5175.301334319894, 5176.870578235536, 5179.119549676564, 4177.603127702863, 5600.215969764236, 5602.24369710088, 5642.887142257173, 5698.572607054488, 6142.447179753799, 6182.227221597301, 6184.659843708594, 6191.040388739752, 6212.782552610682, 5172.741362931838, 5695.34503532095, 6234.0, 6258.0, 6276.184096067527, 5488.4237155098135, 5542.39033706292, 5674.716264186774, 5810.186573879702, 5833.212516310286, 6140.938590614126, 6154.261488621394, 6160.168377269011, 6166.075088736726, 6167.013277875519, 5776.855578610568, 5790.276215473066, 5794.420557944172, 5800.9129863052085, 5825.912611310834, 5887.5289976802605, 5948.375420580864, 5969.074793407029, 6103.542234332443, 6118.385025140603, 6113.841195312599, 6117.541184411098, 6162.075688646739, 6192.845178870564, 6228.314885362606, 6240.469560087444, 6243.313235544178, 6252.624842509464, 6255.78104766331, 6257.9687101564205, 4812.109759694467, 4988.825391111366, 4999.275105109738, 5007.899842003139, 5034.194528875362, 4261.382099595541, 4376.452943382077, 4386.846460373871, 4461.977690111594, 4507.5943165115295, 5768.74040668171, 5774.249347584871, 5778.017736984722, 5780.913286300624, 5784.074548072288, 6111.865232675468, 6124.234470691164, 6142.498775697809, 6199.504039676905, 6216.813495595139, 5736.971315143481, 5785.132230165509, 5791.449812267828, 5835.212246346774, 5860.150278209636, 5380.811671591476, 5410.729463526808, 5414.7021913795115, 5417.864553386197, 5437.755301011464, 6119.472088496418, 6296.212973378328, 6305.0, 6307.463865571478, 6315.652639104802, 6103.298120715996, 6111.602745821508, 6142.938570614237, 6165.568410211242, 6214.689265536615, 6234.844128896814, 6247.96876015617, 6252.968735156477, 6257.7184026718, 6259.186305780401, 6133.202683651097, 6177.320494745484, 6182.258129024546, 6199.0, 6199.411055949858, 6123.648682309606, 6124.785632502841, 6129.358790882775, 6140.964409184426, 6175.505959523138, 6003.90994135097, 6023.397660233942, 6027.969860150672, 6057.273127224761, 6077.939220607737, 4609.700369476108, 5984.072468767348, 6005.489533389711, 6029.638221706711, 6031.638101713911, 5707.571932105026, 5856.824295271149, 5866.325372582037, 5935.169076329404, 5976.820695379146, 5010.348654675015, 6103.7558497661375, 6107.877842443215, 6118.357572454828, 6129.877402452015, 5949.881002380015, 5970.0, 5970.58205925581, 5970.641761494324, 5974.551908606959], "value": 5621.979816667864, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.3102866358114, 493.555799780198, 494.132796941368, 504.27888119988427, 510.5558164396974, 28087.719122808765, 32778.50832237516, 32782.0, 40084.19831603366, 42683.0, 44441.777791111, 45024.0, 45123.32315015269, 45151.0969780605, 45155.87110322244, 9086.95456522718, 9272.536373181347, 9304.395214311047, 9312.30157738169, 9315.115064068903, 8501.447405918596, 8706.390552661316, 9422.0, 9562.091601297865, 9584.424934503952, 11384.829227561593, 11670.94961453469, 11699.883001170007, 11848.407579621027, 11878.821817672742, 11511.539538418454, 11537.884621153766, 11606.0, 11636.069114470822, 11643.883561164364, 8432.241098301183, 8621.31029517637, 11011.504482298236, 11385.0, 11483.770324593545, 40249.59750402488, 42517.36223956643, 42518.93702657428, 42558.57441425608, 42618.934526636775, 3940.271049855786, 3950.348192548226, 3963.663088637469, 3983.5618082010956, 4044.4539987101657, 28437.00470483544, 30308.54537181944, 30998.690013099807, 31481.842590787128, 32278.677213227802, 2903.8094381303777, 3109.657937626859, 3150.716435520791, 3192.8563214655396, 3226.58054452922, 376232.99999999726, 377483.0, 382706.0, 382907.0, 383089.0, 65866.67066664732, 66077.33922660808, 66415.0, 66452.6709465808, 66489.00266496006, 70169.0, 70203.94694079593, 70276.0, 70367.0, 70608.94086588705, 16378.426755063516, 17017.91491042537, 17040.744388834177, 17062.74405883913, 17063.744043839353, 13011.414486347947, 13079.934600326937, 13097.017723670762, 13122.212667239995, 13149.342532873317, 15803.525894223192, 16142.515724528283, 16180.43368482121, 17919.641607167785, 18363.888152862324, 6759.864802703918, 6912.032315475837, 7462.403007759366, 7517.285857843496, 7601.923980760233, 866.2074202105003, 885.6538062145503, 896.9192772650492, 900.1628485508539, 923.007766650853, 29242.85378573136, 29617.25956851053, 30503.627336769456, 30621.46892655403, 31534.36931261408, 1074.8011617850723, 1076.2304951959386, 1079.3092420850662, 1081.464674985887, 1203.1397550751255, 15474.458393956158, 15950.840491594936, 15975.440859570092, 16028.839711602735, 16273.674526509403, 606156.0, 606709.9329006742, 610609.0, 612043.0, 612197.0, 60498.395016050155, 60662.69668651628, 61030.69484652548, 61074.64089475122, 61246.38753612496, 1264.2919964819546, 1422.267532220907, 1424.1526291856328, 1460.0436713952379, 1466.5453709350136, 26058.087966921066, 28750.7124928748, 29292.70707292985, 29517.557236641896, 30786.69213307928, 52586.737066314425, 53125.0, 53127.468725312254, 53127.734361327944, 53278.0, 587649.0, 593414.0, 594353.0, 594904.0, 595989.0, 21118.155273788878, 25136.62295065539, 25460.363490912874, 25477.490450191264, 25532.23403297904, 43553.12893742171, 43693.0, 44220.0, 45008.549914500436, 46099.84750381267, 34473.827630861684, 36435.635643643225, 36497.63502365049, 37006.88979330625, 37736.62263377331, 36063.0, 36318.91043268706, 37143.814280928425, 37560.624393755716, 37604.81197593995, 35077.47383789194, 35865.64134358623, 36037.0, 36323.81838090793, 36754.0, 30692.846535767178, 32763.180920477178, 32934.0, 32970.0, 33010.33979320352, 23890.761092388853, 24326.51346973086, 24546.631800523362, 24622.630660539748, 24667.38331541654], "value": 19991.418217257993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.9361361761691, 390.35786131813165, 390.74015779506647, 401.6264873667489, 426.7716771527233, 13899.513517026906, 15045.849541504582, 18555.907220463894, 21032.8948355258, 21691.240806571772, 21786.89106554465, 21841.453963650918, 22386.776132238672, 22725.772742272573, 22749.203777867777, 5553.666779993193, 5686.658800471985, 5687.090065589507, 5778.653280803165, 5804.390538993387, 4120.443740095094, 4336.804843782022, 5686.0, 5803.796867109652, 5813.244278243822, 6076.179715738363, 6357.0, 6383.585066970655, 6389.105525226449, 6426.903596446057, 6233.906491402588, 6352.809415717536, 6354.17395738551, 6400.679966001728, 6411.8397040073905, 5633.887322253573, 5644.322681278273, 5650.463205995424, 5653.067243904751, 5657.264555607786, 26295.474090518273, 27149.185524434102, 27261.318467038283, 27274.318142046606, 27374.17877463679, 2721.5237333466566, 2738.589211618253, 2741.7121202273875, 2745.3548416122194, 2752.6008728734223, 7683.692652293901, 11080.670319561705, 15623.921880390639, 16149.434769783002, 16680.916595417068, 1544.2201688147527, 1806.2594336322177, 1856.1623396001273, 1867.962640747191, 1869.8223668751448, 125132.37433812863, 127239.0, 127924.36037819751, 131070.3446482771, 131353.0, 7950.4832185907735, 10385.740356491147, 10470.267081304388, 10511.421871796972, 10578.735531611772, 12769.233845969271, 12877.162984405984, 12881.355932203352, 12881.677958051123, 12884.162529435744, 6772.93227067723, 8186.222308880647, 8281.668733250723, 8387.280607475454, 8424.705135320235, 8458.873116903129, 8494.06565277819, 8505.829883402297, 8667.869981950276, 8672.60973256205, 3991.06210040646, 4033.921162336251, 4064.695147863863, 4116.608922152391, 4143.79281035953, 1731.8181590933023, 2000.5898790747863, 2028.3407892435018, 2040.6122836660986, 2049.3134799841923, 953.9332246742662, 965.9668640468933, 985.5023213277392, 996.5848495136923, 997.3915911294105, 21414.0, 21772.0, 21954.121835126734, 22009.779902201095, 22061.00725467358, 924.9917589827121, 1013.4546558684295, 1016.4155610523978, 1026.4867566216892, 1050.821360368739, 10492.527836247387, 11133.777324453466, 11142.27575207609, 11216.270942388719, 11219.943900280447, 702794.0, 738957.0, 749424.0, 751846.2407687927, 756140.0, 145647.5435245634, 149761.0, 151203.24398378158, 152569.0, 169661.0, 421.7069136949852, 451.1405772004337, 452.0574601954895, 455.2533844495031, 455.4580049740864, 10709.357438553712, 11032.28290161169, 11184.993350598485, 11205.271657342246, 11406.20156589064, 61747.0, 62951.79668711573, 63315.68342158444, 63389.68305158445, 64627.0, 71055.0, 88246.55876720576, 89073.10926890648, 89712.10287897037, 91398.08601914161, 7959.442839001446, 8058.970514742628, 8217.54803485814, 8256.83486330258, 8259.132791056853, 12564.743525647362, 12582.30797306157, 12604.30676312775, 12712.427940742873, 13090.869091309345, 10744.570217191538, 10928.726781830517, 10953.83569246446, 11132.165087618623, 11359.204855660024, 10620.681379558626, 10643.148548116287, 10842.674719758419, 10960.725981850517, 11171.832422513506, 9982.652341933746, 11011.61459348919, 11368.62308011405, 11373.260738052, 11375.943120284346, 8042.03495580534, 8230.300424463987, 8363.581820908808, 8519.872201916853, 8559.871601925852, 8326.45878017927, 10780.353178809297, 10830.945845270724, 10919.890801091888, 10954.671359859218], "value": 9484.26192898367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.4530078570142, 1439.9352029158688, 1462.122726364181, 1466.3035058347286, 1466.9193194374309, 8001.0, 8427.452215605981, 8437.409381343308, 8446.239838414542, 8446.704365347214, 7404.555726656405, 7648.770536883889, 7648.885266721004, 7894.763157105282, 8222.506649601028, 2273.2043784675357, 2312.167619656922, 2315.4558678710573, 2319.3969567912295, 2325.2559181062065, 2010.979890201094, 2319.8840057997118, 2341.3912382780513, 2350.8471949323325, 2360.8701521416315, 2276.499170182557, 2293.587154312223, 2296.1045192374986, 2334.9766502335015, 2338.6608941703444, 2281.863088214704, 2300.654901764732, 2307.088699963522, 2313.1210140146804, 2314.259436980167, 2233.7096177496983, 2335.3344296875307, 2336.906523739048, 2342.5666251743482, 2344.5310937812505, 8250.257476827115, 8337.249647531751, 8344.165583441669, 8351.37364697644, 8352.707655232098, 4947.50524947506, 5093.719845408501, 5099.235114732783, 5102.948970510284, 5115.2071428928575, 3076.50775875861, 3284.2117891706057, 3414.607320158189, 3453.740969427303, 3490.2321489272317, 1141.5833220874322, 1156.410230782307, 1183.597576823884, 1191.8927296543266, 1225.136278923357, 10577.576896924114, 10704.625338113128, 10711.143108551298, 10715.08921741653, 10726.0, 3752.512173417438, 4397.582229688174, 4596.195665758546, 4612.60792832613, 4624.606908412756, 9441.339106262632, 9444.197243234403, 9446.29152813528, 9461.05389461062, 9485.810283794286, 5094.949050509447, 5172.7155006475, 5186.092433824066, 5188.092083885381, 5201.817936372209, 3723.6276372362545, 4208.242516347087, 4664.930026049612, 4710.6702530823195, 4747.382840230748, 3320.5351250824906, 3826.827792749333, 3882.2429626222615, 3954.2882281189663, 3987.8205480753436, 1255.9246445213316, 1269.4674125120443, 1271.3389037700344, 1283.165942137618, 1283.3968035023524, 890.283321925856, 913.4639226382345, 918.1644703319947, 920.0845159066638, 950.9809803803885, 5538.695371754511, 5666.546676265972, 5770.0, 5795.478406943395, 6086.513078953673, 885.9468431894107, 952.9047095290554, 959.5586030426082, 981.2297346583041, 997.9750506237257, 3546.131197856542, 3703.500027496307, 3722.16251343451, 3861.227754449121, 3888.6111388861455, 9547.665831695856, 9643.758906027266, 9697.563609637584, 9955.55200016001, 9956.352837065713, 9565.569549370295, 9709.126178643955, 9819.459929703791, 9823.607055717834, 9842.409455432553, 5985.0, 7732.149463559004, 7741.806454838674, 7753.418493613001, 7836.255555722198, 5550.4727050931715, 5656.462636049569, 5706.629069110494, 5832.183494310715, 5838.182654428469, 7812.1797211292, 8413.663453462037, 8654.264387527131, 9252.444853308823, 9319.534023298673, 9081.77295567616, 9256.0, 9306.162445379949, 9357.39176953496, 9405.918319393357, 6593.967030164818, 6772.55978361405, 6983.860322793414, 7001.754938577125, 7118.430525558047, 7779.688812447439, 7884.369250459835, 7958.761237162895, 7964.402669799904, 7964.800879978047, 6917.342852429011, 7097.609631470319, 7100.325469080429, 7164.9641751793, 7229.638518074181, 6910.98539456561, 6961.199462061928, 6975.8256043597285, 7062.046623705939, 7096.183938847099, 6339.524535659936, 6341.0, 6362.395572420613, 6426.646534440651, 6429.517786165963, 4885.462599114024, 4896.143174944442, 4943.0, 4943.728094954668, 4957.801687932442, 4664.533546645308, 4890.119778439915, 4920.31115643803, 5049.116404629249, 5059.569936555434], "value": 4385.002501272295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.98492567834444, 360.27404779369556, 364.4420104055164, 374.9175181460078, 376.52745804015956, 4149.585041495849, 4285.978570107149, 5274.367075950881, 5380.435054319299, 5385.515303622673, 4533.0, 5103.897922041557, 5132.589392848563, 5176.745603212742, 5245.396779370373, 3497.89506314811, 3744.8876533704033, 4143.689223308249, 4145.6162706443765, 4191.958080419203, 4029.355303151496, 4133.181400183925, 4202.117555313388, 4229.619334259916, 4230.640395566381, 4097.770668799363, 4101.308822060155, 4118.423420721101, 4131.607497287753, 4166.937495937564, 3509.824508774551, 4023.786917195531, 4101.999999999985, 4108.958910410887, 4138.6482149017365, 3500.2824420993634, 3534.4168212245204, 3552.2185119273718, 3670.761400508985, 3683.3001729671278, 4824.6863953842885, 5093.955739073481, 5138.383393992707, 5205.817796377147, 5239.973800130975, 3963.5243770747406, 4727.361806156159, 4736.4316282046375, 4742.857714268577, 4753.572178503917, 5090.065775005512, 5553.888922221573, 5607.775688972436, 5621.915671264935, 5640.0823719935415, 3487.1118702646622, 3758.342290099222, 3791.545014598238, 3858.5562660294145, 4019.974906398879, 4866.51334866514, 5755.22304488897, 5805.970970145165, 5822.679752613604, 5835.44563266489, 3268.607767067967, 3282.917927051843, 3554.360215161244, 3666.871659491905, 3846.9230615387537, 3697.0387699197863, 3747.662710356081, 3881.3789793633446, 3881.670058045098, 3894.337962546374, 3956.742811717229, 4201.243776120266, 4403.405540252025, 4565.246734288805, 4568.817247310137, 4695.812167513262, 4883.413990321184, 5249.921251181236, 5620.667423019483, 5665.971670141623, 1023.5036007536339, 1168.9362679961193, 1185.9466324015268, 1216.8965637920699, 1229.9262044277373, 805.3557154276556, 838.4172999765104, 864.8529749942525, 867.6746220167437, 869.6130222051127, 4989.775460104304, 5053.519915608012, 5063.772130254148, 5070.797168113234, 5104.464031276737, 4974.925376119361, 5434.83695489136, 5452.372977107604, 5468.91796623051, 5524.392316845144, 4257.808398622069, 4837.87133661195, 4895.559399654048, 4992.675476094042, 5010.0, 2535.8858851351733, 2644.008496813695, 2756.338478765122, 2774.7940387392073, 2827.448647513756, 5078.593712503065, 5165.638405311667, 5639.943600563942, 5693.28833895763, 5719.542436605062, 4900.166971614834, 5167.948320516747, 5408.242321245611, 5592.993261213021, 5676.517496012885, 4945.8346658139535, 5302.398513850281, 5545.750441230154, 5669.914951275651, 5728.0, 4172.395002724648, 4896.681715688469, 5287.836675931289, 5355.4376790436445, 5488.69812160335, 4874.5405146235025, 5157.375426740565, 5307.6284660073425, 5405.486478784509, 5416.7562459688625, 4663.650226232979, 5291.842649284414, 5486.79290556077, 5500.202470641814, 5546.83673367379, 3076.630804303498, 3171.8255495947947, 3567.250877315793, 3620.2397496524973, 3628.818559071983, 4722.433308003062, 5163.896722065613, 5357.8392648220615, 5434.592405569519, 5447.1829225616475, 4641.257398816173, 4721.22099853534, 5172.861970366514, 5273.78904843802, 5317.787288508416, 4647.65142614312, 4682.2508398656055, 4952.257161425815, 5176.482351764794, 5232.9738351308, 4139.503259608866, 4594.540545945379, 5142.845714628567, 5153.871153221199, 5330.653507521999, 5509.228707980806, 5515.7865269640615, 5520.558355331644, 5522.199281104297, 5536.335639723259, 4777.0207107543565, 5238.842834714965, 5257.500537449089, 5380.0, 5468.343798744176], "value": 3966.2835865784164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.3216535216754, 712.7378277898168, 713.464901324007, 714.7105422303962, 756.3873262657246, 14285.285735713212, 14808.334499790033, 15241.085534867916, 15251.771223431644, 15262.465813696523, 11763.647090587274, 14273.0, 14384.640383990405, 14395.496157634485, 14415.85584144161, 662.7481557008355, 833.3832963606933, 849.6643825688849, 851.948883067018, 852.927501162402, 681.6319187638694, 690.9032735417046, 820.3191351178508, 834.8664213725805, 848.855694531928, 904.1184844776324, 908.554808144008, 908.7137551671202, 910.3536489092752, 910.7085732565581, 747.2079595628651, 897.9999999999967, 898.5282726568538, 900.2527901841456, 903.0202230579829, 520.0664806671995, 535.5581645142772, 539.1104677282476, 539.7328322480397, 541.7183064806318, 14063.0, 14661.973661843675, 14678.192699401528, 14950.177740224392, 15009.949303548756, 11553.826692599618, 13968.301584920713, 14030.95106627465, 14051.929740351234, 14150.646233844236, 10996.505157267942, 11137.721556961142, 11163.776724465546, 11585.36280504572, 12061.939690301493, 3631.479454780624, 3676.4301533262387, 3686.225892562565, 3703.6851867591286, 3714.3499887519574, 92370.5381473095, 95058.52470737603, 95624.0, 96272.0, 96402.03597964, 10622.521986510626, 10802.459877006275, 10830.566777328977, 10871.402072886067, 11447.656570302905, 22066.66899996501, 22480.0, 22491.437714056952, 22621.773782262295, 22744.65883011756, 7514.398848092249, 7562.0, 7575.924240757632, 7704.537727736354, 7865.606719663994, 4098.221337945781, 4165.958340416557, 4270.636995855387, 4345.652347812231, 4373.671974601918, 3392.881249156317, 3478.565179352581, 3502.439609662442, 3519.9648003519637, 3529.5588051493564, 639.047818750059, 642.3512252624882, 667.3226674924955, 702.9086218791626, 706.0327351528439, 658.4205898809017, 659.66686823154, 683.8016975077271, 702.6205848841671, 721.6608194148741, 10061.664749970329, 10146.340487868265, 10160.542775575117, 10343.172546196287, 10524.210684198715, 657.1719633262124, 674.6660403100399, 675.7702381190419, 693.5630552751734, 698.9580625162506, 4411.338299255138, 4725.337294219582, 4981.452040275567, 4983.750812459362, 4993.275974983607, 106582.46708766406, 107276.0, 108003.0, 108051.0, 109695.0, 76069.0, 76087.0, 76812.61593691996, 85317.72023419653, 85778.14221857826, 64348.356516434236, 65766.55700611824, 74971.0, 77212.0, 77803.99999999886, 9434.433933963985, 10374.740631484274, 10560.788784224425, 10796.406197659204, 11061.668149955514, 48857.755711221216, 49875.0, 50157.498425015285, 50214.0, 50434.0, 61357.38642613695, 61809.76380472456, 62902.11293661197, 63139.36860631335, 63817.0, 12269.69325766863, 12313.753724925631, 12591.24452532851, 12662.493500259887, 13030.08789384734, 13905.513307034205, 14146.363413646204, 14167.787483187967, 14394.640133996734, 14424.711505769616, 12799.744005120032, 13167.407466663832, 13299.335033248492, 13379.862711669617, 13823.585292441243, 12705.872941270469, 12868.935655321664, 13157.88158006542, 13349.132306400441, 13394.598162055154, 12748.936255318664, 12965.675858103623, 13111.40998655082, 13260.07179497426, 13690.0, 10944.781104378028, 11277.492512837107, 11550.711232219262, 11741.29552226869, 11787.351695656822, 10090.293679442662, 10888.346699198073, 10903.34579925207, 10914.290571112851, 10946.17903657213], "value": 7328.401209563578, "unit": "score"}], "name": "dromaeo_css", "value": 7170.09208693488, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 112.0, 113.0, 115.0, 113.0, 111.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 107.0, 109.0, 145.0, 110.0, 110.0, 92.0, 110.0, 160.0, 138.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 187.0, 185.0, 184.0, 187.0, 185.0, 188.0, 237.0, 183.0], "value": 190.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 82.0, 78.0, 74.0, 82.0, 82.0, 82.0, 75.0, 57.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 86.0, 70.0, 67.0, 68.0, 83.0, 68.0, 68.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 135.0, 86.0, 88.0, 84.0, 88.0, 86.0, 87.0, 84.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 98.0, 99.0, 99.0, 98.0, 98.0, 98.0, 98.0, 97.0], "value": 98.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 85.0, 87.0, 87.0, 88.0, 87.0, 85.0, 87.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 53.0, 54.0, 57.0, 56.0, 57.0, 56.0, 58.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 79.0, 76.0, 72.0, 70.0, 68.0, 91.0, 89.0, 97.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 83.0, 83.0, 82.0, 83.0, 84.0, 83.0, 85.0, 86.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 136.0, 135.0, 135.0, 149.0, 152.0, 159.0, 205.0, 145.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 168.0, 165.0, 166.0, 167.0, 165.0, 168.0, 168.0, 166.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 64.0, 63.0, 69.0, 63.0, 83.0, 63.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1452.5, "alertThreshold": 2.0}]} 08:30:41 INFO - Return code: 0 08:30:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:30:41 ERROR - # TBPL SUCCESS # 08:30:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:41 INFO - 2017-03-03 08:30:41.711 screenresolution[7368:157916] starting screenresolution argv=screenresolution get 08:30:41 INFO - 2017-03-03 08:30:41.713 screenresolution[7368:157916] Display 0: 1600x1200x32@60 08:30:41 INFO - 2017-03-03 08:30:41.720 screenresolution[7369:157919] starting screenresolution argv=screenresolution list 08:30:41 INFO - Available Modes on Display 0 08:30:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:41 INFO - Intel Iris: 08:30:41 INFO - Chipset Model: Intel Iris 08:30:41 INFO - Type: GPU 08:30:41 INFO - Bus: Built-In 08:30:41 INFO - VRAM (Dynamic, Max): 1536 MB 08:30:41 INFO - Vendor: Intel (0x8086) 08:30:41 INFO - Device ID: 0x0a2e 08:30:41 INFO - Revision ID: 0x0009 08:30:41 INFO - Displays: 08:30:41 INFO - Display: 08:30:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:41 INFO - Display Serial Number: 1600x1200 60 08:30:41 INFO - Main Display: Yes 08:30:41 INFO - Mirror: Off 08:30:41 INFO - Online: Yes 08:30:41 INFO - Rotation: Supported 08:30:41 INFO - Return code: 0 08:30:41 INFO - Running post-action listener: _resource_record_post_action 08:30:41 INFO - [mozharness: 2017-03-03 16:30:41.959103Z] Finished run-tests step (success) 08:30:41 INFO - Running post-run listener: _resource_record_post_run 08:30:42 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 524288; Write bytes: 509743616; Read time: 2; Write time: 1573 08:30:42 INFO - TinderboxPrint: CPU usage
53.7% 08:30:42 INFO - TinderboxPrint: I/O read bytes / time
524,288 / 2 08:30:42 INFO - TinderboxPrint: I/O write bytes / time
509,743,616 / 1,573 08:30:42 INFO - TinderboxPrint: CPU idle
2,219.7 (46.3%) 08:30:42 INFO - TinderboxPrint: CPU system
959.1 (20.0%) 08:30:42 INFO - TinderboxPrint: CPU user
1,614.9 (33.7%) 08:30:42 INFO - TinderboxPrint: Swap in / out
207,724,544 / 0 08:30:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205353472; Write bytes: 202057728; Read time: 15677; Write time: 425 08:30:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 487424; Write bytes: 296634880; Read time: 2; Write time: 1111 08:30:42 INFO - Running post-run listener: _upload_blobber_files 08:30:42 INFO - Blob upload gear active. 08:30:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08: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 08: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'] 08: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 08:30:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:43 INFO - (blobuploader) - INFO - Done attempting. 08:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:44 INFO - (blobuploader) - INFO - Done attempting. 08:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:30:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:45 INFO - (blobuploader) - INFO - Done attempting. 08:30:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:30:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:30:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:47 INFO - (blobuploader) - INFO - Done attempting. 08:30:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:47 INFO - Return code: 0 08:30:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d20736f793211e5da040eb370767a8f008bb6c768d2bf0826a4ac610be49538ecc7405c0bce71dd2813de86c512753de5eb5ac43433c5c8e77bf4d6efc2fccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/311483b8a15f11ccd8d0b50225d92c154cf52a4669c4e9d5c4a4be86bb7c2b1fe8da62c2ddc0d8067d4478b9680340e0eebd5b48921cec80609cb001e94c9c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a11f64acf53c1aa9f5855377ab5316a8314d22ae6175c0a386cbffbf1ba4d2eafc31fc71224a6fe050f61fe7ca91024a7acffb2e2bbcaa9b94d9bd164ca189bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64532200ab124079a475f0be7fbab435217fb3095290dfee0470389536d36e48b52c87d236c3c01249468bfe2cc8c47536ef72b0eff66fbc13badeebb69079da"} 08:30:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:47 INFO - Contents: 08:30:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5d20736f793211e5da040eb370767a8f008bb6c768d2bf0826a4ac610be49538ecc7405c0bce71dd2813de86c512753de5eb5ac43433c5c8e77bf4d6efc2fccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/311483b8a15f11ccd8d0b50225d92c154cf52a4669c4e9d5c4a4be86bb7c2b1fe8da62c2ddc0d8067d4478b9680340e0eebd5b48921cec80609cb001e94c9c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a11f64acf53c1aa9f5855377ab5316a8314d22ae6175c0a386cbffbf1ba4d2eafc31fc71224a6fe050f61fe7ca91024a7acffb2e2bbcaa9b94d9bd164ca189bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64532200ab124079a475f0be7fbab435217fb3095290dfee0470389536d36e48b52c87d236c3c01249468bfe2cc8c47536ef72b0eff66fbc13badeebb69079da"} 08:30:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:47 INFO - Copying logs to upload dir... 08:30:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.066793 ========= master_lag: 1.44 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-03 08:30:49.331999) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:49.336034) ========= 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.0MPkxstwpK/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.xnvXO2Cywy/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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/5d20736f793211e5da040eb370767a8f008bb6c768d2bf0826a4ac610be49538ecc7405c0bce71dd2813de86c512753de5eb5ac43433c5c8e77bf4d6efc2fccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/311483b8a15f11ccd8d0b50225d92c154cf52a4669c4e9d5c4a4be86bb7c2b1fe8da62c2ddc0d8067d4478b9680340e0eebd5b48921cec80609cb001e94c9c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a11f64acf53c1aa9f5855377ab5316a8314d22ae6175c0a386cbffbf1ba4d2eafc31fc71224a6fe050f61fe7ca91024a7acffb2e2bbcaa9b94d9bd164ca189bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64532200ab124079a475f0be7fbab435217fb3095290dfee0470389536d36e48b52c87d236c3c01249468bfe2cc8c47536ef72b0eff66fbc13badeebb69079da"} build_url:https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011627 build_url: 'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/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/5d20736f793211e5da040eb370767a8f008bb6c768d2bf0826a4ac610be49538ecc7405c0bce71dd2813de86c512753de5eb5ac43433c5c8e77bf4d6efc2fccf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/311483b8a15f11ccd8d0b50225d92c154cf52a4669c4e9d5c4a4be86bb7c2b1fe8da62c2ddc0d8067d4478b9680340e0eebd5b48921cec80609cb001e94c9c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a11f64acf53c1aa9f5855377ab5316a8314d22ae6175c0a386cbffbf1ba4d2eafc31fc71224a6fe050f61fe7ca91024a7acffb2e2bbcaa9b94d9bd164ca189bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64532200ab124079a475f0be7fbab435217fb3095290dfee0470389536d36e48b52c87d236c3c01249468bfe2cc8c47536ef72b0eff66fbc13badeebb69079da"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:49.445126) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:49.445505) ========= 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.0MPkxstwpK/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.xnvXO2Cywy/Listeners TMPDIR=/var/folders/vn/28yn3b3s6nq12pmzj1bqp29w00000w/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.005458 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:49.727693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 08:30:49.728010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 08:30:49.730252) ========= ========= Total master_lag: 1.89 =========