builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0378 starttime: 1488820645.99 results: success (0) buildid: 20170306080423 builduid: a1003f63462f4cf2a1d09cb99a81a03a revision: 517c553ad64746c479456653ce11b04ab8e4977f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:25.992821) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:25.993324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:25.993700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:26.078438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:26.078808) ========= 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.gFJzV6MhaB/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.flvAmzDeSf/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-06 09:17:26-- 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% 7.62M=0.002s 2017-03-06 09:17:26 (7.62 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:26.248536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:26.248909) ========= 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.gFJzV6MhaB/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.flvAmzDeSf/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.021498 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:26.298350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 09:17:26.298746) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 517c553ad64746c479456653ce11b04ab8e4977f --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 517c553ad64746c479456653ce11b04ab8e4977f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gFJzV6MhaB/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.flvAmzDeSf/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-06 09:17:26,389 truncating revision to first 12 chars 2017-03-06 09:17:26,389 Setting DEBUG logging. 2017-03-06 09:17:26,389 attempt 1/10 2017-03-06 09:17:26,389 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/517c553ad647?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-06 09:17:27,726 unpacking tar archive at: mozilla-central-517c553ad647/testing/mozharness/ program finished with exit code 0 elapsedTime=1.601769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 09:17:27.925017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:27.925532) ========= script_repo_revision: 517c553ad64746c479456653ce11b04ab8e4977f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:27.925990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:27.926299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 09:17:27.946506) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-06 09:17:27.946828) ========= /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.gFJzV6MhaB/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.flvAmzDeSf/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:17:28 INFO - MultiFileLogger online at 20170306 09:17:28 in /builds/slave/test 09:17:28 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 09:17:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:28 INFO - {'append_to_log': False, 09:17:28 INFO - 'base_work_dir': '/builds/slave/test', 09:17:28 INFO - 'blob_upload_branch': 'Firefox', 09:17:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:28 INFO - 'branch': 'Firefox', 09:17:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:28 INFO - 'config_files': ('talos/mac_config.py',), 09:17:28 INFO - 'default_actions': ('clobber', 09:17:28 INFO - 'read-buildbot-config', 09:17:28 INFO - 'download-and-extract', 09:17:28 INFO - 'populate-webroot', 09:17:28 INFO - 'create-virtualenv', 09:17:28 INFO - 'install', 09:17:28 INFO - 'run-tests'), 09:17:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:28 INFO - 'download_minidump_stackwalk': True, 09:17:28 INFO - 'download_symbols': 'ondemand', 09:17:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:28 INFO - 'gecko_profile': False, 09:17:28 INFO - 'gecko_profile_interval': 0, 09:17:28 INFO - 'installer_path': 'installer.exe', 09:17:28 INFO - 'log_level': 'info', 09:17:28 INFO - 'log_name': 'talos', 09:17:28 INFO - 'log_to_console': True, 09:17:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:28 INFO - 'opt_config_files': (), 09:17:28 INFO - 'pip_index': False, 09:17:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:28 INFO - 'cmd': ('bash', 09:17:28 INFO - '-c', 09:17:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:28 INFO - 'enabled': True, 09:17:28 INFO - 'halt_on_failure': False, 09:17:28 INFO - 'name': 'check_screen_resolution'},), 09:17:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:28 INFO - 'cmd': ('bash', 09:17:28 INFO - '-c', 09:17:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:28 INFO - 'enabled': True, 09:17:28 INFO - 'halt_on_failure': False, 09:17:28 INFO - 'name': 'check_screen_resolution'},), 09:17:28 INFO - 'run_cmd_checks_enabled': True, 09:17:28 INFO - 'suite': 'dromaeojs', 09:17:28 INFO - 'system_bits': '32', 09:17:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:28 INFO - 'title': 't-yosemite-r7-0378', 09:17:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:28 INFO - 'use_talos_json': True, 09:17:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:28 INFO - 'work_dir': 'build'} 09:17:28 INFO - [mozharness: 2017-03-06 17:17:28.160090Z] Running clobber step. 09:17:28 INFO - Running pre-action listener: _resource_record_pre_action 09:17:28 INFO - Running main action method: clobber 09:17:28 INFO - rmtree: /builds/slave/test/build 09:17:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:30 INFO - Running post-action listener: _resource_record_post_action 09:17:30 INFO - [mozharness: 2017-03-06 17:17:30.217813Z] Finished clobber step (success) 09:17:30 INFO - [mozharness: 2017-03-06 17:17:30.218128Z] Running read-buildbot-config step. 09:17:30 INFO - Running pre-action listener: _resource_record_pre_action 09:17:30 INFO - Running main action method: read_buildbot_config 09:17:30 INFO - Using buildbot properties: 09:17:30 INFO - { 09:17:30 INFO - "project": "", 09:17:30 INFO - "product": "firefox", 09:17:30 INFO - "script_repo_revision": "production", 09:17:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:17:30 INFO - "repository": "", 09:17:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:17:30 INFO - "buildid": "20170306080423", 09:17:30 INFO - "pgo_build": "False", 09:17:30 INFO - "basedir": "/builds/slave/test", 09:17:30 INFO - "buildnumber": 6, 09:17:30 INFO - "slavename": "t-yosemite-r7-0378", 09:17:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:17:30 INFO - "platform": "yosemite_r7", 09:17:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:17:30 INFO - "branch": "mozilla-central", 09:17:30 INFO - "repo_path": "mozilla-central", 09:17:30 INFO - "revision": "517c553ad64746c479456653ce11b04ab8e4977f", 09:17:30 INFO - "stage_platform": "macosx64", 09:17:30 INFO - "builduid": "a1003f63462f4cf2a1d09cb99a81a03a", 09:17:30 INFO - "slavebuilddir": "test" 09:17:30 INFO - } 09:17:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 09:17:30 INFO - Running post-action listener: _resource_record_post_action 09:17:30 INFO - [mozharness: 2017-03-06 17:17:30.223855Z] Finished read-buildbot-config step (success) 09:17:30 INFO - [mozharness: 2017-03-06 17:17:30.224015Z] Running download-and-extract step. 09:17:30 INFO - Running pre-action listener: _resource_record_pre_action 09:17:30 INFO - Running main action method: download_and_extract 09:17:30 INFO - mkdir: /builds/slave/test/build/tests 09:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:30 INFO - trying https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 09:17:30 INFO - Downloading https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 09:17:31 INFO - Downloaded 1199 bytes. 09:17:31 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:17:31 INFO - Using the following test package requirements: 09:17:31 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:17:31 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 09:17:31 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 09:17:31 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'jsshell-mac.zip'], 09:17:31 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 09:17:31 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:17:31 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 09:17:31 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 09:17:31 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 09:17:31 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:17:31 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 09:17:31 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:17:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:17:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:31 INFO - Fetch https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:17:32 INFO - Expected file size: 51778594 09:17:32 INFO - Obtained file size: 51778594 09:17:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:17:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:17:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:17:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:17:50 INFO - Expected file size: 51778594 09:17:50 INFO - Obtained file size: 51778594 09:18:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 09:18:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:18:05 INFO - Fetch https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 09:18:06 INFO - Expected file size: 14404424 09:18:06 INFO - Obtained file size: 14404424 09:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:07 INFO - trying https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:18:07 INFO - Downloading https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 09:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 09:18:09 INFO - Downloaded 75213310 bytes. 09:18:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:18:09 INFO - mkdir: /builds/slave/test/properties 09:18:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:09 INFO - Contents: 09:18:09 INFO - build_url:https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:18:09 INFO - Running post-action listener: _resource_record_post_action 09:18:09 INFO - Running post-action listener: set_extra_try_arguments 09:18:09 INFO - [mozharness: 2017-03-06 17:18:09.890270Z] Finished download-and-extract step (success) 09:18:09 INFO - [mozharness: 2017-03-06 17:18:09.890391Z] Running populate-webroot step. 09:18:09 INFO - Running pre-action listener: _resource_record_pre_action 09:18:09 INFO - Running main action method: populate_webroot 09:18:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:09 INFO - '--tppagecycles', 09:18:09 INFO - '7'], 09:18:09 INFO - 'tests': ['tsvgm']}}, 09:18:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['damp', 'tps']}, 09:18:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'tests': ['damp', 'tps']}, 09:18:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['dromaeo_dom']}, 09:18:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['basic_compositor_video']}, 09:18:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['a11yr', 09:18:09 INFO - 'ts_paint', 09:18:09 INFO - 'tpaint', 09:18:09 INFO - 'sessionrestore', 09:18:09 INFO - 'sessionrestore_no_auto_restore', 09:18:09 INFO - 'tabpaint']}, 09:18:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:09 INFO - 'ts_paint', 09:18:09 INFO - 'tpaint', 09:18:09 INFO - 'sessionrestore', 09:18:09 INFO - 'sessionrestore_no_auto_restore', 09:18:09 INFO - 'tabpaint']}, 09:18:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:09 INFO - 'ts_paint', 09:18:09 INFO - 'tpaint', 09:18:09 INFO - 'sessionrestore', 09:18:09 INFO - 'sessionrestore_no_auto_restore', 09:18:09 INFO - 'tabpaint']}, 09:18:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:09 INFO - 'ts_paint', 09:18:09 INFO - 'tpaint', 09:18:09 INFO - 'sessionrestore', 09:18:09 INFO - 'sessionrestore_no_auto_restore', 09:18:09 INFO - 'tabpaint']}, 09:18:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['a11yr', 09:18:09 INFO - 'ts_paint', 09:18:09 INFO - 'tpaint', 09:18:09 INFO - 'sessionrestore', 09:18:09 INFO - 'sessionrestore_no_auto_restore', 09:18:09 INFO - 'tabpaint']}, 09:18:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['a11yr', 09:18:09 INFO - 'ts_paint', 09:18:09 INFO - 'tpaint', 09:18:09 INFO - 'sessionrestore', 09:18:09 INFO - 'sessionrestore_no_auto_restore', 09:18:09 INFO - 'tabpaint']}, 09:18:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['tsvgx', 09:18:09 INFO - 'tsvgr_opacity', 09:18:09 INFO - 'tart', 09:18:09 INFO - 'tscrollx', 09:18:09 INFO - 'cart', 09:18:09 INFO - 'tsvg_static']}, 09:18:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:09 INFO - 'tsvgr_opacity', 09:18:09 INFO - 'tart', 09:18:09 INFO - 'tscrollx', 09:18:09 INFO - 'cart', 09:18:09 INFO - 'tsvg_static']}, 09:18:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'talos_options': ['--disable-e10s'], 09:18:09 INFO - 'tests': ['tp5o']}, 09:18:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:18:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'talos_options': ['--disable-e10s', 09:18:09 INFO - '--xperf_path', 09:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:09 INFO - 'tests': ['tp5n']}, 09:18:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:18:09 INFO - 'talos_options': ['--xperf_path', 09:18:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:09 INFO - 'tests': ['tp5n']}}, 09:18:09 INFO - 'talos.zip': {'path': '', 09:18:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:09 INFO - Running post-action listener: _resource_record_post_action 09:18:09 INFO - [mozharness: 2017-03-06 17:18:09.908666Z] Finished populate-webroot step (success) 09:18:09 INFO - [mozharness: 2017-03-06 17:18:09.908815Z] Running create-virtualenv step. 09:18:09 INFO - Running pre-action listener: _resource_record_pre_action 09:18:09 INFO - Running main action method: create_virtualenv 09:18:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:18:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:10 INFO - Using real prefix '/tools/python27' 09:18:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:10 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:13 INFO - Installing pip.................done. 09:18:13 INFO - Return code: 0 09:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:18:13 INFO - Reading from file tmpfile_stdout 09:18:13 INFO - Output received: 09:18:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:18:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:13 INFO - 'HOME': '/Users/cltbld', 09:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:13 INFO - 'LOGNAME': 'cltbld', 09:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:13 INFO - 'MOZ_NO_REMOTE': '1', 09:18:13 INFO - 'NO_EM_RESTART': '1', 09:18:13 INFO - 'PAGER': '/bin/cat', 09:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:13 INFO - 'PWD': '/builds/slave/test', 09:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:13 INFO - 'SHELL': '/bin/bash', 09:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:13 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:13 INFO - 'USER': 'cltbld', 09:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:13 INFO - 'XPC_FLAGS': '0x0', 09:18:13 INFO - 'XPC_SERVICE_NAME': '0', 09:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:18:14 INFO - Cleaning up... 09:18:14 INFO - Return code: 0 09:18:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:18:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:14 INFO - 'HOME': '/Users/cltbld', 09:18:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:14 INFO - 'LOGNAME': 'cltbld', 09:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:14 INFO - 'MOZ_NO_REMOTE': '1', 09:18:14 INFO - 'NO_EM_RESTART': '1', 09:18:14 INFO - 'PAGER': '/bin/cat', 09:18:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:14 INFO - 'PWD': '/builds/slave/test', 09:18:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:14 INFO - 'SHELL': '/bin/bash', 09:18:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:14 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:14 INFO - 'USER': 'cltbld', 09:18:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:14 INFO - 'XPC_FLAGS': '0x0', 09:18:14 INFO - 'XPC_SERVICE_NAME': '0', 09:18:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:14 INFO - Downloading/unpacking psutil>=3.1.1 09:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:18 INFO - Installing collected packages: psutil 09:18:18 INFO - Running setup.py install for psutil 09:18:18 INFO - building 'psutil._psutil_osx' extension 09:18:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:18:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:18:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:18:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:18:18 INFO - building 'psutil._psutil_posix' extension 09:18:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:18:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:18:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:18:18 INFO - ^ 09:18:18 INFO - 1 warning generated. 09:18:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:18:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:18 INFO - Successfully installed psutil 09:18:18 INFO - Cleaning up... 09:18:19 INFO - Return code: 0 09:18:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:19 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 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:19 INFO - 'HOME': '/Users/cltbld', 09:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:19 INFO - 'LOGNAME': 'cltbld', 09:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:19 INFO - 'MOZ_NO_REMOTE': '1', 09:18:19 INFO - 'NO_EM_RESTART': '1', 09:18:19 INFO - 'PAGER': '/bin/cat', 09:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:19 INFO - 'PWD': '/builds/slave/test', 09:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:19 INFO - 'SHELL': '/bin/bash', 09:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:19 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:19 INFO - 'USER': 'cltbld', 09:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:19 INFO - 'XPC_FLAGS': '0x0', 09:18:19 INFO - 'XPC_SERVICE_NAME': '0', 09:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:22 INFO - Installing collected packages: mozsystemmonitor 09:18:22 INFO - Running setup.py install for mozsystemmonitor 09:18:22 INFO - Successfully installed mozsystemmonitor 09:18:22 INFO - Cleaning up... 09:18:22 INFO - Return code: 0 09:18:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:23 INFO - 'HOME': '/Users/cltbld', 09:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:23 INFO - 'LOGNAME': 'cltbld', 09:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:23 INFO - 'MOZ_NO_REMOTE': '1', 09:18:23 INFO - 'NO_EM_RESTART': '1', 09:18:23 INFO - 'PAGER': '/bin/cat', 09:18:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:23 INFO - 'PWD': '/builds/slave/test', 09:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:23 INFO - 'SHELL': '/bin/bash', 09:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:23 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:23 INFO - 'USER': 'cltbld', 09:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:23 INFO - 'XPC_FLAGS': '0x0', 09:18:23 INFO - 'XPC_SERVICE_NAME': '0', 09:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:27 INFO - warning: no files found matching '*.txt' 09:18:27 INFO - no previously-included directories found matching 'build' 09:18:27 INFO - no previously-included directories found matching 'dist' 09:18:27 INFO - no previously-included directories found matching '.git*' 09:18:27 INFO - Installing collected packages: jsonschema, functools32 09:18:27 INFO - Running setup.py install for functools32 09:18:27 INFO - warning: no files found matching '*.txt' 09:18:27 INFO - no previously-included directories found matching 'build' 09:18:27 INFO - no previously-included directories found matching 'dist' 09:18:27 INFO - no previously-included directories found matching '.git*' 09:18:27 INFO - Successfully installed jsonschema functools32 09:18:27 INFO - Cleaning up... 09:18:27 INFO - Return code: 0 09:18:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:27 INFO - 'HOME': '/Users/cltbld', 09:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:27 INFO - 'LOGNAME': 'cltbld', 09:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:27 INFO - 'MOZ_NO_REMOTE': '1', 09:18:27 INFO - 'NO_EM_RESTART': '1', 09:18:27 INFO - 'PAGER': '/bin/cat', 09:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:27 INFO - 'PWD': '/builds/slave/test', 09:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:27 INFO - 'SHELL': '/bin/bash', 09:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:27 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:27 INFO - 'USER': 'cltbld', 09:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:27 INFO - 'XPC_FLAGS': '0x0', 09:18:27 INFO - 'XPC_SERVICE_NAME': '0', 09:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:27 INFO - Cleaning up... 09:18:27 INFO - Return code: 0 09:18:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:27 INFO - 'HOME': '/Users/cltbld', 09:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:27 INFO - 'LOGNAME': 'cltbld', 09:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:27 INFO - 'MOZ_NO_REMOTE': '1', 09:18:27 INFO - 'NO_EM_RESTART': '1', 09:18:27 INFO - 'PAGER': '/bin/cat', 09:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:27 INFO - 'PWD': '/builds/slave/test', 09:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:27 INFO - 'SHELL': '/bin/bash', 09:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:27 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:27 INFO - 'USER': 'cltbld', 09:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:27 INFO - 'XPC_FLAGS': '0x0', 09:18:27 INFO - 'XPC_SERVICE_NAME': '0', 09:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:31 INFO - Downloading docopt-0.6.1.tar.gz 09:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:31 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:31 INFO - Running setup.py install for blobuploader 09:18:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:32 INFO - Running setup.py install for requests 09:18:32 INFO - Running setup.py install for docopt 09:18:32 INFO - Successfully installed blobuploader requests docopt 09:18:32 INFO - Cleaning up... 09:18:32 INFO - Return code: 0 09:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:32 INFO - 'HOME': '/Users/cltbld', 09:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:32 INFO - 'LOGNAME': 'cltbld', 09:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:32 INFO - 'MOZ_NO_REMOTE': '1', 09:18:32 INFO - 'NO_EM_RESTART': '1', 09:18:32 INFO - 'PAGER': '/bin/cat', 09:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:32 INFO - 'PWD': '/builds/slave/test', 09:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:32 INFO - 'SHELL': '/bin/bash', 09:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:32 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:32 INFO - 'USER': 'cltbld', 09:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:32 INFO - 'XPC_FLAGS': '0x0', 09:18:32 INFO - 'XPC_SERVICE_NAME': '0', 09:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-O1PqSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-ChLWkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-hzNG70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-C0wMa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-r_pv3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-vzB6Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-TCZQU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-ItDd_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:33 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-nh0AM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Q9QTEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Axcwyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-RNovUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-3dOdnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-j2Ofat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-nMe3c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-SNuOEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:34 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-B5Rs_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:34 INFO - Running setup.py install for manifestparser 09:18:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:35 INFO - Running setup.py install for mozcrash 09:18:35 INFO - Running setup.py install for mozdebug 09:18:35 INFO - Running setup.py install for mozdevice 09:18:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:35 INFO - Running setup.py install for mozfile 09:18:35 INFO - Running setup.py install for mozhttpd 09:18:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:35 INFO - Running setup.py install for mozinfo 09:18:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:35 INFO - Running setup.py install for mozInstall 09:18:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Running setup.py install for mozleak 09:18:36 INFO - Running setup.py install for mozlog 09:18:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Running setup.py install for moznetwork 09:18:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Running setup.py install for mozprocess 09:18:36 INFO - Running setup.py install for mozprofile 09:18:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:36 INFO - Running setup.py install for mozrunner 09:18:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:37 INFO - Running setup.py install for mozscreenshot 09:18:37 INFO - Running setup.py install for moztest 09:18:37 INFO - Running setup.py install for mozversion 09:18:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:37 INFO - Cleaning up... 09:18:37 INFO - Return code: 0 09:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:37 INFO - 'HOME': '/Users/cltbld', 09:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:37 INFO - 'LOGNAME': 'cltbld', 09:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:37 INFO - 'MOZ_NO_REMOTE': '1', 09:18:37 INFO - 'NO_EM_RESTART': '1', 09:18:37 INFO - 'PAGER': '/bin/cat', 09:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:37 INFO - 'PWD': '/builds/slave/test', 09:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:37 INFO - 'SHELL': '/bin/bash', 09:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:37 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:37 INFO - 'USER': 'cltbld', 09:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:37 INFO - 'XPC_FLAGS': '0x0', 09:18:37 INFO - 'XPC_SERVICE_NAME': '0', 09:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:37 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-D7mt5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:37 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-QPygZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:37 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-0RumkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-lRy2dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-i7sPlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-UMNd1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-fsX3ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-qnfNXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-WbsUZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Fk94c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-ZfcCYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:38 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-wwapL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:39 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-kNqb6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:39 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-pljmWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:39 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-T6cMHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:39 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-JxBtJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:39 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-meh5is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:42 INFO - Downloading blessings-1.6.tar.gz 09:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:42 INFO - Installing collected packages: blessings 09:18:42 INFO - Running setup.py install for blessings 09:18:42 INFO - Successfully installed blessings 09:18:42 INFO - Cleaning up... 09:18:42 INFO - Return code: 0 09:18:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:42 INFO - Reading from file tmpfile_stdout 09:18:42 INFO - Current package versions: 09:18:42 INFO - blessings == 1.6 09:18:42 INFO - blobuploader == 1.2.4 09:18:42 INFO - docopt == 0.6.1 09:18:42 INFO - functools32 == 3.2.3-2 09:18:42 INFO - jsonschema == 2.5.1 09:18:42 INFO - manifestparser == 1.1 09:18:42 INFO - mozInstall == 1.12 09:18:42 INFO - mozcrash == 1.0 09:18:42 INFO - mozdebug == 0.1 09:18:42 INFO - mozdevice == 0.49 09:18:42 INFO - mozfile == 1.2 09:18:42 INFO - mozhttpd == 0.7 09:18:42 INFO - mozinfo == 0.9 09:18:42 INFO - mozleak == 0.1 09:18:42 INFO - mozlog == 3.4 09:18:42 INFO - moznetwork == 0.27 09:18:42 INFO - mozprocess == 0.25 09:18:42 INFO - mozprofile == 0.28 09:18:42 INFO - mozrunner == 6.13 09:18:42 INFO - mozscreenshot == 0.1 09:18:42 INFO - mozsystemmonitor == 0.3 09:18:42 INFO - moztest == 0.8 09:18:42 INFO - mozversion == 1.4 09:18:42 INFO - psutil == 3.1.1 09:18:42 INFO - requests == 1.2.3 09:18:42 INFO - wsgiref == 0.1.2 09:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:42 INFO - 'HOME': '/Users/cltbld', 09:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:42 INFO - 'LOGNAME': 'cltbld', 09:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:42 INFO - 'MOZ_NO_REMOTE': '1', 09:18:42 INFO - 'NO_EM_RESTART': '1', 09:18:42 INFO - 'PAGER': '/bin/cat', 09:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:42 INFO - 'PWD': '/builds/slave/test', 09:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:42 INFO - 'SHELL': '/bin/bash', 09:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:42 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:42 INFO - 'USER': 'cltbld', 09:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:42 INFO - 'XPC_FLAGS': '0x0', 09:18:42 INFO - 'XPC_SERVICE_NAME': '0', 09:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:18:43 INFO - Cleaning up... 09:18:43 INFO - Return code: 0 09:18:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:43 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 0x102911b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102914768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bb5bbce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, '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.gFJzV6MhaB/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.flvAmzDeSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:18:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:43 INFO - 'HOME': '/Users/cltbld', 09:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:43 INFO - 'LOGNAME': 'cltbld', 09:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:43 INFO - 'MOZ_NO_REMOTE': '1', 09:18:43 INFO - 'NO_EM_RESTART': '1', 09:18:43 INFO - 'PAGER': '/bin/cat', 09:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:43 INFO - 'PWD': '/builds/slave/test', 09:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:43 INFO - 'SHELL': '/bin/bash', 09:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:18:43 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:43 INFO - 'USER': 'cltbld', 09:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:43 INFO - 'XPC_FLAGS': '0x0', 09:18:43 INFO - 'XPC_SERVICE_NAME': '0', 09:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:43 INFO - Cleaning up... 09:18:43 INFO - Return code: 0 09:18:43 INFO - Running post-action listener: _resource_record_post_action 09:18:43 INFO - Running post-action listener: _start_resource_monitoring 09:18:43 INFO - Starting resource monitoring. 09:18:43 INFO - [mozharness: 2017-03-06 17:18:43.391043Z] Finished create-virtualenv step (success) 09:18:43 INFO - [mozharness: 2017-03-06 17:18:43.392012Z] Running install step. 09:18:43 INFO - Running pre-action listener: _resource_record_pre_action 09:18:43 INFO - Running main action method: install 09:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:43 INFO - Reading from file tmpfile_stdout 09:18:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:43 INFO - Reading from file tmpfile_stdout 09:18:43 INFO - Output received: 09:18:43 INFO - Usage: mozinstall [options] installer 09:18:43 INFO - Options: 09:18:43 INFO - -h, --help show this help message and exit 09:18:43 INFO - -d DEST, --destination=DEST 09:18:43 INFO - Directory to install application into. [default: 09:18:43 INFO - "/builds/slave/test"] 09:18:43 INFO - --app=APP Application being installed. [default: firefox] 09:18:43 INFO - mkdir: /builds/slave/test/build/application 09:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:19:03 INFO - Reading from file tmpfile_stdout 09:19:03 INFO - Output received: 09:19:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:19:03 INFO - Running post-action listener: _resource_record_post_action 09:19:03 INFO - [mozharness: 2017-03-06 17:19:03.888226Z] Finished install step (success) 09:19:03 INFO - [mozharness: 2017-03-06 17:19:03.888387Z] Running run-tests step. 09:19:03 INFO - Running pre-action listener: _resource_record_pre_action 09:19:03 INFO - Running main action method: run_tests 09:19:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:19:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:19:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:19:03 INFO - 2017-03-06 09:19:03.903 screenresolution[1973:17978] starting screenresolution argv=screenresolution get 09:19:03 INFO - 2017-03-06 09:19:03.906 screenresolution[1973:17978] Display 0: 1600x1200x32@60 09:19:03 INFO - 2017-03-06 09:19:03.912 screenresolution[1974:17980] starting screenresolution argv=screenresolution list 09:19:03 INFO - Available Modes on Display 0 09:19:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:19:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:19:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:19:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:19:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:19:04 INFO - Intel Iris: 09:19:04 INFO - Chipset Model: Intel Iris 09:19:04 INFO - Type: GPU 09:19:04 INFO - Bus: Built-In 09:19:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:19:04 INFO - Vendor: Intel (0x8086) 09:19:04 INFO - Device ID: 0x0a2e 09:19:04 INFO - Revision ID: 0x0009 09:19:04 INFO - Displays: 09:19:04 INFO - Display: 09:19:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:19:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:19:04 INFO - Display Serial Number: 1600x1200 60 09:19:04 INFO - Main Display: Yes 09:19:04 INFO - Mirror: Off 09:19:04 INFO - Online: Yes 09:19:04 INFO - Rotation: Supported 09:19:04 INFO - Return code: 0 09:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:04 INFO - Python 2.7.3 09:19:04 INFO - Return code: 0 09:19:04 INFO - grabbing minidump binary from tooltool 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 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 0x1026efd30>, '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 0x102616db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1026e4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:19:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:19:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:19:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:04 INFO - Return code: 0 09:19:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:19:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:04 INFO - ENV: RUST_BACKTRACE is now 1 09:19:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:19:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:04 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/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:19:04 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/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0378 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:19:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFJzV6MhaB/Render', 09:19:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:19:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:19:04 INFO - 'HOME': '/Users/cltbld', 09:19:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:19:04 INFO - 'LOGNAME': 'cltbld', 09:19:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:04 INFO - 'MOZ_NO_REMOTE': '1', 09:19:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:04 INFO - 'NO_EM_RESTART': '1', 09:19:04 INFO - 'PAGER': '/bin/cat', 09:19:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:04 INFO - 'PWD': '/builds/slave/test', 09:19:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:19:04 INFO - 'RUST_BACKTRACE': '1', 09:19:04 INFO - 'SHELL': '/bin/bash', 09:19:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.flvAmzDeSf/Listeners', 09:19:04 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 09:19:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:19:04 INFO - 'USER': 'cltbld', 09:19:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:19:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:04 INFO - 'XPC_FLAGS': '0x0', 09:19:04 INFO - 'XPC_SERVICE_NAME': '0', 09:19:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:19:04 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/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:19:04 INFO - mozversion application_buildid: 20170306080423 09:19:04 INFO - mozversion application_changeset: 517c553ad64746c479456653ce11b04ab8e4977f 09:19:04 INFO - mozversion application_display_name: Nightly 09:19:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:04 INFO - mozversion application_name: Firefox 09:19:04 INFO - mozversion application_remotingname: firefox 09:19:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:19:04 INFO - mozversion application_vendor: Mozilla 09:19:04 INFO - mozversion application_version: 54.0a1 09:19:04 INFO - mozversion platform_buildid: 20170306080423 09:19:04 INFO - mozversion platform_changeset: 517c553ad64746c479456653ce11b04ab8e4977f 09:19:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:19:04 INFO - mozversion platform_version: 54.0a1 09:19:04 INFO - using testdate: 1488820744 09:19:04 INFO - actual date: 1488820744 09:19:04 INFO - starting webserver on 'localhost:53001' 09:19:04 INFO - SUITE-START | Running 2 tests 09:19:04 INFO - TEST-START | dromaeo_css 09:19:04 INFO - operating with platform_type : mac_ 09:19:04 INFO - Initialising browser for dromaeo_css test... 09:19:04 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpWlAfRC/profile http://localhost:53001/getInfo.html) 09:19:06 INFO - PROCESS | 1984 | __metrics Screen width/height:1600/1200 09:19:06 INFO - PROCESS | 1984 | colorDepth:24 09:19:06 INFO - PROCESS | 1984 | Browser inner width/height: 1024/689 09:19:06 INFO - PROCESS | 1984 | __metrics 09:19:06 INFO - PROCESS | 1984 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:19:06 INFO - PROCESS | 1984 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:07 INFO - TEST-INFO | 1984: exit 0 09:19:07 INFO - Browser initialized. 09:19:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:07 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpWlAfRC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:20 INFO - PROCESS | 1986 | RSS: Main: 232628224 09:19:20 INFO - PROCESS | 1986 | 09:22:23 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:53001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53001/tests/dromaeo/cssquery-ext.html) 09:22:26 INFO - PROCESS | 1986 | RSS: Main: 516325376 09:22:26 INFO - PROCESS | 1986 | 09:24:10 INFO - PROCESS | 1986 | ************************* 09:24:10 INFO - PROCESS | 1986 | A coding exception was thrown and uncaught in a Task. 09:24:10 INFO - PROCESS | 1986 | 09:24:10 ERROR - PROCESS | 1986 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:24:10 INFO - PROCESS | 1986 | Full stack: 09:24:10 INFO - PROCESS | 1986 | ************************* 09:25:30 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:53001/tests/dromaeo/cssquery-ext.html (next: http://localhost:53001/tests/dromaeo/cssquery-jquery.html) 09:25:30 INFO - PROCESS | 1986 | RSS: Main: 364863488 09:25:30 INFO - PROCESS | 1986 | 09:28:33 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:53001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53001/tests/dromaeo/cssquery-mootools.html) 09:28:34 INFO - PROCESS | 1986 | RSS: Main: 359403520 09:28:34 INFO - PROCESS | 1986 | 09:31:36 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:53001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53001/tests/dromaeo/cssquery-prototype.html) 09:31:37 INFO - PROCESS | 1986 | RSS: Main: 332722176 09:31:37 INFO - PROCESS | 1986 | 09:34:41 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:53001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53001/tests/dromaeo/cssquery-yui.html) 09:34:42 INFO - PROCESS | 1986 | RSS: Main: 341807104 09:34:42 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:53001/tests/dromaeo/cssquery-yui.html (next: http://localhost:53001/tests/dromaeo/cssquery-dojo.html) 09:37:45 INFO - PROCESS | 1986 | RSS: Main: 538083328 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | __start_tp_report 09:37:45 INFO - PROCESS | 1986 | _x_x_mozilla_page_load 09:37:45 INFO - PROCESS | 1986 | _x_x_mozilla_page_load_details 09:37:45 INFO - PROCESS | 1986 | |i|pagename|runs| 09:37:45 INFO - PROCESS | 1986 | |0;dojo.html;3308.4044871923043;3314.370269648767;3323.135984643992;3338.6828251316147;3382.2389962258494;5479.068558345081;5628.605997580171;5735.996200664883;5809.448102430268;5810.477057064869;4739.431268247807;5657.660540367581;5668.744906479208;5740.7129643517865;5799.681017544033;5131.512506311913;5143.7685304161405;5154.252633368159;5199.428062913076;5217.530422261995;5250.238715386266;5272.657277276984;5282.128448805962;5292.259083728281;5325.014872248627;5072.670276432039;5113.718745468997;5172.586193104543;5196.740162991873;5204.8959020819375;4566.698490930069;4948.802047918079;5164.173732202867;5190.143626301693;5193.688378697252;5095.421174460324;5125.1287281162295;5139.306193663845;5167.741612919339;5174.2238664200295;5639.71801409932;5649.435056494359;5664.291963504562;5669.886602267973;5675.290588676416;6157.630542167484;6170.5372097092895;6171.444569988723;6173.536984726119;6187.535934804862;5198.610104242197;6122.977604208165;6130.165000698321;6180.412860778219;6216.2540495140875;5819.7672093116225;5894.97052514739;5908.615939963932;5950.19672344228;5950.7917222896995;6302.676437947991;6313.053042043638;6320.810375688737;6326.68366581669;6338.524610654219;6079.96960015206;6116.235470566179;6128.442013630915;6192.256929168529;6207.379262073847;6222.160008398899;6226.097215903668;6237.220347456568;6242.313345531988;6260.342664020212;6156.661383623854;6168.136460895478;6180.598261113013;6185.876282474325;6187.3503282154725;6167.753289868355;6168.9691551542855;6176.197094377792;6199.814005579839;6212.689365531705;4300.182965236595;4928.112939670894;5074.568661663726;5104.438511763703;5114.641975061784;4435.489918659331;4455.554444555519;4496.887577810516;4517.796699148546;4529.116822219701;5700.173474846124;5773.797917072882;5845.152452894306;5852.268466441695;5943.791967281211;6169.876602467925;6186.907196392058;6188.44304012641;6193.504519638418;6197.876042479125;4287;5742.971285143548;5775;5822.126680997884;5969.044952807617;5494.09347457673;5499.230107784913;5503.257060296889;5503.779848806083;5547.140193270049;6345.206849143857;6359.236891573041;6365.108884756138;6386.840328991812;6387.169667943138;6124.777645458507;6171.074338849029;6197.070439434121;6207;6220.657863817533;6247.562670613195;6255.40573645503;6257.7184026718;6306.085617585516;6429.7428102875365;6189.535784816067;6200.56596038273;6215.595986260879;6217.844553886189;6234.906476402948;6081.239845019372;6226.844328891632;6227.532935029982;6235.189425374672;6247;5992.49063829562;6012.6993650316435;6096.573239873166;6187.597806142587;6205.875882482415;6085.57400981927;6088.878222435438;6099.054646529795;6104.938950610437;6113.663748493876;5913.319968203712;5948.940510594839;5964.970175149097;5989.760409583568;5994.70026498682;6108.541859360655;6118.143459915705;6121.265448146251;6135.079738039151;6136.938630613815;5887.4406931341455;5936.28764548257;5975.25309336333;5985.730642121028;5994.280686317496 09:37:45 INFO - PROCESS | 1986 | |1;ext.html;773.2344978471314;790.9288164065234;857.5626430520433;870.7910101575624;872.0712441250068;35252;38542.61457385429;41015;41095.972600684996;41145;32925.835370823115;40256.59743402565;40406.39390409139;40433.78698639038;40606;7328;8999.820003599923;9144.908550914506;9154.359194856363;9157.084291570856;7335.743248986287;10540.156787457023;10745.83881241778;10957.50691218897;11091.500882460308;9921.3055086144;10958.671239862777;10993.835092473579;11013.944930275338;11015.669529914116;7241.167265764399;10878.184136189779;10922.726931826728;10925.453727313603;10942.617008404748;7309.305615966475;10542.78914421715;10766.569337226501;10913.454327283604;10937.945310273477;38420.61579384226;38537.807310963544;38608.80695596532;38621.841344759705;38758;3795.35478968576;3810.9186555676783;3811.8284677189595;3859.1316953685478;3949.7037722170667;28223.01219457309;28249.717502824915;28259.57610635842;28342.858285708644;28396.290092747848;3045.1778019934713;3126.7967582107317;3159.6840315968448;3193.840307984615;3196.7602429817857;328247;333076;333525;333748.33125834214;334775;51043.489565103875;51296.48703512917;51354.99999999925;51394.48605513972;51472;43590.34614480785;53060.20409693858;53121.46878531243;53139;53336.199957000674;12480.75038499243;12521.436535355931;12555.435005424777;12574.43415046325;12576.622701318975;10876.075533579735;10895.291806032583;10897.346159230472;10924.508397122148;10936.50785714629;8676.69631562905;9447.055294470498;10115.241356898263;10683.25217234786;10711.517981690842;4710.3405523226775;4717.268823332389;4723.362346083303;4723.622110231173;4739.715617062987;921.5852866210232;925.9305552083621;961.8028304197622;977.750673578233;984.4044353166374;20572;23208.3037508875;23291.767082329297;23386.12545166506;23574.88212558926;1016.3190662256159;1017.5370206555999;1036.7097212780434;1052.1687866585312;1055.678018204455;11818.468168932419;11848.407579620984;11855.407229638657;11903;11927.343996080126;382050;384195;384425;384992;385053.1494685073;41840.790796046436;41854.79072604617;41985.79007104945;42014.36978445326;42079;1348.0900392235203;1401.5515035188641;1419.2194293138732;1420.8508106648653;1420.920100723437;20809.791902080786;26092.608610871233;27400;29935.251618709706;30361.392772144874;52805.47194528006;53041;53079.469205307454;53097.734511327195;53158;407087;417965;444327;445155;445759;34046;34575.481367779;34714.479282811284;34732.305353892276;34756.47865281972;41124.38313425241;42252.78873605612;42432.36351454669;42482.937926552084;42505.78747106368;34647.13382165466;35247.647523524436;35584.46623300704;36395;36861.26277474382;34452;34527.82736086303;34704;36080.91757247287;36240;35174.12064698403;35587.82206088953;35901.74343897951;35930.10174745652;35998;29384.706152939052;29861.506924654113;30249.546256805726;31167.844160779052;31328;23111.075556977532;23166.884165579737;23378.766212338338;23637.64543531814;23702.88148559246 09:37:45 INFO - PROCESS | 1986 | |2;jquery.html;334.9598048234212;379.10531146494253;390.81436317749075;405.62277082313443;430.3243907065906;10972.451377431127;11638.476268567914;14952.401903923843;21342.93285335731;21585.1365945362;22100.33698989029;22530;23110.96000679969;23618.88190559045;23840.927158277875;6411.743530258807;6545.574537655061;6624.5694029888145;6709.3290670933;6752.324767523233;4152.5432202457705;6603.636799976023;6740.898886516707;6743.898841517381;6750.763723269686;4339.349097635349;4363.956360436387;4416.138852923681;7577.242275772406;7699.961500192491;6423.64669943153;7319.268073192691;7674.079110506747;7689.692412303501;7699.037620297463;7280.980662707225;7294.161171465296;7294.562326260441;7296.489245752799;7346;25654.615180772118;26835.865820670773;27161.72838271612;27308.31729206766;27319.180424587295;2849.3873817129415;2914.9125526234247;2936.2219011961847;2952;2953.1731115287753;14155.292235388293;15612.4535641252;15972;16188.75716864248;16321.347146114142;1911.694128939363;1956.0415396455776;1970.3891793544046;1975.6345076160956;2037.8064083912004;119308.40345798302;123913.38043309726;124430;124514;125852.37073814664;20503.487412814502;21295.041723122496;21354.679679804816;21587.460313491974;21593;36850.447243291375;36879.4468082979;37018.8149059253;37075;37097.814510927274;10389.444080518995;10670.413127278074;10861.619843305447;11047.502862371213;11052.336859788438;8757.036725960139;8757.56212189388;8780.473171609723;8971.596278167499;8976.102389760972;10362.274640775224;10673.83989240162;10721.892781072245;10862.945685271523;10883.510242039127;3176.682331766805;3631.2374401376005;3820.6370394812448;4011.438398624195;4061.817218225187;757.4849102610278;855.234565064264;862.3316929379655;896.1486587741672;900.045951291633;18863;20213.184373117496;20683.793162068487;20819.37541873746;20936.895315523325;861.5347712235448;903.2277402820625;905.1491597897955;912.5346073502428;915.1306259053925;10176.491175441199;10763.677089687322;10832.512536935857;10856.565737370574;10885.564577416815;646846.7657661776;681513;693822;695427;695573;123481;124255.37872310581;126233;128227;129155.73020563032;1148.9885101148882;1154.5999650709216;1191.1007189571817;1195.4381440722846;1200.0639501189087;14768.100902051518;18077.909610451865;18116;18165.27338906429;18329.633407332047;50895.72760680864;50963.49036509587;51422.74288628533;52285;53156.46843531515;63540.04689929747;72060;73288;73565;75163.62418187874;9360.625574977197;11230.719232019264;11498.655040348469;11540.019098376732;11704.414779260833;11229.943850280697;12716.36418179106;12782.488700451877;13165.012624053043;13195.076344655781;11048.447577620926;11327.886721133013;11431.885681143414;11511.021563166889;11557.901999310052;10838.187135964992;10972.451377431256;11030.22788404804;11379.886201138213;11434.82847757301;11170;11241.775164496828;11413.486393112496;11487.25332853362;11954.880451195377;11370.94314528422;11573.18987670855;11668.183227174017;11705.88294117048;11739.11956603241;11393.54425822991;11494.367809770543;11718;11724.88275117272;11795.587154449553 09:37:45 INFO - PROCESS | 1986 | |3;mootools.html;1498.8875834312416;1538.092525410008;1566.741487654537;1567.29471737718;1578.928948197331;10118.898811011888;10633.255672102936;10652.307600006005;10659.680209593715;10664;10223.48882555871;10628.04347608715;10705.304155229904;10740.03339699427;10741.194410419212;2299.1148407862966;2337.333859849943;2339.076064954342;2345.167465549731;2346.049849810821;2273.27255278311;2301.079568172736;2314.3404129823;2318.3160967514623;2318.547883162784;2269.1830940861278;2291.724993000834;2301.493671392291;2303.09027933966;2306.7693230676964;2247.516783891455;2268.455570663029;2273.806726428247;2275.89758460868;2279.5326957973657;1960.235508151822;2255.424866659008;2312.3178662294663;2315.0739704118487;2316.1893337331967;10713.303635263683;10782.892171078267;10805.405702686348;10807.135429165648;10825.729356766065;5458.153986132156;5639.830805075854;5641;5641.407652196543;5643.633163844378;3112.766542509321;3198.2803869129493;3376.6116896556964;3386.170388254893;3386.3227354529195;1104.3429159649995;1123.9381833999128;1135.8523391959075;1174.054885816917;1176.1355403778216;13196.14225075367;13531.864681353258;13610.387532561059;14483.203423811687;14539.200343981076;4105.774182419936;4220.662347012231;4224.598663126998;4232.30167022444;4245.1085272093205;10872.130229581615;11153.330800152016;11239.381833999209;11284;11291.661250162508;5211.635185537052;5245.816396426183;5260.736963151827;5261.053010458154;5277.182036784227;4814.735189564538;5103.591712662978;5128.3076784633595;5144.38267407906;5173.793048278027;3614.710823134143;3736.831842567091;3782.8108594570162;3872.419137129397;3872.5740168581433;1004.3120462483222;1009.4145395670494;1016.9338992965434;1019.6278358399131;1023.9436830974367;778.2217782217782;897.3494216692845;922.460360688991;922.6217250927222;944.2351695126969;6182.887080325495;6661.733530658817;6820.147481564804;6904.827379315558;6980.616066116412;874.8897668787522;910.7158905942589;969.3069455339466;1013.2957594471918;1025.5282570017876;3608.5850127235703;3673.173535954389;4194.496660400771;4241.7879106044575;4337.4795024596615;12410.875891241152;12784.61646150617;12941.935290323489;13043.543475978295;13052.738945221232;13159;13159.144655597547;13162.605121846169;13179.275139867208;13179.472821087049;9670.274729395323;9929.602815887283;9943.005699430143;9952.80094398108;9960.701178964642;5077.669951453144;5473.343198816167;6447.258565265054;6587.604743715392;6837.760678376233;11538.019268362283;11689.941550292195;11748.530058797895;11893.048556115316;11981.940090299842;10739.731506712395;10877.45612719345;11618.593349232737;11985.101117416403;12127.454264558293;8726.476411415335;8956.462612243286;9091.90908090937;9095.454272743393;9098.90901091007;9558.95220523893;9912.15746661513;9977.052180042885;10036.146927511243;10050.246231532517;8486.448380855225;8899.377043607145;8969.686060988095;9008.954955225181;9052.049534799015;8601.82796344082;8710.346723995852;8792.34057445707;8875.556222188994;8877.24543413817;7415.443841711785;7631.7328893490685;7714.151443341116;7723.266289702469;7736.4584479085925;5596;5669.34802497718;5714.085746280575;5799.652020878761;5975.133605627247;5730.742116604846;5836.620619659709;5908.084246941731;5973.701314934149;6035.637861728311 09:37:45 INFO - PROCESS | 1986 | |4;prototype.html;371.98884033479;373.4454335312063;374.62724589033917;381.67366901299386;381.67748252726454;4237.6398006169475;4240.106252309292;4663.673542852001;4935.555799978001;4967.565892712563;4011.9598804011953;4540.955580216544;4930.8027678892895;4966.52817982292;5020.799168033283;3515.4199557073052;3747.5502939647213;3806.9619303806885;4244.278472659656;4282.914341713164;3613.674769270765;4230.873073807791;4280.3793449949735;4320.351947207928;4326.545712700168;3638.072291565647;3786.046883430928;3798.7464136834915;3966.5438474575503;4336.934945975813;4012.518497780285;4019.523112507689;4123.154753275571;4216.894577635553;4422.646188304928;4096.40602112695;4114.19773144237;4117.670586353084;4164.146349998243;4168.997762148341;4767.666263361566;4789;4821.85534433964;4836.975815120937;4863.319135321058;4196.349565817303;4642.860714178546;4979.502049794992;4983.576396006308;5044.9478065770045;4565.480174627095;4854.06820475416;5328.973355133199;5339.786408543654;5347.144456886879;3646.762960407565;4568.132054909556;4594;4659.534046595347;4719.640179910045;4727.598154156935;5039.697618142886;5280.732624170171;5343.904499577616;5617.764091899776;4416.583416583417;4613.95386046142;4632.1008386562025;4695.906081878344;4696.506866778939;4221.374770713298;4664.440267167962;4769.546893045155;4802.399700037496;4820.807167713252;4069.694772892045;4960.851174464772;4984.837660553406;4990.6257030722845;5026.949730502722;4546.886327841764;4558.931616025762;4746.928796068062;5029.899402011939;5050;1568.6744700727866;1624.7887774589228;1642.24456749894;1677.0692265792602;1681.5880109373281;1147.9311241325547;1155.3760969076773;1188.9048876089892;1337.585348541955;1377.5316392426623;4552.430946131733;4790.568848803555;4870.9269360959615;5004.9499505005215;5036.194208926554;4974.726390048582;5359.276497672842;5361.571074314045;5522.708076148353;5554.25064593029;4100.774457404871;4563.95436045642;4650.790714417859;4885.780139893714;5006.744267372704;2655.3404122423485;2745.341118131634;2805.8456784877026;2817.9432712732723;2834.795212034877;5082.5527663294615;5592.7762889483965;5647.808987921811;5661.915071273934;5715.428457154335;4528.682992190515;4632.374629425052;5147.202183661464;5447.5641948644015;5640.32316122068;4732.976335118371;5000.424951130593;5512.6692398456225;5582.404182055364;5669.744861481161;4797.880052998703;5354.250404943233;5409.594280428905;5421.322334708161;5439.755211015435;4796.944672172117;4809.927851082167;5064.670796398223;5117.385913690381;5405.621606487665;5480.040992826319;5558.833235002957;5610.410906854721;5684.261046063985;5700.916825803084;4287.356896465555;4292.656587472932;4453.732776033448;4530.343100250379;4622.260438329851;4032.939505907355;4877.365942427462;5133.639585509917;5185.974070129776;5371.1327843952295;5248.396434410091;5258.581052715794;5278.340207474066;5315.485086750257;5322.361316642027;4293.420388247547;5096.120691809116;5273.732295113138;5281.758786685049;5286.656367336111;4461.219286624892;4812.903741925212;4932.4327702314695;4987.401511818605;5198.402183748917;5198.584113271005;5285.7621407036;5297.2583838263445;5328.706921119376;5350.357957045179;4347.521772604948;4520.841770538147;4839.008003359232;5014.398272207359;5077.39071311445 09:37:45 INFO - PROCESS | 1986 | |5;yui.html;695.8817001109811;734.7024455095685;775.5075527040327;824.653645468903;842.3135144856944;17724.645507089866;18380.35668751594;18438.44684659459;18505.7224141638;18533.536661583483;16751.329946802114;16814.495565133035;16858.494245172635;16864.915675421606;16867.831321686812;937.8124375124968;952.342883410448;958.2477754962356;958.4393130018947;963.5134257200104;928.5450129436595;949.6438835436711;950.5627411390768;958.1281034258826;963.3689933093834;986.2110311750607;990.1583653894169;991.1080027974845;992.7071513903416;993.6720882108923;991.4992928571097;991.851222316651;992.2409356842022;993.0516356879235;996.1333639733442;737.6090671943824;741.5921243316209;742.7140550887893;742.9672754870734;744.2408743082026;15557.22213889301;15912.443064492687;15972;16137.273822678007;16419.343226270936;13935.442582296797;14071.437142514287;14114.71770564583;14175;14233.146011239358;9779;11756.706082347924;11794.88205117955;11855.407229638484;12057.276563406223;3559.430491121408;3604.891853244407;3666.4133738601695;3707.9629203707887;3791.1659434924272;104518.95481045169;105250.94749052488;116784;117091.8290817098;118516.81483185144;10759;10973.780524389627;11055.668329950115;11079.390633515233;11114.999999999838;21280.574388512145;22704;23024.309270721904;23038.42403939915;23065.88467057654;6778.051072849805;6814.93185068143;6905.861882762317;6975.407090397373;7066.50534462593;4066.959330406717;4105.240530501807;4113.856015039519;4119.032027473541;4120.484939382577;3121.828299443507;3159.4313023655964;3183.697548732913;3212.7429805615493;3214.8714051438146;607.8267693707272;611.9388061193845;614.1064750787593;627.6673363117555;631.4601016131141;646.2342124582385;655.9963256217994;666.7799626123368;687.3470203306879;693.1543516909362;10083;10104.898951010542;10167.644132455476;10296.124829389586;10330;649.9610023398611;667.1147287979508;689.5724650716588;705.3158436316867;709.2234003765868;3821.2357528494413;4676.579107880307;4860.635452341088;4906.55840974314;4917.606591472745;99627;103766;104687;105042.94957050485;107528.38707419395;41143.38284925729;47926.76036619864;50062.749686251336;68957.65521172361;96490;73843.63078184682;76245;77336;78007.60996194869;78067.219327806;10848.698914431774;10888.355162306685;10903.618373356894;10957.287776294515;11205;49076.75461622669;49095.772605685146;50016.49983500118;51591;51702;64458.35541644711;65536.7740064693;66835.99492015247;66899.66550167218;66981.33018669946;9709.46597937092;12078.75842483163;12495.312757798409;12603.432845521791;12708.491660333482;10776.730581735519;14359.353829077925;14424.350904209545;14748.926255368655;14930.626734331729;13220.933895330461;13408.396622151831;13601.183928964294;13717.519886803913;14016.789748153582;13340.399682014138;13473;13516.864831351953;13539.932300338436;14407.495737649131;13183;13271.336433178496;13309.068365214342;13783.655408614864;13835.962302827127;9630.903690963001;10815.35107893529;10890.673279801618;10906.890931090906;11216.327020378803;9173.954130229306;9501;9557.856632150384;11109.3481947186;11221.326720396803 09:37:45 INFO - PROCESS | 1986 | __end_tp_report 09:37:45 INFO - PROCESS | 1986 | __start_cc_report 09:37:45 INFO - PROCESS | 1986 | _x_x_mozilla_cycle_collect,3497 09:37:45 INFO - PROCESS | 1986 | __end_cc_report 09:37:45 INFO - PROCESS | 1986 | __startTimestamp1488821865839__endTimestamp 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | ------- Summary: start ------- 09:37:45 INFO - PROCESS | 1986 | Number of tests: 6 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | [#0] dojo.html Cycles:165 Average:5727.69 Median:5985.73 stddev:661.10 (11.0%) stddev-sans-first:635.30 09:37:45 INFO - PROCESS | 1986 | Values: 3308.4 3314.4 3323.1 3338.7 3382.2 5479.1 5628.6 5736.0 5809.4 5810.5 4739.4 5657.7 5668.7 5740.7 5799.7 5131.5 5143.8 5154.3 5199.4 5217.5 5250.2 5272.7 5282.1 5292.3 5325.0 5072.7 5113.7 5172.6 5196.7 5204.9 4566.7 4948.8 5164.2 5190.1 5193.7 5095.4 5125.1 5139.3 5167.7 5174.2 5639.7 5649.4 5664.3 5669.9 5675.3 6157.6 6170.5 6171.4 6173.5 6187.5 5198.6 6123.0 6130.2 6180.4 6216.3 5819.8 5895.0 5908.6 5950.2 5950.8 6302.7 6313.1 6320.8 6326.7 6338.5 6080.0 6116.2 6128.4 6192.3 6207.4 6222.2 6226.1 6237.2 6242.3 6260.3 6156.7 6168.1 6180.6 6185.9 6187.4 6167.8 6169.0 6176.2 6199.8 6212.7 4300.2 4928.1 5074.6 5104.4 5114.6 4435.5 4455.6 4496.9 4517.8 4529.1 5700.2 5773.8 5845.2 5852.3 5943.8 6169.9 6186.9 6188.4 6193.5 6197.9 4287.0 5743.0 5775.0 5822.1 5969.0 5494.1 5499.2 5503.3 5503.8 5547.1 6345.2 6359.2 6365.1 6386.8 6387.2 6124.8 6171.1 6197.1 6207.0 6220.7 6247.6 6255.4 6257.7 6306.1 6429.7 6189.5 6200.6 6215.6 6217.8 6234.9 6081.2 6226.8 6227.5 6235.2 6247.0 5992.5 6012.7 6096.6 6187.6 6205.9 6085.6 6088.9 6099.1 6104.9 6113.7 5913.3 5948.9 5965.0 5989.8 5994.7 6108.5 6118.1 6121.3 6135.1 6136.9 5887.4 5936.3 5975.3 5985.7 5994.3 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | [#1] ext.html Cycles:180 Average:52491.50 Median:35249.82 stddev:101907.08 (289.1%) stddev-sans-first:102118.98 09:37:45 INFO - PROCESS | 1986 | Values: 773.2 790.9 857.6 870.8 872.1 35252.0 38542.6 41015.0 41096.0 41145.0 32925.8 40256.6 40406.4 40433.8 40606.0 7328.0 8999.8 9144.9 9154.4 9157.1 7335.7 10540.2 10745.8 10957.5 11091.5 9921.3 10958.7 10993.8 11013.9 11015.7 7241.2 10878.2 10922.7 10925.5 10942.6 7309.3 10542.8 10766.6 10913.5 10937.9 38420.6 38537.8 38608.8 38621.8 38758.0 3795.4 3810.9 3811.8 3859.1 3949.7 28223.0 28249.7 28259.6 28342.9 28396.3 3045.2 3126.8 3159.7 3193.8 3196.8 328247.0 333076.0 333525.0 333748.3 334775.0 51043.5 51296.5 51355.0 51394.5 51472.0 43590.3 53060.2 53121.5 53139.0 53336.2 12480.8 12521.4 12555.4 12574.4 12576.6 10876.1 10895.3 10897.3 10924.5 10936.5 8676.7 9447.1 10115.2 10683.3 10711.5 4710.3 4717.3 4723.4 4723.6 4739.7 921.6 925.9 961.8 977.8 984.4 20572.0 23208.3 23291.8 23386.1 23574.9 1016.3 1017.5 1036.7 1052.2 1055.7 11818.5 11848.4 11855.4 11903.0 11927.3 382050.0 384195.0 384425.0 384992.0 385053.1 41840.8 41854.8 41985.8 42014.4 42079.0 1348.1 1401.6 1419.2 1420.9 1420.9 20809.8 26092.6 27400.0 29935.3 30361.4 52805.5 53041.0 53079.5 53097.7 53158.0 407087.0 417965.0 444327.0 445155.0 445759.0 34046.0 34575.5 34714.5 34732.3 34756.5 41124.4 42252.8 42432.4 42482.9 42505.8 34647.1 35247.6 35584.5 36395.0 36861.3 34452.0 34527.8 34704.0 36080.9 36240.0 35174.1 35587.8 35901.7 35930.1 35998.0 29384.7 29861.5 30249.5 31167.8 31328.0 23111.1 23166.9 23378.8 23637.6 23702.9 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | [#2] jquery.html Cycles:180 Average:38903.01 Median:21469.91 stddev:112963.56 (526.1%) stddev-sans-first:113243.33 09:37:45 INFO - PROCESS | 1986 | Values: 335.0 379.1 390.8 405.6 430.3 10972.5 11638.5 14952.4 21342.9 21585.1 22100.3 22530.0 23111.0 23618.9 23840.9 6411.7 6545.6 6624.6 6709.3 6752.3 4152.5 6603.6 6740.9 6743.9 6750.8 4339.3 4364.0 4416.1 7577.2 7700.0 6423.6 7319.3 7674.1 7689.7 7699.0 7281.0 7294.2 7294.6 7296.5 7346.0 25654.6 26835.9 27161.7 27308.3 27319.2 2849.4 2914.9 2936.2 2952.0 2953.2 14155.3 15612.5 15972.0 16188.8 16321.3 1911.7 1956.0 1970.4 1975.6 2037.8 119308.4 123913.4 124430.0 124514.0 125852.4 20503.5 21295.0 21354.7 21587.5 21593.0 36850.4 36879.4 37018.8 37075.0 37097.8 10389.4 10670.4 10861.6 11047.5 11052.3 8757.0 8757.6 8780.5 8971.6 8976.1 10362.3 10673.8 10721.9 10862.9 10883.5 3176.7 3631.2 3820.6 4011.4 4061.8 757.5 855.2 862.3 896.1 900.0 18863.0 20213.2 20683.8 20819.4 20936.9 861.5 903.2 905.1 912.5 915.1 10176.5 10763.7 10832.5 10856.6 10885.6 646846.8 681513.0 693822.0 695427.0 695573.0 123481.0 124255.4 126233.0 128227.0 129155.7 1149.0 1154.6 1191.1 1195.4 1200.1 14768.1 18077.9 18116.0 18165.3 18329.6 50895.7 50963.5 51422.7 52285.0 53156.5 63540.0 72060.0 73288.0 73565.0 75163.6 9360.6 11230.7 11498.7 11540.0 11704.4 11229.9 12716.4 12782.5 13165.0 13195.1 11048.4 11327.9 11431.9 11511.0 11557.9 10838.2 10972.5 11030.2 11379.9 11434.8 11170.0 11241.8 11413.5 11487.3 11954.9 11370.9 11573.2 11668.2 11705.9 11739.1 11393.5 11494.4 11718.0 11724.9 11795.6 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | [#3] mootools.html Cycles:180 Average:6471.54 Median:3287.45 stddev:4014.67 (122.1%) stddev-sans-first:4008.54 09:37:45 INFO - PROCESS | 1986 | Values: 1498.9 1538.1 1566.7 1567.3 1578.9 10118.9 10633.3 10652.3 10659.7 10664.0 10223.5 10628.0 10705.3 10740.0 10741.2 2299.1 2337.3 2339.1 2345.2 2346.0 2273.3 2301.1 2314.3 2318.3 2318.5 2269.2 2291.7 2301.5 2303.1 2306.8 2247.5 2268.5 2273.8 2275.9 2279.5 1960.2 2255.4 2312.3 2315.1 2316.2 10713.3 10782.9 10805.4 10807.1 10825.7 5458.2 5639.8 5641.0 5641.4 5643.6 3112.8 3198.3 3376.6 3386.2 3386.3 1104.3 1123.9 1135.9 1174.1 1176.1 13196.1 13531.9 13610.4 14483.2 14539.2 4105.8 4220.7 4224.6 4232.3 4245.1 10872.1 11153.3 11239.4 11284.0 11291.7 5211.6 5245.8 5260.7 5261.1 5277.2 4814.7 5103.6 5128.3 5144.4 5173.8 3614.7 3736.8 3782.8 3872.4 3872.6 1004.3 1009.4 1016.9 1019.6 1023.9 778.2 897.3 922.5 922.6 944.2 6182.9 6661.7 6820.1 6904.8 6980.6 874.9 910.7 969.3 1013.3 1025.5 3608.6 3673.2 4194.5 4241.8 4337.5 12410.9 12784.6 12941.9 13043.5 13052.7 13159.0 13159.1 13162.6 13179.3 13179.5 9670.3 9929.6 9943.0 9952.8 9960.7 5077.7 5473.3 6447.3 6587.6 6837.8 11538.0 11689.9 11748.5 11893.0 11981.9 10739.7 10877.5 11618.6 11985.1 12127.5 8726.5 8956.5 9091.9 9095.5 9098.9 9559.0 9912.2 9977.1 10036.1 10050.2 8486.4 8899.4 8969.7 9009.0 9052.0 8601.8 8710.3 8792.3 8875.6 8877.2 7415.4 7631.7 7714.2 7723.3 7736.5 5596.0 5669.3 5714.1 5799.7 5975.1 5730.7 5836.6 5908.1 5973.7 6035.6 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | [#4] prototype.html Cycles:180 Average:4446.93 Median:4793.76 stddev:1186.83 (24.8%) stddev-sans-first:1150.08 09:37:45 INFO - PROCESS | 1986 | Values: 372.0 373.4 374.6 381.7 381.7 4237.6 4240.1 4663.7 4935.6 4967.6 4012.0 4541.0 4930.8 4966.5 5020.8 3515.4 3747.6 3807.0 4244.3 4282.9 3613.7 4230.9 4280.4 4320.4 4326.5 3638.1 3786.0 3798.7 3966.5 4336.9 4012.5 4019.5 4123.2 4216.9 4422.6 4096.4 4114.2 4117.7 4164.1 4169.0 4767.7 4789.0 4821.9 4837.0 4863.3 4196.3 4642.9 4979.5 4983.6 5044.9 4565.5 4854.1 5329.0 5339.8 5347.1 3646.8 4568.1 4594.0 4659.5 4719.6 4727.6 5039.7 5280.7 5343.9 5617.8 4416.6 4614.0 4632.1 4695.9 4696.5 4221.4 4664.4 4769.5 4802.4 4820.8 4069.7 4960.9 4984.8 4990.6 5026.9 4546.9 4558.9 4746.9 5029.9 5050.0 1568.7 1624.8 1642.2 1677.1 1681.6 1147.9 1155.4 1188.9 1337.6 1377.5 4552.4 4790.6 4870.9 5004.9 5036.2 4974.7 5359.3 5361.6 5522.7 5554.3 4100.8 4564.0 4650.8 4885.8 5006.7 2655.3 2745.3 2805.8 2817.9 2834.8 5082.6 5592.8 5647.8 5661.9 5715.4 4528.7 4632.4 5147.2 5447.6 5640.3 4733.0 5000.4 5512.7 5582.4 5669.7 4797.9 5354.3 5409.6 5421.3 5439.8 4796.9 4809.9 5064.7 5117.4 5405.6 5480.0 5558.8 5610.4 5684.3 5700.9 4287.4 4292.7 4453.7 4530.3 4622.3 4032.9 4877.4 5133.6 5186.0 5371.1 5248.4 5258.6 5278.3 5315.5 5322.4 4293.4 5096.1 5273.7 5281.8 5286.7 4461.2 4812.9 4932.4 4987.4 5198.4 5198.6 5285.8 5297.3 5328.7 5350.4 4347.5 4520.8 4839.0 5014.4 5077.4 09:37:45 INFO - PROCESS | 1986 | 09:37:45 INFO - PROCESS | 1986 | [#5] yui.html Cycles:180 Average:19979.56 Median:3687.19 stddev:28632.96 (776.6%) stddev-sans-first:28676.67 09:37:45 INFO - PROCESS | 1986 | Values: 695.9 734.7 775.5 824.7 842.3 17724.6 18380.4 18438.4 18505.7 18533.5 16751.3 16814.5 16858.5 16864.9 16867.8 937.8 952.3 958.2 958.4 963.5 928.5 949.6 950.6 958.1 963.4 986.2 990.2 991.1 992.7 993.7 991.5 991.9 992.2 993.1 996.1 737.6 741.6 742.7 743.0 744.2 15557.2 15912.4 15972.0 16137.3 16419.3 13935.4 14071.4 14114.7 14175.0 14233.1 9779.0 11756.7 11794.9 11855.4 12057.3 3559.4 3604.9 3666.4 3708.0 3791.2 104519.0 105250.9 116784.0 117091.8 118516.8 10759.0 10973.8 11055.7 11079.4 11115.0 21280.6 22704.0 23024.3 23038.4 23065.9 6778.1 6814.9 6905.9 6975.4 7066.5 4067.0 4105.2 4113.9 4119.0 4120.5 3121.8 3159.4 3183.7 3212.7 3214.9 607.8 611.9 614.1 627.7 631.5 646.2 656.0 666.8 687.3 693.2 10083.0 10104.9 10167.6 10296.1 10330.0 650.0 667.1 689.6 705.3 709.2 3821.2 4676.6 4860.6 4906.6 4917.6 99627.0 103766.0 104687.0 105042.9 107528.4 41143.4 47926.8 50062.7 68957.7 96490.0 73843.6 76245.0 77336.0 78007.6 78067.2 10848.7 10888.4 10903.6 10957.3 11205.0 49076.8 49095.8 50016.5 51591.0 51702.0 64458.4 65536.8 66836.0 66899.7 66981.3 9709.5 12078.8 12495.3 12603.4 12708.5 10776.7 14359.4 14424.4 14748.9 14930.6 13220.9 13408.4 13601.2 13717.5 14016.8 13340.4 13473.0 13516.9 13539.9 14407.5 13183.0 13271.3 13309.1 13783.7 13836.0 9630.9 10815.4 10890.7 10906.9 11216.3 9174.0 9501.0 9557.9 11109.3 11221.3 09:37:45 INFO - PROCESS | 1986 | -------- Summary: end -------- 09:37:45 INFO - PROCESS | 1986 | 09:37:46 INFO - TEST-INFO | 1986: exit 0 09:37:46 INFO - TEST-OK | dromaeo_css | took 1121998ms 09:37:46 INFO - TEST-START | kraken 09:37:46 INFO - operating with platform_type : mac_ 09:37:46 INFO - Initialising browser for kraken test... 09:37:46 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpblKAb3/profile http://localhost:53001/getInfo.html) 09:37:48 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 09:37:48 INFO - PROCESS | 1993 | colorDepth:24 09:37:48 INFO - PROCESS | 1993 | Browser inner width/height: 1024/689 09:37:48 INFO - PROCESS | 1993 | __metrics 09:37:48 INFO - PROCESS | 1993 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:37:48 INFO - PROCESS | 1993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:49 INFO - TEST-INFO | 1993: exit 0 09:37:49 INFO - Browser initialized. 09:37:49 INFO - Running cycle 1/1 for kraken test... 09:37:49 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpblKAb3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:02 INFO - PROCESS | 1994 | RSS: Main: 232906752 09:38:02 INFO - PROCESS | 1994 | 09:38:05 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53001/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:06 INFO - PROCESS | 1994 | RSS: Main: 284794880 09:38:06 INFO - PROCESS | 1994 | 09:38:08 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53001/tests/kraken/driver.html?testName=audio-dft) 09:38:09 INFO - PROCESS | 1994 | RSS: Main: 286744576 09:38:09 INFO - PROCESS | 1994 | 09:38:12 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53001/tests/kraken/driver.html?testName=audio-fft) 09:38:13 INFO - PROCESS | 1994 | RSS: Main: 378388480 09:38:13 INFO - PROCESS | 1994 | 09:38:15 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53001/tests/kraken/driver.html?testName=audio-oscillator) 09:38:16 INFO - PROCESS | 1994 | RSS: Main: 281583616 09:38:16 INFO - PROCESS | 1994 | 09:38:18 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:18 INFO - PROCESS | 1994 | RSS: Main: 282976256 09:38:18 INFO - PROCESS | 1994 | 09:38:21 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53001/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:22 INFO - PROCESS | 1994 | RSS: Main: 324517888 09:38:22 INFO - PROCESS | 1994 | 09:38:25 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53001/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:26 INFO - PROCESS | 1994 | RSS: Main: 327749632 09:38:26 INFO - PROCESS | 1994 | 09:38:29 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53001/tests/kraken/driver.html?testName=json-parse-financial) 09:38:30 INFO - PROCESS | 1994 | RSS: Main: 323108864 09:38:30 INFO - PROCESS | 1994 | 09:38:31 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:32 INFO - PROCESS | 1994 | RSS: Main: 301670400 09:38:32 INFO - PROCESS | 1994 | 09:38:34 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:35 INFO - PROCESS | 1994 | RSS: Main: 306700288 09:38:35 INFO - PROCESS | 1994 | 09:38:37 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:38 INFO - PROCESS | 1994 | RSS: Main: 307888128 09:38:38 INFO - PROCESS | 1994 | 09:38:41 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:41 INFO - PROCESS | 1994 | RSS: Main: 323850240 09:38:41 INFO - PROCESS | 1994 | 09:38:44 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:45 INFO - PROCESS | 1994 | RSS: Main: 318119936 09:38:45 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53001/tests/kraken/driver.html?testName=ai-astar) 09:38:47 INFO - PROCESS | 1994 | RSS: Main: 363540480 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | __start_tp_report 09:38:47 INFO - PROCESS | 1994 | _x_x_mozilla_page_load 09:38:47 INFO - PROCESS | 1994 | _x_x_mozilla_page_load_details 09:38:47 INFO - PROCESS | 1994 | |i|pagename|runs| 09:38:47 INFO - PROCESS | 1994 | |0;ai-astar;116;119;169;166;116;114;114;119;166;170 09:38:47 INFO - PROCESS | 1994 | |1;audio-beat-detection;142;109;108;148;113;112;112;109;131;103 09:38:47 INFO - PROCESS | 1994 | |2;audio-dft;186;189;185;182;186;185;184;186;186;185 09:38:47 INFO - PROCESS | 1994 | |3;audio-fft;83;59;52;91;75;85;84;62;77;61 09:38:47 INFO - PROCESS | 1994 | |4;audio-oscillator;86;71;90;73;72;69;86;71;69;85 09:38:47 INFO - PROCESS | 1994 | |5;imaging-gaussian-blur;86;86;87;87;87;86;86;93;87;86 09:38:47 INFO - PROCESS | 1994 | |6;imaging-darkroom;93;94;94;97;94;94;95;106;91;136 09:38:47 INFO - PROCESS | 1994 | |7;imaging-desaturate;87;84;85;83;98;127;130;84;83;85 09:38:47 INFO - PROCESS | 1994 | |8;json-parse-financial;65;59;61;61;60;60;60;60;60;59 09:38:47 INFO - PROCESS | 1994 | |9;json-stringify-tinderbox;64;68;55;64;62;59;59;62;58;60 09:38:47 INFO - PROCESS | 1994 | |10;stanford-crypto-aes;89;91;96;104;106;105;81;88;87;90 09:38:47 INFO - PROCESS | 1994 | |11;stanford-crypto-ccm;142;141;141;138;139;138;140;142;200;184 09:38:47 INFO - PROCESS | 1994 | |12;stanford-crypto-pbkdf2;174;222;175;173;175;174;172;171;171;172 09:38:47 INFO - PROCESS | 1994 | |13;stanford-crypto-sha256-iterative;68;68;70;64;84;66;65;65;66;66 09:38:47 INFO - PROCESS | 1994 | __end_tp_report 09:38:47 INFO - PROCESS | 1994 | __start_cc_report 09:38:47 INFO - PROCESS | 1994 | _x_x_mozilla_cycle_collect,2163 09:38:47 INFO - PROCESS | 1994 | __end_cc_report 09:38:47 INFO - PROCESS | 1994 | __startTimestamp1488821927555__endTimestamp 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | ------- Summary: start ------- 09:38:47 INFO - PROCESS | 1994 | Number of tests: 14 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#0] ai-astar Cycles:10 Average:136.90 Median:142.50 stddev:26.63 (18.7%) stddev-sans-first:27.15 09:38:47 INFO - PROCESS | 1994 | Values: 116.0 119.0 169.0 166.0 116.0 114.0 114.0 119.0 166.0 170.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:112.50 stddev:15.72 (14.0%) stddev-sans-first:14.23 09:38:47 INFO - PROCESS | 1994 | Values: 142.0 109.0 108.0 148.0 113.0 112.0 112.0 109.0 131.0 103.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#2] audio-dft Cycles:10 Average:185.40 Median:186.00 stddev:1.78 (1.0%) stddev-sans-first:1.87 09:38:47 INFO - PROCESS | 1994 | Values: 186.0 189.0 185.0 182.0 186.0 185.0 184.0 186.0 186.0 185.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#3] audio-fft Cycles:10 Average:72.90 Median:80.00 stddev:13.38 (16.7%) stddev-sans-first:13.68 09:38:47 INFO - PROCESS | 1994 | Values: 83.0 59.0 52.0 91.0 75.0 85.0 84.0 62.0 77.0 61.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.00 stddev:8.40 (10.6%) stddev-sans-first:8.29 09:38:47 INFO - PROCESS | 1994 | Values: 86.0 71.0 90.0 73.0 72.0 69.0 86.0 71.0 69.0 85.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.00 stddev:2.13 (2.5%) stddev-sans-first:2.22 09:38:47 INFO - PROCESS | 1994 | Values: 86.0 86.0 87.0 87.0 87.0 86.0 86.0 93.0 87.0 86.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:94.00 stddev:13.48 (14.3%) stddev-sans-first:14.10 09:38:47 INFO - PROCESS | 1994 | Values: 93.0 94.0 94.0 97.0 94.0 94.0 95.0 106.0 91.0 136.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:84.50 stddev:18.41 (21.8%) stddev-sans-first:19.32 09:38:47 INFO - PROCESS | 1994 | Values: 87.0 84.0 85.0 83.0 98.0 127.0 130.0 84.0 83.0 85.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:60.00 stddev:1.72 (2.9%) stddev-sans-first:0.71 09:38:47 INFO - PROCESS | 1994 | Values: 65.0 59.0 61.0 61.0 60.0 60.0 60.0 60.0 60.0 59.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:62.00 stddev:3.70 (6.0%) stddev-sans-first:3.77 09:38:47 INFO - PROCESS | 1994 | Values: 64.0 68.0 55.0 64.0 62.0 59.0 59.0 62.0 58.0 60.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:88.50 stddev:8.64 (9.8%) stddev-sans-first:9.00 09:38:47 INFO - PROCESS | 1994 | Values: 89.0 91.0 96.0 104.0 106.0 105.0 81.0 88.0 87.0 90.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:141.50 stddev:22.24 (15.7%) stddev-sans-first:23.38 09:38:47 INFO - PROCESS | 1994 | Values: 142.0 141.0 141.0 138.0 139.0 138.0 140.0 142.0 200.0 184.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:174.00 stddev:15.57 (8.9%) stddev-sans-first:16.45 09:38:47 INFO - PROCESS | 1994 | Values: 174.0 222.0 175.0 173.0 175.0 174.0 172.0 171.0 171.0 172.0 09:38:47 INFO - PROCESS | 1994 | 09:38:47 INFO - PROCESS | 1994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:5.83 (8.7%) stddev-sans-first:6.18 09:38:47 INFO - PROCESS | 1994 | Values: 68.0 68.0 70.0 64.0 84.0 66.0 65.0 65.0 66.0 66.0 09:38:47 INFO - PROCESS | 1994 | -------- Summary: end -------- 09:38:47 INFO - PROCESS | 1994 | 09:38:48 INFO - TEST-INFO | 1994: exit 0 09:38:48 INFO - TEST-OK | kraken | took 62012ms 09:38:48 INFO - SUITE-END | took 1184s 09:38:48 INFO - Completed test suite (00:19:44) 09:38:48 INFO - javascript benchmark 09:38:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7479.866030583043, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.4044871923043, 3314.370269648767, 3323.135984643992, 3338.6828251316147, 3382.2389962258494, 5479.068558345081, 5628.605997580171, 5735.996200664883, 5809.448102430268, 5810.477057064869, 4739.431268247807, 5657.660540367581, 5668.744906479208, 5740.7129643517865, 5799.681017544033, 5131.512506311913, 5143.7685304161405, 5154.252633368159, 5199.428062913076, 5217.530422261995, 5250.238715386266, 5272.657277276984, 5282.128448805962, 5292.259083728281, 5325.014872248627, 5072.670276432039, 5113.718745468997, 5172.586193104543, 5196.740162991873, 5204.8959020819375, 4566.698490930069, 4948.802047918079, 5164.173732202867, 5190.143626301693, 5193.688378697252, 5095.421174460324, 5125.1287281162295, 5139.306193663845, 5167.741612919339, 5174.2238664200295, 5639.71801409932, 5649.435056494359, 5664.291963504562, 5669.886602267973, 5675.290588676416, 6157.630542167484, 6170.5372097092895, 6171.444569988723, 6173.536984726119, 6187.535934804862, 5198.610104242197, 6122.977604208165, 6130.165000698321, 6180.412860778219, 6216.2540495140875, 5819.7672093116225, 5894.97052514739, 5908.615939963932, 5950.19672344228, 5950.7917222896995, 6302.676437947991, 6313.053042043638, 6320.810375688737, 6326.68366581669, 6338.524610654219, 6079.96960015206, 6116.235470566179, 6128.442013630915, 6192.256929168529, 6207.379262073847, 6222.160008398899, 6226.097215903668, 6237.220347456568, 6242.313345531988, 6260.342664020212, 6156.661383623854, 6168.136460895478, 6180.598261113013, 6185.876282474325, 6187.3503282154725, 6167.753289868355, 6168.9691551542855, 6176.197094377792, 6199.814005579839, 6212.689365531705, 4300.182965236595, 4928.112939670894, 5074.568661663726, 5104.438511763703, 5114.641975061784, 4435.489918659331, 4455.554444555519, 4496.887577810516, 4517.796699148546, 4529.116822219701, 5700.173474846124, 5773.797917072882, 5845.152452894306, 5852.268466441695, 5943.791967281211, 6169.876602467925, 6186.907196392058, 6188.44304012641, 6193.504519638418, 6197.876042479125, 4287.0, 5742.971285143548, 5775.0, 5822.126680997884, 5969.044952807617, 5494.09347457673, 5499.230107784913, 5503.257060296889, 5503.779848806083, 5547.140193270049, 6345.206849143857, 6359.236891573041, 6365.108884756138, 6386.840328991812, 6387.169667943138, 6124.777645458507, 6171.074338849029, 6197.070439434121, 6207.0, 6220.657863817533, 6247.562670613195, 6255.40573645503, 6257.7184026718, 6306.085617585516, 6429.7428102875365, 6189.535784816067, 6200.56596038273, 6215.595986260879, 6217.844553886189, 6234.906476402948, 6081.239845019372, 6226.844328891632, 6227.532935029982, 6235.189425374672, 6247.0, 5992.49063829562, 6012.6993650316435, 6096.573239873166, 6187.597806142587, 6205.875882482415, 6085.57400981927, 6088.878222435438, 6099.054646529795, 6104.938950610437, 6113.663748493876, 5913.319968203712, 5948.940510594839, 5964.970175149097, 5989.760409583568, 5994.70026498682, 6108.541859360655, 6118.143459915705, 6121.265448146251, 6135.079738039151, 6136.938630613815, 5887.4406931341455, 5936.28764548257, 5975.25309336333, 5985.730642121028, 5994.280686317496], "value": 5685.342722838701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.2344978471314, 790.9288164065234, 857.5626430520433, 870.7910101575624, 872.0712441250068, 35252.0, 38542.61457385429, 41015.0, 41095.972600684996, 41145.0, 32925.835370823115, 40256.59743402565, 40406.39390409139, 40433.78698639038, 40606.0, 7328.0, 8999.820003599923, 9144.908550914506, 9154.359194856363, 9157.084291570856, 7335.743248986287, 10540.156787457023, 10745.83881241778, 10957.50691218897, 11091.500882460308, 9921.3055086144, 10958.671239862777, 10993.835092473579, 11013.944930275338, 11015.669529914116, 7241.167265764399, 10878.184136189779, 10922.726931826728, 10925.453727313603, 10942.617008404748, 7309.305615966475, 10542.78914421715, 10766.569337226501, 10913.454327283604, 10937.945310273477, 38420.61579384226, 38537.807310963544, 38608.80695596532, 38621.841344759705, 38758.0, 3795.35478968576, 3810.9186555676783, 3811.8284677189595, 3859.1316953685478, 3949.7037722170667, 28223.01219457309, 28249.717502824915, 28259.57610635842, 28342.858285708644, 28396.290092747848, 3045.1778019934713, 3126.7967582107317, 3159.6840315968448, 3193.840307984615, 3196.7602429817857, 328247.0, 333076.0, 333525.0, 333748.33125834214, 334775.0, 51043.489565103875, 51296.48703512917, 51354.99999999925, 51394.48605513972, 51472.0, 43590.34614480785, 53060.20409693858, 53121.46878531243, 53139.0, 53336.199957000674, 12480.75038499243, 12521.436535355931, 12555.435005424777, 12574.43415046325, 12576.622701318975, 10876.075533579735, 10895.291806032583, 10897.346159230472, 10924.508397122148, 10936.50785714629, 8676.69631562905, 9447.055294470498, 10115.241356898263, 10683.25217234786, 10711.517981690842, 4710.3405523226775, 4717.268823332389, 4723.362346083303, 4723.622110231173, 4739.715617062987, 921.5852866210232, 925.9305552083621, 961.8028304197622, 977.750673578233, 984.4044353166374, 20572.0, 23208.3037508875, 23291.767082329297, 23386.12545166506, 23574.88212558926, 1016.3190662256159, 1017.5370206555999, 1036.7097212780434, 1052.1687866585312, 1055.678018204455, 11818.468168932419, 11848.407579620984, 11855.407229638657, 11903.0, 11927.343996080126, 382050.0, 384195.0, 384425.0, 384992.0, 385053.1494685073, 41840.790796046436, 41854.79072604617, 41985.79007104945, 42014.36978445326, 42079.0, 1348.0900392235203, 1401.5515035188641, 1419.2194293138732, 1420.8508106648653, 1420.920100723437, 20809.791902080786, 26092.608610871233, 27400.0, 29935.251618709706, 30361.392772144874, 52805.47194528006, 53041.0, 53079.469205307454, 53097.734511327195, 53158.0, 407087.0, 417965.0, 444327.0, 445155.0, 445759.0, 34046.0, 34575.481367779, 34714.479282811284, 34732.305353892276, 34756.47865281972, 41124.38313425241, 42252.78873605612, 42432.36351454669, 42482.937926552084, 42505.78747106368, 34647.13382165466, 35247.647523524436, 35584.46623300704, 36395.0, 36861.26277474382, 34452.0, 34527.82736086303, 34704.0, 36080.91757247287, 36240.0, 35174.12064698403, 35587.82206088953, 35901.74343897951, 35930.10174745652, 35998.0, 29384.706152939052, 29861.506924654113, 30249.546256805726, 31167.844160779052, 31328.0, 23111.075556977532, 23166.884165579737, 23378.766212338338, 23637.64543531814, 23702.88148559246], "value": 18023.807816789376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.9598048234212, 379.10531146494253, 390.81436317749075, 405.62277082313443, 430.3243907065906, 10972.451377431127, 11638.476268567914, 14952.401903923843, 21342.93285335731, 21585.1365945362, 22100.33698989029, 22530.0, 23110.96000679969, 23618.88190559045, 23840.927158277875, 6411.743530258807, 6545.574537655061, 6624.5694029888145, 6709.3290670933, 6752.324767523233, 4152.5432202457705, 6603.636799976023, 6740.898886516707, 6743.898841517381, 6750.763723269686, 4339.349097635349, 4363.956360436387, 4416.138852923681, 7577.242275772406, 7699.961500192491, 6423.64669943153, 7319.268073192691, 7674.079110506747, 7689.692412303501, 7699.037620297463, 7280.980662707225, 7294.161171465296, 7294.562326260441, 7296.489245752799, 7346.0, 25654.615180772118, 26835.865820670773, 27161.72838271612, 27308.31729206766, 27319.180424587295, 2849.3873817129415, 2914.9125526234247, 2936.2219011961847, 2952.0, 2953.1731115287753, 14155.292235388293, 15612.4535641252, 15972.0, 16188.75716864248, 16321.347146114142, 1911.694128939363, 1956.0415396455776, 1970.3891793544046, 1975.6345076160956, 2037.8064083912004, 119308.40345798302, 123913.38043309726, 124430.0, 124514.0, 125852.37073814664, 20503.487412814502, 21295.041723122496, 21354.679679804816, 21587.460313491974, 21593.0, 36850.447243291375, 36879.4468082979, 37018.8149059253, 37075.0, 37097.814510927274, 10389.444080518995, 10670.413127278074, 10861.619843305447, 11047.502862371213, 11052.336859788438, 8757.036725960139, 8757.56212189388, 8780.473171609723, 8971.596278167499, 8976.102389760972, 10362.274640775224, 10673.83989240162, 10721.892781072245, 10862.945685271523, 10883.510242039127, 3176.682331766805, 3631.2374401376005, 3820.6370394812448, 4011.438398624195, 4061.817218225187, 757.4849102610278, 855.234565064264, 862.3316929379655, 896.1486587741672, 900.045951291633, 18863.0, 20213.184373117496, 20683.793162068487, 20819.37541873746, 20936.895315523325, 861.5347712235448, 903.2277402820625, 905.1491597897955, 912.5346073502428, 915.1306259053925, 10176.491175441199, 10763.677089687322, 10832.512536935857, 10856.565737370574, 10885.564577416815, 646846.7657661776, 681513.0, 693822.0, 695427.0, 695573.0, 123481.0, 124255.37872310581, 126233.0, 128227.0, 129155.73020563032, 1148.9885101148882, 1154.5999650709216, 1191.1007189571817, 1195.4381440722846, 1200.0639501189087, 14768.100902051518, 18077.909610451865, 18116.0, 18165.27338906429, 18329.633407332047, 50895.72760680864, 50963.49036509587, 51422.74288628533, 52285.0, 53156.46843531515, 63540.04689929747, 72060.0, 73288.0, 73565.0, 75163.62418187874, 9360.625574977197, 11230.719232019264, 11498.655040348469, 11540.019098376732, 11704.414779260833, 11229.943850280697, 12716.36418179106, 12782.488700451877, 13165.012624053043, 13195.076344655781, 11048.447577620926, 11327.886721133013, 11431.885681143414, 11511.021563166889, 11557.901999310052, 10838.187135964992, 10972.451377431256, 11030.22788404804, 11379.886201138213, 11434.82847757301, 11170.0, 11241.775164496828, 11413.486393112496, 11487.25332853362, 11954.880451195377, 11370.94314528422, 11573.18987670855, 11668.183227174017, 11705.88294117048, 11739.11956603241, 11393.54425822991, 11494.367809770543, 11718.0, 11724.88275117272, 11795.587154449553], "value": 11141.009990741743, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.8875834312416, 1538.092525410008, 1566.741487654537, 1567.29471737718, 1578.928948197331, 10118.898811011888, 10633.255672102936, 10652.307600006005, 10659.680209593715, 10664.0, 10223.48882555871, 10628.04347608715, 10705.304155229904, 10740.03339699427, 10741.194410419212, 2299.1148407862966, 2337.333859849943, 2339.076064954342, 2345.167465549731, 2346.049849810821, 2273.27255278311, 2301.079568172736, 2314.3404129823, 2318.3160967514623, 2318.547883162784, 2269.1830940861278, 2291.724993000834, 2301.493671392291, 2303.09027933966, 2306.7693230676964, 2247.516783891455, 2268.455570663029, 2273.806726428247, 2275.89758460868, 2279.5326957973657, 1960.235508151822, 2255.424866659008, 2312.3178662294663, 2315.0739704118487, 2316.1893337331967, 10713.303635263683, 10782.892171078267, 10805.405702686348, 10807.135429165648, 10825.729356766065, 5458.153986132156, 5639.830805075854, 5641.0, 5641.407652196543, 5643.633163844378, 3112.766542509321, 3198.2803869129493, 3376.6116896556964, 3386.170388254893, 3386.3227354529195, 1104.3429159649995, 1123.9381833999128, 1135.8523391959075, 1174.054885816917, 1176.1355403778216, 13196.14225075367, 13531.864681353258, 13610.387532561059, 14483.203423811687, 14539.200343981076, 4105.774182419936, 4220.662347012231, 4224.598663126998, 4232.30167022444, 4245.1085272093205, 10872.130229581615, 11153.330800152016, 11239.381833999209, 11284.0, 11291.661250162508, 5211.635185537052, 5245.816396426183, 5260.736963151827, 5261.053010458154, 5277.182036784227, 4814.735189564538, 5103.591712662978, 5128.3076784633595, 5144.38267407906, 5173.793048278027, 3614.710823134143, 3736.831842567091, 3782.8108594570162, 3872.419137129397, 3872.5740168581433, 1004.3120462483222, 1009.4145395670494, 1016.9338992965434, 1019.6278358399131, 1023.9436830974367, 778.2217782217782, 897.3494216692845, 922.460360688991, 922.6217250927222, 944.2351695126969, 6182.887080325495, 6661.733530658817, 6820.147481564804, 6904.827379315558, 6980.616066116412, 874.8897668787522, 910.7158905942589, 969.3069455339466, 1013.2957594471918, 1025.5282570017876, 3608.5850127235703, 3673.173535954389, 4194.496660400771, 4241.7879106044575, 4337.4795024596615, 12410.875891241152, 12784.61646150617, 12941.935290323489, 13043.543475978295, 13052.738945221232, 13159.0, 13159.144655597547, 13162.605121846169, 13179.275139867208, 13179.472821087049, 9670.274729395323, 9929.602815887283, 9943.005699430143, 9952.80094398108, 9960.701178964642, 5077.669951453144, 5473.343198816167, 6447.258565265054, 6587.604743715392, 6837.760678376233, 11538.019268362283, 11689.941550292195, 11748.530058797895, 11893.048556115316, 11981.940090299842, 10739.731506712395, 10877.45612719345, 11618.593349232737, 11985.101117416403, 12127.454264558293, 8726.476411415335, 8956.462612243286, 9091.90908090937, 9095.454272743393, 9098.90901091007, 9558.95220523893, 9912.15746661513, 9977.052180042885, 10036.146927511243, 10050.246231532517, 8486.448380855225, 8899.377043607145, 8969.686060988095, 9008.954955225181, 9052.049534799015, 8601.82796344082, 8710.346723995852, 8792.34057445707, 8875.556222188994, 8877.24543413817, 7415.443841711785, 7631.7328893490685, 7714.151443341116, 7723.266289702469, 7736.4584479085925, 5596.0, 5669.34802497718, 5714.085746280575, 5799.652020878761, 5975.133605627247, 5730.742116604846, 5836.620619659709, 5908.084246941731, 5973.701314934149, 6035.637861728311], "value": 4939.320790258685, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.98884033479, 373.4454335312063, 374.62724589033917, 381.67366901299386, 381.67748252726454, 4237.6398006169475, 4240.106252309292, 4663.673542852001, 4935.555799978001, 4967.565892712563, 4011.9598804011953, 4540.955580216544, 4930.8027678892895, 4966.52817982292, 5020.799168033283, 3515.4199557073052, 3747.5502939647213, 3806.9619303806885, 4244.278472659656, 4282.914341713164, 3613.674769270765, 4230.873073807791, 4280.3793449949735, 4320.351947207928, 4326.545712700168, 3638.072291565647, 3786.046883430928, 3798.7464136834915, 3966.5438474575503, 4336.934945975813, 4012.518497780285, 4019.523112507689, 4123.154753275571, 4216.894577635553, 4422.646188304928, 4096.40602112695, 4114.19773144237, 4117.670586353084, 4164.146349998243, 4168.997762148341, 4767.666263361566, 4789.0, 4821.85534433964, 4836.975815120937, 4863.319135321058, 4196.349565817303, 4642.860714178546, 4979.502049794992, 4983.576396006308, 5044.9478065770045, 4565.480174627095, 4854.06820475416, 5328.973355133199, 5339.786408543654, 5347.144456886879, 3646.762960407565, 4568.132054909556, 4594.0, 4659.534046595347, 4719.640179910045, 4727.598154156935, 5039.697618142886, 5280.732624170171, 5343.904499577616, 5617.764091899776, 4416.583416583417, 4613.95386046142, 4632.1008386562025, 4695.906081878344, 4696.506866778939, 4221.374770713298, 4664.440267167962, 4769.546893045155, 4802.399700037496, 4820.807167713252, 4069.694772892045, 4960.851174464772, 4984.837660553406, 4990.6257030722845, 5026.949730502722, 4546.886327841764, 4558.931616025762, 4746.928796068062, 5029.899402011939, 5050.0, 1568.6744700727866, 1624.7887774589228, 1642.24456749894, 1677.0692265792602, 1681.5880109373281, 1147.9311241325547, 1155.3760969076773, 1188.9048876089892, 1337.585348541955, 1377.5316392426623, 4552.430946131733, 4790.568848803555, 4870.9269360959615, 5004.9499505005215, 5036.194208926554, 4974.726390048582, 5359.276497672842, 5361.571074314045, 5522.708076148353, 5554.25064593029, 4100.774457404871, 4563.95436045642, 4650.790714417859, 4885.780139893714, 5006.744267372704, 2655.3404122423485, 2745.341118131634, 2805.8456784877026, 2817.9432712732723, 2834.795212034877, 5082.5527663294615, 5592.7762889483965, 5647.808987921811, 5661.915071273934, 5715.428457154335, 4528.682992190515, 4632.374629425052, 5147.202183661464, 5447.5641948644015, 5640.32316122068, 4732.976335118371, 5000.424951130593, 5512.6692398456225, 5582.404182055364, 5669.744861481161, 4797.880052998703, 5354.250404943233, 5409.594280428905, 5421.322334708161, 5439.755211015435, 4796.944672172117, 4809.927851082167, 5064.670796398223, 5117.385913690381, 5405.621606487665, 5480.040992826319, 5558.833235002957, 5610.410906854721, 5684.261046063985, 5700.916825803084, 4287.356896465555, 4292.656587472932, 4453.732776033448, 4530.343100250379, 4622.260438329851, 4032.939505907355, 4877.365942427462, 5133.639585509917, 5185.974070129776, 5371.1327843952295, 5248.396434410091, 5258.581052715794, 5278.340207474066, 5315.485086750257, 5322.361316642027, 4293.420388247547, 5096.120691809116, 5273.732295113138, 5281.758786685049, 5286.656367336111, 4461.219286624892, 4812.903741925212, 4932.4327702314695, 4987.401511818605, 5198.402183748917, 5198.584113271005, 5285.7621407036, 5297.2583838263445, 5328.706921119376, 5350.357957045179, 4347.521772604948, 4520.841770538147, 4839.008003359232, 5014.398272207359, 5077.39071311445], "value": 4113.069068772175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.8817001109811, 734.7024455095685, 775.5075527040327, 824.653645468903, 842.3135144856944, 17724.645507089866, 18380.35668751594, 18438.44684659459, 18505.7224141638, 18533.536661583483, 16751.329946802114, 16814.495565133035, 16858.494245172635, 16864.915675421606, 16867.831321686812, 937.8124375124968, 952.342883410448, 958.2477754962356, 958.4393130018947, 963.5134257200104, 928.5450129436595, 949.6438835436711, 950.5627411390768, 958.1281034258826, 963.3689933093834, 986.2110311750607, 990.1583653894169, 991.1080027974845, 992.7071513903416, 993.6720882108923, 991.4992928571097, 991.851222316651, 992.2409356842022, 993.0516356879235, 996.1333639733442, 737.6090671943824, 741.5921243316209, 742.7140550887893, 742.9672754870734, 744.2408743082026, 15557.22213889301, 15912.443064492687, 15972.0, 16137.273822678007, 16419.343226270936, 13935.442582296797, 14071.437142514287, 14114.71770564583, 14175.0, 14233.146011239358, 9779.0, 11756.706082347924, 11794.88205117955, 11855.407229638484, 12057.276563406223, 3559.430491121408, 3604.891853244407, 3666.4133738601695, 3707.9629203707887, 3791.1659434924272, 104518.95481045169, 105250.94749052488, 116784.0, 117091.8290817098, 118516.81483185144, 10759.0, 10973.780524389627, 11055.668329950115, 11079.390633515233, 11114.999999999838, 21280.574388512145, 22704.0, 23024.309270721904, 23038.42403939915, 23065.88467057654, 6778.051072849805, 6814.93185068143, 6905.861882762317, 6975.407090397373, 7066.50534462593, 4066.959330406717, 4105.240530501807, 4113.856015039519, 4119.032027473541, 4120.484939382577, 3121.828299443507, 3159.4313023655964, 3183.697548732913, 3212.7429805615493, 3214.8714051438146, 607.8267693707272, 611.9388061193845, 614.1064750787593, 627.6673363117555, 631.4601016131141, 646.2342124582385, 655.9963256217994, 666.7799626123368, 687.3470203306879, 693.1543516909362, 10083.0, 10104.898951010542, 10167.644132455476, 10296.124829389586, 10330.0, 649.9610023398611, 667.1147287979508, 689.5724650716588, 705.3158436316867, 709.2234003765868, 3821.2357528494413, 4676.579107880307, 4860.635452341088, 4906.55840974314, 4917.606591472745, 99627.0, 103766.0, 104687.0, 105042.94957050485, 107528.38707419395, 41143.38284925729, 47926.76036619864, 50062.749686251336, 68957.65521172361, 96490.0, 73843.63078184682, 76245.0, 77336.0, 78007.60996194869, 78067.219327806, 10848.698914431774, 10888.355162306685, 10903.618373356894, 10957.287776294515, 11205.0, 49076.75461622669, 49095.772605685146, 50016.49983500118, 51591.0, 51702.0, 64458.35541644711, 65536.7740064693, 66835.99492015247, 66899.66550167218, 66981.33018669946, 9709.46597937092, 12078.75842483163, 12495.312757798409, 12603.432845521791, 12708.491660333482, 10776.730581735519, 14359.353829077925, 14424.350904209545, 14748.926255368655, 14930.626734331729, 13220.933895330461, 13408.396622151831, 13601.183928964294, 13717.519886803913, 14016.789748153582, 13340.399682014138, 13473.0, 13516.864831351953, 13539.932300338436, 14407.495737649131, 13183.0, 13271.336433178496, 13309.068365214342, 13783.655408614864, 13835.962302827127, 9630.903690963001, 10815.35107893529, 10890.673279801618, 10906.890931090906, 11216.327020378803, 9173.954130229306, 9501.0, 9557.856632150384, 11109.3481947186, 11221.326720396803], "value": 7550.223377053713, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 169.0, 166.0, 116.0, 114.0, 114.0, 119.0, 166.0, 170.0], "value": 136.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 148.0, 113.0, 112.0, 112.0, 109.0, 131.0, 103.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 189.0, 185.0, 182.0, 186.0, 185.0, 184.0, 186.0, 186.0, 185.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 52.0, 91.0, 75.0, 85.0, 84.0, 62.0, 77.0, 61.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 90.0, 73.0, 72.0, 69.0, 86.0, 71.0, 69.0, 85.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 87.0, 87.0, 86.0, 86.0, 93.0, 87.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 97.0, 94.0, 94.0, 95.0, 106.0, 91.0, 136.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 83.0, 98.0, 127.0, 130.0, 84.0, 83.0, 85.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 59.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 55.0, 64.0, 62.0, 59.0, 59.0, 62.0, 58.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 96.0, 104.0, 106.0, 105.0, 81.0, 88.0, 87.0, 90.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 141.0, 138.0, 139.0, 138.0, 140.0, 142.0, 200.0, 184.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 222.0, 175.0, 173.0, 175.0, 174.0, 172.0, 171.0, 171.0, 172.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 64.0, 84.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 68.2, "unit": "score"}]}]} 09:38:48 INFO - Return code: 0 09:38:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:48 ERROR - # TBPL SUCCESS # 09:38:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:48 INFO - 2017-03-06 09:38:48.884 screenresolution[1998:20509] starting screenresolution argv=screenresolution get 09:38:48 INFO - 2017-03-06 09:38:48.887 screenresolution[1998:20509] Display 0: 1600x1200x32@60 09:38:48 INFO - 2017-03-06 09:38:48.893 screenresolution[1999:20512] starting screenresolution argv=screenresolution list 09:38:48 INFO - Available Modes on Display 0 09:38:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:49 INFO - Intel Iris: 09:38:49 INFO - Chipset Model: Intel Iris 09:38:49 INFO - Type: GPU 09:38:49 INFO - Bus: Built-In 09:38:49 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:49 INFO - Vendor: Intel (0x8086) 09:38:49 INFO - Device ID: 0x0a2e 09:38:49 INFO - Revision ID: 0x0009 09:38:49 INFO - Displays: 09:38:49 INFO - Display: 09:38:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:49 INFO - Display Serial Number: 1600x1200 60 09:38:49 INFO - Main Display: Yes 09:38:49 INFO - Mirror: Off 09:38:49 INFO - Online: Yes 09:38:49 INFO - Rotation: Supported 09:38:49 INFO - Return code: 0 09:38:49 INFO - Running post-action listener: _resource_record_post_action 09:38:49 INFO - [mozharness: 2017-03-06 17:38:49.132172Z] Finished run-tests step (success) 09:38:49 INFO - Running post-run listener: _resource_record_post_run 09:38:49 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 880640; Write bytes: 514827776; Read time: 11; Write time: 1603 09:38:49 INFO - TinderboxPrint: CPU usage
54.1% 09:38:49 INFO - TinderboxPrint: I/O read bytes / time
880,640 / 11 09:38:49 INFO - TinderboxPrint: I/O write bytes / time
514,827,776 / 1,603 09:38:49 INFO - TinderboxPrint: CPU idle
2,213.4 (45.9%) 09:38:49 INFO - TinderboxPrint: CPU system
961.9 (19.9%) 09:38:49 INFO - TinderboxPrint: CPU user
1,646.5 (34.1%) 09:38:49 INFO - TinderboxPrint: Swap in / out
211,316,736 / 0 09:38:49 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205646336; Write bytes: 204081152; Read time: 15747; Write time: 440 09:38:49 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 880640; Write bytes: 299982336; Read time: 11; Write time: 1124 09:38:49 INFO - Running post-run listener: _upload_blobber_files 09:38:49 INFO - Blob upload gear active. 09:38:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:38:49 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'] 09:38:49 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 09:38:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:51 INFO - (blobuploader) - INFO - Done attempting. 09:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:52 INFO - (blobuploader) - INFO - Done attempting. 09:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:52 INFO - (blobuploader) - INFO - Done attempting. 09:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:55 INFO - (blobuploader) - INFO - Done attempting. 09:38:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:55 INFO - Return code: 0 09:38:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10c971da7e150c0542ed787bd2a7f8f1c57c15e01a565ef83bc5e920cf246b7468274e8a906c59d7522e728eaabeb6f6f2e978714ce0adbbac3c0474f57d206b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5900bfa1679e06063ea8a6a427abdc5fca5e31fdb1978ab5375104835b738b18ab9ba3f0291233641ece01e0848f31a4d0323101d4458ea44bb3bc32a1332cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da18cab5eef3051368f175e055d0b4cded4fbb57ab2249a0f3206054fa511862b3f881242f5e45ceaed0576c8f1f0a395a20710ff9517c8faf6784799ac2223", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf0dd1c0f7cabfbbaa9f0f3bb03637f5dee3eadee0c2e4d0450c00a313453aa07cb0402cdc7089c70edf9cb77c5760fec123cd4ee76f7e4356dc8dbc50debff"} 09:38:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:55 INFO - Contents: 09:38:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10c971da7e150c0542ed787bd2a7f8f1c57c15e01a565ef83bc5e920cf246b7468274e8a906c59d7522e728eaabeb6f6f2e978714ce0adbbac3c0474f57d206b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5900bfa1679e06063ea8a6a427abdc5fca5e31fdb1978ab5375104835b738b18ab9ba3f0291233641ece01e0848f31a4d0323101d4458ea44bb3bc32a1332cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da18cab5eef3051368f175e055d0b4cded4fbb57ab2249a0f3206054fa511862b3f881242f5e45ceaed0576c8f1f0a395a20710ff9517c8faf6784799ac2223", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf0dd1c0f7cabfbbaa9f0f3bb03637f5dee3eadee0c2e4d0450c00a313453aa07cb0402cdc7089c70edf9cb77c5760fec123cd4ee76f7e4356dc8dbc50debff"} 09:38:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:55 INFO - Copying logs to upload dir... 09:38:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.878834 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-06 09:38:55.867612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 09:38:55.870998) ========= 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.gFJzV6MhaB/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.flvAmzDeSf/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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/10c971da7e150c0542ed787bd2a7f8f1c57c15e01a565ef83bc5e920cf246b7468274e8a906c59d7522e728eaabeb6f6f2e978714ce0adbbac3c0474f57d206b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5900bfa1679e06063ea8a6a427abdc5fca5e31fdb1978ab5375104835b738b18ab9ba3f0291233641ece01e0848f31a4d0323101d4458ea44bb3bc32a1332cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da18cab5eef3051368f175e055d0b4cded4fbb57ab2249a0f3206054fa511862b3f881242f5e45ceaed0576c8f1f0a395a20710ff9517c8faf6784799ac2223", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf0dd1c0f7cabfbbaa9f0f3bb03637f5dee3eadee0c2e4d0450c00a313453aa07cb0402cdc7089c70edf9cb77c5760fec123cd4ee76f7e4356dc8dbc50debff"} build_url:https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011602 build_url: 'https://queue.taskcluster.net/v1/task/O5H_2xOERWO0mghUwOY5Tg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10c971da7e150c0542ed787bd2a7f8f1c57c15e01a565ef83bc5e920cf246b7468274e8a906c59d7522e728eaabeb6f6f2e978714ce0adbbac3c0474f57d206b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5900bfa1679e06063ea8a6a427abdc5fca5e31fdb1978ab5375104835b738b18ab9ba3f0291233641ece01e0848f31a4d0323101d4458ea44bb3bc32a1332cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1da18cab5eef3051368f175e055d0b4cded4fbb57ab2249a0f3206054fa511862b3f881242f5e45ceaed0576c8f1f0a395a20710ff9517c8faf6784799ac2223", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cf0dd1c0f7cabfbbaa9f0f3bb03637f5dee3eadee0c2e4d0450c00a313453aa07cb0402cdc7089c70edf9cb77c5760fec123cd4ee76f7e4356dc8dbc50debff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 09:38:55.906901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:38:55.907288) ========= 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.gFJzV6MhaB/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.flvAmzDeSf/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 09:38:55.956663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 09:38:55.957149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 09:38:55.957554) ========= ========= Total master_lag: 0.19 =========