builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0108 starttime: 1481558586.5 results: success (0) buildid: 20161212064450 builduid: ab4901a24ba04e399f3604d18065332f revision: 3c9a0a6cdfff95eaa1c851344e898b3b15d55609 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:06.497081) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:06.497653) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:06.497945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:06.524504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:06.524831) ========= 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.L214RHK5B2/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.zqBI7BYjB4/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-12 08:03:06-- 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% 40.2M=0s 2016-12-12 08:03:07 (40.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.591098 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:07.165223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:07.165552) ========= 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.L214RHK5B2/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.zqBI7BYjB4/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.027579 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:07.215337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-12 08:03:07.215698) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c9a0a6cdfff95eaa1c851344e898b3b15d55609 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3c9a0a6cdfff95eaa1c851344e898b3b15d55609 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L214RHK5B2/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.zqBI7BYjB4/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-12 08:03:07,310 truncating revision to first 12 chars 2016-12-12 08:03:07,310 Setting DEBUG logging. 2016-12-12 08:03:07,310 attempt 1/10 2016-12-12 08:03:07,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c9a0a6cdfff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-12 08:03:09,100 unpacking tar archive at: mozilla-central-3c9a0a6cdfff/testing/mozharness/ program finished with exit code 0 elapsedTime=2.058229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-12 08:03:09.297169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:09.297467) ========= script_repo_revision: 3c9a0a6cdfff95eaa1c851344e898b3b15d55609 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:09.298390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:09.298670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-12 08:03:09.318960) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-12 08:03:09.319247) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L214RHK5B2/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.zqBI7BYjB4/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:03:09 INFO - MultiFileLogger online at 20161212 08:03:09 in /builds/slave/test 08:03:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:03:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:09 INFO - {'append_to_log': False, 08:03:09 INFO - 'base_work_dir': '/builds/slave/test', 08:03:09 INFO - 'blob_upload_branch': 'Firefox', 08:03:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:09 INFO - 'branch': 'Firefox', 08:03:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:09 INFO - 'config_files': ('talos/mac_config.py',), 08:03:09 INFO - 'default_actions': ('clobber', 08:03:09 INFO - 'read-buildbot-config', 08:03:09 INFO - 'download-and-extract', 08:03:09 INFO - 'populate-webroot', 08:03:09 INFO - 'create-virtualenv', 08:03:09 INFO - 'install', 08:03:09 INFO - 'run-tests'), 08:03:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:09 INFO - 'download_minidump_stackwalk': True, 08:03:09 INFO - 'download_symbols': 'ondemand', 08:03:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:09 INFO - 'installer_path': 'installer.exe', 08:03:09 INFO - 'log_level': 'info', 08:03:09 INFO - 'log_name': 'talos', 08:03:09 INFO - 'log_to_console': True, 08:03:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:03:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:03:09 INFO - 'opt_config_files': (), 08:03:09 INFO - 'pip_index': False, 08:03:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:09 INFO - 'cmd': ('bash', 08:03:09 INFO - '-c', 08:03:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:09 INFO - 'enabled': True, 08:03:09 INFO - 'halt_on_failure': False, 08:03:09 INFO - 'name': 'check_screen_resolution'},), 08:03:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:09 INFO - 'cmd': ('bash', 08:03:09 INFO - '-c', 08:03:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:09 INFO - 'enabled': True, 08:03:09 INFO - 'halt_on_failure': False, 08:03:09 INFO - 'name': 'check_screen_resolution'},), 08:03:09 INFO - 'run_cmd_checks_enabled': True, 08:03:09 INFO - 'sps_profile': False, 08:03:09 INFO - 'sps_profile_interval': 0, 08:03:09 INFO - 'suite': 'dromaeojs', 08:03:09 INFO - 'system_bits': '32', 08:03:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:09 INFO - 'title': 't-yosemite-r7-0108', 08:03:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:09 INFO - 'use_talos_json': True, 08:03:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:09 INFO - 'work_dir': 'build'} 08:03:09 INFO - [mozharness: 2016-12-12 16:03:09.534916Z] Running clobber step. 08:03:09 INFO - Running pre-action listener: _resource_record_pre_action 08:03:09 INFO - Running main action method: clobber 08:03:09 INFO - rmtree: /builds/slave/test/build 08:03:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:11 INFO - Running post-action listener: _resource_record_post_action 08:03:11 INFO - [mozharness: 2016-12-12 16:03:11.918925Z] Finished clobber step (success) 08:03:11 INFO - [mozharness: 2016-12-12 16:03:11.919170Z] Running read-buildbot-config step. 08:03:11 INFO - Running pre-action listener: _resource_record_pre_action 08:03:11 INFO - Running main action method: read_buildbot_config 08:03:11 INFO - Using buildbot properties: 08:03:11 INFO - { 08:03:11 INFO - "project": "", 08:03:11 INFO - "product": "firefox", 08:03:11 INFO - "script_repo_revision": "production", 08:03:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:03:11 INFO - "repository": "", 08:03:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:03:11 INFO - "buildid": "20161212064450", 08:03:11 INFO - "pgo_build": "False", 08:03:11 INFO - "basedir": "/builds/slave/test", 08:03:11 INFO - "buildnumber": 41, 08:03:11 INFO - "slavename": "t-yosemite-r7-0108", 08:03:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:03:11 INFO - "platform": "yosemite_r7", 08:03:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:03:11 INFO - "branch": "mozilla-central", 08:03:11 INFO - "repo_path": "mozilla-central", 08:03:11 INFO - "revision": "3c9a0a6cdfff95eaa1c851344e898b3b15d55609", 08:03:11 INFO - "stage_platform": "macosx64", 08:03:11 INFO - "builduid": "ab4901a24ba04e399f3604d18065332f", 08:03:11 INFO - "slavebuilddir": "test" 08:03:11 INFO - } 08:03:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 08:03:11 INFO - Running post-action listener: _resource_record_post_action 08:03:11 INFO - [mozharness: 2016-12-12 16:03:11.924775Z] Finished read-buildbot-config step (success) 08:03:11 INFO - [mozharness: 2016-12-12 16:03:11.925019Z] Running download-and-extract step. 08:03:11 INFO - Running pre-action listener: _resource_record_pre_action 08:03:11 INFO - Running main action method: download_and_extract 08:03:11 INFO - mkdir: /builds/slave/test/build/tests 08:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:11 INFO - trying https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:03:11 INFO - Downloading https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:03:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 08:03:12 INFO - Downloaded 1235 bytes. 08:03:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:03:12 INFO - Using the following test package requirements: 08:03:12 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:03:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 08:03:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 08:03:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'jsshell-mac64.zip'], 08:03:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 08:03:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:03:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 08:03:12 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 08:03:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 08:03:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:03:12 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 08:03:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 08:03:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:03:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:03:12 INFO - Fetch https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:03:13 INFO - Expected file size: 16289444 08:03:13 INFO - Obtained file size: 16289444 08:03:20 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 08:03:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:03:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:03:20 INFO - Fetch https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:03:21 INFO - Expected file size: 16289444 08:03:21 INFO - Obtained file size: 16289444 08:03:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 08:03:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 08:03:27 INFO - Fetch https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 08:03:29 INFO - Expected file size: 14409734 08:03:29 INFO - Obtained file size: 14409734 08:03: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')]} 08:03:29 INFO - trying https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:03:29 INFO - Downloading https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 08:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 08:03:31 INFO - Downloaded 69678963 bytes. 08:03:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:03:31 INFO - mkdir: /builds/slave/test/properties 08:03:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:31 INFO - Contents: 08:03:31 INFO - build_url:https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:03:32 INFO - Running post-action listener: _resource_record_post_action 08:03:32 INFO - Running post-action listener: set_extra_try_arguments 08:03:32 INFO - [mozharness: 2016-12-12 16:03:32.631272Z] Finished download-and-extract step (success) 08:03:32 INFO - [mozharness: 2016-12-12 16:03:32.631421Z] Running populate-webroot step. 08:03:32 INFO - Running pre-action listener: _resource_record_pre_action 08:03:32 INFO - Running main action method: populate_webroot 08:03:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:32 INFO - '--tppagecycles', 08:03:32 INFO - '7'], 08:03:32 INFO - 'tests': ['tsvgm']}}, 08:03:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['damp', 'tps']}, 08:03:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'tests': ['damp', 'tps']}, 08:03:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['dromaeo_dom']}, 08:03:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['basic_compositor_video']}, 08:03:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['a11yr', 08:03:32 INFO - 'ts_paint', 08:03:32 INFO - 'tpaint', 08:03:32 INFO - 'sessionrestore', 08:03:32 INFO - 'sessionrestore_no_auto_restore', 08:03:32 INFO - 'tabpaint']}, 08:03:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tsvgx', 08:03:32 INFO - 'tsvgr_opacity', 08:03:32 INFO - 'tart', 08:03:32 INFO - 'tscrollx', 08:03:32 INFO - 'cart', 08:03:32 INFO - 'tsvg_static']}, 08:03:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:32 INFO - 'tsvgr_opacity', 08:03:32 INFO - 'tart', 08:03:32 INFO - 'tscrollx', 08:03:32 INFO - 'cart', 08:03:32 INFO - 'tsvg_static']}, 08:03:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s'], 08:03:32 INFO - 'tests': ['tp5o']}, 08:03:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:03:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'talos_options': ['--disable-e10s', 08:03:32 INFO - '--xperf_path', 08:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:32 INFO - 'tests': ['tp5n']}, 08:03:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:03:32 INFO - 'talos_options': ['--xperf_path', 08:03:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:32 INFO - 'tests': ['tp5n']}}, 08:03:32 INFO - 'talos.zip': {'path': '', 08:03:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:32 INFO - Running post-action listener: _resource_record_post_action 08:03:32 INFO - [mozharness: 2016-12-12 16:03:32.649663Z] Finished populate-webroot step (success) 08:03:32 INFO - [mozharness: 2016-12-12 16:03:32.649797Z] Running create-virtualenv step. 08:03:32 INFO - Running pre-action listener: _resource_record_pre_action 08:03:32 INFO - Running main action method: create_virtualenv 08:03:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:03:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:32 INFO - Using real prefix '/tools/python27' 08:03:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:36 INFO - Installing pip.................done. 08:03:36 INFO - Return code: 0 08:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:03:36 INFO - Reading from file tmpfile_stdout 08:03:36 INFO - Output received: 08:03:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:03:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:36 INFO - 'HOME': '/Users/cltbld', 08:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:36 INFO - 'LOGNAME': 'cltbld', 08:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:36 INFO - 'MOZ_NO_REMOTE': '1', 08:03:36 INFO - 'NO_EM_RESTART': '1', 08:03:36 INFO - 'PAGER': '/bin/cat', 08:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:36 INFO - 'PWD': '/builds/slave/test', 08:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:36 INFO - 'SHELL': '/bin/bash', 08:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:36 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:36 INFO - 'USER': 'cltbld', 08:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:36 INFO - 'XPC_FLAGS': '0x0', 08:03:36 INFO - 'XPC_SERVICE_NAME': '0', 08:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:03:36 INFO - Cleaning up... 08:03:36 INFO - Return code: 0 08:03:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:36 INFO - 'HOME': '/Users/cltbld', 08:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:36 INFO - 'LOGNAME': 'cltbld', 08:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:36 INFO - 'MOZ_NO_REMOTE': '1', 08:03:36 INFO - 'NO_EM_RESTART': '1', 08:03:36 INFO - 'PAGER': '/bin/cat', 08:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:36 INFO - 'PWD': '/builds/slave/test', 08:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:36 INFO - 'SHELL': '/bin/bash', 08:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:36 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:36 INFO - 'USER': 'cltbld', 08:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:36 INFO - 'XPC_FLAGS': '0x0', 08:03:36 INFO - 'XPC_SERVICE_NAME': '0', 08:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:37 INFO - Downloading/unpacking psutil>=3.1.1 08:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:41 INFO - Installing collected packages: psutil 08:03:41 INFO - Running setup.py install for psutil 08:03:41 INFO - building 'psutil._psutil_osx' extension 08:03:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:03:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:03:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:03:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:03:41 INFO - building 'psutil._psutil_posix' extension 08:03:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:03:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:03:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:03:41 INFO - ^ 08:03:42 INFO - 1 warning generated. 08:03:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:42 INFO - Successfully installed psutil 08:03:42 INFO - Cleaning up... 08:03:42 INFO - Return code: 0 08:03:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:42 INFO - 'HOME': '/Users/cltbld', 08:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:42 INFO - 'LOGNAME': 'cltbld', 08:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:42 INFO - 'MOZ_NO_REMOTE': '1', 08:03:42 INFO - 'NO_EM_RESTART': '1', 08:03:42 INFO - 'PAGER': '/bin/cat', 08:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:42 INFO - 'PWD': '/builds/slave/test', 08:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:42 INFO - 'SHELL': '/bin/bash', 08:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:42 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:42 INFO - 'USER': 'cltbld', 08:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:42 INFO - 'XPC_FLAGS': '0x0', 08:03:42 INFO - 'XPC_SERVICE_NAME': '0', 08:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:45 INFO - Installing collected packages: mozsystemmonitor 08:03:45 INFO - Running setup.py install for mozsystemmonitor 08:03:45 INFO - Successfully installed mozsystemmonitor 08:03:45 INFO - Cleaning up... 08:03:45 INFO - Return code: 0 08:03:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:45 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:45 INFO - 'HOME': '/Users/cltbld', 08:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:45 INFO - 'LOGNAME': 'cltbld', 08:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:45 INFO - 'MOZ_NO_REMOTE': '1', 08:03:45 INFO - 'NO_EM_RESTART': '1', 08:03:45 INFO - 'PAGER': '/bin/cat', 08:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:45 INFO - 'PWD': '/builds/slave/test', 08:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:45 INFO - 'SHELL': '/bin/bash', 08:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:45 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:45 INFO - 'USER': 'cltbld', 08:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:45 INFO - 'XPC_FLAGS': '0x0', 08:03:45 INFO - 'XPC_SERVICE_NAME': '0', 08:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:48 INFO - warning: no files found matching '*.txt' 08:03:48 INFO - no previously-included directories found matching 'build' 08:03:48 INFO - no previously-included directories found matching 'dist' 08:03:48 INFO - no previously-included directories found matching '.git*' 08:03:48 INFO - Installing collected packages: jsonschema, functools32 08:03:48 INFO - Running setup.py install for functools32 08:03:49 INFO - warning: no files found matching '*.txt' 08:03:49 INFO - no previously-included directories found matching 'build' 08:03:49 INFO - no previously-included directories found matching 'dist' 08:03:49 INFO - no previously-included directories found matching '.git*' 08:03:49 INFO - Successfully installed jsonschema functools32 08:03:49 INFO - Cleaning up... 08:03:49 INFO - Return code: 0 08:03:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:49 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:49 INFO - 'HOME': '/Users/cltbld', 08:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:49 INFO - 'LOGNAME': 'cltbld', 08:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:49 INFO - 'MOZ_NO_REMOTE': '1', 08:03:49 INFO - 'NO_EM_RESTART': '1', 08:03:49 INFO - 'PAGER': '/bin/cat', 08:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:49 INFO - 'PWD': '/builds/slave/test', 08:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:49 INFO - 'SHELL': '/bin/bash', 08:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:49 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:49 INFO - 'USER': 'cltbld', 08:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:49 INFO - 'XPC_FLAGS': '0x0', 08:03:49 INFO - 'XPC_SERVICE_NAME': '0', 08:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:03:49 INFO - Cleaning up... 08:03:49 INFO - Return code: 0 08:03:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:49 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:49 INFO - 'HOME': '/Users/cltbld', 08:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:49 INFO - 'LOGNAME': 'cltbld', 08:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:49 INFO - 'MOZ_NO_REMOTE': '1', 08:03:49 INFO - 'NO_EM_RESTART': '1', 08:03:49 INFO - 'PAGER': '/bin/cat', 08:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:49 INFO - 'PWD': '/builds/slave/test', 08:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:49 INFO - 'SHELL': '/bin/bash', 08:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:49 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:49 INFO - 'USER': 'cltbld', 08:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:49 INFO - 'XPC_FLAGS': '0x0', 08:03:49 INFO - 'XPC_SERVICE_NAME': '0', 08:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:53 INFO - Downloading docopt-0.6.1.tar.gz 08:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:53 INFO - Running setup.py install for blobuploader 08:03:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:53 INFO - Running setup.py install for requests 08:03:54 INFO - Running setup.py install for docopt 08:03:54 INFO - Successfully installed blobuploader requests docopt 08:03:54 INFO - Cleaning up... 08:03:54 INFO - Return code: 0 08:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:54 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:54 INFO - 'HOME': '/Users/cltbld', 08:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:54 INFO - 'LOGNAME': 'cltbld', 08:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:54 INFO - 'MOZ_NO_REMOTE': '1', 08:03:54 INFO - 'NO_EM_RESTART': '1', 08:03:54 INFO - 'PAGER': '/bin/cat', 08:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:54 INFO - 'PWD': '/builds/slave/test', 08:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:54 INFO - 'SHELL': '/bin/bash', 08:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:54 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:54 INFO - 'USER': 'cltbld', 08:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:54 INFO - 'XPC_FLAGS': '0x0', 08:03:54 INFO - 'XPC_SERVICE_NAME': '0', 08:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:54 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-vmygYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:54 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-VWRKjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:54 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-c2YrOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-vE8QJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-QOP7jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-wwE1_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-9A2lNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-RvMnDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-6CPwBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-LCpNZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-UWyi4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:55 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-11_nOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-W8KH7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-V4KOij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-ska3Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-rxWY3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:56 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-qI6W6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:56 INFO - Running setup.py install for manifestparser 08:03:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:56 INFO - Running setup.py install for mozcrash 08:03:56 INFO - Running setup.py install for mozdebug 08:03:56 INFO - Running setup.py install for mozdevice 08:03:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Running setup.py install for mozfile 08:03:57 INFO - Running setup.py install for mozhttpd 08:03:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Running setup.py install for mozinfo 08:03:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Running setup.py install for mozInstall 08:03:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:57 INFO - Running setup.py install for mozleak 08:03:57 INFO - Running setup.py install for mozlog 08:03:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Running setup.py install for moznetwork 08:03:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Running setup.py install for mozprocess 08:03:58 INFO - Running setup.py install for mozprofile 08:03:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Running setup.py install for mozrunner 08:03:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:58 INFO - Running setup.py install for mozscreenshot 08:03:58 INFO - Running setup.py install for moztest 08:03:58 INFO - Running setup.py install for mozversion 08:03:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:59 INFO - Cleaning up... 08:03:59 INFO - Return code: 0 08:03:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:59 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:03:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:03:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:59 INFO - 'HOME': '/Users/cltbld', 08:03:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:59 INFO - 'LOGNAME': 'cltbld', 08:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:59 INFO - 'MOZ_NO_REMOTE': '1', 08:03:59 INFO - 'NO_EM_RESTART': '1', 08:03:59 INFO - 'PAGER': '/bin/cat', 08:03:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:59 INFO - 'PWD': '/builds/slave/test', 08:03:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:59 INFO - 'SHELL': '/bin/bash', 08:03:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:03:59 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:03:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:59 INFO - 'USER': 'cltbld', 08:03:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:59 INFO - 'XPC_FLAGS': '0x0', 08:03:59 INFO - 'XPC_SERVICE_NAME': '0', 08:03:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-ePQEEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-dgnrA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-hfPM5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-gq3itP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-xtSJPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-lfAZtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:59 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-4feTdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-hFUjLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-gfIIZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-YqDczu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-LrfHH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-w5_nwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-azCrAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-AOjrxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-lWK3Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:00 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-4LSn2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:01 INFO - Running setup.py (path:/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/pip-ZxEpRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:03 INFO - Downloading blessings-1.6.tar.gz 08:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:03 INFO - Installing collected packages: blessings 08:04:03 INFO - Running setup.py install for blessings 08:04:04 INFO - Successfully installed blessings 08:04:04 INFO - Cleaning up... 08:04:04 INFO - Return code: 0 08:04:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:04 INFO - Reading from file tmpfile_stdout 08:04:04 INFO - Current package versions: 08:04:04 INFO - blessings == 1.6 08:04:04 INFO - blobuploader == 1.2.4 08:04:04 INFO - docopt == 0.6.1 08:04:04 INFO - functools32 == 3.2.3-2 08:04:04 INFO - jsonschema == 2.5.1 08:04:04 INFO - manifestparser == 1.1 08:04:04 INFO - mozInstall == 1.12 08:04:04 INFO - mozcrash == 1.0 08:04:04 INFO - mozdebug == 0.1 08:04:04 INFO - mozdevice == 0.49 08:04:04 INFO - mozfile == 1.2 08:04:04 INFO - mozhttpd == 0.7 08:04:04 INFO - mozinfo == 0.9 08:04:04 INFO - mozleak == 0.1 08:04:04 INFO - mozlog == 3.4 08:04:04 INFO - moznetwork == 0.27 08:04:04 INFO - mozprocess == 0.23 08:04:04 INFO - mozprofile == 0.28 08:04:04 INFO - mozrunner == 6.13 08:04:04 INFO - mozscreenshot == 0.1 08:04:04 INFO - mozsystemmonitor == 0.3 08:04:04 INFO - moztest == 0.7 08:04:04 INFO - mozversion == 1.4 08:04:04 INFO - psutil == 3.1.1 08:04:04 INFO - requests == 1.2.3 08:04:04 INFO - wsgiref == 0.1.2 08:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:04 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:04 INFO - 'HOME': '/Users/cltbld', 08:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:04 INFO - 'LOGNAME': 'cltbld', 08:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:04 INFO - 'MOZ_NO_REMOTE': '1', 08:04:04 INFO - 'NO_EM_RESTART': '1', 08:04:04 INFO - 'PAGER': '/bin/cat', 08:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:04 INFO - 'PWD': '/builds/slave/test', 08:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:04 INFO - 'SHELL': '/bin/bash', 08:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:04:04 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:04 INFO - 'USER': 'cltbld', 08:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:04 INFO - 'XPC_FLAGS': '0x0', 08:04:04 INFO - 'XPC_SERVICE_NAME': '0', 08:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:04:04 INFO - Cleaning up... 08:04:04 INFO - Return code: 0 08:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:04 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 0x1030ed3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103063570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd003d805e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, '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.L214RHK5B2/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.zqBI7BYjB4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:04 INFO - 'HOME': '/Users/cltbld', 08:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:04 INFO - 'LOGNAME': 'cltbld', 08:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:04 INFO - 'MOZ_NO_REMOTE': '1', 08:04:04 INFO - 'NO_EM_RESTART': '1', 08:04:04 INFO - 'PAGER': '/bin/cat', 08:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:04 INFO - 'PWD': '/builds/slave/test', 08:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:04 INFO - 'SHELL': '/bin/bash', 08:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:04:04 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:04 INFO - 'USER': 'cltbld', 08:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:04 INFO - 'XPC_FLAGS': '0x0', 08:04:04 INFO - 'XPC_SERVICE_NAME': '0', 08:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:04 INFO - Cleaning up... 08:04:04 INFO - Return code: 0 08:04:04 INFO - Running post-action listener: _resource_record_post_action 08:04:04 INFO - Running post-action listener: _start_resource_monitoring 08:04:04 INFO - Starting resource monitoring. 08:04:04 INFO - [mozharness: 2016-12-12 16:04:04.953787Z] Finished create-virtualenv step (success) 08:04:04 INFO - [mozharness: 2016-12-12 16:04:04.954759Z] Running install step. 08:04:04 INFO - Running pre-action listener: _resource_record_pre_action 08:04:04 INFO - Running main action method: install 08:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:05 INFO - Reading from file tmpfile_stdout 08:04:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:05 INFO - Reading from file tmpfile_stdout 08:04:05 INFO - Output received: 08:04:05 INFO - Usage: mozinstall [options] installer 08:04:05 INFO - Options: 08:04:05 INFO - -h, --help show this help message and exit 08:04:05 INFO - -d DEST, --destination=DEST 08:04:05 INFO - Directory to install application into. [default: 08:04:05 INFO - "/builds/slave/test"] 08:04:05 INFO - --app=APP Application being installed. [default: firefox] 08:04:05 INFO - mkdir: /builds/slave/test/build/application 08:04:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 08:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 08:04:27 INFO - Reading from file tmpfile_stdout 08:04:27 INFO - Output received: 08:04:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:04:27 INFO - Running post-action listener: _resource_record_post_action 08:04:27 INFO - [mozharness: 2016-12-12 16:04:27.216750Z] Finished install step (success) 08:04:27 INFO - [mozharness: 2016-12-12 16:04:27.216908Z] Running run-tests step. 08:04:27 INFO - Running pre-action listener: _resource_record_pre_action 08:04:27 INFO - Running main action method: run_tests 08:04:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:04:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:04:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:04:27 INFO - 2016-12-12 08:04:27.231 screenresolution[1631:8355] starting screenresolution argv=screenresolution get 08:04:27 INFO - 2016-12-12 08:04:27.234 screenresolution[1631:8355] Display 0: 1600x1200x32@60 08:04:27 INFO - 2016-12-12 08:04:27.239 screenresolution[1632:8358] starting screenresolution argv=screenresolution list 08:04:27 INFO - Available Modes on Display 0 08:04:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:04:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:04:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:04:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:04:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:04:27 INFO - Intel Iris: 08:04:27 INFO - Chipset Model: Intel Iris 08:04:27 INFO - Type: GPU 08:04:27 INFO - Bus: Built-In 08:04:27 INFO - VRAM (Dynamic, Max): 1536 MB 08:04:27 INFO - Vendor: Intel (0x8086) 08:04:27 INFO - Device ID: 0x0a2e 08:04:27 INFO - Revision ID: 0x0009 08:04:27 INFO - Displays: 08:04:27 INFO - Display: 08:04:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:04:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:04:27 INFO - Display Serial Number: 1600x1200 60 08:04:27 INFO - Main Display: Yes 08:04:27 INFO - Mirror: Off 08:04:27 INFO - Online: Yes 08:04:27 INFO - Rotation: Supported 08:04:27 INFO - Return code: 0 08:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:27 INFO - Python 2.7.3 08:04:27 INFO - Return code: 0 08:04:27 INFO - grabbing minidump binary from tooltool 08:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f02d30>, '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 0x102d69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102efab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:04:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:04:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:04:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:27 INFO - Return code: 0 08:04:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0108 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:04:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L214RHK5B2/Render', 08:04:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:27 INFO - 'HOME': '/Users/cltbld', 08:04:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:27 INFO - 'LOGNAME': 'cltbld', 08:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:27 INFO - 'MOZ_NO_REMOTE': '1', 08:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:27 INFO - 'NO_EM_RESTART': '1', 08:04:27 INFO - 'PAGER': '/bin/cat', 08:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:27 INFO - 'PWD': '/builds/slave/test', 08:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:27 INFO - 'SHELL': '/bin/bash', 08:04:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zqBI7BYjB4/Listeners', 08:04:27 INFO - 'TMPDIR': '/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/', 08:04:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:27 INFO - 'USER': 'cltbld', 08:04:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:27 INFO - 'XPC_FLAGS': '0x0', 08:04:27 INFO - 'XPC_SERVICE_NAME': '0', 08:04:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0108', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:04:27 INFO - mozversion application_buildid: 20161212064450 08:04:27 INFO - mozversion application_changeset: 3c9a0a6cdfff95eaa1c851344e898b3b15d55609 08:04:27 INFO - mozversion application_display_name: Nightly 08:04:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:27 INFO - mozversion application_name: Firefox 08:04:27 INFO - mozversion application_remotingname: firefox 08:04:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:04:27 INFO - mozversion application_vendor: Mozilla 08:04:27 INFO - mozversion application_version: 53.0a1 08:04:27 INFO - mozversion platform_buildid: 20161212064450 08:04:27 INFO - mozversion platform_changeset: 3c9a0a6cdfff95eaa1c851344e898b3b15d55609 08:04:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:04:27 INFO - mozversion platform_version: 53.0a1 08:04:27 INFO - using testdate: 1481558667 08:04:27 INFO - actual date: 1481558667 08:04:27 INFO - starting webserver on 'localhost:49250' 08:04:27 INFO - SUITE-START | Running 2 tests 08:04:27 INFO - TEST-START | dromaeo_css 08:04:27 INFO - operating with platform_type : mac_ 08:04:27 INFO - Initialising browser for dromaeo_css test... 08:04:27 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpO3Qt5O/profile http://localhost:49250/getInfo.html) 08:04:30 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 08:04:30 INFO - PROCESS | 1642 | colorDepth:24 08:04:30 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 08:04:30 INFO - PROCESS | 1642 | __metrics 08:04:30 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:30 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:31 INFO - TEST-INFO | 1642: exit 0 08:04:31 INFO - Browser initialized. 08:04:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:31 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpO3Qt5O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:43 INFO - PROCESS | 1645 | RSS: Main: 236920832 08:04:43 INFO - PROCESS | 1645 | 08:05:34 INFO - PROCESS | 1645 | 1481558734480 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:07:47 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 08:07:49 INFO - PROCESS | 1645 | RSS: Main: 392511488 08:07:49 INFO - PROCESS | 1645 | 08:10:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 08:10:52 INFO - PROCESS | 1645 | RSS: Main: 375611392 08:10:52 INFO - PROCESS | 1645 | 08:13:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 08:13:55 INFO - PROCESS | 1645 | RSS: Main: 336916480 08:13:55 INFO - PROCESS | 1645 | 08:16:58 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 08:16:58 INFO - PROCESS | 1645 | RSS: Main: 351535104 08:16:58 INFO - PROCESS | 1645 | 08:20:02 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 08:20:03 INFO - PROCESS | 1645 | RSS: Main: 331190272 08:20:03 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 08:23:06 INFO - PROCESS | 1645 | RSS: Main: 400830464 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | __start_tp_report 08:23:06 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 08:23:06 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 08:23:06 INFO - PROCESS | 1645 | |i|pagename|runs| 08:23:06 INFO - PROCESS | 1645 | |0;dojo.html;3291.2594666200107;3308.933821323573;3309.420851351013;3343.5151902974053;3361.394948909197;5519.116941289394;5558.583106267031;5619;5625.493705566499;5642.040853054986;5550.583706222029;5591.329040515144;5592.552595792337;5596.27248457701;5623.746931388087;4227.957720422787;5040.067587496315;5078.466760990098;5079.034983353151;5165.328507294046;5086.669366491166;5162.690238585678;5163.225516172567;5167.793288268484;5169.974150129263;5084.491550844923;5121.590272778188;5144.125498665236;5162.793488260465;5168.9224661630105;5147.22791581262;5152;5159.174532074888;5164.793408263665;5199.428062913076;4966.47851975541;5008.12357837377;5112.744362781883;5116.104681680728;5140.820071297487;4688.460827004904;5549.1676248562635;5555.194496797942;5578.191162281487;5621.156826476021;6114.571979961404;6125.356837532084;6127.417895299939;6127.846803829895;6135.233095863017;6070.939290607082;6141;6222.43998040174;6226.875462490725;6227.688615569249;5637.408072152406;5670.603057785916;5694.772209111672;5714.142878568248;5731.77072917087;4967.950320496821;5206.427292997767;6295.118683384329;6303.338149494329;6308.179936608211;5514.979728750194;5922.911156332659;5961.940380596138;5984.551158663031;5993.850153746104;5146.279520867081;6022;6053.45518903292;6059.6364218147055;6153.446189842935;6073.787417440369;6083.695815209222;6102.095423428478;6127.509799216052;6135.570510064342;6106.650236514695;6110.384670839732;6119.238007986427;6121.910283036266;6134.632471123787;4787.784549695272;4813.253945638432;4820.638452116105;4857.6599638025;4886.877828054327;3695.870644527429;4342.478902531653;4354.825806967686;4365.345198220229;4411.316245981878;5668.744906479218;5730.512906402919;5731.168980497804;5738.68437235956;5747.85630359236;6177.8455538611;6196.721147548371;6201.10084037812;6202.782902598387;6204.317525072239;5571.888562228733;5586.385497595261;5631.324241091095;5655.632383895034;5703.144528320785;5309.177077552986;5348.304720386325;5352.437994010651;5354.170103633943;5361.731913404392;6118.479929206067;6138.631682099089;6149.877002459926;6189.876202475835;6203;6055.394460553909;6116.816495504964;6155.815325540241;6157.230346206724;6178.907316390348;6108.816735497942;6141.0257691268425;6146.262448506208;6161.353057929032;6174.166487524307;6085.69571521431;6092.725827337692;6095.085737139465;6103.755849765959;6129.0193569030525;5845;6145.262568491809;6151.630902145886;6168.228971378578;6188.566800323934;5839.182514448065;5882.117682347682;5906.438888305604;5998.25021872266;6010.7295171716505;5918.585699001029;5957.314908785372;5985.760569577168;6031.487323577545;6035.185249991195;5817.389174136655;5828.446297601721;5831.562632802472;5846.356900741001;5863.648181109147;5879.147523609138;5911.0246809277705;5925.05199168131;5967.283925928743;5980.730867110903;5725.942740572541;5759.2512973313205;5779.104238842986;5814.592978491465;5832.854178645568 08:23:06 INFO - PROCESS | 1645 | |1;ext.html;443.4567654623086;448.2984129836807;465.897502549439;486.49404619196036;486.56695540968536;27857.303567410825;40348.79825600872;41572.75281741545;41671.374929376005;41685;41904;42294.788526057404;42315;42343.78828105863;42759.3586096208;8381.413301068927;8590.355723320776;9212.309076819249;9429.85855212169;9434.339596228267;11288.209825312231;11542.653720388402;11577;11729.824052639216;11741.7651646967;11297.491612877398;11355.148363872742;11412.771744565103;11413.144014198968;11428.428578571038;11268.042216411615;11279.041281491041;11360.204785665006;11362.715932101723;11397.886021139848;11257.60598379061;11301.943490282578;11329.037031852302;11344.48949797261;11346.943265283704;39325.01687457837;39418.60581394178;39715;39718.602813972066;39749.80125099385;2886.235147685865;3316.60200775906;3368.713659338959;3404.0128362774767;3413.5562376890844;30340.69659303401;30407.69592304071;30703.846480767454;30932;31476.055718328487;3160.8261545614982;3174.5238214267815;3190.840457977115;3277.8197199154038;3277.950830737541;356351;358480;359338;360475;362533;59337.70331148403;59851.80296394048;59864.40135598588;60034.69982650146;60132.67943468769;61496;62181.68909155425;62270.688646556475;62362.37637623656;62369.37630623727;12940.223586584834;15932.362705491882;15979;15983.680326393407;15999.680006399807;11337.829932551018;11610.825837612443;11617.244879082833;12260.632181034583;12357;16376.344946202256;16660.41688540895;16672.41543068222;16961.830381696273;16985.830141698425;5429.859729456858;6266.368125387348;6318.715657795318;6342.080398342215;6366.490680745622;851.7104184577273;884.769959810441;911.8374073056773;913.3469569257879;935.3218916285774;24117.397065073164;28310.292242694097;29426.558601620993;29597.852010739807;30268.697313027027;1010.8938561451089;1041.354360296621;1068.2949253492814;1095.8191898336686;1206.0773508266184;14461.566153015427;14593.12441253507;15538.844611553739;15578.532644020697;15638.843611563967;536191;538684;541718;545773;547799;57309.14036289459;57421.84179870147;57529.42470575324;57648.370437400234;57875;1213.836132122152;1220.725336799231;1229.7847876621556;1376.4425407709894;1393.0248825821966;28953;29953.850230748707;30283.091507254816;30880.91916782902;31053.378932420772;46523.76738116423;55015;55209.89580208454;55393.89212215814;55480.6129846757;499992;502378;503225;503899;504038;33788.83105584457;34771.65228347684;38008;38318.61681383262;38591.228175436896;37417;38535.42196867106;39393.21213575655;40167.799161004004;44461.77769111134;36947.44578831374;38583.80708096441;38819.805900970314;40274.59725402708;40905;37308.440373394966;37533.68632097863;38026.429603555414;38810;38879;36346.63653363432;37247;37689.81155094207;37812.62187378091;37890;28333;28341.71658283391;32267.35465290728;32380;33207.505662244774;24135.164095791635;24144.51710965806;24302.513949720553;24621.876890615433;24807.25578232656 08:23:06 INFO - PROCESS | 1645 | |2;jquery.html;325.78009843355727;345.34039983631254;367.7701436602125;368.61295639578447;382.70531690598256;19237.038148092593;19923.302684406048;20631;20808.959552022396;21004;19994.60010799783;20147;20599.86700731459;21370.572588548257;22251.888740556315;6536;6551.770688025908;6744.393004629583;6851.554648947827;6897.827554311132;4581.198290299201;4843.200871856139;6698.732050717966;6838.11104556407;6849.657517124148;4692.457194817907;4846.612271018328;4935.383077115361;7608.087029556461;7628.237176282355;7392.186859445511;7647.388208943326;7681.50070245435;7697.384209263301;7705.807354816118;7475.663595138232;7483.139438964535;7486.326230639214;7490.812729681747;7499.550026998398;28402;28769.56845647317;28904.85547572249;28989.710102898913;29208.415831683247;2331.300609817048;2350.576896158691;2370.6444033394955;2389.8566086034893;2545.2364290712712;16845.41041063569;16916.915415422965;16971.830281697272;17104.914475427544;17647.558811029827;1883.50087226885;1986.3941497843152;2018.5559176981042;2031;2086.2906611751923;81063.59468202622;112947;120625;130485.34757326152;130862.03706944404;20218.19127234894;20763.480912976993;21032.89483552603;21685.783142168377;21946.53817701957;30739.69260307413;35088.64911350905;35120.64879351225;35179.82410087984;35264.11839704028;8238.80537322097;8855.73432797017;10282.794344113076;10564.471776411148;10722.356658600353;8674.56627168639;8717.084706105894;8726.781830454163;8897.466152030898;8974;8096.5546894921345;9698.660546880825;9779.657711980046;9918.206543476505;9932.851007234898;3683.3369993401443;3791.9241615167543;3794.2221844521805;3799.3920972644246;3853;716.25425552297;832.9167083291622;909.6679711905107;932.5943214701626;950.3157726436955;20057.39827805168;20886.164553417995;20922.37232883016;20967.07273790658;21086.367408977756;908.7364664247294;935.2564711054728;939.0234156477323;947.5783276442055;984.542187882638;10137.13834324076;10196.756713523013;10757.462126893624;10801;10811.891881081247;548914;559438;560258;570735;571006;105825.47087264515;107168;124440.37779811044;127007;138781;825.7976795685096;882.8322618702555;963.4845357733578;1018;1021.8875923648393;17891;18728.157232924277;18783.71824422662;18827.811721883154;18923.243070277586;47068;55246.723766380914;56866;57493.137602936826;58834;62763.6861815688;79769.60115199386;80011.19988800038;81917.18082819096;82497.17502824895;7819.491733037335;7827.373810095065;7874.72438464651;8074.3540516759695;8085.272325490734;9888.653897113567;12221.877781222074;12306.507739690313;12439.564615238423;12615.49538018469;9171.63313467454;10303.3817970922;10445.68662940113;10621.89378106209;10637.308574942605;6999.440044796303;10646.73383165396;10862.185336099667;10871.836922446011;10999.890001099886;9974.950125249326;10945.616903408343;10999.34003959765;11143.777124457627;11234.382108984084;6866.965665171642;7266.055412796302;7298.160711518031;7542.811429714301;8060.516369017878;10740.785184296114;10785.083267922;11060.059894909024;11255.831162532404;11364.715882103013 08:23:06 INFO - PROCESS | 1645 | |3;mootools.html;1474.6313421644588;1498.8426215247396;1677.706401379759;1824.616830465602;1853.82388673076;7973.92026079739;8411.495310281372;8414.537200453988;8423.989121305443;8426.031006434254;7413.221611730772;7651;7652.120006199289;7891.171427000154;8149.348052155829;2264.5697317509703;2338.1582630253097;2340.9531809363802;2344.2732752846673;2345.26124270855;1965.3514340267677;2324.1400681747778;2332.696749422573;2368.86971216583;2375.8099352051795;2301.7928386445215;2306.066043252477;2325.848819826706;2326.523062772136;2326.9883650581723;2296.552172326397;2313.4679023824447;2320.7331156917003;2324.5583339165505;2330.196082351586;2239.8880055997133;2339;2343.613303804887;2346.8005219556358;2348.588996925548;8122.18778122189;8201.26188643019;8212.63043163059;8234;8234.341252699769;4967.900641987176;5152.9484705152845;5153.2270159476;5164.767585458663;5168.870778230536;2788.9581656275172;3056.51095824667;3230.2321607304243;3342.197872510604;3345.7992520448606;963.2294164668307;977.6480467031863;1000.8448690452991;1003.1824063388389;1003.6085926488676;10481;10552.997465240867;10703.892961070367;10715.08921741653;10734.087602553793;4310.978445107754;4401.449818772653;4583.862484125481;4644.349791029259;4662.743549104764;9386.483743394043;9397.154256116846;9405.153536181777;9406.811863762823;9417.529123543796;5155.690658560498;5159.458256882973;5169.431362550116;5172.534471897472;5177.275181474596;4560.749158796231;4662.393888794435;4719.598834099072;4724.881877953078;4760.547747963938;3051.9847400762856;3615.6203598621764;3688.5573731152435;3739.700823934079;3758.699304055669;1208.6736581123048;1230.1081715756006;1230.2126638951079;1235.5737270641614;1241.4103300932165;867.3364875869838;867.3668222197831;883.327933002672;883.6244596046654;899.2670973156856;5208.5051920067535;5350.678959262456;5383.757730902119;5573.359063707644;5587;379.646928356631;435.4100194236764;444.7709429643736;446.4040505924627;450.2233646959035;3616.6383361663625;3629.4192929131214;3752.4371344298575;3769.5099637047556;3785.091578021255;9320;9730.318877678636;9740.610375584898;9742.220622350336;9791.216702663769;8255.834883302301;9837.80324393508;9845.75385615351;9870.30907836459;9872.802543949081;7332.340089391873;7577.962110189414;7580.54516728998;7749.883751743729;7752.999999999887;5317.494837990384;5425.104857698436;5430.02259593277;5498.45015498447;5664.320281566238;8824.073472285318;9121.49831759233;9211.585478653611;9236.353455258068;9294.814103718023;7351.779446616396;9126.863097053416;9342;9343.065693430874;9539.523023848918;6909.618076384642;7219.422446204396;7236.38490728294;7241.312075352833;7251.854962900818;7592.620368981639;7700.730474433368;7704.26809453101;7748.186440423674;7811.101723301893;7044.718211271696;7056.6118863463;7064.32888875556;7094.609796461038;7151.106111736033;6900.7929762107215;6927.653617319214;6988.685509152202;7008.5094043416475;7050.506464547432;6517.4134327910715;6659.567128136656;6666;6667.733290668319;6675.465962723068;4567.2464043432465;4750.881227969328;4802.423709154924;4851.345068415719;4901.926471103007;3826.6364695353896;4594.333821595783;4835.758212089452;4906.55840974314;4918.065567542156 08:23:06 INFO - PROCESS | 1645 | |4;prototype.html;297.2212802457561;349.3483309979461;359.41953744702306;367.2123295531084;368.24509755002236;4794.952050479495;4804.591609713169;5159.922601160985;5195.480451954802;5200.765965531556;3904.4338570907203;4981.302617633534;5064.822731204408;5066.771995260213;5075.3909530856345;3636.309101270763;4080.9183816323657;4081.3061779497407;4107.178564287147;4121;3761.5298087739034;4078.877633670995;4105.958940410587;4106.281400754856;4120.299549076664;3412.191538484607;3449.6032956210106;3952.529668956902;4082.5305089914596;4109.91780164398;3606.801625910574;3774.9056273593105;3928.46965659638;4103.405006274089;4122.154958233555;3420.7605467617277;3581.301646178996;3601.94597081044;3626.34725749365;3652.214773823614;4597.953910509825;4884.389451318585;5003.874903127415;5079.161938280179;5092.879566495365;3671.7980511071883;4431.933520997188;4713.929291060636;4759.952400475986;4801.68789028712;4505;5130.153524668425;5504.614676972614;5513.751881165357;5547.611667183299;3770.26479836432;4040.8483582178937;4045.1302969861326;4047.5952404759582;4048.736832105933;4894.951050489485;5423.972880135613;5536.307961504852;5708.457696518824;5721.6554109784165;4090;4091.3044782387065;4095.996480862208;4099.959000410017;4107.453378905038;3375.578052743407;4112.444819949328;4124.711270211056;4135.793210339471;4144.937825932613;4011.618896204856;4014.458048163519;4166.229247589205;4388.670849686222;4716.834910778106;5487.570268582136;5502.368436831672;5504.091824848855;5513.393526712059;5529.502344788988;1213.7451135261517;1332.666833291677;1350.0482160077122;1352.0468070010618;1353.911995720275;842.3952370733762;842.9336888835628;896.8296023755596;922.8385032619399;966.7631430299481;4543.910480567516;4627.259638457831;4721.216509775498;4862.270659401047;4903.485134060872;4646.95353046472;5224.05583784248;5302.560822021913;5466.726663666801;5496.697681627469;4830.492798256132;4837.4920633333695;4874.171390863562;5188.7405629719115;5289.973550132302;2452.619843924195;2660.9733902661114;2851.957220641692;2864.8281103133877;2900.347421830071;5343.866403339947;5610.49505544503;5624.409437009137;5653.897489989495;5657.6039677223025;5232.607554433433;5524.66851988882;5574.888502229933;5588.720563971785;5609.214709940612;4836.951630483721;4883.313098610526;5450.781968721286;5475.425080366584;5530.446955304437;4593.567207644639;4638.489766125656;4873.731944743073;4922.975385123052;5334.5596688893;4633.72197668141;4834.854954351375;5383.623146379872;5383.650062745909;5387.272718182995;4517.457905051283;5400.594955378284;5614.747336369792;5621.5221706155435;5628.21403405317;3457.4913957180793;3590;3590.0127464946304;3596.6043735189633;3598.6401359863803;4731.337612734289;4767.33257343979;4790.957741833891;4813.78337974799;5339.786408543615;4932.457429682804;5051.419086805065;5167.974160129175;5233.947660523346;5274.7890084396195;4289.897950004538;4479.7536135512855;4608.377868987778;5242.764075616683;5257.947420525746;4858.805647774049;4930.630202734881;5013.468198559704;5154.664946778447;5164.3802743671;4608.815647374067;5366.865828354323;5387.111126664213;5401.810936617199;5427.457254274541;4727.149113159664;4838.104950584153;5301.3373328333955;5374.732761893289;5386.569074474111 08:23:06 INFO - PROCESS | 1645 | |5;yui.html;701.5054386657404;733.6331834082958;738.3170567225322;757.261669871875;850.1116333431565;14463.34914928828;15076.698466030673;15565.844341556582;15571.610709732235;15703.293351799168;13568.728625427486;13570.117942333742;14206.289685515709;14391.712165756704;14409.711805763878;697.689528159969;863.408565132886;892.5180402582598;893.5219657483248;895.8297923394567;700.4571457120721;721.7185297733888;725.5356571794056;876.5047748022379;885.406777459104;924.5931790012406;924.944503329799;926.8795056642628;929.2705226397279;929.8977112517617;778.4745296924553;871.3813192633238;914.0448231597996;928.8746019287445;932.6083045121065;543.5814422894389;563.7463141586303;670.6814263224978;691.948103892205;699.1295836683311;14761.483348082873;14771.556853294418;15302.234888255654;15306;15327.693446131127;13674.794878076837;13724.588262352145;13783.379747911367;13784.517541885985;13832.654183645489;12759.489620415172;12777.16948398351;12803.231806091664;12812.910902573292;12910.225386476748;4049.97975010126;4219.346001369792;4247;4346.369776382407;4421.579949904786;108420;109681.35477967837;110499;112090;113306;10681;10757.354558726502;10840.945795270973;11047.668569942914;11260.718482038015;21431.357059288246;21612.675809862863;21685.783142168377;22014;22249.332520024425;7456.850862982818;7590.203028681909;7611.809704757426;7637.847243055107;7828.608569571498;3725.906852328659;4164.75011499311;4209.873703788891;4210.873673789792;4368.060866913629;3368.7136593389837;3478.4608385700258;3478.7738796978115;3483.8606455741487;3491.127218195451;631.6494345638215;638.4254171245916;640.3500447046251;643.5881036136876;656.2813718977711;595.3094410483818;595.627732667083;613.141601757543;625.602742258669;642.1390077116185;8064.556449395222;8643.611037503328;8716.694915677921;8905.287576993825;8952.955235223912;532.6617597825409;596.892559339323;620.2928661326092;622.2501885228289;633.173708310659;4235.576442355739;4263.658907287409;4297.548757380492;4343.20607031149;4403.713758605681;103847.4807625957;106640;108024;111418;111740;71259.6437017822;90579.09420905706;90855.54572227229;90873.72815679661;91544.54227728819;76386;82713;84562;84692.99999999876;85880;8296.502209867427;8335.874961875455;8339.041010283652;8472.068072511895;8539.103394143774;46077.76961115173;46656.53343466658;55032.443186931196;55591.166132507235;56970.43029569651;63985.680071599345;68573;71388.5722285541;74885.62557187179;75352.24647753453;12692.936535317263;12812.487500500249;12968.546100886424;13171.209727416002;13283.070185086952;14747.336369863167;15047;15192.544223673307;15352.30914608823;15389.923050384676;10487.37075775456;13573.660658483223;13659.248741319323;14014;14259.215743134228;10527.736806579896;13116.606501804961;13475.730485390433;13976.650583735081;14323.140611562923;13066.251486044888;13139.277339746024;13265.933670331586;13546;13597.66857120012;10710.410927399067;10747.89252107469;11213.775724485302;11488.540458381905;11873.703157421134;11271.211015228855;11283.323000619988;11288.998153668448;11311.490982905954;11596.536138554364 08:23:06 INFO - PROCESS | 1645 | __end_tp_report 08:23:06 INFO - PROCESS | 1645 | __start_cc_report 08:23:06 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1686 08:23:06 INFO - PROCESS | 1645 | __end_cc_report 08:23:06 INFO - PROCESS | 1645 | __startTimestamp1481559786847__endTimestamp 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | ------- Summary: start ------- 08:23:06 INFO - PROCESS | 1645 | Number of tests: 6 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5612.31 Median:5814.59 stddev:643.19 (11.1%) stddev-sans-first:618.85 08:23:06 INFO - PROCESS | 1645 | Values: 3291.3 3308.9 3309.4 3343.5 3361.4 5519.1 5558.6 5619.0 5625.5 5642.0 5550.6 5591.3 5592.6 5596.3 5623.7 4228.0 5040.1 5078.5 5079.0 5165.3 5086.7 5162.7 5163.2 5167.8 5170.0 5084.5 5121.6 5144.1 5162.8 5168.9 5147.2 5152.0 5159.2 5164.8 5199.4 4966.5 5008.1 5112.7 5116.1 5140.8 4688.5 5549.2 5555.2 5578.2 5621.2 6114.6 6125.4 6127.4 6127.8 6135.2 6070.9 6141.0 6222.4 6226.9 6227.7 5637.4 5670.6 5694.8 5714.1 5731.8 4968.0 5206.4 6295.1 6303.3 6308.2 5515.0 5922.9 5961.9 5984.6 5993.9 5146.3 6022.0 6053.5 6059.6 6153.4 6073.8 6083.7 6102.1 6127.5 6135.6 6106.7 6110.4 6119.2 6121.9 6134.6 4787.8 4813.3 4820.6 4857.7 4886.9 3695.9 4342.5 4354.8 4365.3 4411.3 5668.7 5730.5 5731.2 5738.7 5747.9 6177.8 6196.7 6201.1 6202.8 6204.3 5571.9 5586.4 5631.3 5655.6 5703.1 5309.2 5348.3 5352.4 5354.2 5361.7 6118.5 6138.6 6149.9 6189.9 6203.0 6055.4 6116.8 6155.8 6157.2 6178.9 6108.8 6141.0 6146.3 6161.4 6174.2 6085.7 6092.7 6095.1 6103.8 6129.0 5845.0 6145.3 6151.6 6168.2 6188.6 5839.2 5882.1 5906.4 5998.3 6010.7 5918.6 5957.3 5985.8 6031.5 6035.2 5817.4 5828.4 5831.6 5846.4 5863.6 5879.1 5911.0 5925.1 5967.3 5980.7 5725.9 5759.3 5779.1 5814.6 5832.9 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:61772.68 Median:359906.50 stddev:126180.38 (35.1%) stddev-sans-first:126450.33 08:23:06 INFO - PROCESS | 1645 | Values: 443.5 448.3 465.9 486.5 486.6 27857.3 40348.8 41572.8 41671.4 41685.0 41904.0 42294.8 42315.0 42343.8 42759.4 8381.4 8590.4 9212.3 9429.9 9434.3 11288.2 11542.7 11577.0 11729.8 11741.8 11297.5 11355.1 11412.8 11413.1 11428.4 11268.0 11279.0 11360.2 11362.7 11397.9 11257.6 11301.9 11329.0 11344.5 11346.9 39325.0 39418.6 39715.0 39718.6 39749.8 2886.2 3316.6 3368.7 3404.0 3413.6 30340.7 30407.7 30703.8 30932.0 31476.1 3160.8 3174.5 3190.8 3277.8 3278.0 356351.0 358480.0 359338.0 360475.0 362533.0 59337.7 59851.8 59864.4 60034.7 60132.7 61496.0 62181.7 62270.7 62362.4 62369.4 12940.2 15932.4 15979.0 15983.7 15999.7 11337.8 11610.8 11617.2 12260.6 12357.0 16376.3 16660.4 16672.4 16961.8 16985.8 5429.9 6266.4 6318.7 6342.1 6366.5 851.7 884.8 911.8 913.3 935.3 24117.4 28310.3 29426.6 29597.9 30268.7 1010.9 1041.4 1068.3 1095.8 1206.1 14461.6 14593.1 15538.8 15578.5 15638.8 536191.0 538684.0 541718.0 545773.0 547799.0 57309.1 57421.8 57529.4 57648.4 57875.0 1213.8 1220.7 1229.8 1376.4 1393.0 28953.0 29953.9 30283.1 30880.9 31053.4 46523.8 55015.0 55209.9 55393.9 55480.6 499992.0 502378.0 503225.0 503899.0 504038.0 33788.8 34771.7 38008.0 38318.6 38591.2 37417.0 38535.4 39393.2 40167.8 44461.8 36947.4 38583.8 38819.8 40274.6 40905.0 37308.4 37533.7 38026.4 38810.0 38879.0 36346.6 37247.0 37689.8 37812.6 37890.0 28333.0 28341.7 32267.4 32380.0 33207.5 24135.2 24144.5 24302.5 24621.9 24807.3 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:35150.22 Median:35221.97 stddev:93750.30 (266.2%) stddev-sans-first:93976.83 08:23:06 INFO - PROCESS | 1645 | Values: 325.8 345.3 367.8 368.6 382.7 19237.0 19923.3 20631.0 20809.0 21004.0 19994.6 20147.0 20599.9 21370.6 22251.9 6536.0 6551.8 6744.4 6851.6 6897.8 4581.2 4843.2 6698.7 6838.1 6849.7 4692.5 4846.6 4935.4 7608.1 7628.2 7392.2 7647.4 7681.5 7697.4 7705.8 7475.7 7483.1 7486.3 7490.8 7499.6 28402.0 28769.6 28904.9 28989.7 29208.4 2331.3 2350.6 2370.6 2389.9 2545.2 16845.4 16916.9 16971.8 17104.9 17647.6 1883.5 1986.4 2018.6 2031.0 2086.3 81063.6 112947.0 120625.0 130485.3 130862.0 20218.2 20763.5 21032.9 21685.8 21946.5 30739.7 35088.6 35120.6 35179.8 35264.1 8238.8 8855.7 10282.8 10564.5 10722.4 8674.6 8717.1 8726.8 8897.5 8974.0 8096.6 9698.7 9779.7 9918.2 9932.9 3683.3 3791.9 3794.2 3799.4 3853.0 716.3 832.9 909.7 932.6 950.3 20057.4 20886.2 20922.4 20967.1 21086.4 908.7 935.3 939.0 947.6 984.5 10137.1 10196.8 10757.5 10801.0 10811.9 548914.0 559438.0 560258.0 570735.0 571006.0 105825.5 107168.0 124440.4 127007.0 138781.0 825.8 882.8 963.5 1018.0 1021.9 17891.0 18728.2 18783.7 18827.8 18923.2 47068.0 55246.7 56866.0 57493.1 58834.0 62763.7 79769.6 80011.2 81917.2 82497.2 7819.5 7827.4 7874.7 8074.4 8085.3 9888.7 12221.9 12306.5 12439.6 12615.5 9171.6 10303.4 10445.7 10621.9 10637.3 6999.4 10646.7 10862.2 10871.8 10999.9 9975.0 10945.6 10999.3 11143.8 11234.4 6867.0 7266.1 7298.2 7542.8 8060.5 10740.8 10785.1 11060.1 11255.8 11364.7 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5326.13 Median:5170.98 stddev:2924.31 (56.6%) stddev-sans-first:2918.19 08:23:06 INFO - PROCESS | 1645 | Values: 1474.6 1498.8 1677.7 1824.6 1853.8 7973.9 8411.5 8414.5 8424.0 8426.0 7413.2 7651.0 7652.1 7891.2 8149.3 2264.6 2338.2 2341.0 2344.3 2345.3 1965.4 2324.1 2332.7 2368.9 2375.8 2301.8 2306.1 2325.8 2326.5 2327.0 2296.6 2313.5 2320.7 2324.6 2330.2 2239.9 2339.0 2343.6 2346.8 2348.6 8122.2 8201.3 8212.6 8234.0 8234.3 4967.9 5152.9 5153.2 5164.8 5168.9 2789.0 3056.5 3230.2 3342.2 3345.8 963.2 977.6 1000.8 1003.2 1003.6 10481.0 10553.0 10703.9 10715.1 10734.1 4311.0 4401.4 4583.9 4644.3 4662.7 9386.5 9397.2 9405.2 9406.8 9417.5 5155.7 5159.5 5169.4 5172.5 5177.3 4560.7 4662.4 4719.6 4724.9 4760.5 3052.0 3615.6 3688.6 3739.7 3758.7 1208.7 1230.1 1230.2 1235.6 1241.4 867.3 867.4 883.3 883.6 899.3 5208.5 5350.7 5383.8 5573.4 5587.0 379.6 435.4 444.8 446.4 450.2 3616.6 3629.4 3752.4 3769.5 3785.1 9320.0 9730.3 9740.6 9742.2 9791.2 8255.8 9837.8 9845.8 9870.3 9872.8 7332.3 7578.0 7580.5 7749.9 7753.0 5317.5 5425.1 5430.0 5498.5 5664.3 8824.1 9121.5 9211.6 9236.4 9294.8 7351.8 9126.9 9342.0 9343.1 9539.5 6909.6 7219.4 7236.4 7241.3 7251.9 7592.6 7700.7 7704.3 7748.2 7811.1 7044.7 7056.6 7064.3 7094.6 7151.1 6900.8 6927.7 6988.7 7008.5 7050.5 6517.4 6659.6 6666.0 6667.7 6675.5 4567.2 4750.9 4802.4 4851.3 4901.9 3826.6 4594.3 4835.8 4906.6 4918.1 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4355.83 Median:4809.19 stddev:1276.41 (26.5%) stddev-sans-first:1243.10 08:23:06 INFO - PROCESS | 1645 | Values: 297.2 349.3 359.4 367.2 368.2 4795.0 4804.6 5159.9 5195.5 5200.8 3904.4 4981.3 5064.8 5066.8 5075.4 3636.3 4080.9 4081.3 4107.2 4121.0 3761.5 4078.9 4106.0 4106.3 4120.3 3412.2 3449.6 3952.5 4082.5 4109.9 3606.8 3774.9 3928.5 4103.4 4122.2 3420.8 3581.3 3601.9 3626.3 3652.2 4598.0 4884.4 5003.9 5079.2 5092.9 3671.8 4431.9 4713.9 4760.0 4801.7 4505.0 5130.2 5504.6 5513.8 5547.6 3770.3 4040.8 4045.1 4047.6 4048.7 4895.0 5424.0 5536.3 5708.5 5721.7 4090.0 4091.3 4096.0 4100.0 4107.5 3375.6 4112.4 4124.7 4135.8 4144.9 4011.6 4014.5 4166.2 4388.7 4716.8 5487.6 5502.4 5504.1 5513.4 5529.5 1213.7 1332.7 1350.0 1352.0 1353.9 842.4 842.9 896.8 922.8 966.8 4543.9 4627.3 4721.2 4862.3 4903.5 4647.0 5224.1 5302.6 5466.7 5496.7 4830.5 4837.5 4874.2 5188.7 5290.0 2452.6 2661.0 2852.0 2864.8 2900.3 5343.9 5610.5 5624.4 5653.9 5657.6 5232.6 5524.7 5574.9 5588.7 5609.2 4837.0 4883.3 5450.8 5475.4 5530.4 4593.6 4638.5 4873.7 4923.0 5334.6 4633.7 4834.9 5383.6 5383.7 5387.3 4517.5 5400.6 5614.7 5621.5 5628.2 3457.5 3590.0 3590.0 3596.6 3598.6 4731.3 4767.3 4791.0 4813.8 5339.8 4932.5 5051.4 5168.0 5233.9 5274.8 4289.9 4479.8 4608.4 5242.8 5257.9 4858.8 4930.6 5013.5 5154.7 5164.4 4608.8 5366.9 5387.1 5401.8 5427.5 4727.1 4838.1 5301.3 5374.7 5386.6 08:23:06 INFO - PROCESS | 1645 | 08:23:06 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20928.27 Median:4227.46 stddev:30633.97 (724.6%) stddev-sans-first:30682.25 08:23:06 INFO - PROCESS | 1645 | Values: 701.5 733.6 738.3 757.3 850.1 14463.3 15076.7 15565.8 15571.6 15703.3 13568.7 13570.1 14206.3 14391.7 14409.7 697.7 863.4 892.5 893.5 895.8 700.5 721.7 725.5 876.5 885.4 924.6 924.9 926.9 929.3 929.9 778.5 871.4 914.0 928.9 932.6 543.6 563.7 670.7 691.9 699.1 14761.5 14771.6 15302.2 15306.0 15327.7 13674.8 13724.6 13783.4 13784.5 13832.7 12759.5 12777.2 12803.2 12812.9 12910.2 4050.0 4219.3 4247.0 4346.4 4421.6 108420.0 109681.4 110499.0 112090.0 113306.0 10681.0 10757.4 10840.9 11047.7 11260.7 21431.4 21612.7 21685.8 22014.0 22249.3 7456.9 7590.2 7611.8 7637.8 7828.6 3725.9 4164.8 4209.9 4210.9 4368.1 3368.7 3478.5 3478.8 3483.9 3491.1 631.6 638.4 640.4 643.6 656.3 595.3 595.6 613.1 625.6 642.1 8064.6 8643.6 8716.7 8905.3 8953.0 532.7 596.9 620.3 622.3 633.2 4235.6 4263.7 4297.5 4343.2 4403.7 103847.5 106640.0 108024.0 111418.0 111740.0 71259.6 90579.1 90855.5 90873.7 91544.5 76386.0 82713.0 84562.0 84693.0 85880.0 8296.5 8335.9 8339.0 8472.1 8539.1 46077.8 46656.5 55032.4 55591.2 56970.4 63985.7 68573.0 71388.6 74885.6 75352.2 12692.9 12812.5 12968.5 13171.2 13283.1 14747.3 15047.0 15192.5 15352.3 15389.9 10487.4 13573.7 13659.2 14014.0 14259.2 10527.7 13116.6 13475.7 13976.7 14323.1 13066.3 13139.3 13265.9 13546.0 13597.7 10710.4 10747.9 11213.8 11488.5 11873.7 11271.2 11283.3 11289.0 11311.5 11596.5 08:23:06 INFO - PROCESS | 1645 | -------- Summary: end -------- 08:23:06 INFO - PROCESS | 1645 | 08:23:07 INFO - TEST-INFO | 1645: exit 0 08:23:07 INFO - TEST-OK | dromaeo_css | took 1119614ms 08:23:07 INFO - TEST-START | kraken 08:23:07 INFO - operating with platform_type : mac_ 08:23:07 INFO - Initialising browser for kraken test... 08:23:07 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpVfPZzv/profile http://localhost:49250/getInfo.html) 08:23:09 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 08:23:09 INFO - PROCESS | 1651 | colorDepth:24 08:23:09 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 08:23:09 INFO - PROCESS | 1651 | __metrics 08:23:09 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:09 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:10 INFO - TEST-INFO | 1651: exit 0 08:23:10 INFO - Browser initialized. 08:23:10 INFO - Running cycle 1/1 for kraken test... 08:23:10 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/tmpVfPZzv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:22 INFO - PROCESS | 1652 | RSS: Main: 237641728 08:23:22 INFO - PROCESS | 1652 | 08:23:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:26 INFO - PROCESS | 1652 | RSS: Main: 289845248 08:23:26 INFO - PROCESS | 1652 | 08:23:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 08:23:29 INFO - PROCESS | 1652 | RSS: Main: 290566144 08:23:29 INFO - PROCESS | 1652 | 08:23:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 08:23:33 INFO - PROCESS | 1652 | RSS: Main: 384282624 08:23:33 INFO - PROCESS | 1652 | 08:23:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 08:23:36 INFO - PROCESS | 1652 | RSS: Main: 285683712 08:23:36 INFO - PROCESS | 1652 | 08:23:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:38 INFO - PROCESS | 1652 | RSS: Main: 290566144 08:23:38 INFO - PROCESS | 1652 | 08:23:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:42 INFO - PROCESS | 1652 | RSS: Main: 334389248 08:23:42 INFO - PROCESS | 1652 | 08:23:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:46 INFO - PROCESS | 1652 | RSS: Main: 334659584 08:23:46 INFO - PROCESS | 1652 | 08:23:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 08:23:49 INFO - PROCESS | 1652 | RSS: Main: 331669504 08:23:49 INFO - PROCESS | 1652 | 08:23:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:51 INFO - PROCESS | 1652 | RSS: Main: 304992256 08:23:51 INFO - PROCESS | 1652 | 08:23:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:54 INFO - PROCESS | 1652 | RSS: Main: 309866496 08:23:54 INFO - PROCESS | 1652 | 08:23:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:57 INFO - PROCESS | 1652 | RSS: Main: 311746560 08:23:57 INFO - PROCESS | 1652 | 08:24:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:00 INFO - PROCESS | 1652 | RSS: Main: 330846208 08:24:00 INFO - PROCESS | 1652 | 08:24:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:04 INFO - PROCESS | 1652 | RSS: Main: 324526080 08:24:04 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 08:24:06 INFO - PROCESS | 1652 | RSS: Main: 368312320 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | __start_tp_report 08:24:06 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 08:24:06 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 08:24:06 INFO - PROCESS | 1652 | |i|pagename|runs| 08:24:06 INFO - PROCESS | 1652 | |0;ai-astar;115;115;115;114;115;115;113;114;115;115 08:24:06 INFO - PROCESS | 1652 | |1;audio-beat-detection;150;113;117;150;114;115;116;113;133;113 08:24:06 INFO - PROCESS | 1652 | |2;audio-dft;183;185;183;186;184;183;182;180;181;185 08:24:06 INFO - PROCESS | 1652 | |3;audio-fft;80;60;59;86;61;62;59;58;74;58 08:24:06 INFO - PROCESS | 1652 | |4;audio-oscillator;84;70;86;68;69;69;82;68;69;82 08:24:06 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;107;110;109;111;108;111;109;112;108;111 08:24:06 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;94;95;101;121;94;94;104;150;94 08:24:06 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;86;88;87;84;87;85;82;70;101 08:24:06 INFO - PROCESS | 1652 | |8;json-parse-financial;57;57;57;57;56;56;54;55;54;55 08:24:06 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;66;71;79;74;78;102;96;70;70;71 08:24:06 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;89;89;88;87;88;85;87;85;92;89 08:24:06 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;150;154;142;150;149;154;145;147;213;188 08:24:06 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;177;177;178;177;177;178;175;178;174;178 08:24:06 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;73;85;87;86;75;68;68;71;68 08:24:06 INFO - PROCESS | 1652 | __end_tp_report 08:24:06 INFO - PROCESS | 1652 | __start_cc_report 08:24:06 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2038 08:24:06 INFO - PROCESS | 1652 | __end_cc_report 08:24:06 INFO - PROCESS | 1652 | __startTimestamp1481559846642__endTimestamp 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | ------- Summary: start ------- 08:24:06 INFO - PROCESS | 1652 | Number of tests: 14 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 08:24:06 INFO - PROCESS | 1652 | Values: 115.0 115.0 115.0 114.0 115.0 115.0 113.0 114.0 115.0 115.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:116.50 stddev:15.23 (13.1%) stddev-sans-first:12.75 08:24:06 INFO - PROCESS | 1652 | Values: 150.0 113.0 117.0 150.0 114.0 115.0 116.0 113.0 133.0 113.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.87 (1.0%) stddev-sans-first:1.99 08:24:06 INFO - PROCESS | 1652 | Values: 183.0 185.0 183.0 186.0 184.0 183.0 182.0 180.0 181.0 185.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.50 stddev:10.34 (16.8%) stddev-sans-first:9.58 08:24:06 INFO - PROCESS | 1652 | Values: 80.0 60.0 59.0 86.0 61.0 62.0 59.0 58.0 74.0 58.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:76.00 stddev:7.67 (10.1%) stddev-sans-first:7.37 08:24:06 INFO - PROCESS | 1652 | Values: 84.0 70.0 86.0 68.0 69.0 69.0 82.0 68.0 69.0 82.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.50 stddev:1.65 (1.5%) stddev-sans-first:1.45 08:24:06 INFO - PROCESS | 1652 | Values: 107.0 110.0 109.0 111.0 108.0 111.0 109.0 112.0 108.0 111.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:94.00 stddev:18.18 (19.3%) stddev-sans-first:18.98 08:24:06 INFO - PROCESS | 1652 | Values: 95.0 94.0 95.0 101.0 121.0 94.0 94.0 104.0 150.0 94.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:7.50 (8.7%) stddev-sans-first:7.95 08:24:06 INFO - PROCESS | 1652 | Values: 86.0 86.0 88.0 87.0 84.0 87.0 85.0 82.0 70.0 101.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.50 stddev:1.23 (2.2%) stddev-sans-first:1.22 08:24:06 INFO - PROCESS | 1652 | Values: 57.0 57.0 57.0 57.0 56.0 56.0 54.0 55.0 54.0 55.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:72.50 stddev:11.95 (16.5%) stddev-sans-first:11.91 08:24:06 INFO - PROCESS | 1652 | Values: 66.0 71.0 79.0 74.0 78.0 102.0 96.0 70.0 70.0 71.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.50 stddev:2.08 (2.3%) stddev-sans-first:2.17 08:24:06 INFO - PROCESS | 1652 | Values: 89.0 89.0 88.0 87.0 88.0 85.0 87.0 85.0 92.0 89.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:159.20 Median:152.00 stddev:22.85 (15.0%) stddev-sans-first:23.99 08:24:06 INFO - PROCESS | 1652 | Values: 150.0 154.0 142.0 150.0 149.0 154.0 145.0 147.0 213.0 188.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.50 stddev:1.37 (0.8%) stddev-sans-first:1.45 08:24:06 INFO - PROCESS | 1652 | Values: 177.0 177.0 178.0 177.0 177.0 178.0 175.0 178.0 174.0 178.0 08:24:06 INFO - PROCESS | 1652 | 08:24:06 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:74.00 stddev:8.03 (10.9%) stddev-sans-first:8.12 08:24:06 INFO - PROCESS | 1652 | Values: 68.0 73.0 85.0 87.0 86.0 75.0 68.0 68.0 71.0 68.0 08:24:06 INFO - PROCESS | 1652 | -------- Summary: end -------- 08:24:06 INFO - PROCESS | 1652 | 08:24:07 INFO - TEST-INFO | 1652: exit 0 08:24:07 INFO - TEST-OK | kraken | took 60207ms 08:24:07 INFO - SUITE-END | took 1179s 08:24:07 INFO - Completed test suite (00:19:39) 08:24:07 INFO - javascript benchmark 08:24:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.2594666200107, 3308.933821323573, 3309.420851351013, 3343.5151902974053, 3361.394948909197, 5519.116941289394, 5558.583106267031, 5619.0, 5625.493705566499, 5642.040853054986, 5550.583706222029, 5591.329040515144, 5592.552595792337, 5596.27248457701, 5623.746931388087, 4227.957720422787, 5040.067587496315, 5078.466760990098, 5079.034983353151, 5165.328507294046, 5086.669366491166, 5162.690238585678, 5163.225516172567, 5167.793288268484, 5169.974150129263, 5084.491550844923, 5121.590272778188, 5144.125498665236, 5162.793488260465, 5168.9224661630105, 5147.22791581262, 5152.0, 5159.174532074888, 5164.793408263665, 5199.428062913076, 4966.47851975541, 5008.12357837377, 5112.744362781883, 5116.104681680728, 5140.820071297487, 4688.460827004904, 5549.1676248562635, 5555.194496797942, 5578.191162281487, 5621.156826476021, 6114.571979961404, 6125.356837532084, 6127.417895299939, 6127.846803829895, 6135.233095863017, 6070.939290607082, 6141.0, 6222.43998040174, 6226.875462490725, 6227.688615569249, 5637.408072152406, 5670.603057785916, 5694.772209111672, 5714.142878568248, 5731.77072917087, 4967.950320496821, 5206.427292997767, 6295.118683384329, 6303.338149494329, 6308.179936608211, 5514.979728750194, 5922.911156332659, 5961.940380596138, 5984.551158663031, 5993.850153746104, 5146.279520867081, 6022.0, 6053.45518903292, 6059.6364218147055, 6153.446189842935, 6073.787417440369, 6083.695815209222, 6102.095423428478, 6127.509799216052, 6135.570510064342, 6106.650236514695, 6110.384670839732, 6119.238007986427, 6121.910283036266, 6134.632471123787, 4787.784549695272, 4813.253945638432, 4820.638452116105, 4857.6599638025, 4886.877828054327, 3695.870644527429, 4342.478902531653, 4354.825806967686, 4365.345198220229, 4411.316245981878, 5668.744906479218, 5730.512906402919, 5731.168980497804, 5738.68437235956, 5747.85630359236, 6177.8455538611, 6196.721147548371, 6201.10084037812, 6202.782902598387, 6204.317525072239, 5571.888562228733, 5586.385497595261, 5631.324241091095, 5655.632383895034, 5703.144528320785, 5309.177077552986, 5348.304720386325, 5352.437994010651, 5354.170103633943, 5361.731913404392, 6118.479929206067, 6138.631682099089, 6149.877002459926, 6189.876202475835, 6203.0, 6055.394460553909, 6116.816495504964, 6155.815325540241, 6157.230346206724, 6178.907316390348, 6108.816735497942, 6141.0257691268425, 6146.262448506208, 6161.353057929032, 6174.166487524307, 6085.69571521431, 6092.725827337692, 6095.085737139465, 6103.755849765959, 6129.0193569030525, 5845.0, 6145.262568491809, 6151.630902145886, 6168.228971378578, 6188.566800323934, 5839.182514448065, 5882.117682347682, 5906.438888305604, 5998.25021872266, 6010.7295171716505, 5918.585699001029, 5957.314908785372, 5985.760569577168, 6031.487323577545, 6035.185249991195, 5817.389174136655, 5828.446297601721, 5831.562632802472, 5846.356900741001, 5863.648181109147, 5879.147523609138, 5911.0246809277705, 5925.05199168131, 5967.283925928743, 5980.730867110903, 5725.942740572541, 5759.2512973313205, 5779.104238842986, 5814.592978491465, 5832.854178645568], "value": 5571.665256872865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.4567654623086, 448.2984129836807, 465.897502549439, 486.49404619196036, 486.56695540968536, 27857.303567410825, 40348.79825600872, 41572.75281741545, 41671.374929376005, 41685.0, 41904.0, 42294.788526057404, 42315.0, 42343.78828105863, 42759.3586096208, 8381.413301068927, 8590.355723320776, 9212.309076819249, 9429.85855212169, 9434.339596228267, 11288.209825312231, 11542.653720388402, 11577.0, 11729.824052639216, 11741.7651646967, 11297.491612877398, 11355.148363872742, 11412.771744565103, 11413.144014198968, 11428.428578571038, 11268.042216411615, 11279.041281491041, 11360.204785665006, 11362.715932101723, 11397.886021139848, 11257.60598379061, 11301.943490282578, 11329.037031852302, 11344.48949797261, 11346.943265283704, 39325.01687457837, 39418.60581394178, 39715.0, 39718.602813972066, 39749.80125099385, 2886.235147685865, 3316.60200775906, 3368.713659338959, 3404.0128362774767, 3413.5562376890844, 30340.69659303401, 30407.69592304071, 30703.846480767454, 30932.0, 31476.055718328487, 3160.8261545614982, 3174.5238214267815, 3190.840457977115, 3277.8197199154038, 3277.950830737541, 356351.0, 358480.0, 359338.0, 360475.0, 362533.0, 59337.70331148403, 59851.80296394048, 59864.40135598588, 60034.69982650146, 60132.67943468769, 61496.0, 62181.68909155425, 62270.688646556475, 62362.37637623656, 62369.37630623727, 12940.223586584834, 15932.362705491882, 15979.0, 15983.680326393407, 15999.680006399807, 11337.829932551018, 11610.825837612443, 11617.244879082833, 12260.632181034583, 12357.0, 16376.344946202256, 16660.41688540895, 16672.41543068222, 16961.830381696273, 16985.830141698425, 5429.859729456858, 6266.368125387348, 6318.715657795318, 6342.080398342215, 6366.490680745622, 851.7104184577273, 884.769959810441, 911.8374073056773, 913.3469569257879, 935.3218916285774, 24117.397065073164, 28310.292242694097, 29426.558601620993, 29597.852010739807, 30268.697313027027, 1010.8938561451089, 1041.354360296621, 1068.2949253492814, 1095.8191898336686, 1206.0773508266184, 14461.566153015427, 14593.12441253507, 15538.844611553739, 15578.532644020697, 15638.843611563967, 536191.0, 538684.0, 541718.0, 545773.0, 547799.0, 57309.14036289459, 57421.84179870147, 57529.42470575324, 57648.370437400234, 57875.0, 1213.836132122152, 1220.725336799231, 1229.7847876621556, 1376.4425407709894, 1393.0248825821966, 28953.0, 29953.850230748707, 30283.091507254816, 30880.91916782902, 31053.378932420772, 46523.76738116423, 55015.0, 55209.89580208454, 55393.89212215814, 55480.6129846757, 499992.0, 502378.0, 503225.0, 503899.0, 504038.0, 33788.83105584457, 34771.65228347684, 38008.0, 38318.61681383262, 38591.228175436896, 37417.0, 38535.42196867106, 39393.21213575655, 40167.799161004004, 44461.77769111134, 36947.44578831374, 38583.80708096441, 38819.805900970314, 40274.59725402708, 40905.0, 37308.440373394966, 37533.68632097863, 38026.429603555414, 38810.0, 38879.0, 36346.63653363432, 37247.0, 37689.81155094207, 37812.62187378091, 37890.0, 28333.0, 28341.71658283391, 32267.35465290728, 32380.0, 33207.505662244774, 24135.164095791635, 24144.51710965806, 24302.513949720553, 24621.876890615433, 24807.25578232656], "value": 19573.02932072774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.78009843355727, 345.34039983631254, 367.7701436602125, 368.61295639578447, 382.70531690598256, 19237.038148092593, 19923.302684406048, 20631.0, 20808.959552022396, 21004.0, 19994.60010799783, 20147.0, 20599.86700731459, 21370.572588548257, 22251.888740556315, 6536.0, 6551.770688025908, 6744.393004629583, 6851.554648947827, 6897.827554311132, 4581.198290299201, 4843.200871856139, 6698.732050717966, 6838.11104556407, 6849.657517124148, 4692.457194817907, 4846.612271018328, 4935.383077115361, 7608.087029556461, 7628.237176282355, 7392.186859445511, 7647.388208943326, 7681.50070245435, 7697.384209263301, 7705.807354816118, 7475.663595138232, 7483.139438964535, 7486.326230639214, 7490.812729681747, 7499.550026998398, 28402.0, 28769.56845647317, 28904.85547572249, 28989.710102898913, 29208.415831683247, 2331.300609817048, 2350.576896158691, 2370.6444033394955, 2389.8566086034893, 2545.2364290712712, 16845.41041063569, 16916.915415422965, 16971.830281697272, 17104.914475427544, 17647.558811029827, 1883.50087226885, 1986.3941497843152, 2018.5559176981042, 2031.0, 2086.2906611751923, 81063.59468202622, 112947.0, 120625.0, 130485.34757326152, 130862.03706944404, 20218.19127234894, 20763.480912976993, 21032.89483552603, 21685.783142168377, 21946.53817701957, 30739.69260307413, 35088.64911350905, 35120.64879351225, 35179.82410087984, 35264.11839704028, 8238.80537322097, 8855.73432797017, 10282.794344113076, 10564.471776411148, 10722.356658600353, 8674.56627168639, 8717.084706105894, 8726.781830454163, 8897.466152030898, 8974.0, 8096.5546894921345, 9698.660546880825, 9779.657711980046, 9918.206543476505, 9932.851007234898, 3683.3369993401443, 3791.9241615167543, 3794.2221844521805, 3799.3920972644246, 3853.0, 716.25425552297, 832.9167083291622, 909.6679711905107, 932.5943214701626, 950.3157726436955, 20057.39827805168, 20886.164553417995, 20922.37232883016, 20967.07273790658, 21086.367408977756, 908.7364664247294, 935.2564711054728, 939.0234156477323, 947.5783276442055, 984.542187882638, 10137.13834324076, 10196.756713523013, 10757.462126893624, 10801.0, 10811.891881081247, 548914.0, 559438.0, 560258.0, 570735.0, 571006.0, 105825.47087264515, 107168.0, 124440.37779811044, 127007.0, 138781.0, 825.7976795685096, 882.8322618702555, 963.4845357733578, 1018.0, 1021.8875923648393, 17891.0, 18728.157232924277, 18783.71824422662, 18827.811721883154, 18923.243070277586, 47068.0, 55246.723766380914, 56866.0, 57493.137602936826, 58834.0, 62763.6861815688, 79769.60115199386, 80011.19988800038, 81917.18082819096, 82497.17502824895, 7819.491733037335, 7827.373810095065, 7874.72438464651, 8074.3540516759695, 8085.272325490734, 9888.653897113567, 12221.877781222074, 12306.507739690313, 12439.564615238423, 12615.49538018469, 9171.63313467454, 10303.3817970922, 10445.68662940113, 10621.89378106209, 10637.308574942605, 6999.440044796303, 10646.73383165396, 10862.185336099667, 10871.836922446011, 10999.890001099886, 9974.950125249326, 10945.616903408343, 10999.34003959765, 11143.777124457627, 11234.382108984084, 6866.965665171642, 7266.055412796302, 7298.160711518031, 7542.811429714301, 8060.516369017878, 10740.785184296114, 10785.083267922, 11060.059894909024, 11255.831162532404, 11364.715882103013], "value": 10658.224524986734, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.6313421644588, 1498.8426215247396, 1677.706401379759, 1824.616830465602, 1853.82388673076, 7973.92026079739, 8411.495310281372, 8414.537200453988, 8423.989121305443, 8426.031006434254, 7413.221611730772, 7651.0, 7652.120006199289, 7891.171427000154, 8149.348052155829, 2264.5697317509703, 2338.1582630253097, 2340.9531809363802, 2344.2732752846673, 2345.26124270855, 1965.3514340267677, 2324.1400681747778, 2332.696749422573, 2368.86971216583, 2375.8099352051795, 2301.7928386445215, 2306.066043252477, 2325.848819826706, 2326.523062772136, 2326.9883650581723, 2296.552172326397, 2313.4679023824447, 2320.7331156917003, 2324.5583339165505, 2330.196082351586, 2239.8880055997133, 2339.0, 2343.613303804887, 2346.8005219556358, 2348.588996925548, 8122.18778122189, 8201.26188643019, 8212.63043163059, 8234.0, 8234.341252699769, 4967.900641987176, 5152.9484705152845, 5153.2270159476, 5164.767585458663, 5168.870778230536, 2788.9581656275172, 3056.51095824667, 3230.2321607304243, 3342.197872510604, 3345.7992520448606, 963.2294164668307, 977.6480467031863, 1000.8448690452991, 1003.1824063388389, 1003.6085926488676, 10481.0, 10552.997465240867, 10703.892961070367, 10715.08921741653, 10734.087602553793, 4310.978445107754, 4401.449818772653, 4583.862484125481, 4644.349791029259, 4662.743549104764, 9386.483743394043, 9397.154256116846, 9405.153536181777, 9406.811863762823, 9417.529123543796, 5155.690658560498, 5159.458256882973, 5169.431362550116, 5172.534471897472, 5177.275181474596, 4560.749158796231, 4662.393888794435, 4719.598834099072, 4724.881877953078, 4760.547747963938, 3051.9847400762856, 3615.6203598621764, 3688.5573731152435, 3739.700823934079, 3758.699304055669, 1208.6736581123048, 1230.1081715756006, 1230.2126638951079, 1235.5737270641614, 1241.4103300932165, 867.3364875869838, 867.3668222197831, 883.327933002672, 883.6244596046654, 899.2670973156856, 5208.5051920067535, 5350.678959262456, 5383.757730902119, 5573.359063707644, 5587.0, 379.646928356631, 435.4100194236764, 444.7709429643736, 446.4040505924627, 450.2233646959035, 3616.6383361663625, 3629.4192929131214, 3752.4371344298575, 3769.5099637047556, 3785.091578021255, 9320.0, 9730.318877678636, 9740.610375584898, 9742.220622350336, 9791.216702663769, 8255.834883302301, 9837.80324393508, 9845.75385615351, 9870.30907836459, 9872.802543949081, 7332.340089391873, 7577.962110189414, 7580.54516728998, 7749.883751743729, 7752.999999999887, 5317.494837990384, 5425.104857698436, 5430.02259593277, 5498.45015498447, 5664.320281566238, 8824.073472285318, 9121.49831759233, 9211.585478653611, 9236.353455258068, 9294.814103718023, 7351.779446616396, 9126.863097053416, 9342.0, 9343.065693430874, 9539.523023848918, 6909.618076384642, 7219.422446204396, 7236.38490728294, 7241.312075352833, 7251.854962900818, 7592.620368981639, 7700.730474433368, 7704.26809453101, 7748.186440423674, 7811.101723301893, 7044.718211271696, 7056.6118863463, 7064.32888875556, 7094.609796461038, 7151.106111736033, 6900.7929762107215, 6927.653617319214, 6988.685509152202, 7008.5094043416475, 7050.506464547432, 6517.4134327910715, 6659.567128136656, 6666.0, 6667.733290668319, 6675.465962723068, 4567.2464043432465, 4750.881227969328, 4802.423709154924, 4851.345068415719, 4901.926471103007, 3826.6364695353896, 4594.333821595783, 4835.758212089452, 4906.55840974314, 4918.065567542156], "value": 4252.682867783341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.2212802457561, 349.3483309979461, 359.41953744702306, 367.2123295531084, 368.24509755002236, 4794.952050479495, 4804.591609713169, 5159.922601160985, 5195.480451954802, 5200.765965531556, 3904.4338570907203, 4981.302617633534, 5064.822731204408, 5066.771995260213, 5075.3909530856345, 3636.309101270763, 4080.9183816323657, 4081.3061779497407, 4107.178564287147, 4121.0, 3761.5298087739034, 4078.877633670995, 4105.958940410587, 4106.281400754856, 4120.299549076664, 3412.191538484607, 3449.6032956210106, 3952.529668956902, 4082.5305089914596, 4109.91780164398, 3606.801625910574, 3774.9056273593105, 3928.46965659638, 4103.405006274089, 4122.154958233555, 3420.7605467617277, 3581.301646178996, 3601.94597081044, 3626.34725749365, 3652.214773823614, 4597.953910509825, 4884.389451318585, 5003.874903127415, 5079.161938280179, 5092.879566495365, 3671.7980511071883, 4431.933520997188, 4713.929291060636, 4759.952400475986, 4801.68789028712, 4505.0, 5130.153524668425, 5504.614676972614, 5513.751881165357, 5547.611667183299, 3770.26479836432, 4040.8483582178937, 4045.1302969861326, 4047.5952404759582, 4048.736832105933, 4894.951050489485, 5423.972880135613, 5536.307961504852, 5708.457696518824, 5721.6554109784165, 4090.0, 4091.3044782387065, 4095.996480862208, 4099.959000410017, 4107.453378905038, 3375.578052743407, 4112.444819949328, 4124.711270211056, 4135.793210339471, 4144.937825932613, 4011.618896204856, 4014.458048163519, 4166.229247589205, 4388.670849686222, 4716.834910778106, 5487.570268582136, 5502.368436831672, 5504.091824848855, 5513.393526712059, 5529.502344788988, 1213.7451135261517, 1332.666833291677, 1350.0482160077122, 1352.0468070010618, 1353.911995720275, 842.3952370733762, 842.9336888835628, 896.8296023755596, 922.8385032619399, 966.7631430299481, 4543.910480567516, 4627.259638457831, 4721.216509775498, 4862.270659401047, 4903.485134060872, 4646.95353046472, 5224.05583784248, 5302.560822021913, 5466.726663666801, 5496.697681627469, 4830.492798256132, 4837.4920633333695, 4874.171390863562, 5188.7405629719115, 5289.973550132302, 2452.619843924195, 2660.9733902661114, 2851.957220641692, 2864.8281103133877, 2900.347421830071, 5343.866403339947, 5610.49505544503, 5624.409437009137, 5653.897489989495, 5657.6039677223025, 5232.607554433433, 5524.66851988882, 5574.888502229933, 5588.720563971785, 5609.214709940612, 4836.951630483721, 4883.313098610526, 5450.781968721286, 5475.425080366584, 5530.446955304437, 4593.567207644639, 4638.489766125656, 4873.731944743073, 4922.975385123052, 5334.5596688893, 4633.72197668141, 4834.854954351375, 5383.623146379872, 5383.650062745909, 5387.272718182995, 4517.457905051283, 5400.594955378284, 5614.747336369792, 5621.5221706155435, 5628.21403405317, 3457.4913957180793, 3590.0, 3590.0127464946304, 3596.6043735189633, 3598.6401359863803, 4731.337612734289, 4767.33257343979, 4790.957741833891, 4813.78337974799, 5339.786408543615, 4932.457429682804, 5051.419086805065, 5167.974160129175, 5233.947660523346, 5274.7890084396195, 4289.897950004538, 4479.7536135512855, 4608.377868987778, 5242.764075616683, 5257.947420525746, 4858.805647774049, 4930.630202734881, 5013.468198559704, 5154.664946778447, 5164.3802743671, 4608.815647374067, 5366.865828354323, 5387.111126664213, 5401.810936617199, 5427.457254274541, 4727.149113159664, 4838.104950584153, 5301.3373328333955, 5374.732761893289, 5386.569074474111], "value": 3966.3748484007197, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.5054386657404, 733.6331834082958, 738.3170567225322, 757.261669871875, 850.1116333431565, 14463.34914928828, 15076.698466030673, 15565.844341556582, 15571.610709732235, 15703.293351799168, 13568.728625427486, 13570.117942333742, 14206.289685515709, 14391.712165756704, 14409.711805763878, 697.689528159969, 863.408565132886, 892.5180402582598, 893.5219657483248, 895.8297923394567, 700.4571457120721, 721.7185297733888, 725.5356571794056, 876.5047748022379, 885.406777459104, 924.5931790012406, 924.944503329799, 926.8795056642628, 929.2705226397279, 929.8977112517617, 778.4745296924553, 871.3813192633238, 914.0448231597996, 928.8746019287445, 932.6083045121065, 543.5814422894389, 563.7463141586303, 670.6814263224978, 691.948103892205, 699.1295836683311, 14761.483348082873, 14771.556853294418, 15302.234888255654, 15306.0, 15327.693446131127, 13674.794878076837, 13724.588262352145, 13783.379747911367, 13784.517541885985, 13832.654183645489, 12759.489620415172, 12777.16948398351, 12803.231806091664, 12812.910902573292, 12910.225386476748, 4049.97975010126, 4219.346001369792, 4247.0, 4346.369776382407, 4421.579949904786, 108420.0, 109681.35477967837, 110499.0, 112090.0, 113306.0, 10681.0, 10757.354558726502, 10840.945795270973, 11047.668569942914, 11260.718482038015, 21431.357059288246, 21612.675809862863, 21685.783142168377, 22014.0, 22249.332520024425, 7456.850862982818, 7590.203028681909, 7611.809704757426, 7637.847243055107, 7828.608569571498, 3725.906852328659, 4164.75011499311, 4209.873703788891, 4210.873673789792, 4368.060866913629, 3368.7136593389837, 3478.4608385700258, 3478.7738796978115, 3483.8606455741487, 3491.127218195451, 631.6494345638215, 638.4254171245916, 640.3500447046251, 643.5881036136876, 656.2813718977711, 595.3094410483818, 595.627732667083, 613.141601757543, 625.602742258669, 642.1390077116185, 8064.556449395222, 8643.611037503328, 8716.694915677921, 8905.287576993825, 8952.955235223912, 532.6617597825409, 596.892559339323, 620.2928661326092, 622.2501885228289, 633.173708310659, 4235.576442355739, 4263.658907287409, 4297.548757380492, 4343.20607031149, 4403.713758605681, 103847.4807625957, 106640.0, 108024.0, 111418.0, 111740.0, 71259.6437017822, 90579.09420905706, 90855.54572227229, 90873.72815679661, 91544.54227728819, 76386.0, 82713.0, 84562.0, 84692.99999999876, 85880.0, 8296.502209867427, 8335.874961875455, 8339.041010283652, 8472.068072511895, 8539.103394143774, 46077.76961115173, 46656.53343466658, 55032.443186931196, 55591.166132507235, 56970.43029569651, 63985.680071599345, 68573.0, 71388.5722285541, 74885.62557187179, 75352.24647753453, 12692.936535317263, 12812.487500500249, 12968.546100886424, 13171.209727416002, 13283.070185086952, 14747.336369863167, 15047.0, 15192.544223673307, 15352.30914608823, 15389.923050384676, 10487.37075775456, 13573.660658483223, 13659.248741319323, 14014.0, 14259.215743134228, 10527.736806579896, 13116.606501804961, 13475.730485390433, 13976.650583735081, 14323.140611562923, 13066.251486044888, 13139.277339746024, 13265.933670331586, 13546.0, 13597.66857120012, 10710.410927399067, 10747.89252107469, 11213.775724485302, 11488.540458381905, 11873.703157421134, 11271.211015228855, 11283.323000619988, 11288.998153668448, 11311.490982905954, 11596.536138554364], "value": 7429.923038144347, "unit": "score"}], "name": "dromaeo_css", "value": 7253.87584648454, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 117.0, 150.0, 114.0, 115.0, 116.0, 113.0, 133.0, 113.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 183.0, 186.0, 184.0, 183.0, 182.0, 180.0, 181.0, 185.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 86.0, 61.0, 62.0, 59.0, 58.0, 74.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 68.0, 69.0, 69.0, 82.0, 68.0, 69.0, 82.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 109.0, 111.0, 108.0, 111.0, 109.0, 112.0, 108.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 101.0, 121.0, 94.0, 94.0, 104.0, 150.0, 94.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 88.0, 87.0, 84.0, 87.0, 85.0, 82.0, 70.0, 101.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 56.0, 56.0, 54.0, 55.0, 54.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 79.0, 74.0, 78.0, 102.0, 96.0, 70.0, 70.0, 71.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 87.0, 88.0, 85.0, 87.0, 85.0, 92.0, 89.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 142.0, 150.0, 149.0, 154.0, 145.0, 147.0, 213.0, 188.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 178.0, 177.0, 177.0, 178.0, 175.0, 178.0, 174.0, 178.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 85.0, 87.0, 86.0, 75.0, 68.0, 68.0, 71.0, 68.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1493.4000000000003, "alertThreshold": 2.0}]} 08:24:07 INFO - Return code: 0 08:24:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:07 INFO - # TBPL SUCCESS # 08:24:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:24:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:24:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:24:07 INFO - 2016-12-12 08:24:07.978 screenresolution[1656:10754] starting screenresolution argv=screenresolution get 08:24:07 INFO - 2016-12-12 08:24:07.982 screenresolution[1656:10754] Display 0: 1600x1200x32@60 08:24:07 INFO - 2016-12-12 08:24:07.989 screenresolution[1657:10757] starting screenresolution argv=screenresolution list 08:24:07 INFO - Available Modes on Display 0 08:24:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:24:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:24:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:24:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:24:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:24:08 INFO - Intel Iris: 08:24:08 INFO - Chipset Model: Intel Iris 08:24:08 INFO - Type: GPU 08:24:08 INFO - Bus: Built-In 08:24:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:24:08 INFO - Vendor: Intel (0x8086) 08:24:08 INFO - Device ID: 0x0a2e 08:24:08 INFO - Revision ID: 0x0009 08:24:08 INFO - Displays: 08:24:08 INFO - Display: 08:24:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:24:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:24:08 INFO - Display Serial Number: 1600x1200 60 08:24:08 INFO - Main Display: Yes 08:24:08 INFO - Mirror: Off 08:24:08 INFO - Online: Yes 08:24:08 INFO - Rotation: Supported 08:24:08 INFO - Return code: 0 08:24:08 INFO - Running post-action listener: _resource_record_post_action 08:24:08 INFO - [mozharness: 2016-12-12 16:24:08.228065Z] Finished run-tests step (success) 08:24:08 INFO - Running post-run listener: _resource_record_post_run 08:24:08 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 33442816; Write bytes: 551223808; Read time: 314; Write time: 1914 08:24:08 INFO - TinderboxPrint: CPU usage
53.9% 08:24:08 INFO - TinderboxPrint: I/O read bytes / time
33,442,816 / 314 08:24:08 INFO - TinderboxPrint: I/O write bytes / time
551,223,808 / 1,914 08:24:08 INFO - TinderboxPrint: CPU idle
2,215.1 (46.1%) 08:24:08 INFO - TinderboxPrint: CPU system
964.6 (20.1%) 08:24:08 INFO - TinderboxPrint: CPU user
1,630.0 (33.9%) 08:24:08 INFO - TinderboxPrint: Swap in / out
279,240,704 / 0 08:24:08 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 247501312; Write bytes: 241534976; Read time: 18274; Write time: 476 08:24:08 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29191168; Write bytes: 298002944; Read time: 282; Write time: 1404 08:24:08 INFO - Running post-run listener: _upload_blobber_files 08:24:08 INFO - Blob upload gear active. 08:24:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:09 INFO - (blobuploader) - INFO - Done attempting. 08:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:24:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:10 INFO - (blobuploader) - INFO - Done attempting. 08:24:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:13 INFO - (blobuploader) - INFO - Done attempting. 08:24:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:13 INFO - Return code: 0 08:24:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad7869dbecdd020a4394cc3121eee6ceb6342ee18bb72a368632ba330cae02b2ff55d603f8fd9d176316ebd605a1817819bc704d8143da7402e1968b0120a3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2283268fb9b5b3604737e59d98f0a992ad42f0c7fc890ea3ef70409b6a991a2487a811ab5b5e3bee2f938f2b4d5eb691629ae35cd47130cd0623e7206d7308df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4b697431e086b1548caf245a232fab6554e8f76f2ef0b7738f573ff3f86d48ffb9de503d61ad3acaeb9d6de1207a7ad829a3ac39bcc270e222ad4f5b7402777"} 08:24:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:13 INFO - Contents: 08:24:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad7869dbecdd020a4394cc3121eee6ceb6342ee18bb72a368632ba330cae02b2ff55d603f8fd9d176316ebd605a1817819bc704d8143da7402e1968b0120a3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2283268fb9b5b3604737e59d98f0a992ad42f0c7fc890ea3ef70409b6a991a2487a811ab5b5e3bee2f938f2b4d5eb691629ae35cd47130cd0623e7206d7308df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4b697431e086b1548caf245a232fab6554e8f76f2ef0b7738f573ff3f86d48ffb9de503d61ad3acaeb9d6de1207a7ad829a3ac39bcc270e222ad4f5b7402777"} 08:24:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:13 INFO - Copying logs to upload dir... 08:24:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.993607 ========= master_lag: 1.54 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-12 08:24:14.855456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 08:24:14.861860) ========= 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.L214RHK5B2/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.zqBI7BYjB4/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad7869dbecdd020a4394cc3121eee6ceb6342ee18bb72a368632ba330cae02b2ff55d603f8fd9d176316ebd605a1817819bc704d8143da7402e1968b0120a3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2283268fb9b5b3604737e59d98f0a992ad42f0c7fc890ea3ef70409b6a991a2487a811ab5b5e3bee2f938f2b4d5eb691629ae35cd47130cd0623e7206d7308df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4b697431e086b1548caf245a232fab6554e8f76f2ef0b7738f573ff3f86d48ffb9de503d61ad3acaeb9d6de1207a7ad829a3ac39bcc270e222ad4f5b7402777"} build_url:https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/COkNHvaST6SfEZ3HCe1KHg/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ad7869dbecdd020a4394cc3121eee6ceb6342ee18bb72a368632ba330cae02b2ff55d603f8fd9d176316ebd605a1817819bc704d8143da7402e1968b0120a3a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2283268fb9b5b3604737e59d98f0a992ad42f0c7fc890ea3ef70409b6a991a2487a811ab5b5e3bee2f938f2b4d5eb691629ae35cd47130cd0623e7206d7308df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4b697431e086b1548caf245a232fab6554e8f76f2ef0b7738f573ff3f86d48ffb9de503d61ad3acaeb9d6de1207a7ad829a3ac39bcc270e222ad4f5b7402777"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-12 08:24:14.897336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:24:14.897667) ========= 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.L214RHK5B2/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.zqBI7BYjB4/Listeners TMPDIR=/var/folders/sn/mz3kt0bj0yzbmvjqtdrsjfz000000w/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.005300 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-12 08:24:14.947916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 08:24:14.948246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-12 08:24:14.948575) ========= ========= Total master_lag: 1.71 =========