builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0365 starttime: 1484636528.26 results: success (0) buildid: 20170116214334 builduid: df78fa7ba63b47dc9183d5bfa5b41c91 revision: 3e275d37a06236981bff399b7d7aa0646be3fee7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.255526) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.255997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.256397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.283359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.284060) ========= 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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-16 23:02:08-- 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% 151M=0s 2017-01-16 23:02:08 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117146 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.471667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.471991) ========= 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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.020228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:08.520230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 23:02:08.520596) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e275d37a06236981bff399b7d7aa0646be3fee7 --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 3e275d37a06236981bff399b7d7aa0646be3fee7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nCv3QDRJcB/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.4EckwOdgwJ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-16 23:02:08,605 truncating revision to first 12 chars 2017-01-16 23:02:08,606 Setting DEBUG logging. 2017-01-16 23:02:08,606 attempt 1/10 2017-01-16 23:02:08,606 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e275d37a062?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 23:02:09,637 unpacking tar archive at: mozilla-central-3e275d37a062/testing/mozharness/ program finished with exit code 0 elapsedTime=1.317501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 23:02:09.861516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:09.861821) ========= script_repo_revision: 3e275d37a06236981bff399b7d7aa0646be3fee7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:09.862213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:09.862505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 23:02:09.880731) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-16 23:02:09.881064) ========= /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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02:10 INFO - MultiFileLogger online at 20170116 23:02:10 in /builds/slave/test 23:02:10 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 23:02:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:02:10 INFO - {'append_to_log': False, 23:02:10 INFO - 'base_work_dir': '/builds/slave/test', 23:02:10 INFO - 'blob_upload_branch': 'Firefox', 23:02:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:02:10 INFO - 'branch': 'Firefox', 23:02:10 INFO - 'buildbot_json_path': 'buildprops.json', 23:02:10 INFO - 'config_files': ('talos/mac_config.py',), 23:02:10 INFO - 'default_actions': ('clobber', 23:02:10 INFO - 'read-buildbot-config', 23:02:10 INFO - 'download-and-extract', 23:02:10 INFO - 'populate-webroot', 23:02:10 INFO - 'create-virtualenv', 23:02:10 INFO - 'install', 23:02:10 INFO - 'run-tests'), 23:02:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:02:10 INFO - 'download_minidump_stackwalk': True, 23:02:10 INFO - 'download_symbols': 'ondemand', 23:02:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:02:10 INFO - 'tooltool.py': '/tools/tooltool.py', 23:02:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:02:10 INFO - '/tools/misc-python/virtualenv.py')}, 23:02:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:02:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:02:10 INFO - 'installer_path': 'installer.exe', 23:02:10 INFO - 'log_level': 'info', 23:02:10 INFO - 'log_name': 'talos', 23:02:10 INFO - 'log_to_console': True, 23:02:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:02:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:02:10 INFO - 'opt_config_files': (), 23:02:10 INFO - 'pip_index': False, 23:02:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:02:10 INFO - 'cmd': ('bash', 23:02:10 INFO - '-c', 23:02:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:02:10 INFO - 'enabled': True, 23:02:10 INFO - 'halt_on_failure': False, 23:02:10 INFO - 'name': 'check_screen_resolution'},), 23:02:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:02:10 INFO - 'cmd': ('bash', 23:02:10 INFO - '-c', 23:02:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:02:10 INFO - 'enabled': True, 23:02:10 INFO - 'halt_on_failure': False, 23:02:10 INFO - 'name': 'check_screen_resolution'},), 23:02:10 INFO - 'run_cmd_checks_enabled': True, 23:02:10 INFO - 'sps_profile': False, 23:02:10 INFO - 'sps_profile_interval': 0, 23:02:10 INFO - 'suite': 'dromaeojs', 23:02:10 INFO - 'system_bits': '32', 23:02:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:02:10 INFO - 'title': 't-yosemite-r7-0365', 23:02:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:02:10 INFO - 'use_talos_json': True, 23:02:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:02:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:02:10 INFO - 'work_dir': 'build'} 23:02:10 INFO - [mozharness: 2017-01-17 07:02:10.083712Z] Running clobber step. 23:02:10 INFO - Running pre-action listener: _resource_record_pre_action 23:02:10 INFO - Running main action method: clobber 23:02:10 INFO - rmtree: /builds/slave/test/build 23:02:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:02:11 INFO - Running post-action listener: _resource_record_post_action 23:02:11 INFO - [mozharness: 2017-01-17 07:02:11.608642Z] Finished clobber step (success) 23:02:11 INFO - [mozharness: 2017-01-17 07:02:11.608838Z] Running read-buildbot-config step. 23:02:11 INFO - Running pre-action listener: _resource_record_pre_action 23:02:11 INFO - Running main action method: read_buildbot_config 23:02:11 INFO - Using buildbot properties: 23:02:11 INFO - { 23:02:11 INFO - "project": "", 23:02:11 INFO - "product": "firefox", 23:02:11 INFO - "script_repo_revision": "production", 23:02:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 23:02:11 INFO - "repository": "", 23:02:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 23:02:11 INFO - "buildid": "20170116214334", 23:02:11 INFO - "pgo_build": "False", 23:02:11 INFO - "basedir": "/builds/slave/test", 23:02:11 INFO - "buildnumber": 26, 23:02:11 INFO - "slavename": "t-yosemite-r7-0365", 23:02:11 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 23:02:11 INFO - "platform": "yosemite_r7", 23:02:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:02:11 INFO - "branch": "mozilla-central", 23:02:11 INFO - "repo_path": "mozilla-central", 23:02:11 INFO - "revision": "3e275d37a06236981bff399b7d7aa0646be3fee7", 23:02:11 INFO - "stage_platform": "macosx64", 23:02:11 INFO - "builduid": "df78fa7ba63b47dc9183d5bfa5b41c91", 23:02:11 INFO - "slavebuilddir": "test" 23:02:11 INFO - } 23:02:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 23:02:11 INFO - Running post-action listener: _resource_record_post_action 23:02:11 INFO - [mozharness: 2017-01-17 07:02:11.614428Z] Finished read-buildbot-config step (success) 23:02:11 INFO - [mozharness: 2017-01-17 07:02:11.614665Z] Running download-and-extract step. 23:02:11 INFO - Running pre-action listener: _resource_record_pre_action 23:02:11 INFO - Running main action method: download_and_extract 23:02:11 INFO - mkdir: /builds/slave/test/build/tests 23:02: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')]} 23:02:11 INFO - trying https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 23:02:11 INFO - Downloading https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 23:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 23:02:12 INFO - Downloaded 1199 bytes. 23:02:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 23:02:12 INFO - Using the following test package requirements: 23:02:12 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 23:02:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 23:02:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 23:02:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'jsshell-mac.zip'], 23:02:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 23:02:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 23:02:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 23:02:12 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 23:02:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 23:02:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 23:02:12 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 23:02:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:02:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 23:02:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:02:12 INFO - Fetch https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 23:02:13 INFO - Expected file size: 16326588 23:02:13 INFO - Obtained file size: 16326588 23:02:20 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:02:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 23:02:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:02:20 INFO - Fetch https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 23:02:21 INFO - Expected file size: 16326588 23:02:21 INFO - Obtained file size: 16326588 23:02:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 23:02:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:02:28 INFO - Fetch https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 23:02:29 INFO - Expected file size: 14403463 23:02:29 INFO - Obtained file size: 14403463 23:02: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')]} 23:02:29 INFO - trying https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:02:29 INFO - Downloading https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 23:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 23:02:32 INFO - Downloaded 70112883 bytes. 23:02:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:02:32 INFO - mkdir: /builds/slave/test/properties 23:02:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:02:32 INFO - Writing to file /builds/slave/test/properties/build_url 23:02:32 INFO - Contents: 23:02:32 INFO - build_url:https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 23:02:33 INFO - Running post-action listener: _resource_record_post_action 23:02:33 INFO - Running post-action listener: set_extra_try_arguments 23:02:33 INFO - [mozharness: 2017-01-17 07:02:33.839526Z] Finished download-and-extract step (success) 23:02:33 INFO - [mozharness: 2017-01-17 07:02:33.839690Z] Running populate-webroot step. 23:02:33 INFO - Running pre-action listener: _resource_record_pre_action 23:02:33 INFO - Running main action method: populate_webroot 23:02:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:02:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:02:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:02:33 INFO - '--tppagecycles', 23:02:33 INFO - '7'], 23:02:33 INFO - 'tests': ['tsvgm']}}, 23:02:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:02:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:02:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:02:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:02:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['damp', 'tps']}, 23:02:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'tests': ['damp', 'tps']}, 23:02:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['dromaeo_dom']}, 23:02:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:02:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['basic_compositor_video']}, 23:02:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:02:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['a11yr', 23:02:33 INFO - 'ts_paint', 23:02:33 INFO - 'tpaint', 23:02:33 INFO - 'sessionrestore', 23:02:33 INFO - 'sessionrestore_no_auto_restore', 23:02:33 INFO - 'tabpaint']}, 23:02:33 INFO - 'other-e10s': {'tests': ['a11yr', 23:02:33 INFO - 'ts_paint', 23:02:33 INFO - 'tpaint', 23:02:33 INFO - 'sessionrestore', 23:02:33 INFO - 'sessionrestore_no_auto_restore', 23:02:33 INFO - 'tabpaint']}, 23:02:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:02:33 INFO - 'ts_paint', 23:02:33 INFO - 'tpaint', 23:02:33 INFO - 'sessionrestore', 23:02:33 INFO - 'sessionrestore_no_auto_restore', 23:02:33 INFO - 'tabpaint']}, 23:02:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:02:33 INFO - 'ts_paint', 23:02:33 INFO - 'tpaint', 23:02:33 INFO - 'sessionrestore', 23:02:33 INFO - 'sessionrestore_no_auto_restore', 23:02:33 INFO - 'tabpaint']}, 23:02:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['a11yr', 23:02:33 INFO - 'ts_paint', 23:02:33 INFO - 'tpaint', 23:02:33 INFO - 'sessionrestore', 23:02:33 INFO - 'sessionrestore_no_auto_restore', 23:02:33 INFO - 'tabpaint']}, 23:02:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['a11yr', 23:02:33 INFO - 'ts_paint', 23:02:33 INFO - 'tpaint', 23:02:33 INFO - 'sessionrestore', 23:02:33 INFO - 'sessionrestore_no_auto_restore', 23:02:33 INFO - 'tabpaint']}, 23:02:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['tsvgx', 23:02:33 INFO - 'tsvgr_opacity', 23:02:33 INFO - 'tart', 23:02:33 INFO - 'tscrollx', 23:02:33 INFO - 'cart', 23:02:33 INFO - 'tsvg_static']}, 23:02:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:02:33 INFO - 'tsvgr_opacity', 23:02:33 INFO - 'tart', 23:02:33 INFO - 'tscrollx', 23:02:33 INFO - 'cart', 23:02:33 INFO - 'tsvg_static']}, 23:02:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'talos_options': ['--disable-e10s'], 23:02:33 INFO - 'tests': ['tp5o']}, 23:02:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:02:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'talos_options': ['--disable-e10s', 23:02:33 INFO - '--xperf_path', 23:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:33 INFO - 'tests': ['tp5n']}, 23:02:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:02:33 INFO - 'talos_options': ['--xperf_path', 23:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:33 INFO - 'tests': ['tp5n']}}, 23:02:33 INFO - 'talos.zip': {'path': '', 23:02:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:02:33 INFO - Running post-action listener: _resource_record_post_action 23:02:33 INFO - [mozharness: 2017-01-17 07:02:33.859022Z] Finished populate-webroot step (success) 23:02:33 INFO - [mozharness: 2017-01-17 07:02:33.859131Z] Running create-virtualenv step. 23:02:33 INFO - Running pre-action listener: _resource_record_pre_action 23:02:33 INFO - Running main action method: create_virtualenv 23:02:33 INFO - Creating virtualenv /builds/slave/test/build/venv 23:02:33 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 23:02:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:02:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:02:33 INFO - Using real prefix '/tools/python27' 23:02:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:02:34 INFO - Installing distribute.............................................................................................................................................................................................done. 23:02:37 INFO - Installing pip.................done. 23:02:37 INFO - Return code: 0 23:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:02:37 INFO - Reading from file tmpfile_stdout 23:02:37 INFO - Output received: 23:02:37 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) 23:02:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:37 INFO - 'HOME': '/Users/cltbld', 23:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:37 INFO - 'LOGNAME': 'cltbld', 23:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:37 INFO - 'MOZ_NO_REMOTE': '1', 23:02:37 INFO - 'NO_EM_RESTART': '1', 23:02:37 INFO - 'PAGER': '/bin/cat', 23:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:37 INFO - 'PWD': '/builds/slave/test', 23:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:37 INFO - 'SHELL': '/bin/bash', 23:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:37 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:37 INFO - 'USER': 'cltbld', 23:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:37 INFO - 'XPC_FLAGS': '0x0', 23:02:37 INFO - 'XPC_SERVICE_NAME': '0', 23:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:38 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 23:02:38 INFO - Cleaning up... 23:02:38 INFO - Return code: 0 23:02:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:02:38 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')]} 23:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:38 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')]} 23:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:38 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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02:38 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 23:02:38 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 23:02:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:38 INFO - 'HOME': '/Users/cltbld', 23:02:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:38 INFO - 'LOGNAME': 'cltbld', 23:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:38 INFO - 'MOZ_NO_REMOTE': '1', 23:02:38 INFO - 'NO_EM_RESTART': '1', 23:02:38 INFO - 'PAGER': '/bin/cat', 23:02:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:38 INFO - 'PWD': '/builds/slave/test', 23:02:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:38 INFO - 'SHELL': '/bin/bash', 23:02:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:38 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:38 INFO - 'USER': 'cltbld', 23:02:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:38 INFO - 'XPC_FLAGS': '0x0', 23:02:38 INFO - 'XPC_SERVICE_NAME': '0', 23:02:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:38 INFO - Downloading/unpacking psutil>=3.1.1 23:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:02:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:42 INFO - Installing collected packages: psutil 23:02:42 INFO - Running setup.py install for psutil 23:02:42 INFO - building 'psutil._psutil_osx' extension 23:02:42 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 23:02:42 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 23:02:42 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 23:02:42 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 23:02:42 INFO - building 'psutil._psutil_posix' extension 23:02:42 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 23:02:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:02:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:02:42 INFO - ^ 23:02:42 INFO - 1 warning generated. 23:02: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 23:02:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:02:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:02:42 INFO - Successfully installed psutil 23:02:42 INFO - Cleaning up... 23:02:42 INFO - Return code: 0 23:02:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02: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 23:02: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 23:02:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:42 INFO - 'HOME': '/Users/cltbld', 23:02:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:42 INFO - 'LOGNAME': 'cltbld', 23:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:42 INFO - 'MOZ_NO_REMOTE': '1', 23:02:42 INFO - 'NO_EM_RESTART': '1', 23:02:42 INFO - 'PAGER': '/bin/cat', 23:02:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:42 INFO - 'PWD': '/builds/slave/test', 23:02:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:42 INFO - 'SHELL': '/bin/bash', 23:02:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:42 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:42 INFO - 'USER': 'cltbld', 23:02:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:42 INFO - 'XPC_FLAGS': '0x0', 23:02:42 INFO - 'XPC_SERVICE_NAME': '0', 23:02:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:02:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:02:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:02:45 INFO - Installing collected packages: mozsystemmonitor 23:02:45 INFO - Running setup.py install for mozsystemmonitor 23:02:46 INFO - Successfully installed mozsystemmonitor 23:02:46 INFO - Cleaning up... 23:02:46 INFO - Return code: 0 23:02:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:46 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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02:46 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 23:02:46 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 23:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:46 INFO - 'HOME': '/Users/cltbld', 23:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:46 INFO - 'LOGNAME': 'cltbld', 23:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:46 INFO - 'MOZ_NO_REMOTE': '1', 23:02:46 INFO - 'NO_EM_RESTART': '1', 23:02:46 INFO - 'PAGER': '/bin/cat', 23:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:46 INFO - 'PWD': '/builds/slave/test', 23:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:46 INFO - 'SHELL': '/bin/bash', 23:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:46 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:46 INFO - 'USER': 'cltbld', 23:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:46 INFO - 'XPC_FLAGS': '0x0', 23:02:46 INFO - 'XPC_SERVICE_NAME': '0', 23:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:46 INFO - Downloading/unpacking jsonschema==2.5.1 23:02:46 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 23:02:46 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 23:02:46 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 23:02:46 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 23:02:46 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 23:02:46 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 23:02:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:02:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02:49 INFO - Downloading functools32-3.2.3-2.tar.gz 23:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:02:49 INFO - warning: no files found matching '*.txt' 23:02:49 INFO - no previously-included directories found matching 'build' 23:02:49 INFO - no previously-included directories found matching 'dist' 23:02:49 INFO - no previously-included directories found matching '.git*' 23:02:49 INFO - Installing collected packages: jsonschema, functools32 23:02:49 INFO - Running setup.py install for functools32 23:02:49 INFO - warning: no files found matching '*.txt' 23:02:49 INFO - no previously-included directories found matching 'build' 23:02:49 INFO - no previously-included directories found matching 'dist' 23:02:49 INFO - no previously-included directories found matching '.git*' 23:02:49 INFO - Successfully installed jsonschema functools32 23:02:49 INFO - Cleaning up... 23:02:49 INFO - Return code: 0 23:02:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02: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 23:02: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 23:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:49 INFO - 'HOME': '/Users/cltbld', 23:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:49 INFO - 'LOGNAME': 'cltbld', 23:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:49 INFO - 'MOZ_NO_REMOTE': '1', 23:02:49 INFO - 'NO_EM_RESTART': '1', 23:02:49 INFO - 'PAGER': '/bin/cat', 23:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:49 INFO - 'PWD': '/builds/slave/test', 23:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:49 INFO - 'SHELL': '/bin/bash', 23:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:49 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:49 INFO - 'USER': 'cltbld', 23:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:49 INFO - 'XPC_FLAGS': '0x0', 23:02:49 INFO - 'XPC_SERVICE_NAME': '0', 23:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:02:50 INFO - Cleaning up... 23:02:50 INFO - Return code: 0 23:02:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:50 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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02:50 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 23:02:50 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 23:02:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:50 INFO - 'HOME': '/Users/cltbld', 23:02:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:50 INFO - 'LOGNAME': 'cltbld', 23:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:50 INFO - 'MOZ_NO_REMOTE': '1', 23:02:50 INFO - 'NO_EM_RESTART': '1', 23:02:50 INFO - 'PAGER': '/bin/cat', 23:02:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:50 INFO - 'PWD': '/builds/slave/test', 23:02:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:50 INFO - 'SHELL': '/bin/bash', 23:02:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:50 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:50 INFO - 'USER': 'cltbld', 23:02:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:50 INFO - 'XPC_FLAGS': '0x0', 23:02:50 INFO - 'XPC_SERVICE_NAME': '0', 23:02:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:50 INFO - Downloading/unpacking blobuploader==1.2.4 23:02:50 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 23:02:50 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 23:02:50 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 23:02:50 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 23:02:50 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 23:02:50 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 23:02:53 INFO - Downloading blobuploader-1.2.4.tar.gz 23:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:02:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:02:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02:54 INFO - Downloading docopt-0.6.1.tar.gz 23:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:02:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:02:54 INFO - Running setup.py install for blobuploader 23:02:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:02:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:02:54 INFO - Running setup.py install for requests 23:02:54 INFO - Running setup.py install for docopt 23:02:55 INFO - Successfully installed blobuploader requests docopt 23:02:55 INFO - Cleaning up... 23:02:55 INFO - Return code: 0 23:02:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:55 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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02:55 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 23:02:55 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 23:02:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:55 INFO - 'HOME': '/Users/cltbld', 23:02:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:55 INFO - 'LOGNAME': 'cltbld', 23:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:55 INFO - 'MOZ_NO_REMOTE': '1', 23:02:55 INFO - 'NO_EM_RESTART': '1', 23:02:55 INFO - 'PAGER': '/bin/cat', 23:02:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:55 INFO - 'PWD': '/builds/slave/test', 23:02:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:55 INFO - 'SHELL': '/bin/bash', 23:02:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:55 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:55 INFO - 'USER': 'cltbld', 23:02:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:55 INFO - 'XPC_FLAGS': '0x0', 23:02:55 INFO - 'XPC_SERVICE_NAME': '0', 23:02:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:02:55 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0Ofsgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:02:55 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-PqmThc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:02:55 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Re6Hez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:02:55 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HyKCUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:02:55 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-2GRx3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-5Lbtre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-6FhcKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-lGqiON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Uh_oe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-E1mOrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-QokB8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-mo67Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-CwPBDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:02:56 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-KTe_ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:02:57 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-YpZRLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:02:57 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-uwP7EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:02:57 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-r9684_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:02:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:02:57 INFO - Running setup.py install for manifestparser 23:02:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:02:57 INFO - Running setup.py install for mozcrash 23:02:57 INFO - Running setup.py install for mozdebug 23:02:57 INFO - Running setup.py install for mozdevice 23:02:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:02:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:02:57 INFO - Running setup.py install for mozfile 23:02:58 INFO - Running setup.py install for mozhttpd 23:02:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Running setup.py install for mozinfo 23:02:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Running setup.py install for mozInstall 23:02:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Running setup.py install for mozleak 23:02:58 INFO - Running setup.py install for mozlog 23:02:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Running setup.py install for moznetwork 23:02:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:02:58 INFO - Running setup.py install for mozprocess 23:02:59 INFO - Running setup.py install for mozprofile 23:02:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:02:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:02:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:02:59 INFO - Running setup.py install for mozrunner 23:02:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:02:59 INFO - Running setup.py install for mozscreenshot 23:02:59 INFO - Running setup.py install for moztest 23:02:59 INFO - Running setup.py install for mozversion 23:02:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:02:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:02:59 INFO - Cleaning up... 23:02:59 INFO - Return code: 0 23:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:02: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')]} 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:02: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 23:02: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 23:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:02:59 INFO - 'HOME': '/Users/cltbld', 23:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:02:59 INFO - 'LOGNAME': 'cltbld', 23:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:59 INFO - 'MOZ_NO_REMOTE': '1', 23:02:59 INFO - 'NO_EM_RESTART': '1', 23:02:59 INFO - 'PAGER': '/bin/cat', 23:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:02:59 INFO - 'PWD': '/builds/slave/test', 23:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:02:59 INFO - 'SHELL': '/bin/bash', 23:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:02:59 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:02:59 INFO - 'USER': 'cltbld', 23:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:59 INFO - 'XPC_FLAGS': '0x0', 23:02:59 INFO - 'XPC_SERVICE_NAME': '0', 23:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-3ztTkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:03:00 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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-NiDx7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:03:00 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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-hilzlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:03:00 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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-_du5cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:03:00 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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-OVSV0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:03:00 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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-3lsdBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:03:00 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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Irizpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:03: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)) 23:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:03:00 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-cpC_97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-nvgaoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-DzwCqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-U1HX02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-EyeYcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-jcvVyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-IzvgGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-n_U7zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:03:01 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)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-3KMz3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:03:01 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-pn0_Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:03:02 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)) 23:03:02 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)) 23:03:02 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)) 23:03:02 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)) 23:03:02 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)) 23:03:02 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)) 23:03:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:03:02 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 23:03:02 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 23:03:02 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 23:03:02 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 23:03:02 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 23:03:02 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 23:03:04 INFO - Downloading blessings-1.6.tar.gz 23:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:03:04 INFO - Installing collected packages: blessings 23:03:04 INFO - Running setup.py install for blessings 23:03:04 INFO - Successfully installed blessings 23:03:04 INFO - Cleaning up... 23:03:05 INFO - Return code: 0 23:03:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:03:05 INFO - Reading from file tmpfile_stdout 23:03:05 INFO - Current package versions: 23:03:05 INFO - blessings == 1.6 23:03:05 INFO - blobuploader == 1.2.4 23:03:05 INFO - docopt == 0.6.1 23:03:05 INFO - functools32 == 3.2.3-2 23:03:05 INFO - jsonschema == 2.5.1 23:03:05 INFO - manifestparser == 1.1 23:03:05 INFO - mozInstall == 1.12 23:03:05 INFO - mozcrash == 1.0 23:03:05 INFO - mozdebug == 0.1 23:03:05 INFO - mozdevice == 0.49 23:03:05 INFO - mozfile == 1.2 23:03:05 INFO - mozhttpd == 0.7 23:03:05 INFO - mozinfo == 0.9 23:03:05 INFO - mozleak == 0.1 23:03:05 INFO - mozlog == 3.4 23:03:05 INFO - moznetwork == 0.27 23:03:05 INFO - mozprocess == 0.24 23:03:05 INFO - mozprofile == 0.28 23:03:05 INFO - mozrunner == 6.13 23:03:05 INFO - mozscreenshot == 0.1 23:03:05 INFO - mozsystemmonitor == 0.3 23:03:05 INFO - moztest == 0.8 23:03:05 INFO - mozversion == 1.4 23:03:05 INFO - psutil == 3.1.1 23:03:05 INFO - requests == 1.2.3 23:03:05 INFO - wsgiref == 0.1.2 23:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:03:05 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')]} 23:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:05 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')]} 23:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:05 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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:03:05 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 23:03:05 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 23:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:03:05 INFO - 'HOME': '/Users/cltbld', 23:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:03:05 INFO - 'LOGNAME': 'cltbld', 23:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:05 INFO - 'MOZ_NO_REMOTE': '1', 23:03:05 INFO - 'NO_EM_RESTART': '1', 23:03:05 INFO - 'PAGER': '/bin/cat', 23:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:05 INFO - 'PWD': '/builds/slave/test', 23:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:03:05 INFO - 'SHELL': '/bin/bash', 23:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:03:05 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:03:05 INFO - 'USER': 'cltbld', 23:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:05 INFO - 'XPC_FLAGS': '0x0', 23:03:05 INFO - 'XPC_SERVICE_NAME': '0', 23:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 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)) 23:03:05 INFO - Cleaning up... 23:03:05 INFO - Return code: 0 23:03:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:03:05 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')]} 23:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:05 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')]} 23:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:05 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 0x108044b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108047768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c53cb2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, '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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 23:03:05 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 23:03:05 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 23:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:03:05 INFO - 'HOME': '/Users/cltbld', 23:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:03:05 INFO - 'LOGNAME': 'cltbld', 23:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:05 INFO - 'MOZ_NO_REMOTE': '1', 23:03:05 INFO - 'NO_EM_RESTART': '1', 23:03:05 INFO - 'PAGER': '/bin/cat', 23:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:05 INFO - 'PWD': '/builds/slave/test', 23:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:03:05 INFO - 'SHELL': '/bin/bash', 23:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:03:05 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:03:05 INFO - 'USER': 'cltbld', 23:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:05 INFO - 'XPC_FLAGS': '0x0', 23:03:05 INFO - 'XPC_SERVICE_NAME': '0', 23:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:03:05 INFO - Cleaning up... 23:03:05 INFO - Return code: 0 23:03:05 INFO - Running post-action listener: _resource_record_post_action 23:03:05 INFO - Running post-action listener: _start_resource_monitoring 23:03:05 INFO - Starting resource monitoring. 23:03:05 INFO - [mozharness: 2017-01-17 07:03:05.910089Z] Finished create-virtualenv step (success) 23:03:05 INFO - [mozharness: 2017-01-17 07:03:05.911068Z] Running install step. 23:03:05 INFO - Running pre-action listener: _resource_record_pre_action 23:03:05 INFO - Running main action method: install 23:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:03:06 INFO - Reading from file tmpfile_stdout 23:03:06 INFO - Detecting whether we're running mozinstall >=1.0... 23:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:03:06 INFO - Reading from file tmpfile_stdout 23:03:06 INFO - Output received: 23:03:06 INFO - Usage: mozinstall [options] installer 23:03:06 INFO - Options: 23:03:06 INFO - -h, --help show this help message and exit 23:03:06 INFO - -d DEST, --destination=DEST 23:03:06 INFO - Directory to install application into. [default: 23:03:06 INFO - "/builds/slave/test"] 23:03:06 INFO - --app=APP Application being installed. [default: firefox] 23:03:06 INFO - mkdir: /builds/slave/test/build/application 23:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:03:28 INFO - Reading from file tmpfile_stdout 23:03:28 INFO - Output received: 23:03:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:03:28 INFO - Running post-action listener: _resource_record_post_action 23:03:28 INFO - [mozharness: 2017-01-17 07:03:28.344700Z] Finished install step (success) 23:03:28 INFO - [mozharness: 2017-01-17 07:03:28.344835Z] Running run-tests step. 23:03:28 INFO - Running pre-action listener: _resource_record_pre_action 23:03:28 INFO - Running main action method: run_tests 23:03:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:03:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:03:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:03:28 INFO - 2017-01-16 23:03:28.359 screenresolution[1903:15531] starting screenresolution argv=screenresolution get 23:03:28 INFO - 2017-01-16 23:03:28.362 screenresolution[1903:15531] Display 0: 1600x1200x32@60 23:03:28 INFO - 2017-01-16 23:03:28.368 screenresolution[1904:15534] starting screenresolution argv=screenresolution list 23:03:28 INFO - Available Modes on Display 0 23:03:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:03:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:03:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:03:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:03:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:03:28 INFO - Intel Iris: 23:03:28 INFO - Chipset Model: Intel Iris 23:03:28 INFO - Type: GPU 23:03:28 INFO - Bus: Built-In 23:03:28 INFO - VRAM (Dynamic, Max): 1536 MB 23:03:28 INFO - Vendor: Intel (0x8086) 23:03:28 INFO - Device ID: 0x0a2e 23:03:28 INFO - Revision ID: 0x0009 23:03:28 INFO - Displays: 23:03:28 INFO - Display: 23:03:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:03:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:03:28 INFO - Display Serial Number: 1600x1200 60 23:03:28 INFO - Main Display: Yes 23:03:28 INFO - Mirror: Off 23:03:28 INFO - Online: Yes 23:03:28 INFO - Rotation: Supported 23:03:28 INFO - Return code: 0 23:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:03:28 INFO - Python 2.7.3 23:03:28 INFO - Return code: 0 23:03:28 INFO - grabbing minidump binary from tooltool 23:03:28 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')]} 23:03:28 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 0x107e22d30>, '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 0x107d49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e17be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:03:28 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 23:03:28 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 23:03:28 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 23:03:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:03:28 INFO - Return code: 0 23:03:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:03:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:03:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:03:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:03:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:03:28 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/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 23:03:28 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/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --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 23:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nCv3QDRJcB/Render', 23:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:03:28 INFO - 'HOME': '/Users/cltbld', 23:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:03:28 INFO - 'LOGNAME': 'cltbld', 23:03:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:03:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:28 INFO - 'MOZ_NO_REMOTE': '1', 23:03:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:03:28 INFO - 'NO_EM_RESTART': '1', 23:03:28 INFO - 'PAGER': '/bin/cat', 23:03:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:28 INFO - 'PWD': '/builds/slave/test', 23:03:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:03:28 INFO - 'SHELL': '/bin/bash', 23:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4EckwOdgwJ/Listeners', 23:03:28 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 23:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:03:28 INFO - 'USER': 'cltbld', 23:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:28 INFO - 'XPC_FLAGS': '0x0', 23:03:28 INFO - 'XPC_SERVICE_NAME': '0', 23:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:03:28 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/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 23:03:28 INFO - mozversion application_buildid: 20170116214334 23:03:28 INFO - mozversion application_changeset: 3e275d37a06236981bff399b7d7aa0646be3fee7 23:03:28 INFO - mozversion application_display_name: Nightly 23:03:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:03:28 INFO - mozversion application_name: Firefox 23:03:28 INFO - mozversion application_remotingname: firefox 23:03:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:03:28 INFO - mozversion application_vendor: Mozilla 23:03:28 INFO - mozversion application_version: 53.0a1 23:03:28 INFO - mozversion platform_buildid: 20170116214334 23:03:28 INFO - mozversion platform_changeset: 3e275d37a06236981bff399b7d7aa0646be3fee7 23:03:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:03:28 INFO - mozversion platform_version: 53.0a1 23:03:28 INFO - using testdate: 1484636608 23:03:28 INFO - actual date: 1484636608 23:03:28 INFO - starting webserver on 'localhost:53526' 23:03:28 INFO - SUITE-START | Running 2 tests 23:03:28 INFO - TEST-START | dromaeo_css 23:03:28 INFO - operating with platform_type : mac_ 23:03:28 INFO - Initialising browser for dromaeo_css test... 23:03:28 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpuU7t7L/profile http://localhost:53526/getInfo.html) 23:03:31 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 23:03:31 INFO - PROCESS | 1914 | colorDepth:24 23:03:31 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 23:03:31 INFO - PROCESS | 1914 | __metrics 23:03:31 INFO - PROCESS | 1914 | 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" 23:03:31 INFO - PROCESS | 1914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:03:32 INFO - TEST-INFO | 1914: exit 0 23:03:32 INFO - Browser initialized. 23:03:32 INFO - Running cycle 1/1 for dromaeo_css test... 23:03:32 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpuU7t7L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:44 INFO - PROCESS | 1916 | RSS: Main: 227164160 23:03:44 INFO - PROCESS | 1916 | 23:06:47 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53526/tests/dromaeo/cssquery-ext.html) 23:06:50 INFO - PROCESS | 1916 | RSS: Main: 453971968 23:06:50 INFO - PROCESS | 1916 | 23:08:34 INFO - PROCESS | 1916 | ************************* 23:08:34 INFO - PROCESS | 1916 | A coding exception was thrown and uncaught in a Task. 23:08:34 INFO - PROCESS | 1916 | 23:08:34 ERROR - PROCESS | 1916 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:08:34 INFO - PROCESS | 1916 | Full stack: 23:08:34 INFO - PROCESS | 1916 | ************************* 23:09:53 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-ext.html (next: http://localhost:53526/tests/dromaeo/cssquery-jquery.html) 23:09:53 INFO - PROCESS | 1916 | RSS: Main: 370036736 23:09:53 INFO - PROCESS | 1916 | 23:12:56 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53526/tests/dromaeo/cssquery-mootools.html) 23:12:56 INFO - PROCESS | 1916 | RSS: Main: 330215424 23:12:56 INFO - PROCESS | 1916 | 23:15:59 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53526/tests/dromaeo/cssquery-prototype.html) 23:15:59 INFO - PROCESS | 1916 | RSS: Main: 337252352 23:15:59 INFO - PROCESS | 1916 | 23:19:03 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53526/tests/dromaeo/cssquery-yui.html) 23:19:03 INFO - PROCESS | 1916 | RSS: Main: 336064512 23:19:03 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:53526/tests/dromaeo/cssquery-yui.html (next: http://localhost:53526/tests/dromaeo/cssquery-dojo.html) 23:22:07 INFO - PROCESS | 1916 | RSS: Main: 499978240 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | __start_tp_report 23:22:07 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 23:22:07 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 23:22:07 INFO - PROCESS | 1916 | |i|pagename|runs| 23:22:07 INFO - PROCESS | 1916 | |0;dojo.html;2761.3648860762023;3131.7786063435256;3212.919677008076;3315.983420082899;3333.1667083229195;5523;5618.747156377963;5663.348714897788;5712.086066229404;5714.942850571493;5616.719164041802;5629.71851407429;5710.314762228539;5718.42815718429;5784.1902133701215;5126.769295381717;5129.53834154926;5133.255677926699;5176.896462070757;5280.102382594949;5251.264822924774;5271.5782737381105;5275.419703832576;5284.2866213061125;5289.285946397225;5087.923681144785;5198.792048318062;5234.6335756497065;5261.053010458116;5278.1291086970605;5111.974440127813;5131.4098878629065;5184.922226166611;5187.455317191716;5209.140491818884;5174.741262936838;5184.092783762826;5188.040212560688;5246.81636142737;5251.133562962106;5686.2039314496005;5688.744006519716;5696.287964004499;5698;5707.486326230659;6075.726592303313;6136.539759518009;6272;6275.780347687854;6281.748730050838;6180.042093475518;6183.628982261033;6216.564840461169;6241.375862413768;6284.5600807943465;5813.331466881278;5822.854428639318;5823.912641310384;5842.795502157489;5876.44173803488;6083.838749510228;6268.780592679234;6272.6236425814595;6273.278572964167;6288.937110628926;5868.2664666916635;5897.941020589739;5922.289325280994;6001.459868611846;6178.165947597106;6117.827404800917;6119.41115851624;6192.845178870564;6238.282597501346;6262.342454042351;6117.279373342205;6128;6140.5174222817595;6172.135900973867;6215.906761398583;6128.988716861668;6243.875122497525;6247.875042499216;6252.09344645033;6287.811365659038;4336.241157797373;4995.850124496271;4998.375203099613;4999.275105109738;5003.124453220672;4370.584794444522;4380.3210502372185;4382.802773875183;4385.210662080856;4471;5632.436756324335;5666.575006874501;5728.598998070179;5763.279590051244;5765.135229715576;6285.308616052231;6285.308616052231;6292.433680968735;6293;6296.370362963758;5562.7774889004795;5682.261306030272;5749.540036797046;5758.654480731169;5762.711864406763;5326.97336513315;5338.332708411449;5352.223927530564;5371.462853714597;5399.892002159935;6274.905876411857;6280.937190628035;6287.685615719287;6297.96851015742;6312.621242725543;6254.6247225166635;6258.405451482102;6261.060840873905;6278.6860656966055;6290.025046117859;6159.384061593984;6188.81433556976;6199.194104766532;6265.404786545271;6280.654563999024;6150.415710507495;6167.599106058092;6195.473384762346;6208;6209.130721698875;5959.433853783884;6262.46769024638;6274.6548939808745;6289.716962736779;6299.149614801943;5922.141289512911;5954;6002.819915402545;6057.394260573908;6107.9083813741945;6027.36712645166;6117.8578538723295;6130.52043589939;6131.162586540493;6134.834601026089;5754.741036653277;5918.112283157561;5935.821925342247;5947.613405128653;5984.341722410619;5976.7908123215475;6014.969925150346;6027;6057.969710151421;6078.756849725962;5852.853678657897;5867.970660146672;5869.119632055226;5873.207117039145;5874.001419758737 23:22:07 INFO - PROCESS | 1916 | |1;ext.html;447.2196017948679;476.6067993905027;501.07051419616613;523.1968927695988;523.8899831035483;34729.65270347299;36281.81859090704;44089.559104408945;44373.999999999956;46350.536494635046;44096.55903440965;44892.65322040344;44905;44999.32501012488;45115;8367.539785311805;8717.564121793917;9266.490343031148;9600.279979001569;9612.663556775515;11471.483783229774;11724.941375293154;11765.7646847063;11886.524539018472;11947.10396720245;11455.083593312514;11478.598249061284;11579.65261042166;11626.593069242535;11715.531378744883;8457.873131903027;8634.654613815439;11418.31490110596;11546.191766576343;11643.12676549258;11221.214514983954;11534.826977595343;11552.133589980785;11691.766164676745;11721.765564688658;41973.1605367894;42218.1556368874;42440;42643.50747723846;42709.57290427087;4048.898777530556;4075.8777236682945;4096.774677392742;4104.91790164195;4122.546519882811;24859.378515537075;31670.847867587698;31847.84076079628;31887.88392406278;31974.360512789848;3126.45287074761;3184.2835362043356;3213.9196520086953;3216.1798741320813;3274.4106060909025;421879.89060054504;423170.8841455804;423815.8809205965;427673;430872;64899.026514602316;65043;65231;65289.347106529276;65299.67350163314;66378.6724265512;68097;68145.65927170332;68147;68291.3170868285;16054.43809466663;16119.516414507583;16505.092219928018;16716.414925477795;16739.748903766453;11433.314001159957;11642.88357116418;12566;12755.872441275655;12852.971762258996;18421;19253;19366.515837104183;19375.51561210981;19424.028798560015;6291.02489114188;6729.629870357079;6806.659667016629;6843;6870.656467176621;844.7507985144397;873.4366333714719;897.717219075989;897.7531178925848;928.3176865004217;24246.757532424803;28300.86796528116;30795.076147715605;31342.686573134433;31416.91580094573;973.9220862330997;982.5038355630361;992.7270000749852;1001.2740762946805;1213.205350495427;15460.149691766836;16024.75962860558;16156.919215403848;16210.594735131715;16429.58926026835;523740;598652.1684789401;602864;603627;604518;61911;62361;62498.0625290621;62526.74946501135;62725;1449.5941136481802;1454.4981981216463;1470.3971371737537;1483.6810085831382;1497.3561368611383;24137.01818617722;30108.54837177488;30176.24559385945;30397.848010759804;30996.380072398875;53599.196012059074;54028.72985635047;54126.72936635449;54278.728606356715;54353.456465434836;511950;514550;514953;515751;518852;39147.217055658155;39822.800885995384;40662;40707;40721.77834664965;47579.52420475751;47676.761616191696;48438;48575;48796.78008049827;39207.41188882226;39276.214475709756;39475.59435622627;40309.96125484315;40612.781616551554;36452.81773591115;38931.805340973115;39425.80287098661;40171;40716.59283407128;37849.81075094607;38356.80821595874;38604.80697596494;38723.2255354897;38820.61179388283;31336.843315783277;31682.406051122918;34439;34695.82652086723;34769.30461390707;20712.718256844408;24215.910284037614;24429.877850611345;24905.87547062253;24954.875225623757 23:22:07 INFO - PROCESS | 1916 | |2;jquery.html;338.86106696254535;362.75332773713865;383.6202159861736;392.6995848176145;413.51618606230704;15244.314005869735;15281.923590382046;17447.389341373055;20722.585548289026;20947.12304013819;21258.787412125876;21597.35207943764;21894.562108757815;21925.342239732792;21967.780322196773;5641.99999999999;5793.449622285876;5960.344362120185;6004.909926351108;6031.728572214261;4168.228877657628;5930.318013428468;6019.7893073742425;6024.48791852693;6033.7888173913925;4336;6232.283287421937;6508.251551071617;6526.249481309663;6639.93360066398;6488.124103246096;6557.147570815763;6614.338566143395;6615.140031795884;6641.435477984377;5768.769249230026;5785.508231800302;5804;5804.854878628026;5807.970960145214;20984.895075524677;26278.73721262782;26307.947682092883;26553.203403897915;26627.600585991226;2746.5880117982265;2755.3249453883927;2763.6821765497025;2764.6958834528186;2768.44631073784;14405.423783048771;14774.039687420283;14883.553493395215;15151.545453636409;15683.980541264782;1782.465260421881;1819.9818001819945;1827.5431142214447;1832.908354582279;1836.4398858348197;124066;124942;127296.45407091806;127399.08901366487;127962.36018819847;10887.673369798918;11400.372979486208;11402.429878506042;11442;11601.477933493014;14438.133711977314;14449.34977925996;14450.638734031734;14454.927725361305;14490.420383184555;8255.587220638945;8513.276371508491;8567.785805354915;8682.218600326001;8718.43330183536;8437.156284371515;8455.74632761018;8473.195046470575;8605.354598405145;8655.047944726075;6823.863522729517;6978;6982.266861979419;6986.825329366705;6997.440204783605;1832.8900265984084;1855.1095474172473;1856.4405899044598;1859.8512119030445;1861.1252711225702;1003.1824063388315;1012.7366884609908;1013.9442330671884;1031.0565832263394;1046.6912260883057;21531.461713457287;21983.780162198495;21985.900704964686;22031.889840551015;22053.669194962087;915.2037727177399;946.8306641297992;986.9161121304769;1027.1269420992246;1046.3669479964665;11110.222284440011;11381.829272560919;11408.828867566994;11449.713757156138;11487.597934072268;718767;720532;722410;739227;743829;92077;125420;126428;127347.36326318308;131893;971.7910649210454;994.3039872089566;1002.2483137646765;1007.1489591295343;1013.0477351289911;20698.793012070288;20776.48058798542;21098.156073756876;21191;21208.681869772274;53570.73214633902;53754.73122634362;53979.73010134924;54139.45860541344;55232.17151742647;65550;70445;72414.91377629235;73794.15514612178;78745;7455.695253330537;7822.4524283299625;7973.681052757825;8161.020677518736;8291.129431409616;11129.944350278196;12156.270623762603;12456.252624842538;12566.246025238515;12581.496740130659;10380.480975951323;10550.630727924487;10863.945680271549;10928.180386471206;10965.945170274097;10374.844377334195;10677.09244714208;10687.679369618923;11145.721356965816;11197.272177308774;10621.840672389766;10944.945275273572;11117.388543630179;11157.218994670295;11264.436778161224;6893.482988775962;7149.070620819468;7181.389581885598;7823.647935842787;8187.385946053951;10498.212634052325;10542.103921166787;10579.206559508222;10858.511366988663;10949.781004380027 23:22:07 INFO - PROCESS | 1916 | |3;mootools.html;1439.5465428390057;1452.063419094684;1455.2141843404563;1464.3044553836928;1471.7056588682262;7919.287264146233;8354.540500272482;8371.58142092896;8381.24568788809;8383.95808020959;6708.228553716324;7346.889796653055;7570.697172113123;7576;8159.5104293742415;2282.087165133951;2321.907123715058;2324.3840382298704;2326.685897403854;2330.3940975346363;2310.861348319106;2331.63859601762;2337.8831058447095;2339.122828939148;2340.1692399198296;2292.426893276681;2300.66640337151;2314.606516892124;2315.270689732737;2320.8839558022114;2252.3130445214283;2285.851419657717;2290.1068583252545;2293.495431005176;2298;2222.6666000099954;2322.9651555226687;2323.4423738302685;2326.592846251916;2329.6272596384497;8162.428629995903;8230.588470576507;8237.79405514861;8240.752777416687;8252.628631711588;4992.051510213048;5171.560417364529;5175.948240517622;5178.559822415099;5186.0665080285535;3253.6908993645566;3274.918127046819;3453.4804685938107;3456.084137703511;3461.3423449544757;1028.912542433894;1197.449173380246;1222.7187746818192;1246.8690787467276;1257.3398965543072;10543.52554135058;10685.732856678567;10687.145028397787;10691.78616427675;10742.892571074268;4342.174986752507;4482.520768146569;4561;4650.4186976627925;4669.128485981165;8328.625211865481;9109.954450227706;9323.114304141096;9356.111169438893;9365.157135857806;5117.078925793318;5167.483251674803;5171.3535808024;5188.844334669966;5190.714510701872;3863.4011728182177;4206.642435393026;4646.605038571692;4742.857714268577;4780.880477988008;3751.6623503884234;3783;3828.9617103829164;3845.788481633481;3870.5935876732538;1119.675294164683;1230.237252903188;1249.8125281207892;1254.0782524844233;1276.6872116331372;888.5823662878566;910.2172131966504;921.4195057113975;934.6541779541477;943.580106852444;5546.91679624806;5637.098064309773;5661.943380566142;5741.368449470555;5991.670458124758;931.4830269200659;944.1785646487463;955.3837774635322;967.8064387122604;983.9065288797552;3440.351068361234;3528.929421411609;3689;3793;3804.885853424402;8945.329100317502;9882.703518894445;9886.30795844284;9892.961239069939;9900.851487227697;9722.416655000723;9813.9018609813;9818.018198180125;9824.312298139204;9829.59175002129;6488.837779055561;7529.849403011909;7600.391968642495;7636.236376362319;7669.61651917413;4462.821487140478;5352.1436570150145;5582.581306402118;5607.355154157324;5645.382844070176;7577.734779282699;8995.505247211466;9013.414128081653;9064.909350906406;9088.636454541744;8996.55017249148;9190.54047297619;9329.58016889228;9330.020347863376;9352.298577606844;7041.225465198721;7179.964100179465;7477.551346919202;7669.731559395617;7770.300672939463;7794.649240784065;8017.959910200411;8019.879701804361;8030.5181689098845;8034.47775894565;6968.860622787414;7013.614251216232;7034.542754721131;7120.715171393086;7157.892631610426;6835.726570937107;6910.689018994258;6965.547239429421;7100.7869763907165;7131.607761573163;6271.3415091414745;6296.181496405438;6335.619862808247;6406.807795766134;6417.326180750954;4483.372327874035;4523.434570678665;4572.222722137178;4605.815767369268;4725.243960966229;4945.653804233669;5063.291139240583;5071.695698258116;5113.437521872516;5176.922346164886 23:22:07 INFO - PROCESS | 1916 | |4;prototype.html;353.96106428292893;363.49837224630005;366.45398356448885;371.3668195726287;372.51758972131086;5266.868328291795;5274.841754747359;5297.443768404315;5298.364196296445;5322.361316641999;5046.65330621261;5180.04169228692;5215.530602245797;5235.225330574802;5257.921131183026;3384.424647809878;3484.216051388443;3834.7183425861567;4107.178564287155;4122.340425531916;4097.262492751303;4114.033202197496;4126.174765046988;4129.525104612963;4142.647874930634;4067.251082034724;4112.691548133887;4125.566815484376;4129.669626429878;4149.502059752819;3610.3501369753435;3896.922061558767;3900.863469778544;4020.3969404589548;4170.97914510427;3075.5386691996155;3585.8027808470524;3614.27714457107;3672.944905826388;3676.2096149327754;4520.864374068783;5107;5145.30538377318;5152.896942061176;5170.638055336128;4148.108156746314;4160.337384074165;4492.281235002417;4529.666088570774;4778.976105119487;4905.6320775941595;5285.709285989269;5491.270249871318;5511.669299841982;5524.4199359067525;3450.7929524228375;4025.9194816103513;4056.5334986476637;4088.201191475771;4093.2427500912427;4970.17992031318;5438.673679579278;5528.668279903219;5917.792877249276;5930.822075337746;3665.9450108248398;3806.695464362844;3961.267165574378;4096.528899176573;4110.77390743506;3593.6047034826147;4158.459400277945;4179.26862799009;4201.474815648044;4228.809703563285;4104.979475102606;4416.659170639567;4589.311603259538;4598.252663987663;4710.646701497333;5524.972375138099;5549.916751248735;5635.718214089279;5648.079652918028;5657.9434205658235;1220.530095913062;1271.936403179856;1293.7671219180638;1329.4283458112911;1359.7008658095203;827.8079565425768;879.7800549862534;956.4787190980932;960.9135177834029;963.7783309838636;4221.092465119953;4254.7659878706345;4790.179731701931;4859.489753575895;4908.386451693538;4629.560191781776;4860.684055536379;5007.949920500749;5357.7589008494715;5583.492457036577;4438.578335058229;4519.113562336388;4679.67242293043;4761.833335833298;5085.7202853842655;2468.2101727447402;2526.5578523758268;2537.7438168106905;2574.974250257511;2866.7993240472965;4718.905621887543;5101.352532938967;5598.468145526169;5637.154426836008;5771.826845194651;4769.403824521934;5336.252924590561;5535.944640553543;5643.871225754783;5719.8570035749435;4929.926051109164;5124.00081984017;5569.493727822415;5604;5620.1569764534825;4536.0824742268305;5213.009528189632;5282.867928301823;5382.73086345689;5409.945900540944;4677;5139.019368766181;5354.491323324278;5389.140746442471;5424.430434804289;4945.67853089548;5638.605297629127;5686.180422265001;5733.541316694571;5737.512311453406;3449.379111759807;3803.923921521499;3825.2540754552597;3856.8071596420627;3863.879474952232;5205.921911171411;5473.755760138324;5704.286964129484;5707.7716891325545;5753.568482363756;5225.282852916386;5466.34403871538;5480.232767412485;5497.615166938276;5503.2020357048805;5425.403205647297;5447.727613619224;5448.237246785532;5461.235427040297;5467.562594992471;5001.299818025406;5015.598752099896;5314.149736042369;5324.467553244799;5395;4686.461056978491;5092.770825312796;5455.318085239345;5507.83299602722;5519.3652729936575;4632.814687412466;4983.476734942924;5367.1680889462195;5398.163284690722;5398.4871437213405 23:22:07 INFO - PROCESS | 1916 | |5;yui.html;697.2330436519829;715.1275443958369;762.0017776712504;805.8227190018196;808.4542933519873;14661;15606.687866242668;15685.137317447536;15689.29398177082;15723.977941433799;14328.64178395538;14496.42014319426;14523.636909077279;14524.3464044118;14528.854711452883;684.5037347922741;704.1831475488434;859.6131740716671;877.3551439691821;885.4333226734863;881.4711173296004;887.2148148888216;889.1730690457872;892.6741739265154;892.8035832116924;951.6431338248157;954.775627727487;956.5026186383077;958.2621381536213;958.8801399825022;718.2027948976631;946.711253067814;948.1087777489173;951.110711484764;952.3476418653245;536.4608568388784;540.5837505121074;542.4304480295674;545.5199424506409;675.425887995205;14794.630134246623;15128.773068403983;15162.772558411632;15183.240837958168;15215.391384344613;13581.185128892299;13658.248796316198;13666.385012674453;13722.519711810139;13740.725185496334;12741.617751467471;12781.358106657774;12784.808227876589;12807.61577152687;12945;4338.327559228324;4341.7829108544765;4369.12617476506;4375.912481750347;4545.522720114406;105685;107146.46426767894;107425.92574074316;107922.46038769835;110258.44870775675;10898.12814974816;10931.289466184673;10936.671899843017;11056.834147487794;11073.944630276797;20928.79071209299;21524.461888452915;21562.245321413677;21643.458913526974;21646.350609481742;6638.601683898982;7309.963450182715;7543.207963163899;7568.167501574822;7811.336036436966;4251.553586873396;4282.443282373271;4302.311630139163;4310.741355518679;4468.843590474317;3466.4107101792756;3544.7341449390883;3552.964470355315;3559.003479025825;3567.3935430976794;644.1207751419279;652.6312633362135;662.0962386342608;670.4200866250756;671.3789744486428;629.471244154912;643.4594940250213;650.3171669746841;673.7877568565887;674.5817593092314;9519.52402379892;9622.422654640744;9628.229741620653;9659.565319560637;9752.268579856398;635.2345423764353;652.9379708927644;664.5746722097862;673.9764108256187;684.849333146707;4510.125126346186;4650.581447669726;4669.813207471731;4692.835750748775;4797.544233297831;85740.57129714436;91696.08303917009;91772.54113729388;93024.53487732518;93426;85658;89019.66470502947;89428.55285723529;89653;89772;75923.48153036798;77181.6140919303;77787;78978.81531777028;80490.59754701189;8939.955300223457;9009.774755630899;9051.50991033985;9078.364514483923;9212.216961558343;45866.08267834558;45988.77005614951;46907.76546117248;47380;48391.5160848387;62936.68531657312;63936.72126557536;64513.35486645261;65916;65954.01068984065;8439;10974.945125274322;11002.50488728025;11003.504842281956;11334.829977550507;12007.339596322287;12010.519579216734;12038.578649747567;12267;12539.435725392561;11516.30902145874;11699.947004769612;11755.118366122404;12155.392230388623;12199.817002744789;10458.372497650165;10768.46157692128;11599.884001160219;11894.167408281337;12127.393630318626;10573.4713264338;11012.944935275273;11094.500747466222;11196.104311655212;11277.32336059839;9579.90420095818;9702.75743106428;9747.512624368612;9804.65683701067;10107.241956853413;7381.778546643394;8989.370744047854;9333.626654933727;9364.438133712;9384.155426011692 23:22:07 INFO - PROCESS | 1916 | __end_tp_report 23:22:07 INFO - PROCESS | 1916 | __start_cc_report 23:22:07 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,2783 23:22:07 INFO - PROCESS | 1916 | __end_cc_report 23:22:07 INFO - PROCESS | 1916 | __startTimestamp1484637727372__endTimestamp 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | ------- Summary: start ------- 23:22:07 INFO - PROCESS | 1916 | Number of tests: 6 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | [#0] dojo.html Cycles:165 Average:5718.07 Median:5897.94 stddev:660.59 (11.2%) stddev-sans-first:620.56 23:22:07 INFO - PROCESS | 1916 | Values: 2761.4 3131.8 3212.9 3316.0 3333.2 5523.0 5618.7 5663.3 5712.1 5714.9 5616.7 5629.7 5710.3 5718.4 5784.2 5126.8 5129.5 5133.3 5176.9 5280.1 5251.3 5271.6 5275.4 5284.3 5289.3 5087.9 5198.8 5234.6 5261.1 5278.1 5112.0 5131.4 5184.9 5187.5 5209.1 5174.7 5184.1 5188.0 5246.8 5251.1 5686.2 5688.7 5696.3 5698.0 5707.5 6075.7 6136.5 6272.0 6275.8 6281.7 6180.0 6183.6 6216.6 6241.4 6284.6 5813.3 5822.9 5823.9 5842.8 5876.4 6083.8 6268.8 6272.6 6273.3 6288.9 5868.3 5897.9 5922.3 6001.5 6178.2 6117.8 6119.4 6192.8 6238.3 6262.3 6117.3 6128.0 6140.5 6172.1 6215.9 6129.0 6243.9 6247.9 6252.1 6287.8 4336.2 4995.9 4998.4 4999.3 5003.1 4370.6 4380.3 4382.8 4385.2 4471.0 5632.4 5666.6 5728.6 5763.3 5765.1 6285.3 6285.3 6292.4 6293.0 6296.4 5562.8 5682.3 5749.5 5758.7 5762.7 5327.0 5338.3 5352.2 5371.5 5399.9 6274.9 6280.9 6287.7 6298.0 6312.6 6254.6 6258.4 6261.1 6278.7 6290.0 6159.4 6188.8 6199.2 6265.4 6280.7 6150.4 6167.6 6195.5 6208.0 6209.1 5959.4 6262.5 6274.7 6289.7 6299.1 5922.1 5954.0 6002.8 6057.4 6107.9 6027.4 6117.9 6130.5 6131.2 6134.8 5754.7 5918.1 5935.8 5947.6 5984.3 5976.8 6015.0 6027.0 6058.0 6078.8 5852.9 5868.0 5869.1 5873.2 5874.0 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | [#1] ext.html Cycles:180 Average:66477.03 Median:40240.48 stddev:136637.09 (339.6%) stddev-sans-first:136930.46 23:22:07 INFO - PROCESS | 1916 | Values: 447.2 476.6 501.1 523.2 523.9 34729.7 36281.8 44089.6 44374.0 46350.5 44096.6 44892.7 44905.0 44999.3 45115.0 8367.5 8717.6 9266.5 9600.3 9612.7 11471.5 11724.9 11765.8 11886.5 11947.1 11455.1 11478.6 11579.7 11626.6 11715.5 8457.9 8634.7 11418.3 11546.2 11643.1 11221.2 11534.8 11552.1 11691.8 11721.8 41973.2 42218.2 42440.0 42643.5 42709.6 4048.9 4075.9 4096.8 4104.9 4122.5 24859.4 31670.8 31847.8 31887.9 31974.4 3126.5 3184.3 3213.9 3216.2 3274.4 421879.9 423170.9 423815.9 427673.0 430872.0 64899.0 65043.0 65231.0 65289.3 65299.7 66378.7 68097.0 68145.7 68147.0 68291.3 16054.4 16119.5 16505.1 16716.4 16739.7 11433.3 11642.9 12566.0 12755.9 12853.0 18421.0 19253.0 19366.5 19375.5 19424.0 6291.0 6729.6 6806.7 6843.0 6870.7 844.8 873.4 897.7 897.8 928.3 24246.8 28300.9 30795.1 31342.7 31416.9 973.9 982.5 992.7 1001.3 1213.2 15460.1 16024.8 16156.9 16210.6 16429.6 523740.0 598652.2 602864.0 603627.0 604518.0 61911.0 62361.0 62498.1 62526.7 62725.0 1449.6 1454.5 1470.4 1483.7 1497.4 24137.0 30108.5 30176.2 30397.8 30996.4 53599.2 54028.7 54126.7 54278.7 54353.5 511950.0 514550.0 514953.0 515751.0 518852.0 39147.2 39822.8 40662.0 40707.0 40721.8 47579.5 47676.8 48438.0 48575.0 48796.8 39207.4 39276.2 39475.6 40310.0 40612.8 36452.8 38931.8 39425.8 40171.0 40716.6 37849.8 38356.8 38604.8 38723.2 38820.6 31336.8 31682.4 34439.0 34695.8 34769.3 20712.7 24215.9 24429.9 24905.9 24954.9 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | [#2] jquery.html Cycles:180 Average:38803.64 Median:21975.78 stddev:120560.66 (548.6%) stddev-sans-first:120864.27 23:22:07 INFO - PROCESS | 1916 | Values: 338.9 362.8 383.6 392.7 413.5 15244.3 15281.9 17447.4 20722.6 20947.1 21258.8 21597.4 21894.6 21925.3 21967.8 5642.0 5793.4 5960.3 6004.9 6031.7 4168.2 5930.3 6019.8 6024.5 6033.8 4336.0 6232.3 6508.3 6526.2 6639.9 6488.1 6557.1 6614.3 6615.1 6641.4 5768.8 5785.5 5804.0 5804.9 5808.0 20984.9 26278.7 26307.9 26553.2 26627.6 2746.6 2755.3 2763.7 2764.7 2768.4 14405.4 14774.0 14883.6 15151.5 15684.0 1782.5 1820.0 1827.5 1832.9 1836.4 124066.0 124942.0 127296.5 127399.1 127962.4 10887.7 11400.4 11402.4 11442.0 11601.5 14438.1 14449.3 14450.6 14454.9 14490.4 8255.6 8513.3 8567.8 8682.2 8718.4 8437.2 8455.7 8473.2 8605.4 8655.0 6823.9 6978.0 6982.3 6986.8 6997.4 1832.9 1855.1 1856.4 1859.9 1861.1 1003.2 1012.7 1013.9 1031.1 1046.7 21531.5 21983.8 21985.9 22031.9 22053.7 915.2 946.8 986.9 1027.1 1046.4 11110.2 11381.8 11408.8 11449.7 11487.6 718767.0 720532.0 722410.0 739227.0 743829.0 92077.0 125420.0 126428.0 127347.4 131893.0 971.8 994.3 1002.2 1007.1 1013.0 20698.8 20776.5 21098.2 21191.0 21208.7 53570.7 53754.7 53979.7 54139.5 55232.2 65550.0 70445.0 72414.9 73794.2 78745.0 7455.7 7822.5 7973.7 8161.0 8291.1 11129.9 12156.3 12456.3 12566.2 12581.5 10380.5 10550.6 10863.9 10928.2 10965.9 10374.8 10677.1 10687.7 11145.7 11197.3 10621.8 10944.9 11117.4 11157.2 11264.4 6893.5 7149.1 7181.4 7823.6 8187.4 10498.2 10542.1 10579.2 10858.5 10949.8 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | [#3] mootools.html Cycles:180 Average:5349.04 Median:5271.43 stddev:2889.28 (54.8%) stddev-sans-first:2882.44 23:22:07 INFO - PROCESS | 1916 | Values: 1439.5 1452.1 1455.2 1464.3 1471.7 7919.3 8354.5 8371.6 8381.2 8384.0 6708.2 7346.9 7570.7 7576.0 8159.5 2282.1 2321.9 2324.4 2326.7 2330.4 2310.9 2331.6 2337.9 2339.1 2340.2 2292.4 2300.7 2314.6 2315.3 2320.9 2252.3 2285.9 2290.1 2293.5 2298.0 2222.7 2323.0 2323.4 2326.6 2329.6 8162.4 8230.6 8237.8 8240.8 8252.6 4992.1 5171.6 5175.9 5178.6 5186.1 3253.7 3274.9 3453.5 3456.1 3461.3 1028.9 1197.4 1222.7 1246.9 1257.3 10543.5 10685.7 10687.1 10691.8 10742.9 4342.2 4482.5 4561.0 4650.4 4669.1 8328.6 9110.0 9323.1 9356.1 9365.2 5117.1 5167.5 5171.4 5188.8 5190.7 3863.4 4206.6 4646.6 4742.9 4780.9 3751.7 3783.0 3829.0 3845.8 3870.6 1119.7 1230.2 1249.8 1254.1 1276.7 888.6 910.2 921.4 934.7 943.6 5546.9 5637.1 5661.9 5741.4 5991.7 931.5 944.2 955.4 967.8 983.9 3440.4 3528.9 3689.0 3793.0 3804.9 8945.3 9882.7 9886.3 9893.0 9900.9 9722.4 9813.9 9818.0 9824.3 9829.6 6488.8 7529.8 7600.4 7636.2 7669.6 4462.8 5352.1 5582.6 5607.4 5645.4 7577.7 8995.5 9013.4 9064.9 9088.6 8996.6 9190.5 9329.6 9330.0 9352.3 7041.2 7180.0 7477.6 7669.7 7770.3 7794.6 8018.0 8019.9 8030.5 8034.5 6968.9 7013.6 7034.5 7120.7 7157.9 6835.7 6910.7 6965.5 7100.8 7131.6 6271.3 6296.2 6335.6 6406.8 6417.3 4483.4 4523.4 4572.2 4605.8 4725.2 4945.7 5063.3 5071.7 5113.4 5176.9 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | [#4] prototype.html Cycles:180 Average:4437.93 Median:4957.93 stddev:1322.62 (26.7%) stddev-sans-first:1290.32 23:22:07 INFO - PROCESS | 1916 | Values: 354.0 363.5 366.5 371.4 372.5 5266.9 5274.8 5297.4 5298.4 5322.4 5046.7 5180.0 5215.5 5235.2 5257.9 3384.4 3484.2 3834.7 4107.2 4122.3 4097.3 4114.0 4126.2 4129.5 4142.6 4067.3 4112.7 4125.6 4129.7 4149.5 3610.4 3896.9 3900.9 4020.4 4171.0 3075.5 3585.8 3614.3 3672.9 3676.2 4520.9 5107.0 5145.3 5152.9 5170.6 4148.1 4160.3 4492.3 4529.7 4779.0 4905.6 5285.7 5491.3 5511.7 5524.4 3450.8 4025.9 4056.5 4088.2 4093.2 4970.2 5438.7 5528.7 5917.8 5930.8 3665.9 3806.7 3961.3 4096.5 4110.8 3593.6 4158.5 4179.3 4201.5 4228.8 4105.0 4416.7 4589.3 4598.3 4710.6 5525.0 5549.9 5635.7 5648.1 5657.9 1220.5 1271.9 1293.8 1329.4 1359.7 827.8 879.8 956.5 960.9 963.8 4221.1 4254.8 4790.2 4859.5 4908.4 4629.6 4860.7 5007.9 5357.8 5583.5 4438.6 4519.1 4679.7 4761.8 5085.7 2468.2 2526.6 2537.7 2575.0 2866.8 4718.9 5101.4 5598.5 5637.2 5771.8 4769.4 5336.3 5535.9 5643.9 5719.9 4929.9 5124.0 5569.5 5604.0 5620.2 4536.1 5213.0 5282.9 5382.7 5409.9 4677.0 5139.0 5354.5 5389.1 5424.4 4945.7 5638.6 5686.2 5733.5 5737.5 3449.4 3803.9 3825.3 3856.8 3863.9 5205.9 5473.8 5704.3 5707.8 5753.6 5225.3 5466.3 5480.2 5497.6 5503.2 5425.4 5447.7 5448.2 5461.2 5467.6 5001.3 5015.6 5314.1 5324.5 5395.0 4686.5 5092.8 5455.3 5507.8 5519.4 4632.8 4983.5 5367.2 5398.2 5398.5 23:22:07 INFO - PROCESS | 1916 | 23:22:07 INFO - PROCESS | 1916 | [#5] yui.html Cycles:180 Average:19628.97 Median:538.52 stddev:28528.74 (5297.6%) stddev-sans-first:28573.35 23:22:07 INFO - PROCESS | 1916 | Values: 697.2 715.1 762.0 805.8 808.5 14661.0 15606.7 15685.1 15689.3 15724.0 14328.6 14496.4 14523.6 14524.3 14528.9 684.5 704.2 859.6 877.4 885.4 881.5 887.2 889.2 892.7 892.8 951.6 954.8 956.5 958.3 958.9 718.2 946.7 948.1 951.1 952.3 536.5 540.6 542.4 545.5 675.4 14794.6 15128.8 15162.8 15183.2 15215.4 13581.2 13658.2 13666.4 13722.5 13740.7 12741.6 12781.4 12784.8 12807.6 12945.0 4338.3 4341.8 4369.1 4375.9 4545.5 105685.0 107146.5 107425.9 107922.5 110258.4 10898.1 10931.3 10936.7 11056.8 11073.9 20928.8 21524.5 21562.2 21643.5 21646.4 6638.6 7310.0 7543.2 7568.2 7811.3 4251.6 4282.4 4302.3 4310.7 4468.8 3466.4 3544.7 3553.0 3559.0 3567.4 644.1 652.6 662.1 670.4 671.4 629.5 643.5 650.3 673.8 674.6 9519.5 9622.4 9628.2 9659.6 9752.3 635.2 652.9 664.6 674.0 684.8 4510.1 4650.6 4669.8 4692.8 4797.5 85740.6 91696.1 91772.5 93024.5 93426.0 85658.0 89019.7 89428.6 89653.0 89772.0 75923.5 77181.6 77787.0 78978.8 80490.6 8940.0 9009.8 9051.5 9078.4 9212.2 45866.1 45988.8 46907.8 47380.0 48391.5 62936.7 63936.7 64513.4 65916.0 65954.0 8439.0 10974.9 11002.5 11003.5 11334.8 12007.3 12010.5 12038.6 12267.0 12539.4 11516.3 11699.9 11755.1 12155.4 12199.8 10458.4 10768.5 11599.9 11894.2 12127.4 10573.5 11012.9 11094.5 11196.1 11277.3 9579.9 9702.8 9747.5 9804.7 10107.2 7381.8 8989.4 9333.6 9364.4 9384.2 23:22:07 INFO - PROCESS | 1916 | -------- Summary: end -------- 23:22:07 INFO - PROCESS | 1916 | 23:22:08 INFO - TEST-INFO | 1916: exit 0 23:22:08 INFO - TEST-OK | dromaeo_css | took 1119082ms 23:22:08 INFO - TEST-START | kraken 23:22:08 INFO - operating with platform_type : mac_ 23:22:08 INFO - Initialising browser for kraken test... 23:22:08 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpRzzC79/profile http://localhost:53526/getInfo.html) 23:22:10 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 23:22:10 INFO - PROCESS | 1919 | colorDepth:24 23:22:10 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 23:22:10 INFO - PROCESS | 1919 | __metrics 23:22:10 INFO - PROCESS | 1919 | 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" 23:22:10 INFO - PROCESS | 1919 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:11 INFO - TEST-INFO | 1919: exit 0 23:22:11 INFO - Browser initialized. 23:22:11 INFO - Running cycle 1/1 for kraken test... 23:22:11 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpRzzC79/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:23 INFO - PROCESS | 1920 | RSS: Main: 227069952 23:22:23 INFO - PROCESS | 1920 | 23:22:25 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-beat-detection) 23:22:26 INFO - PROCESS | 1920 | RSS: Main: 287682560 23:22:26 INFO - PROCESS | 1920 | 23:22:29 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-dft) 23:22:30 INFO - PROCESS | 1920 | RSS: Main: 289189888 23:22:30 INFO - PROCESS | 1920 | 23:22:33 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-fft) 23:22:34 INFO - PROCESS | 1920 | RSS: Main: 380784640 23:22:34 INFO - PROCESS | 1920 | 23:22:36 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53526/tests/kraken/driver.html?testName=audio-oscillator) 23:22:36 INFO - PROCESS | 1920 | RSS: Main: 284688384 23:22:36 INFO - PROCESS | 1920 | 23:22:38 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:22:39 INFO - PROCESS | 1920 | RSS: Main: 286871552 23:22:39 INFO - PROCESS | 1920 | 23:22:42 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53526/tests/kraken/driver.html?testName=imaging-darkroom) 23:22:43 INFO - PROCESS | 1920 | RSS: Main: 329551872 23:22:43 INFO - PROCESS | 1920 | 23:22:45 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53526/tests/kraken/driver.html?testName=imaging-desaturate) 23:22:46 INFO - PROCESS | 1920 | RSS: Main: 331427840 23:22:46 INFO - PROCESS | 1920 | 23:22:49 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53526/tests/kraken/driver.html?testName=json-parse-financial) 23:22:49 INFO - PROCESS | 1920 | RSS: Main: 325865472 23:22:49 INFO - PROCESS | 1920 | 23:22:51 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:22:52 INFO - PROCESS | 1920 | RSS: Main: 303919104 23:22:52 INFO - PROCESS | 1920 | 23:22:54 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:22:54 INFO - PROCESS | 1920 | RSS: Main: 306278400 23:22:54 INFO - PROCESS | 1920 | 23:22:56 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:22:57 INFO - PROCESS | 1920 | RSS: Main: 307961856 23:22:57 INFO - PROCESS | 1920 | 23:23:00 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:23:01 INFO - PROCESS | 1920 | RSS: Main: 327311360 23:23:01 INFO - PROCESS | 1920 | 23:23:04 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:23:04 INFO - PROCESS | 1920 | RSS: Main: 321224704 23:23:04 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:53526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53526/tests/kraken/driver.html?testName=ai-astar) 23:23:06 INFO - PROCESS | 1920 | RSS: Main: 365289472 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | __start_tp_report 23:23:06 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 23:23:06 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 23:23:06 INFO - PROCESS | 1920 | |i|pagename|runs| 23:23:06 INFO - PROCESS | 1920 | |0;ai-astar;112;115;113;114;113;112;114;114;114;115 23:23:06 INFO - PROCESS | 1920 | |1;audio-beat-detection;145;111;110;146;111;109;107;110;122;94 23:23:06 INFO - PROCESS | 1920 | |2;audio-dft;183;187;184;185;183;181;183;182;187;183 23:23:06 INFO - PROCESS | 1920 | |3;audio-fft;82;60;81;110;90;61;57;74;98;80 23:23:06 INFO - PROCESS | 1920 | |4;audio-oscillator;83;69;111;102;98;77;82;69;70;83 23:23:06 INFO - PROCESS | 1920 | |5;imaging-gaussian-blur;89;87;89;86;135;88;91;88;91;88 23:23:06 INFO - PROCESS | 1920 | |6;imaging-darkroom;95;95;100;95;93;95;95;95;94;95 23:23:06 INFO - PROCESS | 1920 | |7;imaging-desaturate;86;85;87;85;87;87;86;85;88;84 23:23:06 INFO - PROCESS | 1920 | |8;json-parse-financial;58;56;58;56;56;56;56;56;56;56 23:23:06 INFO - PROCESS | 1920 | |9;json-stringify-tinderbox;66;75;66;77;75;69;69;69;70;70 23:23:06 INFO - PROCESS | 1920 | |10;stanford-crypto-aes;88;91;88;85;79;85;106;106;106;90 23:23:06 INFO - PROCESS | 1920 | |11;stanford-crypto-ccm;143;142;141;135;140;141;139;141;195;177 23:23:06 INFO - PROCESS | 1920 | |12;stanford-crypto-pbkdf2;176;172;174;173;174;178;174;176;176;173 23:23:06 INFO - PROCESS | 1920 | |13;stanford-crypto-sha256-iterative;67;68;67;66;67;68;68;67;67;68 23:23:06 INFO - PROCESS | 1920 | __end_tp_report 23:23:06 INFO - PROCESS | 1920 | __start_cc_report 23:23:06 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,2080 23:23:06 INFO - PROCESS | 1920 | __end_cc_report 23:23:06 INFO - PROCESS | 1920 | __startTimestamp1484637786943__endTimestamp 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | ------- Summary: start ------- 23:23:06 INFO - PROCESS | 1920 | Number of tests: 14 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.97 23:23:06 INFO - PROCESS | 1920 | Values: 112.0 115.0 113.0 114.0 113.0 112.0 114.0 114.0 114.0 115.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#1] audio-beat-detection Cycles:10 Average:116.50 Median:116.50 stddev:16.70 (14.3%) stddev-sans-first:14.18 23:23:06 INFO - PROCESS | 1920 | Values: 145.0 111.0 110.0 146.0 111.0 109.0 107.0 110.0 122.0 94.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#2] audio-dft Cycles:10 Average:183.80 Median:183.50 stddev:1.99 (1.1%) stddev-sans-first:2.09 23:23:06 INFO - PROCESS | 1920 | Values: 183.0 187.0 184.0 185.0 183.0 181.0 183.0 182.0 187.0 183.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#3] audio-fft Cycles:10 Average:79.30 Median:80.50 stddev:17.16 (21.3%) stddev-sans-first:18.17 23:23:06 INFO - PROCESS | 1920 | Values: 82.0 60.0 81.0 110.0 90.0 61.0 57.0 74.0 98.0 80.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:79.50 stddev:14.71 (18.5%) stddev-sans-first:15.60 23:23:06 INFO - PROCESS | 1920 | Values: 83.0 69.0 111.0 102.0 98.0 77.0 82.0 69.0 70.0 83.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:88.50 stddev:14.77 (16.7%) stddev-sans-first:15.59 23:23:06 INFO - PROCESS | 1920 | Values: 89.0 87.0 89.0 86.0 135.0 88.0 91.0 88.0 91.0 88.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:1.81 (1.9%) stddev-sans-first:1.92 23:23:06 INFO - PROCESS | 1920 | Values: 95.0 95.0 100.0 95.0 93.0 95.0 95.0 95.0 94.0 95.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 23:23:06 INFO - PROCESS | 1920 | Values: 86.0 85.0 87.0 85.0 87.0 87.0 86.0 85.0 88.0 84.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:0.84 (1.5%) stddev-sans-first:0.67 23:23:06 INFO - PROCESS | 1920 | Values: 58.0 56.0 58.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.00 stddev:3.81 (5.4%) stddev-sans-first:3.66 23:23:06 INFO - PROCESS | 1920 | Values: 66.0 75.0 66.0 77.0 75.0 69.0 69.0 69.0 70.0 70.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:86.50 stddev:9.95 (11.5%) stddev-sans-first:10.42 23:23:06 INFO - PROCESS | 1920 | Values: 88.0 91.0 88.0 85.0 79.0 85.0 106.0 106.0 106.0 90.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:141.50 stddev:19.87 (14.0%) stddev-sans-first:20.94 23:23:06 INFO - PROCESS | 1920 | Values: 143.0 142.0 141.0 135.0 140.0 141.0 139.0 141.0 195.0 177.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:1.84 (1.1%) stddev-sans-first:1.88 23:23:06 INFO - PROCESS | 1920 | Values: 176.0 172.0 174.0 173.0 174.0 178.0 174.0 176.0 176.0 173.0 23:23:06 INFO - PROCESS | 1920 | 23:23:06 INFO - PROCESS | 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 23:23:06 INFO - PROCESS | 1920 | Values: 67.0 68.0 67.0 66.0 67.0 68.0 68.0 67.0 67.0 68.0 23:23:06 INFO - PROCESS | 1920 | -------- Summary: end -------- 23:23:06 INFO - PROCESS | 1920 | 23:23:07 INFO - TEST-INFO | 1920: exit 0 23:23:08 INFO - TEST-OK | kraken | took 59976ms 23:23:08 INFO - SUITE-END | took 1179s 23:23:08 INFO - Completed test suite (00:19:39) 23:23:08 INFO - javascript benchmark 23:23:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2761.3648860762023, 3131.7786063435256, 3212.919677008076, 3315.983420082899, 3333.1667083229195, 5523.0, 5618.747156377963, 5663.348714897788, 5712.086066229404, 5714.942850571493, 5616.719164041802, 5629.71851407429, 5710.314762228539, 5718.42815718429, 5784.1902133701215, 5126.769295381717, 5129.53834154926, 5133.255677926699, 5176.896462070757, 5280.102382594949, 5251.264822924774, 5271.5782737381105, 5275.419703832576, 5284.2866213061125, 5289.285946397225, 5087.923681144785, 5198.792048318062, 5234.6335756497065, 5261.053010458116, 5278.1291086970605, 5111.974440127813, 5131.4098878629065, 5184.922226166611, 5187.455317191716, 5209.140491818884, 5174.741262936838, 5184.092783762826, 5188.040212560688, 5246.81636142737, 5251.133562962106, 5686.2039314496005, 5688.744006519716, 5696.287964004499, 5698.0, 5707.486326230659, 6075.726592303313, 6136.539759518009, 6272.0, 6275.780347687854, 6281.748730050838, 6180.042093475518, 6183.628982261033, 6216.564840461169, 6241.375862413768, 6284.5600807943465, 5813.331466881278, 5822.854428639318, 5823.912641310384, 5842.795502157489, 5876.44173803488, 6083.838749510228, 6268.780592679234, 6272.6236425814595, 6273.278572964167, 6288.937110628926, 5868.2664666916635, 5897.941020589739, 5922.289325280994, 6001.459868611846, 6178.165947597106, 6117.827404800917, 6119.41115851624, 6192.845178870564, 6238.282597501346, 6262.342454042351, 6117.279373342205, 6128.0, 6140.5174222817595, 6172.135900973867, 6215.906761398583, 6128.988716861668, 6243.875122497525, 6247.875042499216, 6252.09344645033, 6287.811365659038, 4336.241157797373, 4995.850124496271, 4998.375203099613, 4999.275105109738, 5003.124453220672, 4370.584794444522, 4380.3210502372185, 4382.802773875183, 4385.210662080856, 4471.0, 5632.436756324335, 5666.575006874501, 5728.598998070179, 5763.279590051244, 5765.135229715576, 6285.308616052231, 6285.308616052231, 6292.433680968735, 6293.0, 6296.370362963758, 5562.7774889004795, 5682.261306030272, 5749.540036797046, 5758.654480731169, 5762.711864406763, 5326.97336513315, 5338.332708411449, 5352.223927530564, 5371.462853714597, 5399.892002159935, 6274.905876411857, 6280.937190628035, 6287.685615719287, 6297.96851015742, 6312.621242725543, 6254.6247225166635, 6258.405451482102, 6261.060840873905, 6278.6860656966055, 6290.025046117859, 6159.384061593984, 6188.81433556976, 6199.194104766532, 6265.404786545271, 6280.654563999024, 6150.415710507495, 6167.599106058092, 6195.473384762346, 6208.0, 6209.130721698875, 5959.433853783884, 6262.46769024638, 6274.6548939808745, 6289.716962736779, 6299.149614801943, 5922.141289512911, 5954.0, 6002.819915402545, 6057.394260573908, 6107.9083813741945, 6027.36712645166, 6117.8578538723295, 6130.52043589939, 6131.162586540493, 6134.834601026089, 5754.741036653277, 5918.112283157561, 5935.821925342247, 5947.613405128653, 5984.341722410619, 5976.7908123215475, 6014.969925150346, 6027.0, 6057.969710151421, 6078.756849725962, 5852.853678657897, 5867.970660146672, 5869.119632055226, 5873.207117039145, 5874.001419758737], "value": 5672.089141800047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.2196017948679, 476.6067993905027, 501.07051419616613, 523.1968927695988, 523.8899831035483, 34729.65270347299, 36281.81859090704, 44089.559104408945, 44373.999999999956, 46350.536494635046, 44096.55903440965, 44892.65322040344, 44905.0, 44999.32501012488, 45115.0, 8367.539785311805, 8717.564121793917, 9266.490343031148, 9600.279979001569, 9612.663556775515, 11471.483783229774, 11724.941375293154, 11765.7646847063, 11886.524539018472, 11947.10396720245, 11455.083593312514, 11478.598249061284, 11579.65261042166, 11626.593069242535, 11715.531378744883, 8457.873131903027, 8634.654613815439, 11418.31490110596, 11546.191766576343, 11643.12676549258, 11221.214514983954, 11534.826977595343, 11552.133589980785, 11691.766164676745, 11721.765564688658, 41973.1605367894, 42218.1556368874, 42440.0, 42643.50747723846, 42709.57290427087, 4048.898777530556, 4075.8777236682945, 4096.774677392742, 4104.91790164195, 4122.546519882811, 24859.378515537075, 31670.847867587698, 31847.84076079628, 31887.88392406278, 31974.360512789848, 3126.45287074761, 3184.2835362043356, 3213.9196520086953, 3216.1798741320813, 3274.4106060909025, 421879.89060054504, 423170.8841455804, 423815.8809205965, 427673.0, 430872.0, 64899.026514602316, 65043.0, 65231.0, 65289.347106529276, 65299.67350163314, 66378.6724265512, 68097.0, 68145.65927170332, 68147.0, 68291.3170868285, 16054.43809466663, 16119.516414507583, 16505.092219928018, 16716.414925477795, 16739.748903766453, 11433.314001159957, 11642.88357116418, 12566.0, 12755.872441275655, 12852.971762258996, 18421.0, 19253.0, 19366.515837104183, 19375.51561210981, 19424.028798560015, 6291.02489114188, 6729.629870357079, 6806.659667016629, 6843.0, 6870.656467176621, 844.7507985144397, 873.4366333714719, 897.717219075989, 897.7531178925848, 928.3176865004217, 24246.757532424803, 28300.86796528116, 30795.076147715605, 31342.686573134433, 31416.91580094573, 973.9220862330997, 982.5038355630361, 992.7270000749852, 1001.2740762946805, 1213.205350495427, 15460.149691766836, 16024.75962860558, 16156.919215403848, 16210.594735131715, 16429.58926026835, 523740.0, 598652.1684789401, 602864.0, 603627.0, 604518.0, 61911.0, 62361.0, 62498.0625290621, 62526.74946501135, 62725.0, 1449.5941136481802, 1454.4981981216463, 1470.3971371737537, 1483.6810085831382, 1497.3561368611383, 24137.01818617722, 30108.54837177488, 30176.24559385945, 30397.848010759804, 30996.380072398875, 53599.196012059074, 54028.72985635047, 54126.72936635449, 54278.728606356715, 54353.456465434836, 511950.0, 514550.0, 514953.0, 515751.0, 518852.0, 39147.217055658155, 39822.800885995384, 40662.0, 40707.0, 40721.77834664965, 47579.52420475751, 47676.761616191696, 48438.0, 48575.0, 48796.78008049827, 39207.41188882226, 39276.214475709756, 39475.59435622627, 40309.96125484315, 40612.781616551554, 36452.81773591115, 38931.805340973115, 39425.80287098661, 40171.0, 40716.59283407128, 37849.81075094607, 38356.80821595874, 38604.80697596494, 38723.2255354897, 38820.61179388283, 31336.843315783277, 31682.406051122918, 34439.0, 34695.82652086723, 34769.30461390707, 20712.718256844408, 24215.910284037614, 24429.877850611345, 24905.87547062253, 24954.875225623757], "value": 20585.66829033071, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.86106696254535, 362.75332773713865, 383.6202159861736, 392.6995848176145, 413.51618606230704, 15244.314005869735, 15281.923590382046, 17447.389341373055, 20722.585548289026, 20947.12304013819, 21258.787412125876, 21597.35207943764, 21894.562108757815, 21925.342239732792, 21967.780322196773, 5641.99999999999, 5793.449622285876, 5960.344362120185, 6004.909926351108, 6031.728572214261, 4168.228877657628, 5930.318013428468, 6019.7893073742425, 6024.48791852693, 6033.7888173913925, 4336.0, 6232.283287421937, 6508.251551071617, 6526.249481309663, 6639.93360066398, 6488.124103246096, 6557.147570815763, 6614.338566143395, 6615.140031795884, 6641.435477984377, 5768.769249230026, 5785.508231800302, 5804.0, 5804.854878628026, 5807.970960145214, 20984.895075524677, 26278.73721262782, 26307.947682092883, 26553.203403897915, 26627.600585991226, 2746.5880117982265, 2755.3249453883927, 2763.6821765497025, 2764.6958834528186, 2768.44631073784, 14405.423783048771, 14774.039687420283, 14883.553493395215, 15151.545453636409, 15683.980541264782, 1782.465260421881, 1819.9818001819945, 1827.5431142214447, 1832.908354582279, 1836.4398858348197, 124066.0, 124942.0, 127296.45407091806, 127399.08901366487, 127962.36018819847, 10887.673369798918, 11400.372979486208, 11402.429878506042, 11442.0, 11601.477933493014, 14438.133711977314, 14449.34977925996, 14450.638734031734, 14454.927725361305, 14490.420383184555, 8255.587220638945, 8513.276371508491, 8567.785805354915, 8682.218600326001, 8718.43330183536, 8437.156284371515, 8455.74632761018, 8473.195046470575, 8605.354598405145, 8655.047944726075, 6823.863522729517, 6978.0, 6982.266861979419, 6986.825329366705, 6997.440204783605, 1832.8900265984084, 1855.1095474172473, 1856.4405899044598, 1859.8512119030445, 1861.1252711225702, 1003.1824063388315, 1012.7366884609908, 1013.9442330671884, 1031.0565832263394, 1046.6912260883057, 21531.461713457287, 21983.780162198495, 21985.900704964686, 22031.889840551015, 22053.669194962087, 915.2037727177399, 946.8306641297992, 986.9161121304769, 1027.1269420992246, 1046.3669479964665, 11110.222284440011, 11381.829272560919, 11408.828867566994, 11449.713757156138, 11487.597934072268, 718767.0, 720532.0, 722410.0, 739227.0, 743829.0, 92077.0, 125420.0, 126428.0, 127347.36326318308, 131893.0, 971.7910649210454, 994.3039872089566, 1002.2483137646765, 1007.1489591295343, 1013.0477351289911, 20698.793012070288, 20776.48058798542, 21098.156073756876, 21191.0, 21208.681869772274, 53570.73214633902, 53754.73122634362, 53979.73010134924, 54139.45860541344, 55232.17151742647, 65550.0, 70445.0, 72414.91377629235, 73794.15514612178, 78745.0, 7455.695253330537, 7822.4524283299625, 7973.681052757825, 8161.020677518736, 8291.129431409616, 11129.944350278196, 12156.270623762603, 12456.252624842538, 12566.246025238515, 12581.496740130659, 10380.480975951323, 10550.630727924487, 10863.945680271549, 10928.180386471206, 10965.945170274097, 10374.844377334195, 10677.09244714208, 10687.679369618923, 11145.721356965816, 11197.272177308774, 10621.840672389766, 10944.945275273572, 11117.388543630179, 11157.218994670295, 11264.436778161224, 6893.482988775962, 7149.070620819468, 7181.389581885598, 7823.647935842787, 8187.385946053951, 10498.212634052325, 10542.103921166787, 10579.206559508222, 10858.511366988663, 10949.781004380027], "value": 9919.722979961665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.5465428390057, 1452.063419094684, 1455.2141843404563, 1464.3044553836928, 1471.7056588682262, 7919.287264146233, 8354.540500272482, 8371.58142092896, 8381.24568788809, 8383.95808020959, 6708.228553716324, 7346.889796653055, 7570.697172113123, 7576.0, 8159.5104293742415, 2282.087165133951, 2321.907123715058, 2324.3840382298704, 2326.685897403854, 2330.3940975346363, 2310.861348319106, 2331.63859601762, 2337.8831058447095, 2339.122828939148, 2340.1692399198296, 2292.426893276681, 2300.66640337151, 2314.606516892124, 2315.270689732737, 2320.8839558022114, 2252.3130445214283, 2285.851419657717, 2290.1068583252545, 2293.495431005176, 2298.0, 2222.6666000099954, 2322.9651555226687, 2323.4423738302685, 2326.592846251916, 2329.6272596384497, 8162.428629995903, 8230.588470576507, 8237.79405514861, 8240.752777416687, 8252.628631711588, 4992.051510213048, 5171.560417364529, 5175.948240517622, 5178.559822415099, 5186.0665080285535, 3253.6908993645566, 3274.918127046819, 3453.4804685938107, 3456.084137703511, 3461.3423449544757, 1028.912542433894, 1197.449173380246, 1222.7187746818192, 1246.8690787467276, 1257.3398965543072, 10543.52554135058, 10685.732856678567, 10687.145028397787, 10691.78616427675, 10742.892571074268, 4342.174986752507, 4482.520768146569, 4561.0, 4650.4186976627925, 4669.128485981165, 8328.625211865481, 9109.954450227706, 9323.114304141096, 9356.111169438893, 9365.157135857806, 5117.078925793318, 5167.483251674803, 5171.3535808024, 5188.844334669966, 5190.714510701872, 3863.4011728182177, 4206.642435393026, 4646.605038571692, 4742.857714268577, 4780.880477988008, 3751.6623503884234, 3783.0, 3828.9617103829164, 3845.788481633481, 3870.5935876732538, 1119.675294164683, 1230.237252903188, 1249.8125281207892, 1254.0782524844233, 1276.6872116331372, 888.5823662878566, 910.2172131966504, 921.4195057113975, 934.6541779541477, 943.580106852444, 5546.91679624806, 5637.098064309773, 5661.943380566142, 5741.368449470555, 5991.670458124758, 931.4830269200659, 944.1785646487463, 955.3837774635322, 967.8064387122604, 983.9065288797552, 3440.351068361234, 3528.929421411609, 3689.0, 3793.0, 3804.885853424402, 8945.329100317502, 9882.703518894445, 9886.30795844284, 9892.961239069939, 9900.851487227697, 9722.416655000723, 9813.9018609813, 9818.018198180125, 9824.312298139204, 9829.59175002129, 6488.837779055561, 7529.849403011909, 7600.391968642495, 7636.236376362319, 7669.61651917413, 4462.821487140478, 5352.1436570150145, 5582.581306402118, 5607.355154157324, 5645.382844070176, 7577.734779282699, 8995.505247211466, 9013.414128081653, 9064.909350906406, 9088.636454541744, 8996.55017249148, 9190.54047297619, 9329.58016889228, 9330.020347863376, 9352.298577606844, 7041.225465198721, 7179.964100179465, 7477.551346919202, 7669.731559395617, 7770.300672939463, 7794.649240784065, 8017.959910200411, 8019.879701804361, 8030.5181689098845, 8034.47775894565, 6968.860622787414, 7013.614251216232, 7034.542754721131, 7120.715171393086, 7157.892631610426, 6835.726570937107, 6910.689018994258, 6965.547239429421, 7100.7869763907165, 7131.607761573163, 6271.3415091414745, 6296.181496405438, 6335.619862808247, 6406.807795766134, 6417.326180750954, 4483.372327874035, 4523.434570678665, 4572.222722137178, 4605.815767369268, 4725.243960966229, 4945.653804233669, 5063.291139240583, 5071.695698258116, 5113.437521872516, 5176.922346164886], "value": 4370.650439832874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.96106428292893, 363.49837224630005, 366.45398356448885, 371.3668195726287, 372.51758972131086, 5266.868328291795, 5274.841754747359, 5297.443768404315, 5298.364196296445, 5322.361316641999, 5046.65330621261, 5180.04169228692, 5215.530602245797, 5235.225330574802, 5257.921131183026, 3384.424647809878, 3484.216051388443, 3834.7183425861567, 4107.178564287155, 4122.340425531916, 4097.262492751303, 4114.033202197496, 4126.174765046988, 4129.525104612963, 4142.647874930634, 4067.251082034724, 4112.691548133887, 4125.566815484376, 4129.669626429878, 4149.502059752819, 3610.3501369753435, 3896.922061558767, 3900.863469778544, 4020.3969404589548, 4170.97914510427, 3075.5386691996155, 3585.8027808470524, 3614.27714457107, 3672.944905826388, 3676.2096149327754, 4520.864374068783, 5107.0, 5145.30538377318, 5152.896942061176, 5170.638055336128, 4148.108156746314, 4160.337384074165, 4492.281235002417, 4529.666088570774, 4778.976105119487, 4905.6320775941595, 5285.709285989269, 5491.270249871318, 5511.669299841982, 5524.4199359067525, 3450.7929524228375, 4025.9194816103513, 4056.5334986476637, 4088.201191475771, 4093.2427500912427, 4970.17992031318, 5438.673679579278, 5528.668279903219, 5917.792877249276, 5930.822075337746, 3665.9450108248398, 3806.695464362844, 3961.267165574378, 4096.528899176573, 4110.77390743506, 3593.6047034826147, 4158.459400277945, 4179.26862799009, 4201.474815648044, 4228.809703563285, 4104.979475102606, 4416.659170639567, 4589.311603259538, 4598.252663987663, 4710.646701497333, 5524.972375138099, 5549.916751248735, 5635.718214089279, 5648.079652918028, 5657.9434205658235, 1220.530095913062, 1271.936403179856, 1293.7671219180638, 1329.4283458112911, 1359.7008658095203, 827.8079565425768, 879.7800549862534, 956.4787190980932, 960.9135177834029, 963.7783309838636, 4221.092465119953, 4254.7659878706345, 4790.179731701931, 4859.489753575895, 4908.386451693538, 4629.560191781776, 4860.684055536379, 5007.949920500749, 5357.7589008494715, 5583.492457036577, 4438.578335058229, 4519.113562336388, 4679.67242293043, 4761.833335833298, 5085.7202853842655, 2468.2101727447402, 2526.5578523758268, 2537.7438168106905, 2574.974250257511, 2866.7993240472965, 4718.905621887543, 5101.352532938967, 5598.468145526169, 5637.154426836008, 5771.826845194651, 4769.403824521934, 5336.252924590561, 5535.944640553543, 5643.871225754783, 5719.8570035749435, 4929.926051109164, 5124.00081984017, 5569.493727822415, 5604.0, 5620.1569764534825, 4536.0824742268305, 5213.009528189632, 5282.867928301823, 5382.73086345689, 5409.945900540944, 4677.0, 5139.019368766181, 5354.491323324278, 5389.140746442471, 5424.430434804289, 4945.67853089548, 5638.605297629127, 5686.180422265001, 5733.541316694571, 5737.512311453406, 3449.379111759807, 3803.923921521499, 3825.2540754552597, 3856.8071596420627, 3863.879474952232, 5205.921911171411, 5473.755760138324, 5704.286964129484, 5707.7716891325545, 5753.568482363756, 5225.282852916386, 5466.34403871538, 5480.232767412485, 5497.615166938276, 5503.2020357048805, 5425.403205647297, 5447.727613619224, 5448.237246785532, 5461.235427040297, 5467.562594992471, 5001.299818025406, 5015.598752099896, 5314.149736042369, 5324.467553244799, 5395.0, 4686.461056978491, 5092.770825312796, 5455.318085239345, 5507.83299602722, 5519.3652729936575, 4632.814687412466, 4983.476734942924, 5367.1680889462195, 5398.163284690722, 5398.4871437213405], "value": 4034.363615853092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.2330436519829, 715.1275443958369, 762.0017776712504, 805.8227190018196, 808.4542933519873, 14661.0, 15606.687866242668, 15685.137317447536, 15689.29398177082, 15723.977941433799, 14328.64178395538, 14496.42014319426, 14523.636909077279, 14524.3464044118, 14528.854711452883, 684.5037347922741, 704.1831475488434, 859.6131740716671, 877.3551439691821, 885.4333226734863, 881.4711173296004, 887.2148148888216, 889.1730690457872, 892.6741739265154, 892.8035832116924, 951.6431338248157, 954.775627727487, 956.5026186383077, 958.2621381536213, 958.8801399825022, 718.2027948976631, 946.711253067814, 948.1087777489173, 951.110711484764, 952.3476418653245, 536.4608568388784, 540.5837505121074, 542.4304480295674, 545.5199424506409, 675.425887995205, 14794.630134246623, 15128.773068403983, 15162.772558411632, 15183.240837958168, 15215.391384344613, 13581.185128892299, 13658.248796316198, 13666.385012674453, 13722.519711810139, 13740.725185496334, 12741.617751467471, 12781.358106657774, 12784.808227876589, 12807.61577152687, 12945.0, 4338.327559228324, 4341.7829108544765, 4369.12617476506, 4375.912481750347, 4545.522720114406, 105685.0, 107146.46426767894, 107425.92574074316, 107922.46038769835, 110258.44870775675, 10898.12814974816, 10931.289466184673, 10936.671899843017, 11056.834147487794, 11073.944630276797, 20928.79071209299, 21524.461888452915, 21562.245321413677, 21643.458913526974, 21646.350609481742, 6638.601683898982, 7309.963450182715, 7543.207963163899, 7568.167501574822, 7811.336036436966, 4251.553586873396, 4282.443282373271, 4302.311630139163, 4310.741355518679, 4468.843590474317, 3466.4107101792756, 3544.7341449390883, 3552.964470355315, 3559.003479025825, 3567.3935430976794, 644.1207751419279, 652.6312633362135, 662.0962386342608, 670.4200866250756, 671.3789744486428, 629.471244154912, 643.4594940250213, 650.3171669746841, 673.7877568565887, 674.5817593092314, 9519.52402379892, 9622.422654640744, 9628.229741620653, 9659.565319560637, 9752.268579856398, 635.2345423764353, 652.9379708927644, 664.5746722097862, 673.9764108256187, 684.849333146707, 4510.125126346186, 4650.581447669726, 4669.813207471731, 4692.835750748775, 4797.544233297831, 85740.57129714436, 91696.08303917009, 91772.54113729388, 93024.53487732518, 93426.0, 85658.0, 89019.66470502947, 89428.55285723529, 89653.0, 89772.0, 75923.48153036798, 77181.6140919303, 77787.0, 78978.81531777028, 80490.59754701189, 8939.955300223457, 9009.774755630899, 9051.50991033985, 9078.364514483923, 9212.216961558343, 45866.08267834558, 45988.77005614951, 46907.76546117248, 47380.0, 48391.5160848387, 62936.68531657312, 63936.72126557536, 64513.35486645261, 65916.0, 65954.01068984065, 8439.0, 10974.945125274322, 11002.50488728025, 11003.504842281956, 11334.829977550507, 12007.339596322287, 12010.519579216734, 12038.578649747567, 12267.0, 12539.435725392561, 11516.30902145874, 11699.947004769612, 11755.118366122404, 12155.392230388623, 12199.817002744789, 10458.372497650165, 10768.46157692128, 11599.884001160219, 11894.167408281337, 12127.393630318626, 10573.4713264338, 11012.944935275273, 11094.500747466222, 11196.104311655212, 11277.32336059839, 9579.90420095818, 9702.75743106428, 9747.512624368612, 9804.65683701067, 10107.241956853413, 7381.778546643394, 8989.370744047854, 9333.626654933727, 9364.438133712, 9384.155426011692], "value": 7202.268052452137, "unit": "score"}], "name": "dromaeo_css", "value": 7265.653399638694, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 113.0, 114.0, 113.0, 112.0, 114.0, 114.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 110.0, 146.0, 111.0, 109.0, 107.0, 110.0, 122.0, 94.0], "value": 116.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 184.0, 185.0, 183.0, 181.0, 183.0, 182.0, 187.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 81.0, 110.0, 90.0, 61.0, 57.0, 74.0, 98.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 111.0, 102.0, 98.0, 77.0, 82.0, 69.0, 70.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 86.0, 135.0, 88.0, 91.0, 88.0, 91.0, 88.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 100.0, 95.0, 93.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 85.0, 87.0, 87.0, 86.0, 85.0, 88.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 66.0, 77.0, 75.0, 69.0, 69.0, 69.0, 70.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 88.0, 85.0, 79.0, 85.0, 106.0, 106.0, 106.0, 90.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 141.0, 135.0, 140.0, 141.0, 139.0, 141.0, 195.0, 177.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 174.0, 173.0, 174.0, 178.0, 174.0, 176.0, 176.0, 173.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1462.7, "alertThreshold": 2.0}]} 23:23:08 INFO - Return code: 0 23:23:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:23:08 ERROR - # TBPL SUCCESS # 23:23:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:23:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:23:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:23:08 INFO - 2017-01-16 23:23:08.237 screenresolution[1924:17612] starting screenresolution argv=screenresolution get 23:23:08 INFO - 2017-01-16 23:23:08.240 screenresolution[1924:17612] Display 0: 1600x1200x32@60 23:23:08 INFO - 2017-01-16 23:23:08.247 screenresolution[1925:17615] starting screenresolution argv=screenresolution list 23:23:08 INFO - Available Modes on Display 0 23:23:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:23:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:23:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:23:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:23:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:23:08 INFO - Intel Iris: 23:23:08 INFO - Chipset Model: Intel Iris 23:23:08 INFO - Type: GPU 23:23:08 INFO - Bus: Built-In 23:23:08 INFO - VRAM (Dynamic, Max): 1536 MB 23:23:08 INFO - Vendor: Intel (0x8086) 23:23:08 INFO - Device ID: 0x0a2e 23:23:08 INFO - Revision ID: 0x0009 23:23:08 INFO - Displays: 23:23:08 INFO - Display: 23:23:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:23:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:23:08 INFO - Display Serial Number: 1600x1200 60 23:23:08 INFO - Main Display: Yes 23:23:08 INFO - Mirror: Off 23:23:08 INFO - Online: Yes 23:23:08 INFO - Rotation: Supported 23:23:08 INFO - Return code: 0 23:23:08 INFO - Running post-action listener: _resource_record_post_action 23:23:08 INFO - [mozharness: 2017-01-17 07:23:08.489793Z] Finished run-tests step (success) 23:23:08 INFO - Running post-run listener: _resource_record_post_run 23:23:08 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 581632; Write bytes: 552486912; Read time: 6; Write time: 1707 23:23:08 INFO - TinderboxPrint: CPU usage
53.9% 23:23:08 INFO - TinderboxPrint: I/O read bytes / time
581,632 / 6 23:23:08 INFO - TinderboxPrint: I/O write bytes / time
552,486,912 / 1,707 23:23:08 INFO - TinderboxPrint: CPU idle
2,216.5 (46.1%) 23:23:08 INFO - TinderboxPrint: CPU system
967.2 (20.1%) 23:23:08 INFO - TinderboxPrint: CPU user
1,626.0 (33.8%) 23:23:08 INFO - TinderboxPrint: Swap in / out
252,571,648 / 0 23:23:08 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243354112; Write bytes: 235941888; Read time: 17787; Write time: 483 23:23:08 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 581632; Write bytes: 298809344; Read time: 6; Write time: 1176 23:23:08 INFO - Running post-run listener: _upload_blobber_files 23:23:08 INFO - Blob upload gear active. 23:23:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:23: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 23:23: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'] 23:23: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 23:23:09 INFO - (blobuploader) - INFO - Open directory for files ... 23:23:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:23:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:10 INFO - (blobuploader) - INFO - Done attempting. 23:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:10 INFO - (blobuploader) - INFO - Done attempting. 23:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:12 INFO - (blobuploader) - INFO - Done attempting. 23:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:23:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:14 INFO - (blobuploader) - INFO - Done attempting. 23:23:14 INFO - (blobuploader) - INFO - Iteration through files over. 23:23:14 INFO - Return code: 0 23:23:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:23:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:23:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd23a1af2e0e2f48908e2ff68af5cff36827a704e3bb0e3c0335098c2aa2fd9d3fd8f8409ab83449db386522af49f5c70e23f7444987881aa169e5caa6806134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9c68794e4ebfdd3fcb26df95a06d917651d88cab15cd8c6fc783bdc519ab21942c8c7bca353006d3997c22829b25effb1daf03697f4f5c374fd1c63b3b3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3293a74cf754a08d9c8e557405891d97aa37e655a8c37943a11e479221542e732ec5ad5c1f3c7c52ed0b0d225736ef2474e6ad02f0a511d7c0802533b0b1995b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9c6bea62e6803c02a0c2bf408ae10cff900ee8b1a75088964fabedd02fa05eef6227bc37567343e77f9cf4997130f95a16116c0df75a0e0864a16bde2ca96f"} 23:23:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:23:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:23:14 INFO - Contents: 23:23:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd23a1af2e0e2f48908e2ff68af5cff36827a704e3bb0e3c0335098c2aa2fd9d3fd8f8409ab83449db386522af49f5c70e23f7444987881aa169e5caa6806134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9c68794e4ebfdd3fcb26df95a06d917651d88cab15cd8c6fc783bdc519ab21942c8c7bca353006d3997c22829b25effb1daf03697f4f5c374fd1c63b3b3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3293a74cf754a08d9c8e557405891d97aa37e655a8c37943a11e479221542e732ec5ad5c1f3c7c52ed0b0d225736ef2474e6ad02f0a511d7c0802533b0b1995b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9c6bea62e6803c02a0c2bf408ae10cff900ee8b1a75088964fabedd02fa05eef6227bc37567343e77f9cf4997130f95a16116c0df75a0e0864a16bde2ca96f"} 23:23:14 INFO - Running post-run listener: copy_logs_to_upload_dir 23:23:14 INFO - Copying logs to upload dir... 23:23:14 INFO - mkdir: /builds/slave/test/build/upload/logs 23:23:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.709163 ========= master_lag: 2.55 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-16 23:23:17.144571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 23:23:17.147804) ========= 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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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/bd23a1af2e0e2f48908e2ff68af5cff36827a704e3bb0e3c0335098c2aa2fd9d3fd8f8409ab83449db386522af49f5c70e23f7444987881aa169e5caa6806134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9c68794e4ebfdd3fcb26df95a06d917651d88cab15cd8c6fc783bdc519ab21942c8c7bca353006d3997c22829b25effb1daf03697f4f5c374fd1c63b3b3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3293a74cf754a08d9c8e557405891d97aa37e655a8c37943a11e479221542e732ec5ad5c1f3c7c52ed0b0d225736ef2474e6ad02f0a511d7c0802533b0b1995b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9c6bea62e6803c02a0c2bf408ae10cff900ee8b1a75088964fabedd02fa05eef6227bc37567343e77f9cf4997130f95a16116c0df75a0e0864a16bde2ca96f"} build_url:https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/P3k2CdPjQPaQgllhleUBMA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd23a1af2e0e2f48908e2ff68af5cff36827a704e3bb0e3c0335098c2aa2fd9d3fd8f8409ab83449db386522af49f5c70e23f7444987881aa169e5caa6806134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9c68794e4ebfdd3fcb26df95a06d917651d88cab15cd8c6fc783bdc519ab21942c8c7bca353006d3997c22829b25effb1daf03697f4f5c374fd1c63b3b3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3293a74cf754a08d9c8e557405891d97aa37e655a8c37943a11e479221542e732ec5ad5c1f3c7c52ed0b0d225736ef2474e6ad02f0a511d7c0802533b0b1995b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f9c6bea62e6803c02a0c2bf408ae10cff900ee8b1a75088964fabedd02fa05eef6227bc37567343e77f9cf4997130f95a16116c0df75a0e0864a16bde2ca96f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 23:23:17.184450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 23:23:17.184828) ========= 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.nCv3QDRJcB/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.4EckwOdgwJ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005335 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 23:23:17.233496) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 23:23:17.233857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 23:23:17.234218) ========= ========= Total master_lag: 2.74 =========