builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0240 starttime: 1485264120.19 results: success (0) buildid: 20170124034343 builduid: be6076085a274d14b2a96ca3ef7a68cf revision: 41a10c805351ddaa8d8940a95f37be28cbf23f16 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.187375) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.188131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.188654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.215871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.216182) ========= 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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 05:22:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-01-24 05:22:00 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.415254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.415615) ========= 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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.026063 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:00.465122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:22:00.465535) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 41a10c805351ddaa8d8940a95f37be28cbf23f16 --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 41a10c805351ddaa8d8940a95f37be28cbf23f16 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S8V0NRCJb1/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.zbsZnAE2SN/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 05:22:00,580 truncating revision to first 12 chars 2017-01-24 05:22:00,580 Setting DEBUG logging. 2017-01-24 05:22:00,580 attempt 1/10 2017-01-24 05:22:00,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/41a10c805351?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 05:22:01,699 unpacking tar archive at: mozilla-aurora-41a10c805351/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:22:01.866732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:01.867100) ========= script_repo_revision: 41a10c805351ddaa8d8940a95f37be28cbf23f16 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:01.867567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:01.867877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:22:01.888135) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 05:22:01.888535) ========= /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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:02 INFO - MultiFileLogger online at 20170124 05:22:02 in /builds/slave/test 05:22:02 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 05:22:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:02 INFO - {'append_to_log': False, 05:22:02 INFO - 'base_work_dir': '/builds/slave/test', 05:22:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:22:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:02 INFO - 'branch': 'Mozilla-Aurora', 05:22:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:02 INFO - 'config_files': ('talos/mac_config.py',), 05:22:02 INFO - 'default_actions': ('clobber', 05:22:02 INFO - 'read-buildbot-config', 05:22:02 INFO - 'download-and-extract', 05:22:02 INFO - 'populate-webroot', 05:22:02 INFO - 'create-virtualenv', 05:22:02 INFO - 'install', 05:22:02 INFO - 'run-tests'), 05:22:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:02 INFO - 'download_minidump_stackwalk': True, 05:22:02 INFO - 'download_symbols': 'ondemand', 05:22:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:02 INFO - 'installer_path': 'installer.exe', 05:22:02 INFO - 'log_level': 'info', 05:22:02 INFO - 'log_name': 'talos', 05:22:02 INFO - 'log_to_console': True, 05:22:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:22:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:22:02 INFO - 'opt_config_files': (), 05:22:02 INFO - 'pip_index': False, 05:22:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:22:02 INFO - 'cmd': ('bash', 05:22:02 INFO - '-c', 05:22:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:22:02 INFO - 'enabled': True, 05:22:02 INFO - 'halt_on_failure': False, 05:22:02 INFO - 'name': 'check_screen_resolution'},), 05:22:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:22:02 INFO - 'cmd': ('bash', 05:22:02 INFO - '-c', 05:22:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:22:02 INFO - 'enabled': True, 05:22:02 INFO - 'halt_on_failure': False, 05:22:02 INFO - 'name': 'check_screen_resolution'},), 05:22:02 INFO - 'run_cmd_checks_enabled': True, 05:22:02 INFO - 'sps_profile': False, 05:22:02 INFO - 'sps_profile_interval': 0, 05:22:02 INFO - 'suite': 'dromaeojs', 05:22:02 INFO - 'system_bits': '32', 05:22:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:02 INFO - 'title': 't-yosemite-r7-0240', 05:22:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:02 INFO - 'use_talos_json': True, 05:22:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:02 INFO - 'work_dir': 'build'} 05:22:02 INFO - [mozharness: 2017-01-24 13:22:02.109055Z] Running clobber step. 05:22:02 INFO - Running pre-action listener: _resource_record_pre_action 05:22:02 INFO - Running main action method: clobber 05:22:02 INFO - rmtree: /builds/slave/test/build 05:22:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:04 INFO - Running post-action listener: _resource_record_post_action 05:22:04 INFO - [mozharness: 2017-01-24 13:22:04.516244Z] Finished clobber step (success) 05:22:04 INFO - [mozharness: 2017-01-24 13:22:04.516492Z] Running read-buildbot-config step. 05:22:04 INFO - Running pre-action listener: _resource_record_pre_action 05:22:04 INFO - Running main action method: read_buildbot_config 05:22:04 INFO - Using buildbot properties: 05:22:04 INFO - { 05:22:04 INFO - "project": "", 05:22:04 INFO - "product": "firefox", 05:22:04 INFO - "script_repo_revision": "production", 05:22:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:22:04 INFO - "repository": "", 05:22:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:22:04 INFO - "buildid": "20170124034343", 05:22:04 INFO - "pgo_build": "False", 05:22:04 INFO - "basedir": "/builds/slave/test", 05:22:04 INFO - "buildnumber": 94, 05:22:04 INFO - "slavename": "t-yosemite-r7-0240", 05:22:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:22:04 INFO - "platform": "yosemite_r7", 05:22:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:22:04 INFO - "branch": "mozilla-aurora", 05:22:04 INFO - "repo_path": "releases/mozilla-aurora", 05:22:04 INFO - "revision": "41a10c805351ddaa8d8940a95f37be28cbf23f16", 05:22:04 INFO - "stage_platform": "macosx64", 05:22:04 INFO - "builduid": "be6076085a274d14b2a96ca3ef7a68cf", 05:22:04 INFO - "slavebuilddir": "test" 05:22:04 INFO - } 05:22:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 05:22:04 INFO - Running post-action listener: _resource_record_post_action 05:22:04 INFO - [mozharness: 2017-01-24 13:22:04.522122Z] Finished read-buildbot-config step (success) 05:22:04 INFO - [mozharness: 2017-01-24 13:22:04.522334Z] Running download-and-extract step. 05:22:04 INFO - Running pre-action listener: _resource_record_pre_action 05:22:04 INFO - Running main action method: download_and_extract 05:22:04 INFO - mkdir: /builds/slave/test/build/tests 05:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:04 INFO - trying https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 05:22:04 INFO - Downloading https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/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 05:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/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 05:22:05 INFO - Downloaded 1199 bytes. 05:22:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 05:22:05 INFO - Using the following test package requirements: 05:22:05 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:22:05 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 05:22:05 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 05:22:05 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'jsshell-mac.zip'], 05:22:05 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 05:22:05 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:22:05 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 05:22:05 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 05:22:05 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 05:22:05 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:22:05 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 05:22:05 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:22:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:22:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:22:05 INFO - Fetch https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:22:06 INFO - Expected file size: 16349513 05:22:06 INFO - Obtained file size: 16349513 05:22:13 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 05:22:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:22:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:22:13 INFO - Fetch https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:22:14 INFO - Expected file size: 16349513 05:22:14 INFO - Obtained file size: 16349513 05:22:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 05:22:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:22:20 INFO - Fetch https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 05:22:22 INFO - Expected file size: 14403485 05:22:22 INFO - Obtained file size: 14403485 05:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:22 INFO - trying https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:22:22 INFO - Downloading https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 05:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/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 05:22:24 INFO - Downloaded 73884597 bytes. 05:22:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:22:24 INFO - mkdir: /builds/slave/test/properties 05:22:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:24 INFO - Contents: 05:22:24 INFO - build_url:https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:22:25 INFO - Running post-action listener: _resource_record_post_action 05:22:25 INFO - Running post-action listener: set_extra_try_arguments 05:22:25 INFO - [mozharness: 2017-01-24 13:22:25.436855Z] Finished download-and-extract step (success) 05:22:25 INFO - [mozharness: 2017-01-24 13:22:25.436978Z] Running populate-webroot step. 05:22:25 INFO - Running pre-action listener: _resource_record_pre_action 05:22:25 INFO - Running main action method: populate_webroot 05:22:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:25 INFO - '--tppagecycles', 05:22:25 INFO - '7'], 05:22:25 INFO - 'tests': ['tsvgm']}}, 05:22:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['damp', 'tps']}, 05:22:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'tests': ['damp', 'tps']}, 05:22:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['dromaeo_dom']}, 05:22:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['basic_compositor_video']}, 05:22:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:22:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['a11yr', 05:22:25 INFO - 'ts_paint', 05:22:25 INFO - 'tpaint', 05:22:25 INFO - 'sessionrestore', 05:22:25 INFO - 'sessionrestore_no_auto_restore', 05:22:25 INFO - 'tabpaint']}, 05:22:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:25 INFO - 'ts_paint', 05:22:25 INFO - 'tpaint', 05:22:25 INFO - 'sessionrestore', 05:22:25 INFO - 'sessionrestore_no_auto_restore', 05:22:25 INFO - 'tabpaint']}, 05:22:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:25 INFO - 'ts_paint', 05:22:25 INFO - 'tpaint', 05:22:25 INFO - 'sessionrestore', 05:22:25 INFO - 'sessionrestore_no_auto_restore', 05:22:25 INFO - 'tabpaint']}, 05:22:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:25 INFO - 'ts_paint', 05:22:25 INFO - 'tpaint', 05:22:25 INFO - 'sessionrestore', 05:22:25 INFO - 'sessionrestore_no_auto_restore', 05:22:25 INFO - 'tabpaint']}, 05:22:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['a11yr', 05:22:25 INFO - 'ts_paint', 05:22:25 INFO - 'tpaint', 05:22:25 INFO - 'sessionrestore', 05:22:25 INFO - 'sessionrestore_no_auto_restore', 05:22:25 INFO - 'tabpaint']}, 05:22:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['a11yr', 05:22:25 INFO - 'ts_paint', 05:22:25 INFO - 'tpaint', 05:22:25 INFO - 'sessionrestore', 05:22:25 INFO - 'sessionrestore_no_auto_restore', 05:22:25 INFO - 'tabpaint']}, 05:22:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['tsvgx', 05:22:25 INFO - 'tsvgr_opacity', 05:22:25 INFO - 'tart', 05:22:25 INFO - 'tscrollx', 05:22:25 INFO - 'cart', 05:22:25 INFO - 'tsvg_static']}, 05:22:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:25 INFO - 'tsvgr_opacity', 05:22:25 INFO - 'tart', 05:22:25 INFO - 'tscrollx', 05:22:25 INFO - 'cart', 05:22:25 INFO - 'tsvg_static']}, 05:22:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'talos_options': ['--disable-e10s'], 05:22:25 INFO - 'tests': ['tp5o']}, 05:22:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:22:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'talos_options': ['--disable-e10s', 05:22:25 INFO - '--xperf_path', 05:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:25 INFO - 'tests': ['tp5n']}, 05:22:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:22:25 INFO - 'talos_options': ['--xperf_path', 05:22:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:25 INFO - 'tests': ['tp5n']}}, 05:22:25 INFO - 'talos.zip': {'path': '', 05:22:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:25 INFO - Running post-action listener: _resource_record_post_action 05:22:25 INFO - [mozharness: 2017-01-24 13:22:25.455100Z] Finished populate-webroot step (success) 05:22:25 INFO - [mozharness: 2017-01-24 13:22:25.455233Z] Running create-virtualenv step. 05:22:25 INFO - Running pre-action listener: _resource_record_pre_action 05:22:25 INFO - Running main action method: create_virtualenv 05:22:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:25 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 05:22:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:25 INFO - Using real prefix '/tools/python27' 05:22:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:29 INFO - Installing pip.................done. 05:22:29 INFO - Return code: 0 05:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:22:29 INFO - Reading from file tmpfile_stdout 05:22:29 INFO - Output received: 05:22:29 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) 05:22:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22:29 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')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:29 INFO - 'HOME': '/Users/cltbld', 05:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PAGER': '/bin/cat', 05:22:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test', 05:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:29 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - 'XPC_FLAGS': '0x0', 05:22:29 INFO - 'XPC_SERVICE_NAME': '0', 05:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:29 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 05:22:29 INFO - Cleaning up... 05:22:29 INFO - Return code: 0 05:22:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:22:29 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')]} 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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')]} 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:29 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:29 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 05:22:29 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 05:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:29 INFO - 'HOME': '/Users/cltbld', 05:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PAGER': '/bin/cat', 05:22:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test', 05:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:29 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - 'XPC_FLAGS': '0x0', 05:22:29 INFO - 'XPC_SERVICE_NAME': '0', 05:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:29 INFO - Downloading/unpacking psutil>=3.1.1 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:33 INFO - Installing collected packages: psutil 05:22:33 INFO - Running setup.py install for psutil 05:22:33 INFO - building 'psutil._psutil_osx' extension 05:22:33 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 05:22:34 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 05:22:34 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 05:22:34 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 05:22:34 INFO - building 'psutil._psutil_posix' extension 05:22:34 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 05:22:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:22:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:22:34 INFO - ^ 05:22:34 INFO - 1 warning generated. 05:22:34 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 05:22:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:34 INFO - Successfully installed psutil 05:22:34 INFO - Cleaning up... 05:22:34 INFO - Return code: 0 05:22:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:34 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:34 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 05:22:34 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 05:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:34 INFO - 'HOME': '/Users/cltbld', 05:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:34 INFO - 'LOGNAME': 'cltbld', 05:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:34 INFO - 'MOZ_NO_REMOTE': '1', 05:22:34 INFO - 'NO_EM_RESTART': '1', 05:22:34 INFO - 'PAGER': '/bin/cat', 05:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:34 INFO - 'PWD': '/builds/slave/test', 05:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:34 INFO - 'SHELL': '/bin/bash', 05:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:34 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:34 INFO - 'USER': 'cltbld', 05:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:34 INFO - 'XPC_FLAGS': '0x0', 05:22:34 INFO - 'XPC_SERVICE_NAME': '0', 05:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:22:37 INFO - Installing collected packages: mozsystemmonitor 05:22:37 INFO - Running setup.py install for mozsystemmonitor 05:22:37 INFO - Successfully installed mozsystemmonitor 05:22:37 INFO - Cleaning up... 05:22:37 INFO - Return code: 0 05:22:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:37 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:37 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 05:22:37 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 05:22:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:37 INFO - 'HOME': '/Users/cltbld', 05:22:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:37 INFO - 'LOGNAME': 'cltbld', 05:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:37 INFO - 'MOZ_NO_REMOTE': '1', 05:22:37 INFO - 'NO_EM_RESTART': '1', 05:22:37 INFO - 'PAGER': '/bin/cat', 05:22:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:37 INFO - 'PWD': '/builds/slave/test', 05:22:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:37 INFO - 'SHELL': '/bin/bash', 05:22:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:37 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:37 INFO - 'USER': 'cltbld', 05:22:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:37 INFO - 'XPC_FLAGS': '0x0', 05:22:37 INFO - 'XPC_SERVICE_NAME': '0', 05:22:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:22:40 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 05:22:40 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 05:22:40 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 05:22:40 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 05:22:40 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 05:22:40 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 05:22:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:41 INFO - warning: no files found matching '*.txt' 05:22:41 INFO - no previously-included directories found matching 'build' 05:22:41 INFO - no previously-included directories found matching 'dist' 05:22:41 INFO - no previously-included directories found matching '.git*' 05:22:41 INFO - Installing collected packages: jsonschema, functools32 05:22:41 INFO - Running setup.py install for functools32 05:22:41 INFO - warning: no files found matching '*.txt' 05:22:41 INFO - no previously-included directories found matching 'build' 05:22:41 INFO - no previously-included directories found matching 'dist' 05:22:41 INFO - no previously-included directories found matching '.git*' 05:22:41 INFO - Successfully installed jsonschema functools32 05:22:41 INFO - Cleaning up... 05:22:41 INFO - Return code: 0 05:22:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:41 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 05:22:41 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 05:22:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:41 INFO - 'HOME': '/Users/cltbld', 05:22:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:41 INFO - 'LOGNAME': 'cltbld', 05:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:41 INFO - 'MOZ_NO_REMOTE': '1', 05:22:41 INFO - 'NO_EM_RESTART': '1', 05:22:41 INFO - 'PAGER': '/bin/cat', 05:22:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:41 INFO - 'PWD': '/builds/slave/test', 05:22:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:41 INFO - 'SHELL': '/bin/bash', 05:22:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:41 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:41 INFO - 'USER': 'cltbld', 05:22:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:41 INFO - 'XPC_FLAGS': '0x0', 05:22:41 INFO - 'XPC_SERVICE_NAME': '0', 05:22:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:22:41 INFO - Cleaning up... 05:22:41 INFO - Return code: 0 05:22:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:41 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:41 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 05:22:41 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 05:22:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:41 INFO - 'HOME': '/Users/cltbld', 05:22:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:41 INFO - 'LOGNAME': 'cltbld', 05:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:41 INFO - 'MOZ_NO_REMOTE': '1', 05:22:41 INFO - 'NO_EM_RESTART': '1', 05:22:41 INFO - 'PAGER': '/bin/cat', 05:22:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:41 INFO - 'PWD': '/builds/slave/test', 05:22:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:41 INFO - 'SHELL': '/bin/bash', 05:22:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:41 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:41 INFO - 'USER': 'cltbld', 05:22:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:41 INFO - 'XPC_FLAGS': '0x0', 05:22:41 INFO - 'XPC_SERVICE_NAME': '0', 05:22:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:42 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 05:22:42 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 05:22:42 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 05:22:42 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 05:22:42 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 05:22:42 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 05:22:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22:44 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 05:22:44 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 05:22:44 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 05:22:44 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 05:22:44 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 05:22:44 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 05:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22:45 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 05:22:45 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 05:22:45 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 05:22:45 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 05:22:45 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 05:22:45 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 05:22:45 INFO - Downloading docopt-0.6.1.tar.gz 05:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:46 INFO - Running setup.py install for blobuploader 05:22:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:46 INFO - Running setup.py install for requests 05:22:46 INFO - Running setup.py install for docopt 05:22:46 INFO - Successfully installed blobuploader requests docopt 05:22:46 INFO - Cleaning up... 05:22:46 INFO - Return code: 0 05:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:46 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:46 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 05:22:46 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 05:22:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:47 INFO - 'HOME': '/Users/cltbld', 05:22:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:47 INFO - 'LOGNAME': 'cltbld', 05:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:47 INFO - 'MOZ_NO_REMOTE': '1', 05:22:47 INFO - 'NO_EM_RESTART': '1', 05:22:47 INFO - 'PAGER': '/bin/cat', 05:22:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:47 INFO - 'PWD': '/builds/slave/test', 05:22:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:47 INFO - 'SHELL': '/bin/bash', 05:22:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:47 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:47 INFO - 'USER': 'cltbld', 05:22:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:47 INFO - 'XPC_FLAGS': '0x0', 05:22:47 INFO - 'XPC_SERVICE_NAME': '0', 05:22:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-DFELIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-YfdOFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-K8v576-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-8CyLEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-v_gJ5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-UzFG3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-lAIJYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:47 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-KipbiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-u3xlxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-gDvQHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-HvtDvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-QEQVcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-jvwdiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-QDKBhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-RIR1Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-XvdnCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:48 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-MrSt4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:49 INFO - Running setup.py install for manifestparser 05:22:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:49 INFO - Running setup.py install for mozcrash 05:22:49 INFO - Running setup.py install for mozdebug 05:22:49 INFO - Running setup.py install for mozdevice 05:22:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:49 INFO - Running setup.py install for mozfile 05:22:49 INFO - Running setup.py install for mozhttpd 05:22:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:49 INFO - Running setup.py install for mozinfo 05:22:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Running setup.py install for mozInstall 05:22:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Running setup.py install for mozleak 05:22:50 INFO - Running setup.py install for mozlog 05:22:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Running setup.py install for moznetwork 05:22:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Running setup.py install for mozprocess 05:22:50 INFO - Running setup.py install for mozprofile 05:22:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:50 INFO - Running setup.py install for mozrunner 05:22:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:51 INFO - Running setup.py install for mozscreenshot 05:22:51 INFO - Running setup.py install for moztest 05:22:51 INFO - Running setup.py install for mozversion 05:22:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:51 INFO - Cleaning up... 05:22:51 INFO - Return code: 0 05:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:51 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:51 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 05:22:51 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 05:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:51 INFO - 'HOME': '/Users/cltbld', 05:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:51 INFO - 'LOGNAME': 'cltbld', 05:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:51 INFO - 'MOZ_NO_REMOTE': '1', 05:22:51 INFO - 'NO_EM_RESTART': '1', 05:22:51 INFO - 'PAGER': '/bin/cat', 05:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:51 INFO - 'PWD': '/builds/slave/test', 05:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:51 INFO - 'SHELL': '/bin/bash', 05:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:51 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:51 INFO - 'USER': 'cltbld', 05:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:51 INFO - 'XPC_FLAGS': '0x0', 05:22:51 INFO - 'XPC_SERVICE_NAME': '0', 05:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:51 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-NoeGaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-gTVx9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Z3mv5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-uYq0kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-8Y_Bnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-MZZHKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-9oOsRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-YUOJje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-66fvxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-gzzsv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:52 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)) 05:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:52 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-GDciNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:53 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)) 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-5JVdm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:53 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)) 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-kWBwjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:53 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)) 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-XEuskP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:53 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)) 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-AfGjE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:53 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)) 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ZSbBSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:53 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)) 05:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:53 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-hFHTFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:53 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)) 05:22:53 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)) 05:22:53 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)) 05:22:53 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)) 05:22:53 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)) 05:22:53 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)) 05:22:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:53 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 05:22:53 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 05:22:53 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 05:22:53 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 05:22:53 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 05:22:53 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 05:22:56 INFO - Downloading blessings-1.6.tar.gz 05:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:56 INFO - Installing collected packages: blessings 05:22:56 INFO - Running setup.py install for blessings 05:22:56 INFO - Successfully installed blessings 05:22:56 INFO - Cleaning up... 05:22:56 INFO - Return code: 0 05:22:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:56 INFO - Reading from file tmpfile_stdout 05:22:56 INFO - Current package versions: 05:22:56 INFO - blessings == 1.6 05:22:56 INFO - blobuploader == 1.2.4 05:22:56 INFO - docopt == 0.6.1 05:22:56 INFO - functools32 == 3.2.3-2 05:22:56 INFO - jsonschema == 2.5.1 05:22:56 INFO - manifestparser == 1.1 05:22:56 INFO - mozInstall == 1.12 05:22:56 INFO - mozcrash == 1.0 05:22:56 INFO - mozdebug == 0.1 05:22:56 INFO - mozdevice == 0.49 05:22:56 INFO - mozfile == 1.2 05:22:56 INFO - mozhttpd == 0.7 05:22:56 INFO - mozinfo == 0.9 05:22:56 INFO - mozleak == 0.1 05:22:56 INFO - mozlog == 3.4 05:22:56 INFO - moznetwork == 0.27 05:22:56 INFO - mozprocess == 0.24 05:22:56 INFO - mozprofile == 0.28 05:22:56 INFO - mozrunner == 6.13 05:22:56 INFO - mozscreenshot == 0.1 05:22:56 INFO - mozsystemmonitor == 0.3 05:22:56 INFO - moztest == 0.8 05:22:56 INFO - mozversion == 1.4 05:22:56 INFO - psutil == 3.1.1 05:22:56 INFO - requests == 1.2.3 05:22:56 INFO - wsgiref == 0.1.2 05:22:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:56 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')]} 05:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:57 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 05:22:57 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 05:22:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:57 INFO - 'HOME': '/Users/cltbld', 05:22:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:57 INFO - 'LOGNAME': 'cltbld', 05:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:57 INFO - 'MOZ_NO_REMOTE': '1', 05:22:57 INFO - 'NO_EM_RESTART': '1', 05:22:57 INFO - 'PAGER': '/bin/cat', 05:22:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:57 INFO - 'PWD': '/builds/slave/test', 05:22:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:57 INFO - 'SHELL': '/bin/bash', 05:22:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:57 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:57 INFO - 'USER': 'cltbld', 05:22:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:57 INFO - 'XPC_FLAGS': '0x0', 05:22:57 INFO - 'XPC_SERVICE_NAME': '0', 05:22:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 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)) 05:22:57 INFO - Cleaning up... 05:22:57 INFO - Return code: 0 05:22:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:58 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 0x105732b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105735768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2a24c97e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, '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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 05:22:58 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 05:22:58 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 05:22:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:22:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:58 INFO - 'HOME': '/Users/cltbld', 05:22:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:58 INFO - 'LOGNAME': 'cltbld', 05:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:58 INFO - 'MOZ_NO_REMOTE': '1', 05:22:58 INFO - 'NO_EM_RESTART': '1', 05:22:58 INFO - 'PAGER': '/bin/cat', 05:22:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:58 INFO - 'PWD': '/builds/slave/test', 05:22:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:58 INFO - 'SHELL': '/bin/bash', 05:22:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:22:58 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:22:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:58 INFO - 'USER': 'cltbld', 05:22:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:58 INFO - 'XPC_FLAGS': '0x0', 05:22:58 INFO - 'XPC_SERVICE_NAME': '0', 05:22:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:22:58 INFO - Cleaning up... 05:22:58 INFO - Return code: 0 05:22:58 INFO - Running post-action listener: _resource_record_post_action 05:22:58 INFO - Running post-action listener: _start_resource_monitoring 05:22:58 INFO - Starting resource monitoring. 05:22:58 INFO - [mozharness: 2017-01-24 13:22:58.662918Z] Finished create-virtualenv step (success) 05:22:58 INFO - [mozharness: 2017-01-24 13:22:58.663854Z] Running install step. 05:22:58 INFO - Running pre-action listener: _resource_record_pre_action 05:22:58 INFO - Running main action method: install 05:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:58 INFO - Reading from file tmpfile_stdout 05:22:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:59 INFO - Reading from file tmpfile_stdout 05:22:59 INFO - Output received: 05:22:59 INFO - Usage: mozinstall [options] installer 05:22:59 INFO - Options: 05:22:59 INFO - -h, --help show this help message and exit 05:22:59 INFO - -d DEST, --destination=DEST 05:22:59 INFO - Directory to install application into. [default: 05:22:59 INFO - "/builds/slave/test"] 05:22:59 INFO - --app=APP Application being installed. [default: firefox] 05:22:59 INFO - mkdir: /builds/slave/test/build/application 05:22:59 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'] 05:22:59 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 05:23:18 INFO - Reading from file tmpfile_stdout 05:23:18 INFO - Output received: 05:23:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:23:18 INFO - Running post-action listener: _resource_record_post_action 05:23:18 INFO - [mozharness: 2017-01-24 13:23:18.746680Z] Finished install step (success) 05:23:18 INFO - [mozharness: 2017-01-24 13:23:18.746879Z] Running run-tests step. 05:23:18 INFO - Running pre-action listener: _resource_record_pre_action 05:23:18 INFO - Running main action method: run_tests 05:23:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:18 INFO - 2017-01-24 05:23:18.761 screenresolution[1620:7280] starting screenresolution argv=screenresolution get 05:23:18 INFO - 2017-01-24 05:23:18.763 screenresolution[1620:7280] Display 0: 1600x1200x32@60 05:23:18 INFO - 2017-01-24 05:23:18.769 screenresolution[1621:7283] starting screenresolution argv=screenresolution list 05:23:18 INFO - Available Modes on Display 0 05:23:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:18 INFO - Intel Iris: 05:23:18 INFO - Chipset Model: Intel Iris 05:23:18 INFO - Type: GPU 05:23:18 INFO - Bus: Built-In 05:23:18 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:18 INFO - Vendor: Intel (0x8086) 05:23:18 INFO - Device ID: 0x0a2e 05:23:18 INFO - Revision ID: 0x0009 05:23:18 INFO - Displays: 05:23:18 INFO - Display: 05:23:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:18 INFO - Display Serial Number: 1600x1200 60 05:23:18 INFO - Main Display: Yes 05:23:18 INFO - Mirror: Off 05:23:18 INFO - Online: Yes 05:23:18 INFO - Rotation: Supported 05:23:19 INFO - Return code: 0 05:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:19 INFO - Python 2.7.3 05:23:19 INFO - Return code: 0 05:23:19 INFO - grabbing minidump binary from tooltool 05:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:19 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 0x105510d30>, '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 0x105437db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105505be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:19 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 05:23:19 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 05:23:19 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 05:23:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:19 INFO - Return code: 0 05:23:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:23:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:23:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:19 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/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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 05:23:19 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/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0240 --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 05:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S8V0NRCJb1/Render', 05:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:19 INFO - 'HOME': '/Users/cltbld', 05:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:19 INFO - 'LOGNAME': 'cltbld', 05:23:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:19 INFO - 'MOZ_NO_REMOTE': '1', 05:23:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:19 INFO - 'NO_EM_RESTART': '1', 05:23:19 INFO - 'PAGER': '/bin/cat', 05:23:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:19 INFO - 'PWD': '/builds/slave/test', 05:23:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:19 INFO - 'SHELL': '/bin/bash', 05:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zbsZnAE2SN/Listeners', 05:23:19 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:19 INFO - 'USER': 'cltbld', 05:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:19 INFO - 'XPC_FLAGS': '0x0', 05:23:19 INFO - 'XPC_SERVICE_NAME': '0', 05:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:19 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/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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 05:23:19 INFO - mozversion application_buildid: 20170124034343 05:23:19 INFO - mozversion application_changeset: 41a10c805351ddaa8d8940a95f37be28cbf23f16 05:23:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:23:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:19 INFO - mozversion application_name: Firefox 05:23:19 INFO - mozversion application_remotingname: firefox-dev 05:23:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:23:19 INFO - mozversion application_vendor: Mozilla 05:23:19 INFO - mozversion application_version: 53.0a2 05:23:19 INFO - mozversion platform_buildid: 20170124034343 05:23:19 INFO - mozversion platform_changeset: 41a10c805351ddaa8d8940a95f37be28cbf23f16 05:23:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:23:19 INFO - mozversion platform_version: 53.0a2 05:23:19 INFO - using testdate: 1485264199 05:23:19 INFO - actual date: 1485264199 05:23:19 INFO - starting webserver on 'localhost:49236' 05:23:19 INFO - SUITE-START | Running 2 tests 05:23:19 INFO - TEST-START | dromaeo_css 05:23:19 INFO - operating with platform_type : mac_ 05:23:19 INFO - Initialising browser for dromaeo_css test... 05:23:19 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpIaOtkq/profile http://localhost:49236/getInfo.html) 05:23:21 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 05:23:21 INFO - PROCESS | 1631 | colorDepth:24 05:23:21 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 05:23:21 INFO - PROCESS | 1631 | __metrics 05:23:22 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 05:23:22 INFO - PROCESS | 1631 | 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" 05:23:22 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:22 INFO - TEST-INFO | 1631: exit 0 05:23:22 INFO - Browser initialized. 05:23:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:22 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpIaOtkq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:34 INFO - PROCESS | 1633 | RSS: Main: 212406272 05:23:34 INFO - PROCESS | 1633 | 05:26:38 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 05:26:39 INFO - PROCESS | 1633 | RSS: Main: 345075712 05:26:39 INFO - PROCESS | 1633 | 05:28:23 INFO - PROCESS | 1633 | ************************* 05:28:23 INFO - PROCESS | 1633 | A coding exception was thrown and uncaught in a Task. 05:28:23 INFO - PROCESS | 1633 | 05:28:23 ERROR - PROCESS | 1633 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:28:23 INFO - PROCESS | 1633 | Full stack: 05:28:23 INFO - PROCESS | 1633 | ************************* 05:29:42 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 05:29:43 INFO - PROCESS | 1633 | RSS: Main: 351666176 05:29:43 INFO - PROCESS | 1633 | 05:32:45 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 05:32:46 INFO - PROCESS | 1633 | RSS: Main: 347987968 05:32:46 INFO - PROCESS | 1633 | 05:35:48 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 05:35:48 INFO - PROCESS | 1633 | RSS: Main: 324997120 05:35:48 INFO - PROCESS | 1633 | 05:38:52 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 05:38:53 INFO - PROCESS | 1633 | RSS: Main: 316440576 05:38:53 INFO - PROCESS | 1633 | 05:41:55 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 05:41:56 INFO - PROCESS | 1633 | RSS: Main: 378413056 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | __start_tp_report 05:41:56 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 05:41:56 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 05:41:56 INFO - PROCESS | 1633 | |i|pagename|runs| 05:41:56 INFO - PROCESS | 1633 | |0;dojo.html;3302.223977365319;3331.117253927709;3333.8666453341853;3337.2324365395957;3347.364000839842;5788.102844059173;5807.506361959233;5810.970945145279;5811.0702287633985;5824.621399609023;5745.971270143644;5805.390434004422;5831.446012628793;5834.21238132852;5838.708064596774;5241.947580524184;5310.8141215057485;5312.495312945283;5329.573634109262;5367.973160134194;5195.870103247411;5211.1922651989;5215.843524694246;5318.494742999409;5377.731113444332;5214.478552144793;5255.973720131394;5264.8683782905355;5302.840914772563;5336.839894803162;5340.652857564265;5348.705821179834;5354;5354.866128346784;5357.491038351351;5150.356205474316;5216.765245563959;5280.9207861882105;5294;5325.760340784635;5732.656040637534;5785.652860828363;5795.913061304083;5797.043487824504;5807.186993820868;6207.534434917354;6287.622742635456;6290;6294.307626161164;6305.306416294204;6321.841953951142;6340.175777148941;6370.840728981766;6372.362763723637;6389.968050159766;5966.642001479881;5969.492593129546;6000.279966404016;6014.117506603622;6039.456448919618;6334.778282760081;6393.968030159819;6402.295747467775;6408.070829729756;6438.163038804925;6102.847428814226;6181.752729890754;6194.6991131862815;6224.875502489925;6336.144620476269;6371.235451745728;6374.681265936684;6376.936230637634;6377.107204991305;6378.776742814072;5181;6353.936460635427;6361.2048493938255;6370.968145159244;6380.680965951684;6223.657698826608;6247.656378899204;6262.248530176408;6284.088807123033;6337.714802833883;5032.7735251913755;5048.62135339851;5054.570361519239;5063.87340316495;5080.872978175576;4495.393121928563;4499.505054444008;4504.301833215857;4505.279155335131;4522.977385113053;5647.407022262603;5667.574931880125;5711.457411545896;5718.857028574319;5779.942200578024;6303.212098487689;6304.148939893147;6324.494040476843;6332.873342533124;6382.968085159638;5653.152027195872;5688.317401911714;5781.075027995501;5801.216835727208;5828.358880523139;5472.26124473199;5506.8347949560775;5514.117741161475;5516.9448305516435;5527.364353099365;6302.810915672537;6343.651099189405;6371.267304260069;6388.968055159788;6427.58220715652;6266.436020758154;6336.398042185985;6344.682765861596;6347.71435285404;6353.841153971003;6417;6422.678866056772;6446.774362897276;6455.160829092188;6458.289588145394;6146.723397447036;6204.317525072148;6302.873942521032;6322.083297921868;6344.587601805868;6206.751729930752;6276.497880169667;6295.811125666238;6331.841703957253;6351.841203969938;6179.907301390393;6215.378462153749;6230.06549017651;6230.844228894314;6234.251889773075;6042.516598672008;6088.726007329769;6091.604045737013;6131.877362452815;6160.9383906160365;5985.191999080069;6007.669578173242;6067;6086.056661217518;6126.792505495216;6178.567500274938;6248.750049998131;6253.687315634109;6270.623762574078;6284.780032698834;5828.6211396259105;6041.916794117507;6101.298350689727;6108.236470441195;6117.082437634391 05:41:56 INFO - PROCESS | 1633 | |1;ext.html;443.00766283524916;489.17085540009674;491.6779509421328;499.47161685243134;501.5861913921015;31201;33290;33422.331553368946;41791.746247612624;43630.563694363045;44424.555754442445;44798.10403791922;44892;45002;45054.32418513725;9352.906470935306;9558.522073896313;9559.378640388388;9573.42559446432;9580.425174489554;8527.976642802872;8745.95627021864;9407.576659050359;11222.719432014183;11487.310761354303;11453.828192577119;11504.597339093134;11507.59723409681;11510.482028308705;11527.25072870265;11485.59800406986;11556.653300401002;11562.826557601642;11571.016463600647;11572;8409.873851892227;8640;11098.223124381297;11391.601293954755;11408.429578521042;42401.36397954033;42629.36055959163;42666.57333426657;42785;42875;4031.9193616127804;4051.9594804051876;4052.8176232069627;4067.450894129314;4093.2018256440006;29641.258968525744;30331;30455;31211.37577248465;32456.02631921046;3252.0406480088195;3262.7438436201996;3309.271960168783;3388.1868351595685;3418.4017796885696;486858;488259;488793;488830;490060;63786;64019;64128;64157.358426416075;64183;67678.98481522781;67823.32176678268;67826.66086669634;67960.98058529125;67992;17196;17399.47801565955;17427.04151271692;17489.912550437166;17501.94988300706;12029.759404811855;13321.866781332063;13427.19436833793;13433.932830335785;13478.595642130751;15094.018888772194;16873.409430669868;17286.740698889527;17296.567585810455;17682.027488488;5776.451237132465;6510.3489651034515;6532.608043517404;6548.6725663716625;6574.737010519526;742.3319012888444;877.1491653096487;909.6179604566098;930.2325581395376;932.5710173320213;29789.702102979125;30257;30452.238694032825;31016.68983310183;31116.844415777778;1035.9792804143874;1044.0759927464096;1065.9520321585546;1068.9946550267355;1087.2606627493221;12431.502739890304;14598.708025839636;14630.341634626468;14631.487897923735;14904.403823846924;623612;627189;627300;628856;630175;53546;53661;53695.46304536905;53721.92556148933;53933.46066539284;1432.8853691704846;1439.3163247457373;1453.9636509087145;1455.1269238457264;1460.3720400227792;20550;26874.790634421108;27647.58528622032;28134;28320.433591327645;47434.52565474439;47785.52214477811;47805;47822.04355912932;47873.76063119662;531646;533810;534258;534444;535488;24658.63012054785;24921.003159873402;24924.252272431855;24946.251612451655;24957.376065598506;42278.788606058006;42538;42641.36037959495;42818;44014.11971760611;35612.64387356093;36230;36247.09382265464;36262.09344766402;36763.89708308755;35381;35539.466907995884;35567.46648800322;35612.465813012306;35915.28169436545;26619.467610648066;34586.654133458345;34805.47791783074;35113.64886351206;35903.820480898474;29704.70295297106;32724.83637581797;32927.341453170324;33120.668793312725;33129.006129816145;20566;25100.874495627406;25154;25491.872540637178;25584.360390990376 05:41:56 INFO - PROCESS | 1633 | |2;jquery.html;365.3551481634914;365.67272291299287;370.13757943990504;391.6142599539453;402.255826720567;15354.385824567018;15414.537563873073;17415.999999999985;21270;21460.785392146074;17733.911330443363;18602.44192674222;21292.4676883078;21677;21962.670559941573;5857.6485410875275;5871;6039.335673075958;6073.180120683717;6104.084387341912;5600.5519558435435;5977.641341519501;6032.215811944441;6044.909326360108;6047.727852246638;4199.3910882921955;4411.88970275744;5997.820065398023;6321.620702757849;6576.93423065768;5785.103308987113;6681.632510211961;6687.866242675168;6694.263631000586;6702.296258892844;5858.853528661775;6003.279606447254;6007.969960150172;6013.218281623404;6019.939800602026;13575.185488870698;13809.51666691661;13827.654308642264;13840.30798460073;24284.421512601803;2570.2417786752767;2583.5607946649116;2652.9602055969176;2654.4027593791434;2697.7994792317427;9951.601935922554;9989.75025624358;10059.446730429823;10424.68725938223;10481.737956551071;1573.9297277851056;1688.8311168883135;1776.733489976501;1798.6222893192446;1830.6796310645584;139092.30453847666;140916.29541852328;145132.27433862764;149072.99999999892;151806;11735.657806611609;11810.881891180978;11891.405429728651;11977.64067077989;12074.698132546757;15436.845631543541;15528.689426211413;15558.611034724223;15574.922125389527;15600.375984960474;8553.786155346166;8858.424202426822;8888.3333749969;8964.327675424369;8972.057933916845;8687.435316704394;8688.478691278417;8712.825743485095;8870.645174193089;8877.73366798997;4697.553732395485;4792.185328494164;4805.1590971579835;4871.5128487151005;4914.582260507826;1978.2482656590403;2023.1401654296865;2041.3875837248765;2044.4582185720797;2046.4781480722618;379.1734019836782;406.794568742783;1010.2524132142162;1046.733821276942;1058.5818601652459;11162.441877906072;11737.941310293394;11776.587819426279;12030.939845300893;12339;416.96455801257235;420.3904338708823;424.58390777038056;438.2440290498864;444.9666275029386;6078.574499785061;6103.176071230327;6110.694465276719;6121.326654068049;6263.843403914939;436928;686264;688648;718642;728831;89883;125560;142048;143242;149072;455.16477264219867;465.9603933665609;466.1097304149059;467.2827210232345;467.55348642046766;10917.39954302521;11061.391623460788;11098.944505277423;11139.94430027877;11200.271982321123;56104;56856.43143568677;58727.82544349175;58841;58967.70516147392;73022;84873.45379638621;87784;89715;90623;7038.542494737826;7637.670510494352;8392.076871544248;8400.915990840012;8477.448965817202;11968.401579921143;12388.132830702125;12514.56199033066;12615.87384126147;12699.619011429671;10746.731331716457;11093.889061109609;11094.334339939629;11369.943150284196;11386.259893106922;9134.725958221265;9541.618335266789;10899.964503372166;11054.889451105386;11408.144389171011;9428.962814090308;10992.780144397228;11402.429878506207;11436.656900293005;11500.597479088192;6319.873602527831;6975.674621821838;7137.2149063604;7615.847683046197;8324;9007.459552426613;10950.178736594946;11081.390523521284;11223.326600404002;11363.034142097684 05:41:56 INFO - PROCESS | 1633 | |3;mootools.html;1431.9856801431984;1446.3491428857017;1462.261557913254;1466.6626675864552;1471.7498025335692;8097.919020809797;8438;8442.113578074306;8446.408751387398;8462.87305690415;7396.260373962601;7690.346320562745;7699.923000769991;7956.641951112199;8210;2248.617734985048;2287.142321629389;2289.645105008726;2295.735990361105;2296.47181148336;2288.107638021173;2311.295055008222;2338.9064437422485;2341.0401735288533;2341.3327201747506;2248.7076680031573;2258.108047321307;2286.702728645274;2288.8969996350206;2293;1912.311567835578;2274.9545009099807;2277.2029789573767;2300.7469178390365;2324.7442781294044;2272.761360057203;2343.1564636730764;2347.4248809041724;2348.5302939412186;2350.6944097267246;7207.711691532332;8328.333733301382;8438.620262088221;8454.746357609281;8477.576121193915;4372.3878656988045;5050.545450909436;5204.76578553966;5221.791128354861;5224.791008359661;2980.6274215723033;3296.456084746014;3332.800031998088;3506.7019303359243;3562.9643703562892;1213.2841623442123;1213.3074361266072;1229.274727910537;1243.832082668837;1264.4499642655474;9063.50150741709;10780.622678206226;10885.564577416893;10888.237823352289;10895.291806032661;4366.956330436718;4606.677532572755;4689.179393606105;4706.858794236178;4719.433667959866;9557.092076252746;9561.665341713007;9574.234061275081;9577.808443831085;9583.952080239693;5174.172132458789;5249.291345668362;5258.50044245796;5260.684358938476;5286.973565132226;4270.7864606769535;4424.247877860771;4568.543145685471;4710.670253082251;4749.240121580599;3384.086296699877;3720.2373513429684;3754.5494540655295;3834;3984.920301593952;1139.925904816201;1284.6017734502148;1289.9419526121346;1302.4985380628527;1303.7392521495549;788.5662885413;870.3994243971639;903.8553831386946;915.1534830282095;920.9355345125776;5448.809291674773;5537.141743029837;5622.269105016322;5736.5123964462655;5891.057430811135;1007.2747621712501;1022.8977102289712;1024.861643678094;1033.4471057983942;1041.8697662792151;3447.8103704296004;3710.5547334319513;3761.304158730589;3770.434434834797;3895.376739721631;8441.324694024463;10069.949650251849;10070.194384449227;10083.949580252198;10091.293609447268;9957.402555846673;10041.04610062043;10059.5473203706;10066.144377727975;10077.09306162449;7606.885896711554;7767.883481747778;7806.1803510632835;7899.210078992055;7910.802229944297;5408.972955135199;5464.3442786865835;5511.255980442749;5628.831135065954;5727.284089488814;9238.076192380708;9319.114684105;9326.673566425143;9449.385789923634;9458.905410946078;8264.586770661563;8935.955320223356;9484.905150948402;9488.762780930532;9504;6263.123162757127;6454.612723236621;6463.709133089116;6626.237982632059;6776.830579235559;7632.465727399029;7773.533587984739;7901.130875603564;7974.561399123104;7983;7010.894836577558;7106.964465177641;7124.5725256484775;7174.282571742784;7241.5293005954445;6693;6780.96609516969;6927.826804329932;6981.057557229709;7020.333068358498;6262.248530176408;6386.978083506617;6411.903821442589;6488.935110648833;6497.252815926229;4977.328060711758;5001.4998500149695;5070.721110338966;5078.898422031612;5091.66904151229;4975.527324904128;5058.645894787477;5095.235714642833;5177.068127737043;5238.057149713089 05:41:56 INFO - PROCESS | 1633 | |4;prototype.html;308.7900227845065;352.5276129985819;354.6990230997738;369.92231631357413;372.89745320036985;5313.548348390386;5364.5708343332535;5364.651297665649;5377.91933121003;5404.648697834638;4260.467441569804;4957.776900039498;5080;5110.361204849394;5331.253624492574;3529.329427408797;3661.5789184243754;3844.384898416254;4071.531773846001;4143.792810359485;3446.6036405813275;4078.6940979426513;4101.2617728808955;4144.8963775905695;4201.138766552849;3760.8683696070643;3900.9804950975204;3972.1857019310974;4083.9795801020955;4145.668346532285;3801.4107813288983;3833.5974722654278;4071.6335529802163;4111.60939710727;4135.855245066423;3496.9683943236805;3554;3598;3628.8548458061646;3652.415613501827;4128.121704624388;4924.852254432372;5037.793442475538;5084.3898732152375;5091.567216786578;4593.609543188833;4695.624350051988;4730.290456431529;4733.692309999839;4741;5500.614956953015;5537.36320323164;5545.584081193927;5546.528545073674;5632;3882.3594106972596;4011.277969965405;4035.757854528738;4050.736702114353;4053.7770422626745;4805.014971930781;5043.393973309102;5717.113847353625;5728.856778580569;5794.203796823041;4056.3915412687743;4065.8170382332864;4078.836846526165;4099.057216840143;4126.958730412657;4191.392248124066;4198.097409057067;4213.810378532973;4215.262329092458;4216.388623649615;3938.940915886264;4012.5028710666575;4627.583517483443;4659.603933665609;4760.78623440102;5501.669899806025;5516.420775818561;5596.356419011784;5599.720013999284;5610.579206559442;1112.7496313329436;1218.3055658274698;1331.094855498251;1351.1825345665927;1363.2502123831853;787.366170232968;838.781916701662;893.2095095840099;935.6725146198776;956.9521374095355;4227.32362821947;4391.012022295022;4401.955980440219;4537.4328208973875;4823.445303790038;4999.600191907832;5425.701586412706;5432.864178395572;5452.345718513804;5461.617686761968;4549;4783.736894470838;4860.646154153623;4888.706677599355;4902.48523904992;2276.918463729748;2572.9099481518056;2761.6962134165224;2819.2238889499486;2841.3891013432212;4873.31773551703;4942.481039490874;5629.819152179006;5652.74562644682;5662.244704141729;4741.230721576355;4951.950480495221;4960.975195124001;5502.523864261098;5595.272614560081;5223.216517522402;5620.297462817148;5645.887082258332;5652.802151924663;5674.205611214434;4903.60771138301;5369.704666243238;5375.838724838261;5380.973095134499;5430.212619170277;5332.466753324637;5351.892962140658;5372.946270537244;5583.162525621189;5588.469095435927;5069.619778516552;5171.741412929414;5434.266374039612;5891.587588868738;6039.667818270037;3363.2264579146445;3835.712321575949;3861.440091186706;3888.6694630956686;3896.220755848785;4520.6383489320115;4882.9257563336005;5486.204500347507;5508.779648814003;5706.28671416073;4870.586000190024;5511.255980442589;5512.503874651301;5524.861878453071;5528.1253748049985;4330.761808100585;4890.6332025097545;5357.758900849549;5556.72216389187;5623.943760562342;5242.7902883885745;5387.838364849061;5419.512243898068;5444.992676354887;5517.310336207974;4643.721376717408;4775.5463230993;5348.1442969124755;5356.3572371315695;5598.832035038792;5395.163749618815;5401.189821526802;5403.648762830403;5426.457354264542;5492.670439773627 05:41:56 INFO - PROCESS | 1633 | |5;yui.html;605.712286663835;726.9636518174093;774.1076397169885;820.8645573480375;827.6110228192751;14477.276136193188;15483.535493935171;15488.922555387235;15513.844861551395;15527.378904843821;14077.225752583603;14210.431582736705;14225.217613031278;14232.92883535581;14236.501722439716;674.81442603284;699.5942353435021;704.5807744392079;858.7252079334615;875.2341701011583;842.7640260727006;863.201538576814;881.2333270055061;882.0870399136894;883.6642076011107;936.1200471556715;942.4157022645969;943.03810113684;945.0738276489045;945.7871978804783;716.7706333973131;738.1290077708302;935.1677007463329;939.2579861909084;940.219617717293;664.9434798042172;686.739039165119;691.3017851969547;692.2834865913806;696.5402834129501;15060.32228549718;15068.773968390373;15069.47256846005;15074.54776356711;15092.16993065381;13169.473221071146;13192.340382980812;13345.666358341023;13496.595102146952;13601.863981360159;12710.712071827067;13147.424211566844;13258.933705331508;13320;13449.193048417028;4438.223310920576;4471.552844715535;4558.817647294104;4574.428196475441;4643.698159619614;101849;102233.48883255536;102377;103718.48140759324;104782;10604.083455307686;10849.945750271198;10989.505472253608;10991.340519568852;11125.109991200685;20950.266740664003;20975;21014.159433622484;21251.46871328198;21303.68044479303;7472.925270747223;7940.404469664798;7995.5202687837755;8026.478278911852;8161.102278749333;4353.434053573015;4362.563743625676;4504.61710754583;4520.254158063948;4575.771211439482;3608;3635.8545658173375;3673.9265214695556;3703.0742314421395;3720.088578298334;570.5635189080357;675.6486626954055;676.7394553097093;679.8912174052227;681.3697329969758;694.1046050594676;696.6830092307988;709.61326077288;712.5154894671673;767.6392095715005;8804.823903521894;9775.364601300893;10051.24615653829;10094.343867648726;10609.893901061045;555.4334578729673;621.9533534984804;694.2193274251529;713.9571625702474;714.9392301654418;4956.355673762388;5042.974785126051;5051.26756620288;5055.87360315995;5058.772355244023;106444;106951;107121.46439267753;107438;107703.46148269209;69581;81536.59231703922;85294;92818.53590732004;94965.5251723737;75695.62152189204;82653;82861;85490.58037678548;85801.14198858057;9472.431654100776;10353;11119.666410007712;11129.775724670442;11197.81778941293;48423.5157648419;48676.269855952894;51605.741971289906;53290;54550.18174727462;61133.69433152806;63641.681791590745;69163;72827.63586182035;73091.26908730845;11892.929636332772;13587.59237222885;13689;13745.175289482662;14052.578422647337;14011;14754.188519631523;15118;15208.695826083638;15375.846241537442;13924.930375348058;14202.360893759598;14257.572272831832;14266.144031358152;14528.709425811636;14133.575992720234;14137.787933181216;14260;14316.141031538142;14553.490627827976;13474.393652285868;13803.930980345034;14233.857661423253;14326;14614.415423382945;11021.393823339793;11027.724306892393;11126.221164518729;11587.42062896835;11663.183577149519;8718.60766265507;10955.34267943926;11162.832557511807;11192.608258710907;11216.383098929637 05:41:56 INFO - PROCESS | 1633 | __end_tp_report 05:41:56 INFO - PROCESS | 1633 | __start_cc_report 05:41:56 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,1294 05:41:56 INFO - PROCESS | 1633 | __end_cc_report 05:41:56 INFO - PROCESS | 1633 | __startTimestamp1485265316208__endTimestamp 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | ------- Summary: start ------- 05:41:56 INFO - PROCESS | 1633 | Number of tests: 6 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5830.71 Median:6086.06 stddev:655.30 (10.8%) stddev-sans-first:626.57 05:41:56 INFO - PROCESS | 1633 | Values: 3302.2 3331.1 3333.9 3337.2 3347.4 5788.1 5807.5 5811.0 5811.1 5824.6 5746.0 5805.4 5831.4 5834.2 5838.7 5241.9 5310.8 5312.5 5329.6 5368.0 5195.9 5211.2 5215.8 5318.5 5377.7 5214.5 5256.0 5264.9 5302.8 5336.8 5340.7 5348.7 5354.0 5354.9 5357.5 5150.4 5216.8 5280.9 5294.0 5325.8 5732.7 5785.7 5795.9 5797.0 5807.2 6207.5 6287.6 6290.0 6294.3 6305.3 6321.8 6340.2 6370.8 6372.4 6390.0 5966.6 5969.5 6000.3 6014.1 6039.5 6334.8 6394.0 6402.3 6408.1 6438.2 6102.8 6181.8 6194.7 6224.9 6336.1 6371.2 6374.7 6376.9 6377.1 6378.8 5181.0 6353.9 6361.2 6371.0 6380.7 6223.7 6247.7 6262.2 6284.1 6337.7 5032.8 5048.6 5054.6 5063.9 5080.9 4495.4 4499.5 4504.3 4505.3 4523.0 5647.4 5667.6 5711.5 5718.9 5779.9 6303.2 6304.1 6324.5 6332.9 6383.0 5653.2 5688.3 5781.1 5801.2 5828.4 5472.3 5506.8 5514.1 5516.9 5527.4 6302.8 6343.7 6371.3 6389.0 6427.6 6266.4 6336.4 6344.7 6347.7 6353.8 6417.0 6422.7 6446.8 6455.2 6458.3 6146.7 6204.3 6302.9 6322.1 6344.6 6206.8 6276.5 6295.8 6331.8 6351.8 6179.9 6215.4 6230.1 6230.8 6234.3 6042.5 6088.7 6091.6 6131.9 6160.9 5985.2 6007.7 6067.0 6086.1 6126.8 6178.6 6248.8 6253.7 6270.6 6284.8 5828.6 6041.9 6101.3 6108.2 6117.1 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:68241.52 Median:35612.55 stddev:147687.61 (414.7%) stddev-sans-first:148014.19 05:41:56 INFO - PROCESS | 1633 | Values: 443.0 489.2 491.7 499.5 501.6 31201.0 33290.0 33422.3 41791.7 43630.6 44424.6 44798.1 44892.0 45002.0 45054.3 9352.9 9558.5 9559.4 9573.4 9580.4 8528.0 8746.0 9407.6 11222.7 11487.3 11453.8 11504.6 11507.6 11510.5 11527.3 11485.6 11556.7 11562.8 11571.0 11572.0 8409.9 8640.0 11098.2 11391.6 11408.4 42401.4 42629.4 42666.6 42785.0 42875.0 4031.9 4052.0 4052.8 4067.5 4093.2 29641.3 30331.0 30455.0 31211.4 32456.0 3252.0 3262.7 3309.3 3388.2 3418.4 486858.0 488259.0 488793.0 488830.0 490060.0 63786.0 64019.0 64128.0 64157.4 64183.0 67679.0 67823.3 67826.7 67961.0 67992.0 17196.0 17399.5 17427.0 17489.9 17501.9 12029.8 13321.9 13427.2 13433.9 13478.6 15094.0 16873.4 17286.7 17296.6 17682.0 5776.5 6510.3 6532.6 6548.7 6574.7 742.3 877.1 909.6 930.2 932.6 29789.7 30257.0 30452.2 31016.7 31116.8 1036.0 1044.1 1066.0 1069.0 1087.3 12431.5 14598.7 14630.3 14631.5 14904.4 623612.0 627189.0 627300.0 628856.0 630175.0 53546.0 53661.0 53695.5 53721.9 53933.5 1432.9 1439.3 1454.0 1455.1 1460.4 20550.0 26874.8 27647.6 28134.0 28320.4 47434.5 47785.5 47805.0 47822.0 47873.8 531646.0 533810.0 534258.0 534444.0 535488.0 24658.6 24921.0 24924.3 24946.3 24957.4 42278.8 42538.0 42641.4 42818.0 44014.1 35612.6 36230.0 36247.1 36262.1 36763.9 35381.0 35539.5 35567.5 35612.5 35915.3 26619.5 34586.7 34805.5 35113.6 35903.8 29704.7 32724.8 32927.3 33120.7 33129.0 20566.0 25100.9 25154.0 25491.9 25584.4 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:36744.59 Median:396.94 stddev:110885.23 (27935.4%) stddev-sans-first:111162.64 05:41:56 INFO - PROCESS | 1633 | Values: 365.4 365.7 370.1 391.6 402.3 15354.4 15414.5 17416.0 21270.0 21460.8 17733.9 18602.4 21292.5 21677.0 21962.7 5857.6 5871.0 6039.3 6073.2 6104.1 5600.6 5977.6 6032.2 6044.9 6047.7 4199.4 4411.9 5997.8 6321.6 6576.9 5785.1 6681.6 6687.9 6694.3 6702.3 5858.9 6003.3 6008.0 6013.2 6019.9 13575.2 13809.5 13827.7 13840.3 24284.4 2570.2 2583.6 2653.0 2654.4 2697.8 9951.6 9989.8 10059.4 10424.7 10481.7 1573.9 1688.8 1776.7 1798.6 1830.7 139092.3 140916.3 145132.3 149073.0 151806.0 11735.7 11810.9 11891.4 11977.6 12074.7 15436.8 15528.7 15558.6 15574.9 15600.4 8553.8 8858.4 8888.3 8964.3 8972.1 8687.4 8688.5 8712.8 8870.6 8877.7 4697.6 4792.2 4805.2 4871.5 4914.6 1978.2 2023.1 2041.4 2044.5 2046.5 379.2 406.8 1010.3 1046.7 1058.6 11162.4 11737.9 11776.6 12030.9 12339.0 417.0 420.4 424.6 438.2 445.0 6078.6 6103.2 6110.7 6121.3 6263.8 436928.0 686264.0 688648.0 718642.0 728831.0 89883.0 125560.0 142048.0 143242.0 149072.0 455.2 466.0 466.1 467.3 467.6 10917.4 11061.4 11098.9 11139.9 11200.3 56104.0 56856.4 58727.8 58841.0 58967.7 73022.0 84873.5 87784.0 89715.0 90623.0 7038.5 7637.7 8392.1 8400.9 8477.4 11968.4 12388.1 12514.6 12615.9 12699.6 10746.7 11093.9 11094.3 11369.9 11386.3 9134.7 9541.6 10900.0 11054.9 11408.1 9429.0 10992.8 11402.4 11436.7 11500.6 6319.9 6975.7 7137.2 7615.8 8324.0 9007.5 10950.2 11081.4 11223.3 11363.0 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5393.07 Median:5093.45 stddev:2927.24 (57.5%) stddev-sans-first:2920.31 05:41:56 INFO - PROCESS | 1633 | Values: 1432.0 1446.3 1462.3 1466.7 1471.7 8097.9 8438.0 8442.1 8446.4 8462.9 7396.3 7690.3 7699.9 7956.6 8210.0 2248.6 2287.1 2289.6 2295.7 2296.5 2288.1 2311.3 2338.9 2341.0 2341.3 2248.7 2258.1 2286.7 2288.9 2293.0 1912.3 2275.0 2277.2 2300.7 2324.7 2272.8 2343.2 2347.4 2348.5 2350.7 7207.7 8328.3 8438.6 8454.7 8477.6 4372.4 5050.5 5204.8 5221.8 5224.8 2980.6 3296.5 3332.8 3506.7 3563.0 1213.3 1213.3 1229.3 1243.8 1264.4 9063.5 10780.6 10885.6 10888.2 10895.3 4367.0 4606.7 4689.2 4706.9 4719.4 9557.1 9561.7 9574.2 9577.8 9584.0 5174.2 5249.3 5258.5 5260.7 5287.0 4270.8 4424.2 4568.5 4710.7 4749.2 3384.1 3720.2 3754.5 3834.0 3984.9 1139.9 1284.6 1289.9 1302.5 1303.7 788.6 870.4 903.9 915.2 920.9 5448.8 5537.1 5622.3 5736.5 5891.1 1007.3 1022.9 1024.9 1033.4 1041.9 3447.8 3710.6 3761.3 3770.4 3895.4 8441.3 10069.9 10070.2 10083.9 10091.3 9957.4 10041.0 10059.5 10066.1 10077.1 7606.9 7767.9 7806.2 7899.2 7910.8 5409.0 5464.3 5511.3 5628.8 5727.3 9238.1 9319.1 9326.7 9449.4 9458.9 8264.6 8936.0 9484.9 9488.8 9504.0 6263.1 6454.6 6463.7 6626.2 6776.8 7632.5 7773.5 7901.1 7974.6 7983.0 7010.9 7107.0 7124.6 7174.3 7241.5 6693.0 6781.0 6927.8 6981.1 7020.3 6262.2 6387.0 6411.9 6488.9 6497.3 4977.3 5001.5 5070.7 5078.9 5091.7 4975.5 5058.6 5095.2 5177.1 5238.1 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4447.57 Median:4896.56 stddev:1324.77 (27.1%) stddev-sans-first:1291.55 05:41:56 INFO - PROCESS | 1633 | Values: 308.8 352.5 354.7 369.9 372.9 5313.5 5364.6 5364.7 5377.9 5404.6 4260.5 4957.8 5080.0 5110.4 5331.3 3529.3 3661.6 3844.4 4071.5 4143.8 3446.6 4078.7 4101.3 4144.9 4201.1 3760.9 3901.0 3972.2 4084.0 4145.7 3801.4 3833.6 4071.6 4111.6 4135.9 3497.0 3554.0 3598.0 3628.9 3652.4 4128.1 4924.9 5037.8 5084.4 5091.6 4593.6 4695.6 4730.3 4733.7 4741.0 5500.6 5537.4 5545.6 5546.5 5632.0 3882.4 4011.3 4035.8 4050.7 4053.8 4805.0 5043.4 5717.1 5728.9 5794.2 4056.4 4065.8 4078.8 4099.1 4127.0 4191.4 4198.1 4213.8 4215.3 4216.4 3938.9 4012.5 4627.6 4659.6 4760.8 5501.7 5516.4 5596.4 5599.7 5610.6 1112.7 1218.3 1331.1 1351.2 1363.3 787.4 838.8 893.2 935.7 957.0 4227.3 4391.0 4402.0 4537.4 4823.4 4999.6 5425.7 5432.9 5452.3 5461.6 4549.0 4783.7 4860.6 4888.7 4902.5 2276.9 2572.9 2761.7 2819.2 2841.4 4873.3 4942.5 5629.8 5652.7 5662.2 4741.2 4952.0 4961.0 5502.5 5595.3 5223.2 5620.3 5645.9 5652.8 5674.2 4903.6 5369.7 5375.8 5381.0 5430.2 5332.5 5351.9 5372.9 5583.2 5588.5 5069.6 5171.7 5434.3 5891.6 6039.7 3363.2 3835.7 3861.4 3888.7 3896.2 4520.6 4882.9 5486.2 5508.8 5706.3 4870.6 5511.3 5512.5 5524.9 5528.1 4330.8 4890.6 5357.8 5556.7 5623.9 5242.8 5387.8 5419.5 5445.0 5517.3 4643.7 4775.5 5348.1 5356.4 5598.8 5395.2 5401.2 5403.6 5426.5 5492.7 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:20714.77 Median:4036.76 stddev:29524.81 (731.4%) stddev-sans-first:29569.02 05:41:56 INFO - PROCESS | 1633 | Values: 605.7 727.0 774.1 820.9 827.6 14477.3 15483.5 15488.9 15513.8 15527.4 14077.2 14210.4 14225.2 14232.9 14236.5 674.8 699.6 704.6 858.7 875.2 842.8 863.2 881.2 882.1 883.7 936.1 942.4 943.0 945.1 945.8 716.8 738.1 935.2 939.3 940.2 664.9 686.7 691.3 692.3 696.5 15060.3 15068.8 15069.5 15074.5 15092.2 13169.5 13192.3 13345.7 13496.6 13601.9 12710.7 13147.4 13258.9 13320.0 13449.2 4438.2 4471.6 4558.8 4574.4 4643.7 101849.0 102233.5 102377.0 103718.5 104782.0 10604.1 10849.9 10989.5 10991.3 11125.1 20950.3 20975.0 21014.2 21251.5 21303.7 7472.9 7940.4 7995.5 8026.5 8161.1 4353.4 4362.6 4504.6 4520.3 4575.8 3608.0 3635.9 3673.9 3703.1 3720.1 570.6 675.6 676.7 679.9 681.4 694.1 696.7 709.6 712.5 767.6 8804.8 9775.4 10051.2 10094.3 10609.9 555.4 622.0 694.2 714.0 714.9 4956.4 5043.0 5051.3 5055.9 5058.8 106444.0 106951.0 107121.5 107438.0 107703.5 69581.0 81536.6 85294.0 92818.5 94965.5 75695.6 82653.0 82861.0 85490.6 85801.1 9472.4 10353.0 11119.7 11129.8 11197.8 48423.5 48676.3 51605.7 53290.0 54550.2 61133.7 63641.7 69163.0 72827.6 73091.3 11892.9 13587.6 13689.0 13745.2 14052.6 14011.0 14754.2 15118.0 15208.7 15375.8 13924.9 14202.4 14257.6 14266.1 14528.7 14133.6 14137.8 14260.0 14316.1 14553.5 13474.4 13803.9 14233.9 14326.0 14614.4 11021.4 11027.7 11126.2 11587.4 11663.2 8718.6 10955.3 11162.8 11192.6 11216.4 05:41:56 INFO - PROCESS | 1633 | -------- Summary: end -------- 05:41:56 INFO - PROCESS | 1633 | 05:41:56 INFO - TEST-INFO | 1633: exit 0 05:41:56 INFO - TEST-OK | dromaeo_css | took 1117601ms 05:41:56 INFO - TEST-START | kraken 05:41:56 INFO - operating with platform_type : mac_ 05:41:56 INFO - Initialising browser for kraken test... 05:41:56 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpNQlxX0/profile http://localhost:49236/getInfo.html) 05:41:59 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:41:59 INFO - PROCESS | 1643 | colorDepth:24 05:41:59 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:41:59 INFO - PROCESS | 1643 | __metrics 05:41:59 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 05:41:59 INFO - PROCESS | 1643 | 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" 05:41:59 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:00 INFO - TEST-INFO | 1643: exit 0 05:42:00 INFO - Browser initialized. 05:42:00 INFO - Running cycle 1/1 for kraken test... 05:42:00 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpNQlxX0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:12 INFO - PROCESS | 1644 | RSS: Main: 212905984 05:42:12 INFO - PROCESS | 1644 | 05:42:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:15 INFO - PROCESS | 1644 | RSS: Main: 263843840 05:42:15 INFO - PROCESS | 1644 | 05:42:18 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 05:42:19 INFO - PROCESS | 1644 | RSS: Main: 276414464 05:42:19 INFO - PROCESS | 1644 | 05:42:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 05:42:22 INFO - PROCESS | 1644 | RSS: Main: 372686848 05:42:22 INFO - PROCESS | 1644 | 05:42:24 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 05:42:25 INFO - PROCESS | 1644 | RSS: Main: 279052288 05:42:25 INFO - PROCESS | 1644 | 05:42:27 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:28 INFO - PROCESS | 1644 | RSS: Main: 280096768 05:42:28 INFO - PROCESS | 1644 | 05:42:30 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:31 INFO - PROCESS | 1644 | RSS: Main: 320602112 05:42:31 INFO - PROCESS | 1644 | 05:42:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:35 INFO - PROCESS | 1644 | RSS: Main: 320237568 05:42:35 INFO - PROCESS | 1644 | 05:42:37 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 05:42:38 INFO - PROCESS | 1644 | RSS: Main: 316682240 05:42:38 INFO - PROCESS | 1644 | 05:42:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:40 INFO - PROCESS | 1644 | RSS: Main: 294785024 05:42:40 INFO - PROCESS | 1644 | 05:42:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:43 INFO - PROCESS | 1644 | RSS: Main: 298577920 05:42:43 INFO - PROCESS | 1644 | 05:42:45 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:46 INFO - PROCESS | 1644 | RSS: Main: 300576768 05:42:46 INFO - PROCESS | 1644 | 05:42:48 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:49 INFO - PROCESS | 1644 | RSS: Main: 316948480 05:42:49 INFO - PROCESS | 1644 | 05:42:52 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:53 INFO - PROCESS | 1644 | RSS: Main: 310755328 05:42:53 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 05:42:55 INFO - PROCESS | 1644 | RSS: Main: 355237888 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | __start_tp_report 05:42:55 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 05:42:55 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 05:42:55 INFO - PROCESS | 1644 | |i|pagename|runs| 05:42:55 INFO - PROCESS | 1644 | |0;ai-astar;110;114;112;113;113;114;113;114;113;114 05:42:55 INFO - PROCESS | 1644 | |1;audio-beat-detection;139;108;109;142;110;108;109;123;162;141 05:42:55 INFO - PROCESS | 1644 | |2;audio-dft;185;182;184;184;183;182;182;184;185;184 05:42:55 INFO - PROCESS | 1644 | |3;audio-fft;79;60;59;89;61;60;62;74;97;83 05:42:55 INFO - PROCESS | 1644 | |4;audio-oscillator;85;70;88;70;69;70;82;69;69;83 05:42:55 INFO - PROCESS | 1644 | |5;imaging-gaussian-blur;89;85;87;85;102;130;136;85;88;83 05:42:55 INFO - PROCESS | 1644 | |6;imaging-darkroom;149;94;94;94;94;92;94;94;94;93 05:42:55 INFO - PROCESS | 1644 | |7;imaging-desaturate;84;85;88;85;85;85;86;87;89;84 05:42:55 INFO - PROCESS | 1644 | |8;json-parse-financial;55;55;54;52;56;56;58;58;58;58 05:42:55 INFO - PROCESS | 1644 | |9;json-stringify-tinderbox;71;80;72;73;73;69;70;72;70;70 05:42:55 INFO - PROCESS | 1644 | |10;stanford-crypto-aes;84;84;86;84;84;84;87;87;88;84 05:42:55 INFO - PROCESS | 1644 | |11;stanford-crypto-ccm;140;139;139;148;137;137;139;142;189;140 05:42:55 INFO - PROCESS | 1644 | |12;stanford-crypto-pbkdf2;167;172;170;170;168;168;169;168;168;169 05:42:55 INFO - PROCESS | 1644 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;66;65;66;66;63 05:42:55 INFO - PROCESS | 1644 | __end_tp_report 05:42:55 INFO - PROCESS | 1644 | __start_cc_report 05:42:55 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2085 05:42:55 INFO - PROCESS | 1644 | __end_cc_report 05:42:55 INFO - PROCESS | 1644 | __startTimestamp1485265375301__endTimestamp 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | ------- Summary: start ------- 05:42:55 INFO - PROCESS | 1644 | Number of tests: 14 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.25 (1.1%) stddev-sans-first:0.71 05:42:55 INFO - PROCESS | 1644 | Values: 110.0 114.0 112.0 113.0 113.0 114.0 113.0 114.0 113.0 114.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:131.00 stddev:19.52 (14.9%) stddev-sans-first:20.04 05:42:55 INFO - PROCESS | 1644 | Values: 139.0 108.0 109.0 142.0 110.0 108.0 109.0 123.0 162.0 141.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.18 (0.6%) stddev-sans-first:1.12 05:42:55 INFO - PROCESS | 1644 | Values: 185.0 182.0 184.0 184.0 183.0 182.0 182.0 184.0 185.0 184.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#3] audio-fft Cycles:10 Average:72.40 Median:76.50 stddev:14.00 (18.3%) stddev-sans-first:14.65 05:42:55 INFO - PROCESS | 1644 | Values: 79.0 60.0 59.0 89.0 61.0 60.0 62.0 74.0 97.0 83.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:7.91 (10.4%) stddev-sans-first:7.60 05:42:55 INFO - PROCESS | 1644 | Values: 85.0 70.0 88.0 70.0 69.0 70.0 82.0 69.0 69.0 83.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:85.00 stddev:19.74 (23.2%) stddev-sans-first:20.73 05:42:55 INFO - PROCESS | 1644 | Values: 89.0 85.0 87.0 85.0 102.0 130.0 136.0 85.0 88.0 83.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:94.00 stddev:17.51 (18.6%) stddev-sans-first:0.71 05:42:55 INFO - PROCESS | 1644 | Values: 149.0 94.0 94.0 94.0 94.0 92.0 94.0 94.0 94.0 93.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:1.69 (2.0%) stddev-sans-first:1.66 05:42:55 INFO - PROCESS | 1644 | Values: 84.0 85.0 88.0 85.0 85.0 85.0 86.0 87.0 89.0 84.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:2.05 (3.6%) stddev-sans-first:2.15 05:42:55 INFO - PROCESS | 1644 | Values: 55.0 55.0 54.0 52.0 56.0 56.0 58.0 58.0 58.0 58.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.00 stddev:3.13 (4.3%) stddev-sans-first:3.30 05:42:55 INFO - PROCESS | 1644 | Values: 71.0 80.0 72.0 73.0 73.0 69.0 70.0 72.0 70.0 70.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.62 (1.9%) stddev-sans-first:1.66 05:42:55 INFO - PROCESS | 1644 | Values: 84.0 84.0 86.0 84.0 84.0 84.0 87.0 87.0 88.0 84.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:140.00 stddev:15.78 (11.3%) stddev-sans-first:16.63 05:42:55 INFO - PROCESS | 1644 | Values: 140.0 139.0 139.0 148.0 137.0 137.0 139.0 142.0 189.0 140.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.00 stddev:1.45 (0.9%) stddev-sans-first:1.36 05:42:55 INFO - PROCESS | 1644 | Values: 167.0 172.0 170.0 170.0 168.0 168.0 169.0 168.0 168.0 169.0 05:42:55 INFO - PROCESS | 1644 | 05:42:55 INFO - PROCESS | 1644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 05:42:55 INFO - PROCESS | 1644 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 63.0 05:42:55 INFO - PROCESS | 1644 | -------- Summary: end -------- 05:42:55 INFO - PROCESS | 1644 | 05:42:56 INFO - TEST-INFO | 1644: exit 0 05:42:56 INFO - TEST-OK | kraken | took 59252ms 05:42:56 INFO - SUITE-END | took 1176s 05:42:56 INFO - Completed test suite (00:19:37) 05:42:56 INFO - javascript benchmark 05:42:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.223977365319, 3331.117253927709, 3333.8666453341853, 3337.2324365395957, 3347.364000839842, 5788.102844059173, 5807.506361959233, 5810.970945145279, 5811.0702287633985, 5824.621399609023, 5745.971270143644, 5805.390434004422, 5831.446012628793, 5834.21238132852, 5838.708064596774, 5241.947580524184, 5310.8141215057485, 5312.495312945283, 5329.573634109262, 5367.973160134194, 5195.870103247411, 5211.1922651989, 5215.843524694246, 5318.494742999409, 5377.731113444332, 5214.478552144793, 5255.973720131394, 5264.8683782905355, 5302.840914772563, 5336.839894803162, 5340.652857564265, 5348.705821179834, 5354.0, 5354.866128346784, 5357.491038351351, 5150.356205474316, 5216.765245563959, 5280.9207861882105, 5294.0, 5325.760340784635, 5732.656040637534, 5785.652860828363, 5795.913061304083, 5797.043487824504, 5807.186993820868, 6207.534434917354, 6287.622742635456, 6290.0, 6294.307626161164, 6305.306416294204, 6321.841953951142, 6340.175777148941, 6370.840728981766, 6372.362763723637, 6389.968050159766, 5966.642001479881, 5969.492593129546, 6000.279966404016, 6014.117506603622, 6039.456448919618, 6334.778282760081, 6393.968030159819, 6402.295747467775, 6408.070829729756, 6438.163038804925, 6102.847428814226, 6181.752729890754, 6194.6991131862815, 6224.875502489925, 6336.144620476269, 6371.235451745728, 6374.681265936684, 6376.936230637634, 6377.107204991305, 6378.776742814072, 5181.0, 6353.936460635427, 6361.2048493938255, 6370.968145159244, 6380.680965951684, 6223.657698826608, 6247.656378899204, 6262.248530176408, 6284.088807123033, 6337.714802833883, 5032.7735251913755, 5048.62135339851, 5054.570361519239, 5063.87340316495, 5080.872978175576, 4495.393121928563, 4499.505054444008, 4504.301833215857, 4505.279155335131, 4522.977385113053, 5647.407022262603, 5667.574931880125, 5711.457411545896, 5718.857028574319, 5779.942200578024, 6303.212098487689, 6304.148939893147, 6324.494040476843, 6332.873342533124, 6382.968085159638, 5653.152027195872, 5688.317401911714, 5781.075027995501, 5801.216835727208, 5828.358880523139, 5472.26124473199, 5506.8347949560775, 5514.117741161475, 5516.9448305516435, 5527.364353099365, 6302.810915672537, 6343.651099189405, 6371.267304260069, 6388.968055159788, 6427.58220715652, 6266.436020758154, 6336.398042185985, 6344.682765861596, 6347.71435285404, 6353.841153971003, 6417.0, 6422.678866056772, 6446.774362897276, 6455.160829092188, 6458.289588145394, 6146.723397447036, 6204.317525072148, 6302.873942521032, 6322.083297921868, 6344.587601805868, 6206.751729930752, 6276.497880169667, 6295.811125666238, 6331.841703957253, 6351.841203969938, 6179.907301390393, 6215.378462153749, 6230.06549017651, 6230.844228894314, 6234.251889773075, 6042.516598672008, 6088.726007329769, 6091.604045737013, 6131.877362452815, 6160.9383906160365, 5985.191999080069, 6007.669578173242, 6067.0, 6086.056661217518, 6126.792505495216, 6178.567500274938, 6248.750049998131, 6253.687315634109, 6270.623762574078, 6284.780032698834, 5828.6211396259105, 6041.916794117507, 6101.298350689727, 6108.236470441195, 6117.082437634391], "value": 5787.320780372057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.00766283524916, 489.17085540009674, 491.6779509421328, 499.47161685243134, 501.5861913921015, 31201.0, 33290.0, 33422.331553368946, 41791.746247612624, 43630.563694363045, 44424.555754442445, 44798.10403791922, 44892.0, 45002.0, 45054.32418513725, 9352.906470935306, 9558.522073896313, 9559.378640388388, 9573.42559446432, 9580.425174489554, 8527.976642802872, 8745.95627021864, 9407.576659050359, 11222.719432014183, 11487.310761354303, 11453.828192577119, 11504.597339093134, 11507.59723409681, 11510.482028308705, 11527.25072870265, 11485.59800406986, 11556.653300401002, 11562.826557601642, 11571.016463600647, 11572.0, 8409.873851892227, 8640.0, 11098.223124381297, 11391.601293954755, 11408.429578521042, 42401.36397954033, 42629.36055959163, 42666.57333426657, 42785.0, 42875.0, 4031.9193616127804, 4051.9594804051876, 4052.8176232069627, 4067.450894129314, 4093.2018256440006, 29641.258968525744, 30331.0, 30455.0, 31211.37577248465, 32456.02631921046, 3252.0406480088195, 3262.7438436201996, 3309.271960168783, 3388.1868351595685, 3418.4017796885696, 486858.0, 488259.0, 488793.0, 488830.0, 490060.0, 63786.0, 64019.0, 64128.0, 64157.358426416075, 64183.0, 67678.98481522781, 67823.32176678268, 67826.66086669634, 67960.98058529125, 67992.0, 17196.0, 17399.47801565955, 17427.04151271692, 17489.912550437166, 17501.94988300706, 12029.759404811855, 13321.866781332063, 13427.19436833793, 13433.932830335785, 13478.595642130751, 15094.018888772194, 16873.409430669868, 17286.740698889527, 17296.567585810455, 17682.027488488, 5776.451237132465, 6510.3489651034515, 6532.608043517404, 6548.6725663716625, 6574.737010519526, 742.3319012888444, 877.1491653096487, 909.6179604566098, 930.2325581395376, 932.5710173320213, 29789.702102979125, 30257.0, 30452.238694032825, 31016.68983310183, 31116.844415777778, 1035.9792804143874, 1044.0759927464096, 1065.9520321585546, 1068.9946550267355, 1087.2606627493221, 12431.502739890304, 14598.708025839636, 14630.341634626468, 14631.487897923735, 14904.403823846924, 623612.0, 627189.0, 627300.0, 628856.0, 630175.0, 53546.0, 53661.0, 53695.46304536905, 53721.92556148933, 53933.46066539284, 1432.8853691704846, 1439.3163247457373, 1453.9636509087145, 1455.1269238457264, 1460.3720400227792, 20550.0, 26874.790634421108, 27647.58528622032, 28134.0, 28320.433591327645, 47434.52565474439, 47785.52214477811, 47805.0, 47822.04355912932, 47873.76063119662, 531646.0, 533810.0, 534258.0, 534444.0, 535488.0, 24658.63012054785, 24921.003159873402, 24924.252272431855, 24946.251612451655, 24957.376065598506, 42278.788606058006, 42538.0, 42641.36037959495, 42818.0, 44014.11971760611, 35612.64387356093, 36230.0, 36247.09382265464, 36262.09344766402, 36763.89708308755, 35381.0, 35539.466907995884, 35567.46648800322, 35612.465813012306, 35915.28169436545, 26619.467610648066, 34586.654133458345, 34805.47791783074, 35113.64886351206, 35903.820480898474, 29704.70295297106, 32724.83637581797, 32927.341453170324, 33120.668793312725, 33129.006129816145, 20566.0, 25100.874495627406, 25154.0, 25491.872540637178, 25584.360390990376], "value": 19771.276685435492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.3551481634914, 365.67272291299287, 370.13757943990504, 391.6142599539453, 402.255826720567, 15354.385824567018, 15414.537563873073, 17415.999999999985, 21270.0, 21460.785392146074, 17733.911330443363, 18602.44192674222, 21292.4676883078, 21677.0, 21962.670559941573, 5857.6485410875275, 5871.0, 6039.335673075958, 6073.180120683717, 6104.084387341912, 5600.5519558435435, 5977.641341519501, 6032.215811944441, 6044.909326360108, 6047.727852246638, 4199.3910882921955, 4411.88970275744, 5997.820065398023, 6321.620702757849, 6576.93423065768, 5785.103308987113, 6681.632510211961, 6687.866242675168, 6694.263631000586, 6702.296258892844, 5858.853528661775, 6003.279606447254, 6007.969960150172, 6013.218281623404, 6019.939800602026, 13575.185488870698, 13809.51666691661, 13827.654308642264, 13840.30798460073, 24284.421512601803, 2570.2417786752767, 2583.5607946649116, 2652.9602055969176, 2654.4027593791434, 2697.7994792317427, 9951.601935922554, 9989.75025624358, 10059.446730429823, 10424.68725938223, 10481.737956551071, 1573.9297277851056, 1688.8311168883135, 1776.733489976501, 1798.6222893192446, 1830.6796310645584, 139092.30453847666, 140916.29541852328, 145132.27433862764, 149072.99999999892, 151806.0, 11735.657806611609, 11810.881891180978, 11891.405429728651, 11977.64067077989, 12074.698132546757, 15436.845631543541, 15528.689426211413, 15558.611034724223, 15574.922125389527, 15600.375984960474, 8553.786155346166, 8858.424202426822, 8888.3333749969, 8964.327675424369, 8972.057933916845, 8687.435316704394, 8688.478691278417, 8712.825743485095, 8870.645174193089, 8877.73366798997, 4697.553732395485, 4792.185328494164, 4805.1590971579835, 4871.5128487151005, 4914.582260507826, 1978.2482656590403, 2023.1401654296865, 2041.3875837248765, 2044.4582185720797, 2046.4781480722618, 379.1734019836782, 406.794568742783, 1010.2524132142162, 1046.733821276942, 1058.5818601652459, 11162.441877906072, 11737.941310293394, 11776.587819426279, 12030.939845300893, 12339.0, 416.96455801257235, 420.3904338708823, 424.58390777038056, 438.2440290498864, 444.9666275029386, 6078.574499785061, 6103.176071230327, 6110.694465276719, 6121.326654068049, 6263.843403914939, 436928.0, 686264.0, 688648.0, 718642.0, 728831.0, 89883.0, 125560.0, 142048.0, 143242.0, 149072.0, 455.16477264219867, 465.9603933665609, 466.1097304149059, 467.2827210232345, 467.55348642046766, 10917.39954302521, 11061.391623460788, 11098.944505277423, 11139.94430027877, 11200.271982321123, 56104.0, 56856.43143568677, 58727.82544349175, 58841.0, 58967.70516147392, 73022.0, 84873.45379638621, 87784.0, 89715.0, 90623.0, 7038.542494737826, 7637.670510494352, 8392.076871544248, 8400.915990840012, 8477.448965817202, 11968.401579921143, 12388.132830702125, 12514.56199033066, 12615.87384126147, 12699.619011429671, 10746.731331716457, 11093.889061109609, 11094.334339939629, 11369.943150284196, 11386.259893106922, 9134.725958221265, 9541.618335266789, 10899.964503372166, 11054.889451105386, 11408.144389171011, 9428.962814090308, 10992.780144397228, 11402.429878506207, 11436.656900293005, 11500.597479088192, 6319.873602527831, 6975.674621821838, 7137.2149063604, 7615.847683046197, 8324.0, 9007.459552426613, 10950.178736594946, 11081.390523521284, 11223.326600404002, 11363.034142097684], "value": 8752.540051977294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.9856801431984, 1446.3491428857017, 1462.261557913254, 1466.6626675864552, 1471.7498025335692, 8097.919020809797, 8438.0, 8442.113578074306, 8446.408751387398, 8462.87305690415, 7396.260373962601, 7690.346320562745, 7699.923000769991, 7956.641951112199, 8210.0, 2248.617734985048, 2287.142321629389, 2289.645105008726, 2295.735990361105, 2296.47181148336, 2288.107638021173, 2311.295055008222, 2338.9064437422485, 2341.0401735288533, 2341.3327201747506, 2248.7076680031573, 2258.108047321307, 2286.702728645274, 2288.8969996350206, 2293.0, 1912.311567835578, 2274.9545009099807, 2277.2029789573767, 2300.7469178390365, 2324.7442781294044, 2272.761360057203, 2343.1564636730764, 2347.4248809041724, 2348.5302939412186, 2350.6944097267246, 7207.711691532332, 8328.333733301382, 8438.620262088221, 8454.746357609281, 8477.576121193915, 4372.3878656988045, 5050.545450909436, 5204.76578553966, 5221.791128354861, 5224.791008359661, 2980.6274215723033, 3296.456084746014, 3332.800031998088, 3506.7019303359243, 3562.9643703562892, 1213.2841623442123, 1213.3074361266072, 1229.274727910537, 1243.832082668837, 1264.4499642655474, 9063.50150741709, 10780.622678206226, 10885.564577416893, 10888.237823352289, 10895.291806032661, 4366.956330436718, 4606.677532572755, 4689.179393606105, 4706.858794236178, 4719.433667959866, 9557.092076252746, 9561.665341713007, 9574.234061275081, 9577.808443831085, 9583.952080239693, 5174.172132458789, 5249.291345668362, 5258.50044245796, 5260.684358938476, 5286.973565132226, 4270.7864606769535, 4424.247877860771, 4568.543145685471, 4710.670253082251, 4749.240121580599, 3384.086296699877, 3720.2373513429684, 3754.5494540655295, 3834.0, 3984.920301593952, 1139.925904816201, 1284.6017734502148, 1289.9419526121346, 1302.4985380628527, 1303.7392521495549, 788.5662885413, 870.3994243971639, 903.8553831386946, 915.1534830282095, 920.9355345125776, 5448.809291674773, 5537.141743029837, 5622.269105016322, 5736.5123964462655, 5891.057430811135, 1007.2747621712501, 1022.8977102289712, 1024.861643678094, 1033.4471057983942, 1041.8697662792151, 3447.8103704296004, 3710.5547334319513, 3761.304158730589, 3770.434434834797, 3895.376739721631, 8441.324694024463, 10069.949650251849, 10070.194384449227, 10083.949580252198, 10091.293609447268, 9957.402555846673, 10041.04610062043, 10059.5473203706, 10066.144377727975, 10077.09306162449, 7606.885896711554, 7767.883481747778, 7806.1803510632835, 7899.210078992055, 7910.802229944297, 5408.972955135199, 5464.3442786865835, 5511.255980442749, 5628.831135065954, 5727.284089488814, 9238.076192380708, 9319.114684105, 9326.673566425143, 9449.385789923634, 9458.905410946078, 8264.586770661563, 8935.955320223356, 9484.905150948402, 9488.762780930532, 9504.0, 6263.123162757127, 6454.612723236621, 6463.709133089116, 6626.237982632059, 6776.830579235559, 7632.465727399029, 7773.533587984739, 7901.130875603564, 7974.561399123104, 7983.0, 7010.894836577558, 7106.964465177641, 7124.5725256484775, 7174.282571742784, 7241.5293005954445, 6693.0, 6780.96609516969, 6927.826804329932, 6981.057557229709, 7020.333068358498, 6262.248530176408, 6386.978083506617, 6411.903821442589, 6488.935110648833, 6497.252815926229, 4977.328060711758, 5001.4998500149695, 5070.721110338966, 5078.898422031612, 5091.66904151229, 4975.527324904128, 5058.645894787477, 5095.235714642833, 5177.068127737043, 5238.057149713089], "value": 4402.80529702154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.7900227845065, 352.5276129985819, 354.6990230997738, 369.92231631357413, 372.89745320036985, 5313.548348390386, 5364.5708343332535, 5364.651297665649, 5377.91933121003, 5404.648697834638, 4260.467441569804, 4957.776900039498, 5080.0, 5110.361204849394, 5331.253624492574, 3529.329427408797, 3661.5789184243754, 3844.384898416254, 4071.531773846001, 4143.792810359485, 3446.6036405813275, 4078.6940979426513, 4101.2617728808955, 4144.8963775905695, 4201.138766552849, 3760.8683696070643, 3900.9804950975204, 3972.1857019310974, 4083.9795801020955, 4145.668346532285, 3801.4107813288983, 3833.5974722654278, 4071.6335529802163, 4111.60939710727, 4135.855245066423, 3496.9683943236805, 3554.0, 3598.0, 3628.8548458061646, 3652.415613501827, 4128.121704624388, 4924.852254432372, 5037.793442475538, 5084.3898732152375, 5091.567216786578, 4593.609543188833, 4695.624350051988, 4730.290456431529, 4733.692309999839, 4741.0, 5500.614956953015, 5537.36320323164, 5545.584081193927, 5546.528545073674, 5632.0, 3882.3594106972596, 4011.277969965405, 4035.757854528738, 4050.736702114353, 4053.7770422626745, 4805.014971930781, 5043.393973309102, 5717.113847353625, 5728.856778580569, 5794.203796823041, 4056.3915412687743, 4065.8170382332864, 4078.836846526165, 4099.057216840143, 4126.958730412657, 4191.392248124066, 4198.097409057067, 4213.810378532973, 4215.262329092458, 4216.388623649615, 3938.940915886264, 4012.5028710666575, 4627.583517483443, 4659.603933665609, 4760.78623440102, 5501.669899806025, 5516.420775818561, 5596.356419011784, 5599.720013999284, 5610.579206559442, 1112.7496313329436, 1218.3055658274698, 1331.094855498251, 1351.1825345665927, 1363.2502123831853, 787.366170232968, 838.781916701662, 893.2095095840099, 935.6725146198776, 956.9521374095355, 4227.32362821947, 4391.012022295022, 4401.955980440219, 4537.4328208973875, 4823.445303790038, 4999.600191907832, 5425.701586412706, 5432.864178395572, 5452.345718513804, 5461.617686761968, 4549.0, 4783.736894470838, 4860.646154153623, 4888.706677599355, 4902.48523904992, 2276.918463729748, 2572.9099481518056, 2761.6962134165224, 2819.2238889499486, 2841.3891013432212, 4873.31773551703, 4942.481039490874, 5629.819152179006, 5652.74562644682, 5662.244704141729, 4741.230721576355, 4951.950480495221, 4960.975195124001, 5502.523864261098, 5595.272614560081, 5223.216517522402, 5620.297462817148, 5645.887082258332, 5652.802151924663, 5674.205611214434, 4903.60771138301, 5369.704666243238, 5375.838724838261, 5380.973095134499, 5430.212619170277, 5332.466753324637, 5351.892962140658, 5372.946270537244, 5583.162525621189, 5588.469095435927, 5069.619778516552, 5171.741412929414, 5434.266374039612, 5891.587588868738, 6039.667818270037, 3363.2264579146445, 3835.712321575949, 3861.440091186706, 3888.6694630956686, 3896.220755848785, 4520.6383489320115, 4882.9257563336005, 5486.204500347507, 5508.779648814003, 5706.28671416073, 4870.586000190024, 5511.255980442589, 5512.503874651301, 5524.861878453071, 5528.1253748049985, 4330.761808100585, 4890.6332025097545, 5357.758900849549, 5556.72216389187, 5623.943760562342, 5242.7902883885745, 5387.838364849061, 5419.512243898068, 5444.992676354887, 5517.310336207974, 4643.721376717408, 4775.5463230993, 5348.1442969124755, 5356.3572371315695, 5598.832035038792, 5395.163749618815, 5401.189821526802, 5403.648762830403, 5426.457354264542, 5492.670439773627], "value": 4036.3246508873094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.712286663835, 726.9636518174093, 774.1076397169885, 820.8645573480375, 827.6110228192751, 14477.276136193188, 15483.535493935171, 15488.922555387235, 15513.844861551395, 15527.378904843821, 14077.225752583603, 14210.431582736705, 14225.217613031278, 14232.92883535581, 14236.501722439716, 674.81442603284, 699.5942353435021, 704.5807744392079, 858.7252079334615, 875.2341701011583, 842.7640260727006, 863.201538576814, 881.2333270055061, 882.0870399136894, 883.6642076011107, 936.1200471556715, 942.4157022645969, 943.03810113684, 945.0738276489045, 945.7871978804783, 716.7706333973131, 738.1290077708302, 935.1677007463329, 939.2579861909084, 940.219617717293, 664.9434798042172, 686.739039165119, 691.3017851969547, 692.2834865913806, 696.5402834129501, 15060.32228549718, 15068.773968390373, 15069.47256846005, 15074.54776356711, 15092.16993065381, 13169.473221071146, 13192.340382980812, 13345.666358341023, 13496.595102146952, 13601.863981360159, 12710.712071827067, 13147.424211566844, 13258.933705331508, 13320.0, 13449.193048417028, 4438.223310920576, 4471.552844715535, 4558.817647294104, 4574.428196475441, 4643.698159619614, 101849.0, 102233.48883255536, 102377.0, 103718.48140759324, 104782.0, 10604.083455307686, 10849.945750271198, 10989.505472253608, 10991.340519568852, 11125.109991200685, 20950.266740664003, 20975.0, 21014.159433622484, 21251.46871328198, 21303.68044479303, 7472.925270747223, 7940.404469664798, 7995.5202687837755, 8026.478278911852, 8161.102278749333, 4353.434053573015, 4362.563743625676, 4504.61710754583, 4520.254158063948, 4575.771211439482, 3608.0, 3635.8545658173375, 3673.9265214695556, 3703.0742314421395, 3720.088578298334, 570.5635189080357, 675.6486626954055, 676.7394553097093, 679.8912174052227, 681.3697329969758, 694.1046050594676, 696.6830092307988, 709.61326077288, 712.5154894671673, 767.6392095715005, 8804.823903521894, 9775.364601300893, 10051.24615653829, 10094.343867648726, 10609.893901061045, 555.4334578729673, 621.9533534984804, 694.2193274251529, 713.9571625702474, 714.9392301654418, 4956.355673762388, 5042.974785126051, 5051.26756620288, 5055.87360315995, 5058.772355244023, 106444.0, 106951.0, 107121.46439267753, 107438.0, 107703.46148269209, 69581.0, 81536.59231703922, 85294.0, 92818.53590732004, 94965.5251723737, 75695.62152189204, 82653.0, 82861.0, 85490.58037678548, 85801.14198858057, 9472.431654100776, 10353.0, 11119.666410007712, 11129.775724670442, 11197.81778941293, 48423.5157648419, 48676.269855952894, 51605.741971289906, 53290.0, 54550.18174727462, 61133.69433152806, 63641.681791590745, 69163.0, 72827.63586182035, 73091.26908730845, 11892.929636332772, 13587.59237222885, 13689.0, 13745.175289482662, 14052.578422647337, 14011.0, 14754.188519631523, 15118.0, 15208.695826083638, 15375.846241537442, 13924.930375348058, 14202.360893759598, 14257.572272831832, 14266.144031358152, 14528.709425811636, 14133.575992720234, 14137.787933181216, 14260.0, 14316.141031538142, 14553.490627827976, 13474.393652285868, 13803.930980345034, 14233.857661423253, 14326.0, 14614.415423382945, 11021.393823339793, 11027.724306892393, 11126.221164518729, 11587.42062896835, 11663.183577149519, 8718.60766265507, 10955.34267943926, 11162.832557511807, 11192.608258710907, 11216.383098929637], "value": 7653.65436966352, "unit": "score"}], "name": "dromaeo_css", "value": 7173.198580638292, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 112.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 109.0, 142.0, 110.0, 108.0, 109.0, 123.0, 162.0, 141.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 184.0, 184.0, 183.0, 182.0, 182.0, 184.0, 185.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 89.0, 61.0, 60.0, 62.0, 74.0, 97.0, 83.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 88.0, 70.0, 69.0, 70.0, 82.0, 69.0, 69.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 85.0, 102.0, 130.0, 136.0, 85.0, 88.0, 83.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 94.0, 94.0, 94.0, 94.0, 92.0, 94.0, 94.0, 94.0, 93.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 88.0, 85.0, 85.0, 85.0, 86.0, 87.0, 89.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 52.0, 56.0, 56.0, 58.0, 58.0, 58.0, 58.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 80.0, 72.0, 73.0, 73.0, 69.0, 70.0, 72.0, 70.0, 70.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 84.0, 84.0, 84.0, 87.0, 87.0, 88.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 139.0, 148.0, 137.0, 137.0, 139.0, 142.0, 189.0, 140.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 170.0, 170.0, 168.0, 168.0, 169.0, 168.0, 168.0, 169.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 63.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1444.2, "alertThreshold": 2.0}]} 05:42:56 INFO - Return code: 0 05:42:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:42:56 ERROR - # TBPL SUCCESS # 05:42:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:42:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:42:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:42:56 INFO - 2017-01-24 05:42:56.609 screenresolution[1648:9997] starting screenresolution argv=screenresolution get 05:42:56 INFO - 2017-01-24 05:42:56.612 screenresolution[1648:9997] Display 0: 1600x1200x32@60 05:42:56 INFO - 2017-01-24 05:42:56.618 screenresolution[1649:10000] starting screenresolution argv=screenresolution list 05:42:56 INFO - Available Modes on Display 0 05:42:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:42:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:42:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:42:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:42:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:42:56 INFO - Intel Iris: 05:42:56 INFO - Chipset Model: Intel Iris 05:42:56 INFO - Type: GPU 05:42:56 INFO - Bus: Built-In 05:42:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:42:56 INFO - Vendor: Intel (0x8086) 05:42:56 INFO - Device ID: 0x0a2e 05:42:56 INFO - Revision ID: 0x0009 05:42:56 INFO - Displays: 05:42:56 INFO - Display: 05:42:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:42:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:42:56 INFO - Display Serial Number: 1600x1200 60 05:42:56 INFO - Main Display: Yes 05:42:56 INFO - Mirror: Off 05:42:56 INFO - Online: Yes 05:42:56 INFO - Rotation: Supported 05:42:56 INFO - Return code: 0 05:42:56 INFO - Running post-action listener: _resource_record_post_action 05:42:56 INFO - [mozharness: 2017-01-24 13:42:56.858176Z] Finished run-tests step (success) 05:42:56 INFO - Running post-run listener: _resource_record_post_run 05:42:56 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 37671936; Write bytes: 508028928; Read time: 245; Write time: 1605 05:42:56 INFO - TinderboxPrint: CPU usage
53.4% 05:42:56 INFO - TinderboxPrint: I/O read bytes / time
37,671,936 / 245 05:42:56 INFO - TinderboxPrint: I/O write bytes / time
508,028,928 / 1,605 05:42:56 INFO - TinderboxPrint: CPU idle
2,231.2 (46.6%) 05:42:56 INFO - TinderboxPrint: CPU system
954.1 (19.9%) 05:42:56 INFO - TinderboxPrint: CPU user
1,604.2 (33.5%) 05:42:56 INFO - TinderboxPrint: Swap in / out
244,797,440 / 0 05:42:56 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208691712; Write bytes: 208441344; Read time: 15937; Write time: 456 05:42:56 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34206720; Write bytes: 298182656; Read time: 221; Write time: 1143 05:42:57 INFO - Running post-run listener: _upload_blobber_files 05:42:57 INFO - Blob upload gear active. 05:42:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:57 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 05:42:57 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'] 05:42:57 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 05:42:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:58 INFO - (blobuploader) - INFO - Done attempting. 05:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:00 INFO - (blobuploader) - INFO - Done attempting. 05:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:01 INFO - (blobuploader) - INFO - Done attempting. 05:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:03 INFO - (blobuploader) - INFO - Done attempting. 05:43:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:03 INFO - Return code: 0 05:43:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72677310374d623bb948a9ca2ee4c8b9d204f8b4a0f363e4750de20d813951aff0e9f369ed5d3bb8b5b382fa173133477e0879481309f8b2574d730d56d1db35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3611780575b3bd7dde30de5bd689f105f97e7eb1fa259146da892e21a55a4a56ee2b5623ec8e7ed2953b47614afc34af5c62e2601c894e629227f296d9ef7898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bb643436f4e980f27f6d64db089c45a2e926cb1138387f922cf1c5c360a254fba1b62b9f60d623eb5df522a167ff1683a2759ed557510b900eae233eaa9fd3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0b73005589f56cf1d0e0aff6db9b2fdd636e24b73b01b71db5d360e8d21841336a2cb2b3c01b59aebbee9e4d7c4b6b8042e46d8b0835aa5eeb273805e926d29"} 05:43:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:03 INFO - Contents: 05:43:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72677310374d623bb948a9ca2ee4c8b9d204f8b4a0f363e4750de20d813951aff0e9f369ed5d3bb8b5b382fa173133477e0879481309f8b2574d730d56d1db35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3611780575b3bd7dde30de5bd689f105f97e7eb1fa259146da892e21a55a4a56ee2b5623ec8e7ed2953b47614afc34af5c62e2601c894e629227f296d9ef7898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bb643436f4e980f27f6d64db089c45a2e926cb1138387f922cf1c5c360a254fba1b62b9f60d623eb5df522a167ff1683a2759ed557510b900eae233eaa9fd3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0b73005589f56cf1d0e0aff6db9b2fdd636e24b73b01b71db5d360e8d21841336a2cb2b3c01b59aebbee9e4d7c4b6b8042e46d8b0835aa5eeb273805e926d29"} 05:43:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:03 INFO - Copying logs to upload dir... 05:43:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.516278 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 05:43:03.447199) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 05:43:03.450714) ========= 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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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/72677310374d623bb948a9ca2ee4c8b9d204f8b4a0f363e4750de20d813951aff0e9f369ed5d3bb8b5b382fa173133477e0879481309f8b2574d730d56d1db35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3611780575b3bd7dde30de5bd689f105f97e7eb1fa259146da892e21a55a4a56ee2b5623ec8e7ed2953b47614afc34af5c62e2601c894e629227f296d9ef7898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bb643436f4e980f27f6d64db089c45a2e926cb1138387f922cf1c5c360a254fba1b62b9f60d623eb5df522a167ff1683a2759ed557510b900eae233eaa9fd3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0b73005589f56cf1d0e0aff6db9b2fdd636e24b73b01b71db5d360e8d21841336a2cb2b3c01b59aebbee9e4d7c4b6b8042e46d8b0835aa5eeb273805e926d29"} build_url:https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010168 build_url: 'https://queue.taskcluster.net/v1/task/STHlROPzQ4yINX3ed-yFOg/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/72677310374d623bb948a9ca2ee4c8b9d204f8b4a0f363e4750de20d813951aff0e9f369ed5d3bb8b5b382fa173133477e0879481309f8b2574d730d56d1db35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3611780575b3bd7dde30de5bd689f105f97e7eb1fa259146da892e21a55a4a56ee2b5623ec8e7ed2953b47614afc34af5c62e2601c894e629227f296d9ef7898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bb643436f4e980f27f6d64db089c45a2e926cb1138387f922cf1c5c360a254fba1b62b9f60d623eb5df522a167ff1683a2759ed557510b900eae233eaa9fd3c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0b73005589f56cf1d0e0aff6db9b2fdd636e24b73b01b71db5d360e8d21841336a2cb2b3c01b59aebbee9e4d7c4b6b8042e46d8b0835aa5eeb273805e926d29"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 05:43:03.485904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:43:03.486553) ========= 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.S8V0NRCJb1/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.zbsZnAE2SN/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.005316 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:43:03.538665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 05:43:03.539438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 05:43:03.539964) ========= ========= Total master_lag: 0.19 =========