builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1490347493.34 results: success (0) buildid: 20170324012224 builduid: 737fe8891d964d8788f9235577b56d95 revision: 1bff0c493536f68a1850c435409495c45c91daf5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:53.344017) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:53.344750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:53.345236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:54.167459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 02:24:54.168138) ========= 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.riNj6Wze6O/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.4137Vlo7yA/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-24 02:24:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.24M=0.001s 2017-03-24 02:24:56 (8.24 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.968330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 02:24:56.160781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:56.161155) ========= 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.riNj6Wze6O/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.4137Vlo7yA/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.020943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:56.212611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-24 02:24:56.213231) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1bff0c493536f68a1850c435409495c45c91daf5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1bff0c493536f68a1850c435409495c45c91daf5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.riNj6Wze6O/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.4137Vlo7yA/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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-24 02:24:56,441 truncating revision to first 12 chars 2017-03-24 02:24:56,441 Setting DEBUG logging. 2017-03-24 02:24:56,441 attempt 1/10 2017-03-24 02:24:56,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1bff0c493536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 02:24:58,573 unpacking tar archive at: mozilla-aurora-1bff0c493536/testing/mozharness/ program finished with exit code 0 elapsedTime=2.395570 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-24 02:24:58.631646) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:58.631993) ========= script_repo_revision: 1bff0c493536f68a1850c435409495c45c91daf5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:58.632434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:58.632704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 02:24:58.655294) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2017-03-24 02:24:58.655641) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.riNj6Wze6O/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.4137Vlo7yA/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:24:58 INFO - MultiFileLogger online at 20170324 02:24:58 in /builds/slave/test 02:24:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:24:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:58 INFO - {'append_to_log': False, 02:24:58 INFO - 'base_work_dir': '/builds/slave/test', 02:24:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:24:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:58 INFO - 'branch': 'Mozilla-Aurora', 02:24:58 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:58 INFO - 'config_files': ('talos/mac_config.py',), 02:24:58 INFO - 'default_actions': ('clobber', 02:24:58 INFO - 'read-buildbot-config', 02:24:58 INFO - 'download-and-extract', 02:24:58 INFO - 'populate-webroot', 02:24:58 INFO - 'create-virtualenv', 02:24:58 INFO - 'install', 02:24:58 INFO - 'run-tests'), 02:24:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:58 INFO - 'download_minidump_stackwalk': True, 02:24:58 INFO - 'download_symbols': 'ondemand', 02:24:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:58 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:58 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:58 INFO - 'gecko_profile': False, 02:24:58 INFO - 'gecko_profile_interval': 0, 02:24:58 INFO - 'installer_path': 'installer.exe', 02:24:58 INFO - 'log_level': 'info', 02:24:58 INFO - 'log_name': 'talos', 02:24:58 INFO - 'log_to_console': True, 02:24:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:24:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:24:58 INFO - 'opt_config_files': (), 02:24:59 INFO - 'pip_index': False, 02:24:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:24:59 INFO - 'cmd': ('bash', 02:24:59 INFO - '-c', 02:24:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:24:59 INFO - 'enabled': True, 02:24:59 INFO - 'halt_on_failure': False, 02:24:59 INFO - 'name': 'check_screen_resolution'},), 02:24:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:24:59 INFO - 'cmd': ('bash', 02:24:59 INFO - '-c', 02:24:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:24:59 INFO - 'enabled': True, 02:24:59 INFO - 'halt_on_failure': False, 02:24:59 INFO - 'name': 'check_screen_resolution'},), 02:24:59 INFO - 'run_cmd_checks_enabled': True, 02:24:59 INFO - 'suite': 'dromaeojs', 02:24:59 INFO - 'system_bits': '32', 02:24:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:59 INFO - 'title': 't-yosemite-r7-0353', 02:24:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:59 INFO - 'use_talos_json': True, 02:24:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:59 INFO - 'work_dir': 'build'} 02:24:59 INFO - [mozharness: 2017-03-24 09:24:59.002675Z] Running clobber step. 02:24:59 INFO - Running pre-action listener: _resource_record_pre_action 02:24:59 INFO - Running main action method: clobber 02:24:59 INFO - rmtree: /builds/slave/test/build 02:24:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:00 INFO - Running post-action listener: _resource_record_post_action 02:25:00 INFO - [mozharness: 2017-03-24 09:25:00.781418Z] Finished clobber step (success) 02:25:00 INFO - [mozharness: 2017-03-24 09:25:00.781564Z] Running read-buildbot-config step. 02:25:00 INFO - Running pre-action listener: _resource_record_pre_action 02:25:00 INFO - Running main action method: read_buildbot_config 02:25:00 INFO - Using buildbot properties: 02:25:00 INFO - { 02:25:00 INFO - "project": "", 02:25:00 INFO - "product": "firefox", 02:25:00 INFO - "script_repo_revision": "production", 02:25:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:25:00 INFO - "repository": "", 02:25:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:25:00 INFO - "buildid": "20170324012224", 02:25:00 INFO - "pgo_build": "False", 02:25:00 INFO - "basedir": "/builds/slave/test", 02:25:00 INFO - "buildnumber": 74, 02:25:00 INFO - "slavename": "t-yosemite-r7-0353", 02:25:00 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:25:00 INFO - "platform": "yosemite_r7", 02:25:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:25:00 INFO - "branch": "mozilla-aurora", 02:25:00 INFO - "repo_path": "releases/mozilla-aurora", 02:25:00 INFO - "revision": "1bff0c493536f68a1850c435409495c45c91daf5", 02:25:00 INFO - "stage_platform": "macosx64", 02:25:00 INFO - "builduid": "737fe8891d964d8788f9235577b56d95", 02:25:00 INFO - "slavebuilddir": "test" 02:25:00 INFO - } 02:25:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:25:00 INFO - Running post-action listener: _resource_record_post_action 02:25:00 INFO - [mozharness: 2017-03-24 09:25:00.785090Z] Finished read-buildbot-config step (success) 02:25:00 INFO - [mozharness: 2017-03-24 09:25:00.785232Z] Running download-and-extract step. 02:25:00 INFO - Running pre-action listener: _resource_record_pre_action 02:25:00 INFO - Running main action method: download_and_extract 02:25:00 INFO - mkdir: /builds/slave/test/build/tests 02:25:00 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')]} 02:25:00 INFO - trying https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:25:03 INFO - Downloaded 1199 bytes. 02:25:03 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:03 INFO - Using the following test package requirements: 02:25:03 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:25:03 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:25:03 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:25:03 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'jsshell-mac.zip'], 02:25:03 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:25:03 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:25:03 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:25:03 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:25:03 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:25:03 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:03 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:25:03 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:25:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:25:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:25:04 INFO - Expected file size: 51787042 02:25:04 INFO - Obtained file size: 51787042 02:25:20 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:25:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:25:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:25:23 INFO - Expected file size: 51787042 02:25:23 INFO - Obtained file size: 51787042 02:25:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:25:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:25:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:25:55 INFO - Expected file size: 14404438 02:25:55 INFO - Obtained file size: 14404438 02:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:55 INFO - trying https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:25:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:26:22 INFO - Downloaded 74765260 bytes. 02:26:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:26:22 INFO - mkdir: /builds/slave/test/properties 02:26:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:22 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:22 INFO - Contents: 02:26:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:26:24 INFO - Running post-action listener: _resource_record_post_action 02:26:24 INFO - Running post-action listener: set_extra_try_arguments 02:26:24 INFO - [mozharness: 2017-03-24 09:26:24.154930Z] Finished download-and-extract step (success) 02:26:24 INFO - [mozharness: 2017-03-24 09:26:24.155083Z] Running populate-webroot step. 02:26:24 INFO - Running pre-action listener: _resource_record_pre_action 02:26:24 INFO - Running main action method: populate_webroot 02:26:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:24 INFO - '--tppagecycles', 02:26:24 INFO - '7'], 02:26:24 INFO - 'tests': ['tsvgm']}}, 02:26:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['damp', 'tps']}, 02:26:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'tests': ['damp', 'tps']}, 02:26:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['dromaeo_dom']}, 02:26:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['basic_compositor_video']}, 02:26:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:26:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['a11yr', 02:26:24 INFO - 'ts_paint', 02:26:24 INFO - 'tpaint', 02:26:24 INFO - 'sessionrestore', 02:26:24 INFO - 'sessionrestore_no_auto_restore', 02:26:24 INFO - 'tabpaint']}, 02:26:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:24 INFO - 'ts_paint', 02:26:24 INFO - 'tpaint', 02:26:24 INFO - 'sessionrestore', 02:26:24 INFO - 'sessionrestore_no_auto_restore', 02:26:24 INFO - 'tabpaint']}, 02:26:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:24 INFO - 'ts_paint', 02:26:24 INFO - 'tpaint', 02:26:24 INFO - 'sessionrestore', 02:26:24 INFO - 'sessionrestore_no_auto_restore', 02:26:24 INFO - 'tabpaint']}, 02:26:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:24 INFO - 'ts_paint', 02:26:24 INFO - 'tpaint', 02:26:24 INFO - 'sessionrestore', 02:26:24 INFO - 'sessionrestore_no_auto_restore', 02:26:24 INFO - 'tabpaint']}, 02:26:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['a11yr', 02:26:24 INFO - 'ts_paint', 02:26:24 INFO - 'tpaint', 02:26:24 INFO - 'sessionrestore', 02:26:24 INFO - 'sessionrestore_no_auto_restore', 02:26:24 INFO - 'tabpaint']}, 02:26:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['a11yr', 02:26:24 INFO - 'ts_paint', 02:26:24 INFO - 'tpaint', 02:26:24 INFO - 'sessionrestore', 02:26:24 INFO - 'sessionrestore_no_auto_restore', 02:26:24 INFO - 'tabpaint']}, 02:26:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['tsvgx', 02:26:24 INFO - 'tsvgr_opacity', 02:26:24 INFO - 'tart', 02:26:24 INFO - 'tscrollx', 02:26:24 INFO - 'cart', 02:26:24 INFO - 'tsvg_static']}, 02:26:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:24 INFO - 'tsvgr_opacity', 02:26:24 INFO - 'tart', 02:26:24 INFO - 'tscrollx', 02:26:24 INFO - 'cart', 02:26:24 INFO - 'tsvg_static']}, 02:26:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'talos_options': ['--disable-e10s'], 02:26:24 INFO - 'tests': ['tp5o']}, 02:26:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:26:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'talos_options': ['--disable-e10s', 02:26:24 INFO - '--xperf_path', 02:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:24 INFO - 'tests': ['tp5n']}, 02:26:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:26:24 INFO - 'talos_options': ['--xperf_path', 02:26:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:24 INFO - 'tests': ['tp5n']}}, 02:26:24 INFO - 'talos.zip': {'path': '', 02:26:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:24 INFO - Running post-action listener: _resource_record_post_action 02:26:24 INFO - [mozharness: 2017-03-24 09:26:24.173634Z] Finished populate-webroot step (success) 02:26:24 INFO - [mozharness: 2017-03-24 09:26:24.173745Z] Running create-virtualenv step. 02:26:24 INFO - Running pre-action listener: _resource_record_pre_action 02:26:24 INFO - Running main action method: create_virtualenv 02:26:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:24 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 02:26:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:24 INFO - Using real prefix '/tools/python27' 02:26:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:27 INFO - Installing pip.................done. 02:26:27 INFO - Return code: 0 02:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:26:28 INFO - Reading from file tmpfile_stdout 02:26:28 INFO - Output received: 02:26:28 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) 02:26:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:28 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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:28 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 02:26:28 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 02:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:28 INFO - 'HOME': '/Users/cltbld', 02:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:28 INFO - 'LOGNAME': 'cltbld', 02:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:28 INFO - 'MOZ_NO_REMOTE': '1', 02:26:28 INFO - 'NO_EM_RESTART': '1', 02:26:28 INFO - 'PAGER': '/bin/cat', 02:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:28 INFO - 'PWD': '/builds/slave/test', 02:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:28 INFO - 'SHELL': '/bin/bash', 02:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:28 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:28 INFO - 'USER': 'cltbld', 02:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:28 INFO - 'XPC_FLAGS': '0x0', 02:26:28 INFO - 'XPC_SERVICE_NAME': '0', 02:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:28 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 02:26:28 INFO - Cleaning up... 02:26:28 INFO - Return code: 0 02:26:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:28 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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:28 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 02:26:28 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 02:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:28 INFO - 'HOME': '/Users/cltbld', 02:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:28 INFO - 'LOGNAME': 'cltbld', 02:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:28 INFO - 'MOZ_NO_REMOTE': '1', 02:26:28 INFO - 'NO_EM_RESTART': '1', 02:26:28 INFO - 'PAGER': '/bin/cat', 02:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:28 INFO - 'PWD': '/builds/slave/test', 02:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:28 INFO - 'SHELL': '/bin/bash', 02:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:28 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:28 INFO - 'USER': 'cltbld', 02:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:28 INFO - 'XPC_FLAGS': '0x0', 02:26:28 INFO - 'XPC_SERVICE_NAME': '0', 02:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:29 INFO - Downloading/unpacking psutil>=3.1.1 02:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:33 INFO - Installing collected packages: psutil 02:26:33 INFO - Running setup.py install for psutil 02:26:33 INFO - building 'psutil._psutil_osx' extension 02:26:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:26:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:26:34 INFO - building 'psutil._psutil_posix' extension 02:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:26:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:26:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:26:34 INFO - ^ 02:26:34 INFO - 1 warning generated. 02:26:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:26:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:34 INFO - Successfully installed psutil 02:26:34 INFO - Cleaning up... 02:26:34 INFO - Return code: 0 02:26:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:26:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:26:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:34 INFO - 'HOME': '/Users/cltbld', 02:26:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:34 INFO - 'LOGNAME': 'cltbld', 02:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:34 INFO - 'MOZ_NO_REMOTE': '1', 02:26:34 INFO - 'NO_EM_RESTART': '1', 02:26:34 INFO - 'PAGER': '/bin/cat', 02:26:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:34 INFO - 'PWD': '/builds/slave/test', 02:26:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:34 INFO - 'SHELL': '/bin/bash', 02:26:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:34 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:34 INFO - 'USER': 'cltbld', 02:26:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:34 INFO - 'XPC_FLAGS': '0x0', 02:26:34 INFO - 'XPC_SERVICE_NAME': '0', 02:26:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:38 INFO - Installing collected packages: mozsystemmonitor 02:26:38 INFO - Running setup.py install for mozsystemmonitor 02:26:38 INFO - Successfully installed mozsystemmonitor 02:26:38 INFO - Cleaning up... 02:26:38 INFO - Return code: 0 02:26:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:38 INFO - 'HOME': '/Users/cltbld', 02:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:38 INFO - 'LOGNAME': 'cltbld', 02:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:38 INFO - 'MOZ_NO_REMOTE': '1', 02:26:38 INFO - 'NO_EM_RESTART': '1', 02:26:38 INFO - 'PAGER': '/bin/cat', 02:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:38 INFO - 'PWD': '/builds/slave/test', 02:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:38 INFO - 'SHELL': '/bin/bash', 02:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:38 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:38 INFO - 'USER': 'cltbld', 02:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:38 INFO - 'XPC_FLAGS': '0x0', 02:26:38 INFO - 'XPC_SERVICE_NAME': '0', 02:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:38 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26:41 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 02:26:41 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 02:26:41 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 02:26:41 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 02:26:41 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 02:26:41 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 02:26:41 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:41 INFO - warning: no files found matching '*.txt' 02:26:41 INFO - no previously-included directories found matching 'build' 02:26:41 INFO - no previously-included directories found matching 'dist' 02:26:41 INFO - no previously-included directories found matching '.git*' 02:26:41 INFO - Installing collected packages: jsonschema, functools32 02:26:41 INFO - Running setup.py install for functools32 02:26:42 INFO - warning: no files found matching '*.txt' 02:26:42 INFO - no previously-included directories found matching 'build' 02:26:42 INFO - no previously-included directories found matching 'dist' 02:26:42 INFO - no previously-included directories found matching '.git*' 02:26:42 INFO - Successfully installed jsonschema functools32 02:26:42 INFO - Cleaning up... 02:26:42 INFO - Return code: 0 02:26:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:42 INFO - 'HOME': '/Users/cltbld', 02:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:42 INFO - 'LOGNAME': 'cltbld', 02:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:42 INFO - 'MOZ_NO_REMOTE': '1', 02:26:42 INFO - 'NO_EM_RESTART': '1', 02:26:42 INFO - 'PAGER': '/bin/cat', 02:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:42 INFO - 'PWD': '/builds/slave/test', 02:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:42 INFO - 'SHELL': '/bin/bash', 02:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:42 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:42 INFO - 'USER': 'cltbld', 02:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:42 INFO - 'XPC_FLAGS': '0x0', 02:26:42 INFO - 'XPC_SERVICE_NAME': '0', 02:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:26:42 INFO - Cleaning up... 02:26:42 INFO - Return code: 0 02:26:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:42 INFO - 'HOME': '/Users/cltbld', 02:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:42 INFO - 'LOGNAME': 'cltbld', 02:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:42 INFO - 'MOZ_NO_REMOTE': '1', 02:26:42 INFO - 'NO_EM_RESTART': '1', 02:26:42 INFO - 'PAGER': '/bin/cat', 02:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:42 INFO - 'PWD': '/builds/slave/test', 02:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:42 INFO - 'SHELL': '/bin/bash', 02:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:42 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:42 INFO - 'USER': 'cltbld', 02:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:42 INFO - 'XPC_FLAGS': '0x0', 02:26:42 INFO - 'XPC_SERVICE_NAME': '0', 02:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:42 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:45 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:46 INFO - Downloading docopt-0.6.1.tar.gz 02:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:47 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:47 INFO - Running setup.py install for blobuploader 02:26:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:47 INFO - Running setup.py install for requests 02:26:47 INFO - Running setup.py install for docopt 02:26:47 INFO - Successfully installed blobuploader requests docopt 02:26:47 INFO - Cleaning up... 02:26:47 INFO - Return code: 0 02:26:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:47 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')]} 02:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:47 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')]} 02:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:47 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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:47 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 02:26:47 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 02:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:47 INFO - 'HOME': '/Users/cltbld', 02:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:47 INFO - 'LOGNAME': 'cltbld', 02:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:47 INFO - 'MOZ_NO_REMOTE': '1', 02:26:47 INFO - 'NO_EM_RESTART': '1', 02:26:47 INFO - 'PAGER': '/bin/cat', 02:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:47 INFO - 'PWD': '/builds/slave/test', 02:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:47 INFO - 'SHELL': '/bin/bash', 02:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:47 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:47 INFO - 'USER': 'cltbld', 02:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:47 INFO - 'XPC_FLAGS': '0x0', 02:26:47 INFO - 'XPC_SERVICE_NAME': '0', 02:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-PMkC9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-E80Dhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-BrRSEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-58T2Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-H_JYok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-y23U2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-LjHNnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:48 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-VutRkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-vNi9lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-tw0LD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-6FXrOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-19s8aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-XWai4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-XghuYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-NvDyc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-XPoH9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:49 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ZHW3zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:49 INFO - Running setup.py install for manifestparser 02:26:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:50 INFO - Running setup.py install for mozcrash 02:26:50 INFO - Running setup.py install for mozdebug 02:26:50 INFO - Running setup.py install for mozdevice 02:26:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:50 INFO - Running setup.py install for mozfile 02:26:50 INFO - Running setup.py install for mozhttpd 02:26:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:50 INFO - Running setup.py install for mozinfo 02:26:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:50 INFO - Running setup.py install for mozInstall 02:26:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Running setup.py install for mozleak 02:26:51 INFO - Running setup.py install for mozlog 02:26:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Running setup.py install for moznetwork 02:26:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Running setup.py install for mozprocess 02:26:51 INFO - Running setup.py install for mozprofile 02:26:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:51 INFO - Running setup.py install for mozrunner 02:26:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Running setup.py install for mozscreenshot 02:26:52 INFO - Running setup.py install for moztest 02:26:52 INFO - Running setup.py install for mozversion 02:26:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:52 INFO - Cleaning up... 02:26:52 INFO - Return code: 0 02:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:52 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')]} 02:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:52 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')]} 02:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:52 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 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:52 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 02:26:52 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 02:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:52 INFO - 'HOME': '/Users/cltbld', 02:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:52 INFO - 'LOGNAME': 'cltbld', 02:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:52 INFO - 'MOZ_NO_REMOTE': '1', 02:26:52 INFO - 'NO_EM_RESTART': '1', 02:26:52 INFO - 'PAGER': '/bin/cat', 02:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:52 INFO - 'PWD': '/builds/slave/test', 02:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:52 INFO - 'SHELL': '/bin/bash', 02:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:52 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:52 INFO - 'USER': 'cltbld', 02:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:52 INFO - 'XPC_FLAGS': '0x0', 02:26:52 INFO - 'XPC_SERVICE_NAME': '0', 02:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:52 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-zgUZZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:52 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-uCgICj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Su0LlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-z_jvl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-2uQH0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-YzZigy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-sdbPXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-L1Bbkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-45oSH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-fbNRDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:53 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)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-TIKkQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:53 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-k6aQcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:54 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Nx2vUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:54 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-oDuuzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:54 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-VJswca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:54 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-2VDqdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:54 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)) 02:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:54 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-5UVsOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:54 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)) 02:26:54 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)) 02:26:54 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)) 02:26:54 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)) 02:26:54 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)) 02:26:54 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)) 02:26:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:54 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 02:26:54 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 02:26:54 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 02:26:54 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 02:26:54 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 02:26:54 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 02:26:57 INFO - Downloading blessings-1.6.tar.gz 02:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:57 INFO - Installing collected packages: blessings 02:26:57 INFO - Running setup.py install for blessings 02:26:57 INFO - Successfully installed blessings 02:26:57 INFO - Cleaning up... 02:26:57 INFO - Return code: 0 02:26:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:57 INFO - Reading from file tmpfile_stdout 02:26:57 INFO - Current package versions: 02:26:57 INFO - blessings == 1.6 02:26:57 INFO - blobuploader == 1.2.4 02:26:57 INFO - docopt == 0.6.1 02:26:57 INFO - functools32 == 3.2.3-2 02:26:57 INFO - jsonschema == 2.5.1 02:26:57 INFO - manifestparser == 1.1 02:26:57 INFO - mozInstall == 1.12 02:26:57 INFO - mozcrash == 1.0 02:26:57 INFO - mozdebug == 0.1 02:26:57 INFO - mozdevice == 0.49 02:26:57 INFO - mozfile == 1.2 02:26:57 INFO - mozhttpd == 0.7 02:26:57 INFO - mozinfo == 0.9 02:26:57 INFO - mozleak == 0.1 02:26:57 INFO - mozlog == 3.4 02:26:57 INFO - moznetwork == 0.27 02:26:57 INFO - mozprocess == 0.25 02:26:57 INFO - mozprofile == 0.28 02:26:57 INFO - mozrunner == 6.13 02:26:57 INFO - mozscreenshot == 0.1 02:26:57 INFO - mozsystemmonitor == 0.3 02:26:57 INFO - moztest == 0.8 02:26:57 INFO - mozversion == 1.4 02:26:57 INFO - psutil == 3.1.1 02:26:57 INFO - requests == 1.2.3 02:26:57 INFO - wsgiref == 0.1.2 02:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:57 INFO - 'HOME': '/Users/cltbld', 02:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:57 INFO - 'LOGNAME': 'cltbld', 02:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:57 INFO - 'MOZ_NO_REMOTE': '1', 02:26:57 INFO - 'NO_EM_RESTART': '1', 02:26:57 INFO - 'PAGER': '/bin/cat', 02:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:57 INFO - 'PWD': '/builds/slave/test', 02:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:57 INFO - 'SHELL': '/bin/bash', 02:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:57 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:57 INFO - 'USER': 'cltbld', 02:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:57 INFO - 'XPC_FLAGS': '0x0', 02:26:57 INFO - 'XPC_SERVICE_NAME': '0', 02:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 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)) 02:26:58 INFO - Cleaning up... 02:26:58 INFO - Return code: 0 02:26:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:58 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')]} 02:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 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')]} 02:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108de6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108de9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0a24a9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, '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.riNj6Wze6O/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.4137Vlo7yA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 02:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:58 INFO - 'HOME': '/Users/cltbld', 02:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:58 INFO - 'LOGNAME': 'cltbld', 02:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:58 INFO - 'MOZ_NO_REMOTE': '1', 02:26:58 INFO - 'NO_EM_RESTART': '1', 02:26:58 INFO - 'PAGER': '/bin/cat', 02:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:58 INFO - 'PWD': '/builds/slave/test', 02:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:58 INFO - 'SHELL': '/bin/bash', 02:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:26:58 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:58 INFO - 'USER': 'cltbld', 02:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:58 INFO - 'XPC_FLAGS': '0x0', 02:26:58 INFO - 'XPC_SERVICE_NAME': '0', 02:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:58 INFO - Cleaning up... 02:26:58 INFO - Return code: 0 02:26:58 INFO - Running post-action listener: _resource_record_post_action 02:26:58 INFO - Running post-action listener: _start_resource_monitoring 02:26:58 INFO - Starting resource monitoring. 02:26:58 INFO - [mozharness: 2017-03-24 09:26:58.485934Z] Finished create-virtualenv step (success) 02:26:58 INFO - [mozharness: 2017-03-24 09:26:58.486928Z] Running install step. 02:26:58 INFO - Running pre-action listener: _resource_record_pre_action 02:26:58 INFO - Running main action method: install 02:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:58 INFO - Reading from file tmpfile_stdout 02:26:58 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:58 INFO - Reading from file tmpfile_stdout 02:26:58 INFO - Output received: 02:26:58 INFO - Usage: mozinstall [options] installer 02:26:58 INFO - Options: 02:26:58 INFO - -h, --help show this help message and exit 02:26:58 INFO - -d DEST, --destination=DEST 02:26:58 INFO - Directory to install application into. [default: 02:26:58 INFO - "/builds/slave/test"] 02:26:58 INFO - --app=APP Application being installed. [default: firefox] 02:26:58 INFO - mkdir: /builds/slave/test/build/application 02:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:27:18 INFO - Reading from file tmpfile_stdout 02:27:18 INFO - Output received: 02:27:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:27:18 INFO - Running post-action listener: _resource_record_post_action 02:27:18 INFO - [mozharness: 2017-03-24 09:27:18.816912Z] Finished install step (success) 02:27:18 INFO - [mozharness: 2017-03-24 09:27:18.817063Z] Running run-tests step. 02:27:18 INFO - Running pre-action listener: _resource_record_pre_action 02:27:18 INFO - Running main action method: run_tests 02:27:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:27:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:27:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:27:18 INFO - 2017-03-24 02:27:18.831 screenresolution[1897:17854] starting screenresolution argv=screenresolution get 02:27:18 INFO - 2017-03-24 02:27:18.834 screenresolution[1897:17854] Display 0: 1600x1200x32@60 02:27:18 INFO - 2017-03-24 02:27:18.839 screenresolution[1898:17856] starting screenresolution argv=screenresolution list 02:27:18 INFO - Available Modes on Display 0 02:27:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:27:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:27:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:27:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:27:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:27:19 INFO - Intel Iris: 02:27:19 INFO - Chipset Model: Intel Iris 02:27:19 INFO - Type: GPU 02:27:19 INFO - Bus: Built-In 02:27:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:27:19 INFO - Vendor: Intel (0x8086) 02:27:19 INFO - Device ID: 0x0a2e 02:27:19 INFO - Revision ID: 0x0009 02:27:19 INFO - Displays: 02:27:19 INFO - Display: 02:27:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:27:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:27:19 INFO - Display Serial Number: 1600x1200 60 02:27:19 INFO - Main Display: Yes 02:27:19 INFO - Mirror: Off 02:27:19 INFO - Online: Yes 02:27:19 INFO - Rotation: Supported 02:27:19 INFO - Return code: 0 02:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:19 INFO - Python 2.7.3 02:27:19 INFO - Return code: 0 02:27:19 INFO - grabbing minidump binary from tooltool 02:27: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')]} 02:27:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc4d30>, '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 0x108aebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108bb9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:27:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:27:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:27:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:19 INFO - Return code: 0 02:27:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:27:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:19 INFO - ENV: RUST_BACKTRACE is now 1 02:27:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:27:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 02:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 02:27:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.riNj6Wze6O/Render', 02:27:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:19 INFO - 'HOME': '/Users/cltbld', 02:27:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:19 INFO - 'LOGNAME': 'cltbld', 02:27:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:19 INFO - 'MOZ_NO_REMOTE': '1', 02:27:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:19 INFO - 'NO_EM_RESTART': '1', 02:27:19 INFO - 'PAGER': '/bin/cat', 02:27:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:19 INFO - 'PWD': '/builds/slave/test', 02:27:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:19 INFO - 'RUST_BACKTRACE': '1', 02:27:19 INFO - 'SHELL': '/bin/bash', 02:27:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4137Vlo7yA/Listeners', 02:27:19 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 02:27:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:19 INFO - 'USER': 'cltbld', 02:27:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:19 INFO - 'XPC_FLAGS': '0x0', 02:27:19 INFO - 'XPC_SERVICE_NAME': '0', 02:27:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 02:27:19 INFO - mozversion application_buildid: 20170324012224 02:27:19 INFO - mozversion application_changeset: 1bff0c493536f68a1850c435409495c45c91daf5 02:27:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:27:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:19 INFO - mozversion application_name: Firefox 02:27:19 INFO - mozversion application_remotingname: firefox-dev 02:27:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:19 INFO - mozversion application_vendor: Mozilla 02:27:19 INFO - mozversion application_version: 54.0a2 02:27:19 INFO - mozversion platform_buildid: 20170324012224 02:27:19 INFO - mozversion platform_changeset: 1bff0c493536f68a1850c435409495c45c91daf5 02:27:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:19 INFO - mozversion platform_version: 54.0a2 02:27:19 INFO - using testdate: 1490347639 02:27:19 INFO - actual date: 1490347639 02:27:19 INFO - starting webserver on 'localhost:54169' 02:27:19 INFO - SUITE-START | Running 2 tests 02:27:19 INFO - TEST-START | dromaeo_css 02:27:19 INFO - operating with platform_type : mac_ 02:27:19 INFO - Initialising browser for dromaeo_css test... 02:27:19 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp0dNUqK/profile http://localhost:54169/getInfo.html) 02:27:21 INFO - PROCESS | 1908 | __metrics Screen width/height:1600/1200 02:27:21 INFO - PROCESS | 1908 | colorDepth:24 02:27:21 INFO - PROCESS | 1908 | Browser inner width/height: 1024/689 02:27:21 INFO - PROCESS | 1908 | __metrics 02:27:22 INFO - PROCESS | 1908 | 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" 02:27:22 INFO - PROCESS | 1908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:22 INFO - TEST-INFO | 1908: exit 0 02:27:22 INFO - Browser initialized. 02:27:22 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:22 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp0dNUqK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:34 INFO - PROCESS | 1910 | RSS: Main: 214814720 02:27:34 INFO - PROCESS | 1910 | 02:30:39 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54169/tests/dromaeo/cssquery-ext.html) 02:30:41 INFO - PROCESS | 1910 | RSS: Main: 369881088 02:30:41 INFO - PROCESS | 1910 | 02:32:24 INFO - PROCESS | 1910 | ************************* 02:32:24 INFO - PROCESS | 1910 | A coding exception was thrown and uncaught in a Task. 02:32:24 INFO - PROCESS | 1910 | 02:32:24 ERROR - PROCESS | 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:32:24 INFO - PROCESS | 1910 | Full stack: 02:32:24 INFO - PROCESS | 1910 | ************************* 02:33:44 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-ext.html (next: http://localhost:54169/tests/dromaeo/cssquery-jquery.html) 02:33:45 INFO - PROCESS | 1910 | RSS: Main: 350023680 02:33:45 INFO - PROCESS | 1910 | 02:36:47 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54169/tests/dromaeo/cssquery-mootools.html) 02:36:48 INFO - PROCESS | 1910 | RSS: Main: 332427264 02:36:48 INFO - PROCESS | 1910 | 02:39:50 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54169/tests/dromaeo/cssquery-prototype.html) 02:39:51 INFO - PROCESS | 1910 | RSS: Main: 318562304 02:39:51 INFO - PROCESS | 1910 | 02:42:55 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54169/tests/dromaeo/cssquery-yui.html) 02:42:55 INFO - PROCESS | 1910 | RSS: Main: 326868992 02:42:55 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-yui.html (next: http://localhost:54169/tests/dromaeo/cssquery-dojo.html) 02:45:59 INFO - PROCESS | 1910 | RSS: Main: 374988800 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | __start_tp_report 02:45:59 INFO - PROCESS | 1910 | _x_x_mozilla_page_load 02:45:59 INFO - PROCESS | 1910 | _x_x_mozilla_page_load_details 02:45:59 INFO - PROCESS | 1910 | |i|pagename|runs| 02:45:59 INFO - PROCESS | 1910 | |0;dojo.html;3374.139594403427;3416.6070901846297;3423.1955490459754;3423.8288085595723;3474.965250347497;6038.737382020963;6075.665838378887;6087.5738698291025;6106.688135492151;6134.509239260859;6055.606385584934;6098.756049758004;6100.298465676448;6107.572469927096;6119.08213767935;5365.490278423544;5403.78384864605;5405.972970135143;5434.3207099112615;5499.560035197194;5334.226537152111;5352.2239275305055;5510.173473978895;5511.173324001412;5520.254765606632;5389.946100539003;5419.891602167954;5435.266239057736;5445.673259604417;5446;5430.70131142787;5432.483914028161;5436.048691479014;5452.2094296327205;5456.290682211326;4142.275101857163;5300.893982120375;5392.487713667196;5397.7031263280505;5425.321834770653;6067.787627433063;6102.664353460558;6103.450689437927;6109.083637454373;6114.755409783604;6331.936680633181;6334.208223972004;6347.174867267272;6360.777372791977;6361.968190159019;6363.93636063638;6375.203099612549;6381.712822922979;6382.266039405481;6419.390157934989;6152.046432802923;6179.412955769195;6198.504119670415;6205.3484384139465;6213.658248796314;6657.567258128206;6678.298778628271;6678.36555527229;6689.866202675919;6705.597664140168;6238.095476156022;6284.654344011032;6296.811095667137;6306.621602703761;6329.810105696744;6474.773382931669;6519.837004074936;6520;6523.7716679915975;6530.836729081716;6313.43179113882;6439.967800160969;6442.065900444503;6447.419732224029;6448.387403196689;6301.338359472281;6308.148399965946;6352.61884286935;6432.195975503062;6445.2265728112925;5120.820771273062;5176.5858731301405;5192.247124166975;5204.9219261711105;5205.713685747321;4557.886052848706;4564.7032942858605;4574.542545745466;4584;4608.769561521911;5765.336986246635;5883.352831188566;6093.634381937098;6124.173236613089;6153.323134455206;5681.886362272814;5932.614380065282;6381;6397.776077837253;6440.677966101676;6115.113308570232;6152.600080994721;6157.261128664589;6170.197874276315;6187.690615469209;5679.148127780866;5697.9430205698245;5703.857403564944;5713.285839270091;5718.456746609066;5508.641938274;6448.1939757531245;6454.806355809334;6717.832054198489;6762.932370676427;6468.5472016958365;6509.446697030616;6509.8698026040165;6518.478521718156;6520.543561950618;6681.632510211985;6682.69927853238;6765.9661701691175;6771.052052712723;6784.2876497967;6282;6286.65423401699;6312.400321969406;6401.8719625608155;6427.517936154901;6454.19322584677;6458.67706614658;6460.612363258219;6478.546501744832;6489.1888513935755;6337.334579869047;6337.809865704036;6341.682915854281;6346.365363463801;6350.523710721622;6237.376262373908;6253.937460625336;6305.369463053658;6360.936390636034;6363.936360636334;4865.659403841839;6150.661713605795;6246.437820596168;6247.656378899204;6269.279032911274;6334.524910631629;6348.206474190726;6368.936310637019;6370.872582548416;6389.105525226379;6029.51763858899;6078.939210607838;6110.801781737137;6158.846028849135;6229.096780966644 02:45:59 INFO - PROCESS | 1910 | |1;ext.html;755.3805879179075;788.3535500889271;814.674130347861;870.3950754225816;883.0992387764477;28192;28576.857115714418;29591.999999999975;40248.195036099336;41029.384559231636;41393.793031034875;41567.79216103923;41617.37573936393;41742.37386439206;41755.37366939498;9130.863037054432;9268.768280793;9285.25717942563;9291.907080929206;9308.34841561091;7318.524295920774;7467.253274672544;9213.539323033856;10938.124950003981;11167.720806979809;10145.391276523433;10484.790304193912;11191;11196;11245.83131253032;11118.888811111907;11139.554417823278;11142.610008649739;11158;11169.38568378747;7350.08123984502;7528.774136775905;10686.305390149615;10917.454127293604;10943.83584246237;39479.802600987096;39604.80197599022;39797.20405591872;39801.40297895534;39808.80573582797;3821.675157611606;3827.6363745444137;3867.207222519377;3903.316919539069;3945.3292940200236;27162.32094197641;27248.727512724818;27491.17526474209;29084.563731544044;29214.831406743706;3111.128883912508;3139.2465808206093;3141.1361875484195;3144.701253380925;3169.714725674677;361143.3885661162;361187;362547;362737;363494;41438.79280603577;42525.93685157834;43686.344704829455;43713.34429983553;52311.73844130755;42856.78571607184;42901.49844755481;43004;43069.92325191895;43226;13558.593242202749;13612.115212511155;13613.319334033258;13635.863641363658;13658.863411365957;12015.879841201651;12017.699557510958;12024.639260822189;12072.396380180955;12201;9200.217981471516;9571.569279382444;9674.371165874196;9681.564329605184;9697.951510242403;4914.803407863646;5254;5255.973720131375;5262.500062494057;5263.5525980292105;1043.139409986764;1058.216919479595;1070.5129166229347;1078.7788503356794;1117.1453837814079;26914.32714182161;27540.173794786187;27568.862155689094;27616;27694.446111077665;948.3551185193996;1116.5924437580225;1186.6262127429832;1235.43170141734;1251.3367915005063;13156.40796164175;13604.047716659938;13791.586252412444;13885.930570347286;14208.218547979961;510308;513010;513438;513590;513755;55014.17478737822;55274.44725552693;55525.444745552835;55599;55737;1319.7822359310799;1357.9408061711881;1461.3496993837641;1475.8671719545293;1475.970480590382;25062.74686265643;25895.482090358466;26025.82883770197;26106.73893261119;26157.692115393773;44186.779066104464;44291.33562996493;44328.11343773171;44462.77768611136;44484.88787780331;458988;461388.6930565326;461641;461742;461768;30876.536851947687;31421;31435.685643143275;31488.212794680316;31545.36909261848;32288.35423291568;37917.81041094777;42961.3555796657;43541.3468797962;44012;32752.76210158141;36103.81948090243;36117;36836.81581592182;37177.25645487129;34948.825255873555;35069.47395789014;35112;36009.81995090008;36286;34875.825620871736;35257.118572035906;35294;35310.646893530735;35869.82065089658;30042.248943775707;31356.372872541964;31405;31427.685723142476;31552;23407.41481462977;23537.293881183592;23963.400914977265;23997.520049598563;24157.63763543513 02:45:59 INFO - PROCESS | 1910 | |2;jquery.html;387.86618616577306;407.86948176583485;426.4030357499501;427.71770631383293;449.2542379649782;12724.936375318122;14722.852771472282;20966.16135354586;21143.894280528577;21516.8924155379;21375.6793648095;21587.892060539674;22061.22785702501;22113.004914778834;22310.330690079325;6301.086342480337;6409.0066039763915;6517.837054073639;6566.835829104263;6577.704003319862;4049.817758200888;4312.892177695567;6426;6552.901706474383;6555.0495178199135;4306.633936115434;4307.82768689252;7445.255474452566;7462.850742985137;7497.437692173082;7173.461990350745;7399.149097853762;7449.627518624047;7450.441216908726;7480.812979675497;6176.722047507873;6967.79096627102;7248.927510724878;7261.927380726178;7273.709051637981;25813.870930645226;26021.869890650614;26205.9517619295;26376.20871373862;26807.865960670268;2889.133260021985;2899.275181204699;2918.430905973336;2921.4449254641763;2940.911772646824;15565;15822.813289003256;15979.920100399424;16520.339186432648;16577;1971.930982415623;1974.5063734066484;1990.1139476714116;1990.5919286546223;2016.4656366063004;127696.36151819275;131164;131268;133372;133748.66251337458;16142.838571614368;17776.844505107125;19076.904615477113;20616.69074963877;20963.846988415782;34063.489047664305;34631.82684086564;34696.82651586726;34940.82529587387;35023.824880875436;10316.948415257875;10663.68008959717;10806.78386432267;10849.78300433987;11009.201825370234;8841.336899732545;8850.114988501098;8856.512891791013;9018.233450156678;9048.140426659456;8196.877046844302;8983.416077954913;9170.128837760401;9786;10027.448490332956;4047.514298284225;4106.40457133714;4107.568705285902;4130.235906357333;4145.2952997990415;896.6413434626202;926.2543652359781;926.9073092690812;933.8365785987424;934.2852717670987;19974.352499641012;21327;21366.78633213679;21383.786162138178;21520.354389368345;905.9864102038474;947.7488465556632;956.93779904306;975.8341082016075;984.1536278800226;10433.426161561187;10489.265751397328;10508.159347252202;10567;10577.36535807854;789973;790927.1360929591;791875;804450;823112;115634;148010;148863;153644.2317788404;154399;1155.8959693627446;1196.8324434579165;1252.3237451776122;1254.8305978692943;1258.3205069262679;18608.44174674762;18665.906670467102;19252;19265.711014334516;19351.806481935;50712.732181695756;55938;57422.13866791918;60730.696346519755;61341;68544.6572767133;85268;85400.57299713462;85660.5716971436;88400.11599884176;10594.682159535227;10844.783104338027;11195.384253866116;11393.373364464702;11395.943020284845;12265.448054837732;12620.936895315464;12622.747545048864;12735.681607959505;12742.936285318885;10476.00477954593;10504.527296271839;10698.358098514114;10720.785584288427;10885.23803333759;10550.736231593964;10723.195760318164;11072.501737421675;11081.778364432505;11142.832857507306;10886.29239099456;11235.269707469315;11248.325100493996;11260.353816853198;11334.376609286568;11000.889991099986;11276.436178190894;11413.657590272305;11415;11425.914538118865;10325.793484130425;10367;10623.681289561326;10686.358818470917;10757 02:45:59 INFO - PROCESS | 1910 | |3;mootools.html;1333.9066265361423;1551.0306058713304;1563.319955819218;1578.4080969636386;1581.2251996521704;9898;10970.945145274272;10975.396353200591;10977.615783447562;10986.395748233854;10655.360678359304;10661.520231589579;11026.724331891706;11105.72235694108;11135.777284454327;2399.3761621978324;2433.902643894242;2434.306222726523;2438.926832195037;2440.3045132137345;2382.0352757133387;2418.4074901649033;2424.078850036992;2424.212131057405;2424.9757502425014;2381.333226696519;2391.6173412254043;2405.458771776354;2406.049610403898;2410.2528216253017;1985.3051431998829;2332.918347857817;2355.740868504463;2359.138914296278;2363.373705967911;2320.7679232076657;2349.993261489157;2377.5839228135005;2380.523895220963;2380.6191009438407;10876;10976.615818446317;10992.945035274852;10998.560057597686;11020.173486988508;5838.678872662002;6003.759849606011;6025.096235564656;6031.125486804389;6031.155638210654;3528.9294214115575;3658.762180458262;3695.2794205130012;3726.5528136623507;3754.7747135171703;1189.9881001190051;1199.466237524302;1207.1730864357855;1255.3534929511309;1272.6182145356356;13693.452261909511;14029.017968742191;15120.319585618563;15350.385984560604;15596.922015389964;4692.741899195509;4792.976035119802;4807.543283388072;4814.253790662453;4822.204336284544;11518.942405288088;11546.94226528862;11556.826647600292;11579.88420115805;11618.76762464746;4888.706677599284;5076.213186956028;5098.056859480934;5105.540501354896;5800.361960184377;4638.211504044253;5199.220116982483;5345.091334473149;5348.491893270133;5349.946500535023;3838.405047217686;3900.4539364488996;3971.126352202511;3978.980105099514;3979.462772525672;1008.5915204342253;1031.504877658728;1046.4558429616557;1047.6961681112543;1050.4642632257603;795.4710117771733;817.5912043978011;835.5613303015965;861.5821326656567;864.7967727584013;5820.777636696256;6409.615423074537;6502.92701704223;6855.485838562127;6944.409725173316;908.5411867007119;1021.9642312519175;1037.3309215555923;1051.4900273367412;1058.3015209961388;4215.831366745296;4233.597808208216;4286.828526858953;4362.694611377173;4378.277584198635;14102.858971410154;14362.994590378783;14589.489367872073;14593.92703036478;14657.193854338113;13986.720265594631;14127;14449.638759031108;14454.421823127168;14465.78301325481;10220.846687299696;10330.483475826179;10340.948295258475;10403.323783953867;10452.111570516592;6508.73965041412;6655.3344665535;6666.333366663295;6674.232463266787;6851.109355783717;12252.448639811051;12471.5011399543;12669.239845609292;12673.683157921127;12681.80977285323;9998.740590759991;12327.383630818602;12574.811377829157;12917.870821291666;13159.736805264032;8301.916980830356;8586.570671466277;8685.478871267744;8686.391952563512;8687.826243474969;10384.221183411426;10386.42874641902;10413.323133996266;10479.738006549896;10559.99680030396;9299.349045566745;9331.906680933374;9379.015203403816;9412;9455.385399948982;9135.63457461694;9151.908480915372;9154.267658587163;9223.631054757734;9263.9809620943;7969.960150199444;8145.79635509117;8147.75556733299;8149.144339844231;8152.3478121751305;5932.228810254812;5986;6027.78902738402;6136.2636483622255;6211.720472578654;5955.166276721176;6051.243594550681;6062.030075187949;6216.906746398718;6364.3134569338235 02:45:59 INFO - PROCESS | 1910 | |4;prototype.html;332.8782004644348;374.7882446417774;381.9159784847336;383.5205992509365;385.4584309045792;4484.9551504485025;4665.300204969256;4821.734804585746;5184.637075404723;5188.195829646402;3928.705347098965;4193.5387107418155;4725.740084295371;5036.546710796028;5037.84886453406;3548.325818094567;3573.1945478065777;3740.7007439404783;3808.219315040424;4053.756774593519;4258.7870606469705;4298.463906295286;4311.852347786118;4343.500497442803;4415.536368681291;3767.227718317752;4365.6507479401735;4372.60076775432;4376.824927002916;4423.77881105945;3458.515807786912;3755.9295600753653;4178.310578754502;4264.530901600806;4418.182636212295;3494.9825250873837;3636.5090712753704;3749.2003838157566;4089.977505623594;4117.785253350269;4279.079997800488;4383.473983122046;4971.776270067856;4979.676321039121;5035.244713292998;4770.403699537558;4931.482194369575;4982.57648099912;4986.626003049786;5091.414487333967;4596.873765927336;5260.842174734764;5360.9463905360835;5456.508914197701;5469.753861076221;4481.193385190664;4706.082313948781;4716.410448693913;4766.618670506351;4775.14047471455;4821.734804585746;5363.195520671891;5607.467290607386;5734.369219385864;5788.565857560658;4033;4060.2285565742413;4685.320628508915;4732.408448943882;4754.78603462845;3983.541892682321;4591.6353078164775;4633.907321853544;4792.856214313576;4804.246450045708;4295.78521073945;4629.953700463019;4651.511591282934;5004.3494345734825;5079.6792833863465;4371.868843934687;5307.814226502054;5313.203019547099;5328.401479556118;5413.539849112791;1401.9158850469005;1428.0003997202;1627.397862790775;1657.7596248543894;1663.7088509510788;1132.8753837077916;1183.4910988275124;1225.8957988570894;1257.5095712672064;1306.8235788168665;4232.470941132358;4635.188841952645;4657.417822772153;5020.7114340106555;5053.46938571452;4613.723176609415;4805.663603547718;4854.320395144682;5547.947259514006;5549.556035517149;4239.918820700763;4477.238869392211;4554;4803.855884323476;5023.874403139951;2778.499091145172;2812.85935703214;2842.4883520966423;2948.9557656635166;2964.762818974477;5755.683237571821;5758.539316854642;5839.1606643907035;5850.5027072699295;5868.122200895672;5218.66078704883;5454.699991500505;5490.752916118784;5651.208830763697;5727.971360143172;5037.750650830194;5318.8936221276135;5717.313922329347;5727.5417966561745;5755.827325180251;4745.430548334222;4753.597688681778;4785.545373189541;5323.574114070788;5498.388265573981;4575.885602859955;4978.800847966186;5248.239005344128;5451.781928722807;5492.340919089735;4708.858734237979;4953.554180123806;5602.263298377516;5606.327240731139;5677.914831277451;4080.551668998577;4225.9577404225565;4328.095637919306;4328.415663885336;4355.1507456045765;4955.776990035385;5117.923231151462;5315.681059136464;5619.8876022480135;5654.575906807088;4234.089670720809;4877.5613192699775;5028.969061342489;5422.945770542244;5432.864178395572;5003.399592048978;5374.328208973879;5403.189521571796;5452.5365343946205;5473.370562385377;4428.512863585068;4617.538246175355;4655.487896331469;5205.947940520547;5319.920201197063;4398.69209155356;4932.630052745986;5263.315768950012;5348.197770334481;5350.357957045179;4537.682362234612;5189.740512974412;5258.8159414420315;5315.468453154654;5390.919136212881 02:45:59 INFO - PROCESS | 1910 | |5;yui.html;711.2141084102063;714.6819665248967;756.5838788666235;789.6249281591245;812.7724237213582;14900.254987250635;15584;15624.140672263022;15645.999999999985;15661.843381566181;13495.73008539831;14281.571552853406;14507.637309067251;14523.491677791279;14565.490207842728;922.1055576091181;937.4984383354906;939.6006697153716;944.1691311645742;944.3106532231475;909.7043460875209;921.8985911549725;924.97789942114;930.5533343994887;942.4580866002076;988.3081842710096;991.1723710701536;992.1864071461405;992.885818130917;993.587661120634;987.244757760314;987.5407935310044;988.0613417253602;989.7921436498344;990.8067926754286;741.5402450480683;741.7737590035038;744.408195484591;744.8398594302197;745.1430854517348;12404.317762523058;15464.226788660635;15607.141607211599;15628.218589070615;16139.435119770751;13920.37358318878;14195.361208745631;14226;14310.21293828839;14316.42734290627;11867.762644747143;11884.584039558575;11920.582779602759;11942.104342174373;11989.94005029978;3349.279904820451;3617.149969757105;3645.5260816093737;3680.3743363628246;3781.6785573226307;99346.5032674832;109084;109834;111758;112145.87854121436;10146.847797283046;10630.30902991303;10693.251472397013;10936.890631093587;11360.48877800501;20945;21978;22324.776752232596;22490.775092249194;22674.65988010181;7628.8855667165035;7773.494722842997;7861.646225919847;7951;8092.919070809335;4271.124419494058;4333.15503476819;4419.535948725337;4517.435320584927;4524.7511386873375;3428.468587368962;3465.7747246428903;3474.270403215353;3494.6155922848466;3499.2126771476724;638.7221558622015;639.7792761497276;650.6941737383422;670.0686046395514;672.5661948043485;588.5144755576666;639.3318981664172;677.9796606101825;691.19475810681;700.5971566349267;9246.691550729458;9932.304574780384;9935.13178542509;9986.900130998742;11039.724006899893;557.1725986909436;575.7437940116608;583.3728741602794;640.3916279534461;687.608063403865;3703.9074023149096;4292.248856450171;4897.1674815281485;4985.426675932242;4990.925136122961;66159.00761488582;74920.62539687267;98317;104418;107534.46232768786;84345;84932.57533712416;86289;86891.56554217315;89859.58038611634;78908;80038.59980700059;80627.5968620165;82416;82545;9363.625454981997;9693.660721874701;9719.611215551298;9729.659461918798;9730.12428881404;45826.54173458223;46710.76644616755;47554.76222618865;49463.01073978428;50077.49922500728;51707.44877653677;56971.71514142403;63791;64632.91654868442;65890;11135.276207046516;12154.817130228663;12612.621621351007;12878.484860605471;13340.866591333963;14248.358823852745;14729.330267832996;14748.336324865193;14814.703705926036;15526.1460619667;13557.322133893069;13931.72136557243;13948.930255348658;14031.719365612835;14032.649183770487;12891.935540322238;12930.224186548838;12941.352932353533;13270.734585308433;13333.599992000256;13620.591382258548;13635.86364136346;13770.65573360674;13815.654608634462;13928.930355348159;10896;11146.665600032013;11343.659690209306;11916.880831191576;11954;9412.341136120405;11146.331220126818;11335.433228338385;11355.54577816878;11403.201775875608 02:45:59 INFO - PROCESS | 1910 | __end_tp_report 02:45:59 INFO - PROCESS | 1910 | __start_cc_report 02:45:59 INFO - PROCESS | 1910 | _x_x_mozilla_cycle_collect,1590 02:45:59 INFO - PROCESS | 1910 | __end_cc_report 02:45:59 INFO - PROCESS | 1910 | __startTimestamp1490348759422__endTimestamp 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | ------- Summary: start ------- 02:45:59 INFO - PROCESS | 1910 | Number of tests: 6 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | [#0] dojo.html Cycles:165 Average:5971.99 Median:6205.35 stddev:687.10 (11.1%) stddev-sans-first:658.29 02:45:59 INFO - PROCESS | 1910 | Values: 3374.1 3416.6 3423.2 3423.8 3475.0 6038.7 6075.7 6087.6 6106.7 6134.5 6055.6 6098.8 6100.3 6107.6 6119.1 5365.5 5403.8 5406.0 5434.3 5499.6 5334.2 5352.2 5510.2 5511.2 5520.3 5389.9 5419.9 5435.3 5445.7 5446.0 5430.7 5432.5 5436.0 5452.2 5456.3 4142.3 5300.9 5392.5 5397.7 5425.3 6067.8 6102.7 6103.5 6109.1 6114.8 6331.9 6334.2 6347.2 6360.8 6362.0 6363.9 6375.2 6381.7 6382.3 6419.4 6152.0 6179.4 6198.5 6205.3 6213.7 6657.6 6678.3 6678.4 6689.9 6705.6 6238.1 6284.7 6296.8 6306.6 6329.8 6474.8 6519.8 6520.0 6523.8 6530.8 6313.4 6440.0 6442.1 6447.4 6448.4 6301.3 6308.1 6352.6 6432.2 6445.2 5120.8 5176.6 5192.2 5204.9 5205.7 4557.9 4564.7 4574.5 4584.0 4608.8 5765.3 5883.4 6093.6 6124.2 6153.3 5681.9 5932.6 6381.0 6397.8 6440.7 6115.1 6152.6 6157.3 6170.2 6187.7 5679.1 5697.9 5703.9 5713.3 5718.5 5508.6 6448.2 6454.8 6717.8 6762.9 6468.5 6509.4 6509.9 6518.5 6520.5 6681.6 6682.7 6766.0 6771.1 6784.3 6282.0 6286.7 6312.4 6401.9 6427.5 6454.2 6458.7 6460.6 6478.5 6489.2 6337.3 6337.8 6341.7 6346.4 6350.5 6237.4 6253.9 6305.4 6360.9 6363.9 4865.7 6150.7 6246.4 6247.7 6269.3 6334.5 6348.2 6368.9 6370.9 6389.1 6029.5 6078.9 6110.8 6158.8 6229.1 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | [#1] ext.html Cycles:180 Average:57459.68 Median:35590.23 stddev:119666.13 (336.2%) stddev-sans-first:119926.09 02:45:59 INFO - PROCESS | 1910 | Values: 755.4 788.4 814.7 870.4 883.1 28192.0 28576.9 29592.0 40248.2 41029.4 41393.8 41567.8 41617.4 41742.4 41755.4 9130.9 9268.8 9285.3 9291.9 9308.3 7318.5 7467.3 9213.5 10938.1 11167.7 10145.4 10484.8 11191.0 11196.0 11245.8 11118.9 11139.6 11142.6 11158.0 11169.4 7350.1 7528.8 10686.3 10917.5 10943.8 39479.8 39604.8 39797.2 39801.4 39808.8 3821.7 3827.6 3867.2 3903.3 3945.3 27162.3 27248.7 27491.2 29084.6 29214.8 3111.1 3139.2 3141.1 3144.7 3169.7 361143.4 361187.0 362547.0 362737.0 363494.0 41438.8 42525.9 43686.3 43713.3 52311.7 42856.8 42901.5 43004.0 43069.9 43226.0 13558.6 13612.1 13613.3 13635.9 13658.9 12015.9 12017.7 12024.6 12072.4 12201.0 9200.2 9571.6 9674.4 9681.6 9698.0 4914.8 5254.0 5256.0 5262.5 5263.6 1043.1 1058.2 1070.5 1078.8 1117.1 26914.3 27540.2 27568.9 27616.0 27694.4 948.4 1116.6 1186.6 1235.4 1251.3 13156.4 13604.0 13791.6 13885.9 14208.2 510308.0 513010.0 513438.0 513590.0 513755.0 55014.2 55274.4 55525.4 55599.0 55737.0 1319.8 1357.9 1461.3 1475.9 1476.0 25062.7 25895.5 26025.8 26106.7 26157.7 44186.8 44291.3 44328.1 44462.8 44484.9 458988.0 461388.7 461641.0 461742.0 461768.0 30876.5 31421.0 31435.7 31488.2 31545.4 32288.4 37917.8 42961.4 43541.3 44012.0 32752.8 36103.8 36117.0 36836.8 37177.3 34948.8 35069.5 35112.0 36009.8 36286.0 34875.8 35257.1 35294.0 35310.6 35869.8 30042.2 31356.4 31405.0 31427.7 31552.0 23407.4 23537.3 23963.4 23997.5 24157.6 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | [#2] jquery.html Cycles:180 Average:43182.06 Median:21518.62 stddev:132365.57 (615.1%) stddev-sans-first:132697.89 02:45:59 INFO - PROCESS | 1910 | Values: 387.9 407.9 426.4 427.7 449.3 12724.9 14722.9 20966.2 21143.9 21516.9 21375.7 21587.9 22061.2 22113.0 22310.3 6301.1 6409.0 6517.8 6566.8 6577.7 4049.8 4312.9 6426.0 6552.9 6555.0 4306.6 4307.8 7445.3 7462.9 7497.4 7173.5 7399.1 7449.6 7450.4 7480.8 6176.7 6967.8 7248.9 7261.9 7273.7 25813.9 26021.9 26206.0 26376.2 26807.9 2889.1 2899.3 2918.4 2921.4 2940.9 15565.0 15822.8 15979.9 16520.3 16577.0 1971.9 1974.5 1990.1 1990.6 2016.5 127696.4 131164.0 131268.0 133372.0 133748.7 16142.8 17776.8 19076.9 20616.7 20963.8 34063.5 34631.8 34696.8 34940.8 35023.8 10316.9 10663.7 10806.8 10849.8 11009.2 8841.3 8850.1 8856.5 9018.2 9048.1 8196.9 8983.4 9170.1 9786.0 10027.4 4047.5 4106.4 4107.6 4130.2 4145.3 896.6 926.3 926.9 933.8 934.3 19974.4 21327.0 21366.8 21383.8 21520.4 906.0 947.7 956.9 975.8 984.2 10433.4 10489.3 10508.2 10567.0 10577.4 789973.0 790927.1 791875.0 804450.0 823112.0 115634.0 148010.0 148863.0 153644.2 154399.0 1155.9 1196.8 1252.3 1254.8 1258.3 18608.4 18665.9 19252.0 19265.7 19351.8 50712.7 55938.0 57422.1 60730.7 61341.0 68544.7 85268.0 85400.6 85660.6 88400.1 10594.7 10844.8 11195.4 11393.4 11395.9 12265.4 12620.9 12622.7 12735.7 12742.9 10476.0 10504.5 10698.4 10720.8 10885.2 10550.7 10723.2 11072.5 11081.8 11142.8 10886.3 11235.3 11248.3 11260.4 11334.4 11000.9 11276.4 11413.7 11415.0 11425.9 10325.8 10367.0 10623.7 10686.4 10757.0 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | [#3] mootools.html Cycles:180 Average:6790.67 Median:2424.15 stddev:4271.86 (176.2%) stddev-sans-first:4264.17 02:45:59 INFO - PROCESS | 1910 | Values: 1333.9 1551.0 1563.3 1578.4 1581.2 9898.0 10970.9 10975.4 10977.6 10986.4 10655.4 10661.5 11026.7 11105.7 11135.8 2399.4 2433.9 2434.3 2438.9 2440.3 2382.0 2418.4 2424.1 2424.2 2425.0 2381.3 2391.6 2405.5 2406.0 2410.3 1985.3 2332.9 2355.7 2359.1 2363.4 2320.8 2350.0 2377.6 2380.5 2380.6 10876.0 10976.6 10992.9 10998.6 11020.2 5838.7 6003.8 6025.1 6031.1 6031.2 3528.9 3658.8 3695.3 3726.6 3754.8 1190.0 1199.5 1207.2 1255.4 1272.6 13693.5 14029.0 15120.3 15350.4 15596.9 4692.7 4793.0 4807.5 4814.3 4822.2 11518.9 11546.9 11556.8 11579.9 11618.8 4888.7 5076.2 5098.1 5105.5 5800.4 4638.2 5199.2 5345.1 5348.5 5349.9 3838.4 3900.5 3971.1 3979.0 3979.5 1008.6 1031.5 1046.5 1047.7 1050.5 795.5 817.6 835.6 861.6 864.8 5820.8 6409.6 6502.9 6855.5 6944.4 908.5 1022.0 1037.3 1051.5 1058.3 4215.8 4233.6 4286.8 4362.7 4378.3 14102.9 14363.0 14589.5 14593.9 14657.2 13986.7 14127.0 14449.6 14454.4 14465.8 10220.8 10330.5 10340.9 10403.3 10452.1 6508.7 6655.3 6666.3 6674.2 6851.1 12252.4 12471.5 12669.2 12673.7 12681.8 9998.7 12327.4 12574.8 12917.9 13159.7 8301.9 8586.6 8685.5 8686.4 8687.8 10384.2 10386.4 10413.3 10479.7 10560.0 9299.3 9331.9 9379.0 9412.0 9455.4 9135.6 9151.9 9154.3 9223.6 9264.0 7970.0 8145.8 8147.8 8149.1 8152.3 5932.2 5986.0 6027.8 6136.3 6211.7 5955.2 6051.2 6062.0 6216.9 6364.3 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | [#4] prototype.html Cycles:180 Average:4480.61 Median:4768.51 stddev:1225.31 (25.7%) stddev-sans-first:1188.54 02:45:59 INFO - PROCESS | 1910 | Values: 332.9 374.8 381.9 383.5 385.5 4485.0 4665.3 4821.7 5184.6 5188.2 3928.7 4193.5 4725.7 5036.5 5037.8 3548.3 3573.2 3740.7 3808.2 4053.8 4258.8 4298.5 4311.9 4343.5 4415.5 3767.2 4365.7 4372.6 4376.8 4423.8 3458.5 3755.9 4178.3 4264.5 4418.2 3495.0 3636.5 3749.2 4090.0 4117.8 4279.1 4383.5 4971.8 4979.7 5035.2 4770.4 4931.5 4982.6 4986.6 5091.4 4596.9 5260.8 5360.9 5456.5 5469.8 4481.2 4706.1 4716.4 4766.6 4775.1 4821.7 5363.2 5607.5 5734.4 5788.6 4033.0 4060.2 4685.3 4732.4 4754.8 3983.5 4591.6 4633.9 4792.9 4804.2 4295.8 4630.0 4651.5 5004.3 5079.7 4371.9 5307.8 5313.2 5328.4 5413.5 1401.9 1428.0 1627.4 1657.8 1663.7 1132.9 1183.5 1225.9 1257.5 1306.8 4232.5 4635.2 4657.4 5020.7 5053.5 4613.7 4805.7 4854.3 5547.9 5549.6 4239.9 4477.2 4554.0 4803.9 5023.9 2778.5 2812.9 2842.5 2949.0 2964.8 5755.7 5758.5 5839.2 5850.5 5868.1 5218.7 5454.7 5490.8 5651.2 5728.0 5037.8 5318.9 5717.3 5727.5 5755.8 4745.4 4753.6 4785.5 5323.6 5498.4 4575.9 4978.8 5248.2 5451.8 5492.3 4708.9 4953.6 5602.3 5606.3 5677.9 4080.6 4226.0 4328.1 4328.4 4355.2 4955.8 5117.9 5315.7 5619.9 5654.6 4234.1 4877.6 5029.0 5422.9 5432.9 5003.4 5374.3 5403.2 5452.5 5473.4 4428.5 4617.5 4655.5 5205.9 5319.9 4398.7 4932.6 5263.3 5348.2 5350.4 4537.7 5189.7 5258.8 5315.5 5390.9 02:45:59 INFO - PROCESS | 1910 | 02:45:59 INFO - PROCESS | 1910 | [#5] yui.html Cycles:180 Average:19988.43 Median:4468.49 stddev:28449.78 (636.7%) stddev-sans-first:28492.77 02:45:59 INFO - PROCESS | 1910 | Values: 711.2 714.7 756.6 789.6 812.8 14900.3 15584.0 15624.1 15646.0 15661.8 13495.7 14281.6 14507.6 14523.5 14565.5 922.1 937.5 939.6 944.2 944.3 909.7 921.9 925.0 930.6 942.5 988.3 991.2 992.2 992.9 993.6 987.2 987.5 988.1 989.8 990.8 741.5 741.8 744.4 744.8 745.1 12404.3 15464.2 15607.1 15628.2 16139.4 13920.4 14195.4 14226.0 14310.2 14316.4 11867.8 11884.6 11920.6 11942.1 11989.9 3349.3 3617.1 3645.5 3680.4 3781.7 99346.5 109084.0 109834.0 111758.0 112145.9 10146.8 10630.3 10693.3 10936.9 11360.5 20945.0 21978.0 22324.8 22490.8 22674.7 7628.9 7773.5 7861.6 7951.0 8092.9 4271.1 4333.2 4419.5 4517.4 4524.8 3428.5 3465.8 3474.3 3494.6 3499.2 638.7 639.8 650.7 670.1 672.6 588.5 639.3 678.0 691.2 700.6 9246.7 9932.3 9935.1 9986.9 11039.7 557.2 575.7 583.4 640.4 687.6 3703.9 4292.2 4897.2 4985.4 4990.9 66159.0 74920.6 98317.0 104418.0 107534.5 84345.0 84932.6 86289.0 86891.6 89859.6 78908.0 80038.6 80627.6 82416.0 82545.0 9363.6 9693.7 9719.6 9729.7 9730.1 45826.5 46710.8 47554.8 49463.0 50077.5 51707.4 56971.7 63791.0 64632.9 65890.0 11135.3 12154.8 12612.6 12878.5 13340.9 14248.4 14729.3 14748.3 14814.7 15526.1 13557.3 13931.7 13948.9 14031.7 14032.6 12891.9 12930.2 12941.4 13270.7 13333.6 13620.6 13635.9 13770.7 13815.7 13928.9 10896.0 11146.7 11343.7 11916.9 11954.0 9412.3 11146.3 11335.4 11355.5 11403.2 02:45:59 INFO - PROCESS | 1910 | -------- Summary: end -------- 02:45:59 INFO - PROCESS | 1910 | 02:46:00 INFO - TEST-INFO | 1910: exit 0 02:46:00 INFO - TEST-OK | dromaeo_css | took 1120690ms 02:46:00 INFO - TEST-START | kraken 02:46:00 INFO - operating with platform_type : mac_ 02:46:00 INFO - Initialising browser for kraken test... 02:46:00 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp6TANHD/profile http://localhost:54169/getInfo.html) 02:46:02 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 02:46:02 INFO - PROCESS | 1915 | colorDepth:24 02:46:02 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 02:46:02 INFO - PROCESS | 1915 | __metrics 02:46:02 INFO - PROCESS | 1915 | 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" 02:46:02 INFO - PROCESS | 1915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:46:03 INFO - TEST-INFO | 1915: exit 0 02:46:03 INFO - Browser initialized. 02:46:03 INFO - Running cycle 1/1 for kraken test... 02:46:03 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmp6TANHD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:15 INFO - PROCESS | 1916 | RSS: Main: 215384064 02:46:15 INFO - PROCESS | 1916 | 02:46:18 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:19 INFO - PROCESS | 1916 | RSS: Main: 267571200 02:46:19 INFO - PROCESS | 1916 | 02:46:21 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-dft) 02:46:22 INFO - PROCESS | 1916 | RSS: Main: 278695936 02:46:22 INFO - PROCESS | 1916 | 02:46:25 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-fft) 02:46:26 INFO - PROCESS | 1916 | RSS: Main: 375296000 02:46:26 INFO - PROCESS | 1916 | 02:46:28 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-oscillator) 02:46:28 INFO - PROCESS | 1916 | RSS: Main: 279064576 02:46:28 INFO - PROCESS | 1916 | 02:46:31 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:31 INFO - PROCESS | 1916 | RSS: Main: 280461312 02:46:31 INFO - PROCESS | 1916 | 02:46:34 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54169/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:35 INFO - PROCESS | 1916 | RSS: Main: 319963136 02:46:35 INFO - PROCESS | 1916 | 02:46:38 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54169/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:38 INFO - PROCESS | 1916 | RSS: Main: 319266816 02:46:38 INFO - PROCESS | 1916 | 02:46:41 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54169/tests/kraken/driver.html?testName=json-parse-financial) 02:46:42 INFO - PROCESS | 1916 | RSS: Main: 317960192 02:46:42 INFO - PROCESS | 1916 | 02:46:44 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:44 INFO - PROCESS | 1916 | RSS: Main: 296214528 02:46:44 INFO - PROCESS | 1916 | 02:46:46 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:47 INFO - PROCESS | 1916 | RSS: Main: 300486656 02:46:47 INFO - PROCESS | 1916 | 02:46:49 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:50 INFO - PROCESS | 1916 | RSS: Main: 306110464 02:46:50 INFO - PROCESS | 1916 | 02:46:52 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:53 INFO - PROCESS | 1916 | RSS: Main: 320901120 02:46:53 INFO - PROCESS | 1916 | 02:46:56 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:57 INFO - PROCESS | 1916 | RSS: Main: 314843136 02:46:57 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54169/tests/kraken/driver.html?testName=ai-astar) 02:46:59 INFO - PROCESS | 1916 | RSS: Main: 359350272 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | __start_tp_report 02:46:59 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 02:46:59 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 02:46:59 INFO - PROCESS | 1916 | |i|pagename|runs| 02:46:59 INFO - PROCESS | 1916 | |0;ai-astar;117;116;115;115;115;115;114;115;114;115 02:46:59 INFO - PROCESS | 1916 | |1;audio-beat-detection;149;110;110;139;101;125;135;111;122;137 02:46:59 INFO - PROCESS | 1916 | |2;audio-dft;186;181;183;184;184;184;185;184;188;183 02:46:59 INFO - PROCESS | 1916 | |3;audio-fft;82;59;60;90;60;60;61;58;89;83 02:46:59 INFO - PROCESS | 1916 | |4;audio-oscillator;92;69;94;100;102;93;82;70;69;85 02:46:59 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;87;86;86;86;86;86;87;86;87;87 02:46:59 INFO - PROCESS | 1916 | |6;imaging-darkroom;149;110;93;94;94;96;94;94;94;95 02:46:59 INFO - PROCESS | 1916 | |7;imaging-desaturate;83;84;84;83;86;86;86;84;84;86 02:46:59 INFO - PROCESS | 1916 | |8;json-parse-financial;63;63;59;60;63;65;64;64;63;62 02:46:59 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;54;61;58;63;60;57;59;60;59;61 02:46:59 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;83;87;84;83;85;87;83;84;94;90 02:46:59 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;139;136;139;151;139;143;136;141;187;168 02:46:59 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;167;168;166;164;166;165;166;166;168;164 02:46:59 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;63;64;66;60;56;82;80;81;64;62 02:46:59 INFO - PROCESS | 1916 | __end_tp_report 02:46:59 INFO - PROCESS | 1916 | __start_cc_report 02:46:59 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,2139 02:46:59 INFO - PROCESS | 1916 | __end_cc_report 02:46:59 INFO - PROCESS | 1916 | __startTimestamp1490348819295__endTimestamp 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | ------- Summary: start ------- 02:46:59 INFO - PROCESS | 1916 | Number of tests: 14 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:0.88 (0.8%) stddev-sans-first:0.60 02:46:59 INFO - PROCESS | 1916 | Values: 117.0 116.0 115.0 115.0 115.0 115.0 114.0 115.0 114.0 115.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:130.00 stddev:15.76 (12.1%) stddev-sans-first:13.85 02:46:59 INFO - PROCESS | 1916 | Values: 149.0 110.0 110.0 139.0 101.0 125.0 135.0 111.0 122.0 137.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.00 stddev:1.87 (1.0%) stddev-sans-first:1.87 02:46:59 INFO - PROCESS | 1916 | Values: 186.0 181.0 183.0 184.0 184.0 184.0 185.0 184.0 188.0 183.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:70.20 Median:71.50 stddev:13.82 (19.3%) stddev-sans-first:13.99 02:46:59 INFO - PROCESS | 1916 | Values: 82.0 59.0 60.0 90.0 60.0 60.0 61.0 58.0 89.0 83.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:83.50 stddev:12.69 (15.2%) stddev-sans-first:13.25 02:46:59 INFO - PROCESS | 1916 | Values: 92.0 69.0 94.0 100.0 102.0 93.0 82.0 70.0 69.0 85.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 02:46:59 INFO - PROCESS | 1916 | Values: 87.0 86.0 86.0 86.0 86.0 86.0 87.0 86.0 87.0 87.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:17.49 (18.6%) stddev-sans-first:5.32 02:46:59 INFO - PROCESS | 1916 | Values: 149.0 110.0 93.0 94.0 94.0 96.0 94.0 94.0 94.0 95.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 02:46:59 INFO - PROCESS | 1916 | Values: 83.0 84.0 84.0 83.0 86.0 86.0 86.0 84.0 84.0 86.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:1.84 (2.9%) stddev-sans-first:1.94 02:46:59 INFO - PROCESS | 1916 | Values: 63.0 63.0 59.0 60.0 63.0 65.0 64.0 64.0 63.0 62.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:60.00 stddev:2.49 (4.1%) stddev-sans-first:1.79 02:46:59 INFO - PROCESS | 1916 | Values: 54.0 61.0 58.0 63.0 60.0 57.0 59.0 60.0 59.0 61.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:3.62 (4.2%) stddev-sans-first:3.67 02:46:59 INFO - PROCESS | 1916 | Values: 83.0 87.0 84.0 83.0 85.0 87.0 83.0 84.0 94.0 90.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:142.00 stddev:16.78 (11.8%) stddev-sans-first:17.49 02:46:59 INFO - PROCESS | 1916 | Values: 139.0 136.0 139.0 151.0 139.0 143.0 136.0 141.0 187.0 168.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 02:46:59 INFO - PROCESS | 1916 | Values: 167.0 168.0 166.0 164.0 166.0 165.0 166.0 166.0 168.0 164.0 02:46:59 INFO - PROCESS | 1916 | 02:46:59 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:65.00 stddev:9.51 (14.6%) stddev-sans-first:9.92 02:46:59 INFO - PROCESS | 1916 | Values: 63.0 64.0 66.0 60.0 56.0 82.0 80.0 81.0 64.0 62.0 02:46:59 INFO - PROCESS | 1916 | -------- Summary: end -------- 02:46:59 INFO - PROCESS | 1916 | 02:47:00 INFO - TEST-INFO | 1916: exit 0 02:47:00 INFO - TEST-OK | kraken | took 60120ms 02:47:00 INFO - SUITE-END | took 1180s 02:47:00 INFO - Completed test suite (00:19:41) 02:47:00 INFO - javascript benchmark 02:47:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7634.493280125533, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.139594403427, 3416.6070901846297, 3423.1955490459754, 3423.8288085595723, 3474.965250347497, 6038.737382020963, 6075.665838378887, 6087.5738698291025, 6106.688135492151, 6134.509239260859, 6055.606385584934, 6098.756049758004, 6100.298465676448, 6107.572469927096, 6119.08213767935, 5365.490278423544, 5403.78384864605, 5405.972970135143, 5434.3207099112615, 5499.560035197194, 5334.226537152111, 5352.2239275305055, 5510.173473978895, 5511.173324001412, 5520.254765606632, 5389.946100539003, 5419.891602167954, 5435.266239057736, 5445.673259604417, 5446.0, 5430.70131142787, 5432.483914028161, 5436.048691479014, 5452.2094296327205, 5456.290682211326, 4142.275101857163, 5300.893982120375, 5392.487713667196, 5397.7031263280505, 5425.321834770653, 6067.787627433063, 6102.664353460558, 6103.450689437927, 6109.083637454373, 6114.755409783604, 6331.936680633181, 6334.208223972004, 6347.174867267272, 6360.777372791977, 6361.968190159019, 6363.93636063638, 6375.203099612549, 6381.712822922979, 6382.266039405481, 6419.390157934989, 6152.046432802923, 6179.412955769195, 6198.504119670415, 6205.3484384139465, 6213.658248796314, 6657.567258128206, 6678.298778628271, 6678.36555527229, 6689.866202675919, 6705.597664140168, 6238.095476156022, 6284.654344011032, 6296.811095667137, 6306.621602703761, 6329.810105696744, 6474.773382931669, 6519.837004074936, 6520.0, 6523.7716679915975, 6530.836729081716, 6313.43179113882, 6439.967800160969, 6442.065900444503, 6447.419732224029, 6448.387403196689, 6301.338359472281, 6308.148399965946, 6352.61884286935, 6432.195975503062, 6445.2265728112925, 5120.820771273062, 5176.5858731301405, 5192.247124166975, 5204.9219261711105, 5205.713685747321, 4557.886052848706, 4564.7032942858605, 4574.542545745466, 4584.0, 4608.769561521911, 5765.336986246635, 5883.352831188566, 6093.634381937098, 6124.173236613089, 6153.323134455206, 5681.886362272814, 5932.614380065282, 6381.0, 6397.776077837253, 6440.677966101676, 6115.113308570232, 6152.600080994721, 6157.261128664589, 6170.197874276315, 6187.690615469209, 5679.148127780866, 5697.9430205698245, 5703.857403564944, 5713.285839270091, 5718.456746609066, 5508.641938274, 6448.1939757531245, 6454.806355809334, 6717.832054198489, 6762.932370676427, 6468.5472016958365, 6509.446697030616, 6509.8698026040165, 6518.478521718156, 6520.543561950618, 6681.632510211985, 6682.69927853238, 6765.9661701691175, 6771.052052712723, 6784.2876497967, 6282.0, 6286.65423401699, 6312.400321969406, 6401.8719625608155, 6427.517936154901, 6454.19322584677, 6458.67706614658, 6460.612363258219, 6478.546501744832, 6489.1888513935755, 6337.334579869047, 6337.809865704036, 6341.682915854281, 6346.365363463801, 6350.523710721622, 6237.376262373908, 6253.937460625336, 6305.369463053658, 6360.936390636034, 6363.936360636334, 4865.659403841839, 6150.661713605795, 6246.437820596168, 6247.656378899204, 6269.279032911274, 6334.524910631629, 6348.206474190726, 6368.936310637019, 6370.872582548416, 6389.105525226379, 6029.51763858899, 6078.939210607838, 6110.801781737137, 6158.846028849135, 6229.096780966644], "value": 5927.19525533125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.3805879179075, 788.3535500889271, 814.674130347861, 870.3950754225816, 883.0992387764477, 28192.0, 28576.857115714418, 29591.999999999975, 40248.195036099336, 41029.384559231636, 41393.793031034875, 41567.79216103923, 41617.37573936393, 41742.37386439206, 41755.37366939498, 9130.863037054432, 9268.768280793, 9285.25717942563, 9291.907080929206, 9308.34841561091, 7318.524295920774, 7467.253274672544, 9213.539323033856, 10938.124950003981, 11167.720806979809, 10145.391276523433, 10484.790304193912, 11191.0, 11196.0, 11245.83131253032, 11118.888811111907, 11139.554417823278, 11142.610008649739, 11158.0, 11169.38568378747, 7350.08123984502, 7528.774136775905, 10686.305390149615, 10917.454127293604, 10943.83584246237, 39479.802600987096, 39604.80197599022, 39797.20405591872, 39801.40297895534, 39808.80573582797, 3821.675157611606, 3827.6363745444137, 3867.207222519377, 3903.316919539069, 3945.3292940200236, 27162.32094197641, 27248.727512724818, 27491.17526474209, 29084.563731544044, 29214.831406743706, 3111.128883912508, 3139.2465808206093, 3141.1361875484195, 3144.701253380925, 3169.714725674677, 361143.3885661162, 361187.0, 362547.0, 362737.0, 363494.0, 41438.79280603577, 42525.93685157834, 43686.344704829455, 43713.34429983553, 52311.73844130755, 42856.78571607184, 42901.49844755481, 43004.0, 43069.92325191895, 43226.0, 13558.593242202749, 13612.115212511155, 13613.319334033258, 13635.863641363658, 13658.863411365957, 12015.879841201651, 12017.699557510958, 12024.639260822189, 12072.396380180955, 12201.0, 9200.217981471516, 9571.569279382444, 9674.371165874196, 9681.564329605184, 9697.951510242403, 4914.803407863646, 5254.0, 5255.973720131375, 5262.500062494057, 5263.5525980292105, 1043.139409986764, 1058.216919479595, 1070.5129166229347, 1078.7788503356794, 1117.1453837814079, 26914.32714182161, 27540.173794786187, 27568.862155689094, 27616.0, 27694.446111077665, 948.3551185193996, 1116.5924437580225, 1186.6262127429832, 1235.43170141734, 1251.3367915005063, 13156.40796164175, 13604.047716659938, 13791.586252412444, 13885.930570347286, 14208.218547979961, 510308.0, 513010.0, 513438.0, 513590.0, 513755.0, 55014.17478737822, 55274.44725552693, 55525.444745552835, 55599.0, 55737.0, 1319.7822359310799, 1357.9408061711881, 1461.3496993837641, 1475.8671719545293, 1475.970480590382, 25062.74686265643, 25895.482090358466, 26025.82883770197, 26106.73893261119, 26157.692115393773, 44186.779066104464, 44291.33562996493, 44328.11343773171, 44462.77768611136, 44484.88787780331, 458988.0, 461388.6930565326, 461641.0, 461742.0, 461768.0, 30876.536851947687, 31421.0, 31435.685643143275, 31488.212794680316, 31545.36909261848, 32288.35423291568, 37917.81041094777, 42961.3555796657, 43541.3468797962, 44012.0, 32752.76210158141, 36103.81948090243, 36117.0, 36836.81581592182, 37177.25645487129, 34948.825255873555, 35069.47395789014, 35112.0, 36009.81995090008, 36286.0, 34875.825620871736, 35257.118572035906, 35294.0, 35310.646893530735, 35869.82065089658, 30042.248943775707, 31356.372872541964, 31405.0, 31427.685723142476, 31552.0, 23407.41481462977, 23537.293881183592, 23963.400914977265, 23997.520049598563, 24157.63763543513], "value": 18427.339141622644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.86618616577306, 407.86948176583485, 426.4030357499501, 427.71770631383293, 449.2542379649782, 12724.936375318122, 14722.852771472282, 20966.16135354586, 21143.894280528577, 21516.8924155379, 21375.6793648095, 21587.892060539674, 22061.22785702501, 22113.004914778834, 22310.330690079325, 6301.086342480337, 6409.0066039763915, 6517.837054073639, 6566.835829104263, 6577.704003319862, 4049.817758200888, 4312.892177695567, 6426.0, 6552.901706474383, 6555.0495178199135, 4306.633936115434, 4307.82768689252, 7445.255474452566, 7462.850742985137, 7497.437692173082, 7173.461990350745, 7399.149097853762, 7449.627518624047, 7450.441216908726, 7480.812979675497, 6176.722047507873, 6967.79096627102, 7248.927510724878, 7261.927380726178, 7273.709051637981, 25813.870930645226, 26021.869890650614, 26205.9517619295, 26376.20871373862, 26807.865960670268, 2889.133260021985, 2899.275181204699, 2918.430905973336, 2921.4449254641763, 2940.911772646824, 15565.0, 15822.813289003256, 15979.920100399424, 16520.339186432648, 16577.0, 1971.930982415623, 1974.5063734066484, 1990.1139476714116, 1990.5919286546223, 2016.4656366063004, 127696.36151819275, 131164.0, 131268.0, 133372.0, 133748.66251337458, 16142.838571614368, 17776.844505107125, 19076.904615477113, 20616.69074963877, 20963.846988415782, 34063.489047664305, 34631.82684086564, 34696.82651586726, 34940.82529587387, 35023.824880875436, 10316.948415257875, 10663.68008959717, 10806.78386432267, 10849.78300433987, 11009.201825370234, 8841.336899732545, 8850.114988501098, 8856.512891791013, 9018.233450156678, 9048.140426659456, 8196.877046844302, 8983.416077954913, 9170.128837760401, 9786.0, 10027.448490332956, 4047.514298284225, 4106.40457133714, 4107.568705285902, 4130.235906357333, 4145.2952997990415, 896.6413434626202, 926.2543652359781, 926.9073092690812, 933.8365785987424, 934.2852717670987, 19974.352499641012, 21327.0, 21366.78633213679, 21383.786162138178, 21520.354389368345, 905.9864102038474, 947.7488465556632, 956.93779904306, 975.8341082016075, 984.1536278800226, 10433.426161561187, 10489.265751397328, 10508.159347252202, 10567.0, 10577.36535807854, 789973.0, 790927.1360929591, 791875.0, 804450.0, 823112.0, 115634.0, 148010.0, 148863.0, 153644.2317788404, 154399.0, 1155.8959693627446, 1196.8324434579165, 1252.3237451776122, 1254.8305978692943, 1258.3205069262679, 18608.44174674762, 18665.906670467102, 19252.0, 19265.711014334516, 19351.806481935, 50712.732181695756, 55938.0, 57422.13866791918, 60730.696346519755, 61341.0, 68544.6572767133, 85268.0, 85400.57299713462, 85660.5716971436, 88400.11599884176, 10594.682159535227, 10844.783104338027, 11195.384253866116, 11393.373364464702, 11395.943020284845, 12265.448054837732, 12620.936895315464, 12622.747545048864, 12735.681607959505, 12742.936285318885, 10476.00477954593, 10504.527296271839, 10698.358098514114, 10720.785584288427, 10885.23803333759, 10550.736231593964, 10723.195760318164, 11072.501737421675, 11081.778364432505, 11142.832857507306, 10886.29239099456, 11235.269707469315, 11248.325100493996, 11260.353816853198, 11334.376609286568, 11000.889991099986, 11276.436178190894, 11413.657590272305, 11415.0, 11425.914538118865, 10325.793484130425, 10367.0, 10623.681289561326, 10686.358818470917, 10757.0], "value": 11295.938198059906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.9066265361423, 1551.0306058713304, 1563.319955819218, 1578.4080969636386, 1581.2251996521704, 9898.0, 10970.945145274272, 10975.396353200591, 10977.615783447562, 10986.395748233854, 10655.360678359304, 10661.520231589579, 11026.724331891706, 11105.72235694108, 11135.777284454327, 2399.3761621978324, 2433.902643894242, 2434.306222726523, 2438.926832195037, 2440.3045132137345, 2382.0352757133387, 2418.4074901649033, 2424.078850036992, 2424.212131057405, 2424.9757502425014, 2381.333226696519, 2391.6173412254043, 2405.458771776354, 2406.049610403898, 2410.2528216253017, 1985.3051431998829, 2332.918347857817, 2355.740868504463, 2359.138914296278, 2363.373705967911, 2320.7679232076657, 2349.993261489157, 2377.5839228135005, 2380.523895220963, 2380.6191009438407, 10876.0, 10976.615818446317, 10992.945035274852, 10998.560057597686, 11020.173486988508, 5838.678872662002, 6003.759849606011, 6025.096235564656, 6031.125486804389, 6031.155638210654, 3528.9294214115575, 3658.762180458262, 3695.2794205130012, 3726.5528136623507, 3754.7747135171703, 1189.9881001190051, 1199.466237524302, 1207.1730864357855, 1255.3534929511309, 1272.6182145356356, 13693.452261909511, 14029.017968742191, 15120.319585618563, 15350.385984560604, 15596.922015389964, 4692.741899195509, 4792.976035119802, 4807.543283388072, 4814.253790662453, 4822.204336284544, 11518.942405288088, 11546.94226528862, 11556.826647600292, 11579.88420115805, 11618.76762464746, 4888.706677599284, 5076.213186956028, 5098.056859480934, 5105.540501354896, 5800.361960184377, 4638.211504044253, 5199.220116982483, 5345.091334473149, 5348.491893270133, 5349.946500535023, 3838.405047217686, 3900.4539364488996, 3971.126352202511, 3978.980105099514, 3979.462772525672, 1008.5915204342253, 1031.504877658728, 1046.4558429616557, 1047.6961681112543, 1050.4642632257603, 795.4710117771733, 817.5912043978011, 835.5613303015965, 861.5821326656567, 864.7967727584013, 5820.777636696256, 6409.615423074537, 6502.92701704223, 6855.485838562127, 6944.409725173316, 908.5411867007119, 1021.9642312519175, 1037.3309215555923, 1051.4900273367412, 1058.3015209961388, 4215.831366745296, 4233.597808208216, 4286.828526858953, 4362.694611377173, 4378.277584198635, 14102.858971410154, 14362.994590378783, 14589.489367872073, 14593.92703036478, 14657.193854338113, 13986.720265594631, 14127.0, 14449.638759031108, 14454.421823127168, 14465.78301325481, 10220.846687299696, 10330.483475826179, 10340.948295258475, 10403.323783953867, 10452.111570516592, 6508.73965041412, 6655.3344665535, 6666.333366663295, 6674.232463266787, 6851.109355783717, 12252.448639811051, 12471.5011399543, 12669.239845609292, 12673.683157921127, 12681.80977285323, 9998.740590759991, 12327.383630818602, 12574.811377829157, 12917.870821291666, 13159.736805264032, 8301.916980830356, 8586.570671466277, 8685.478871267744, 8686.391952563512, 8687.826243474969, 10384.221183411426, 10386.42874641902, 10413.323133996266, 10479.738006549896, 10559.99680030396, 9299.349045566745, 9331.906680933374, 9379.015203403816, 9412.0, 9455.385399948982, 9135.63457461694, 9151.908480915372, 9154.267658587163, 9223.631054757734, 9263.9809620943, 7969.960150199444, 8145.79635509117, 8147.75556733299, 8149.144339844231, 8152.3478121751305, 5932.228810254812, 5986.0, 6027.78902738402, 6136.2636483622255, 6211.720472578654, 5955.166276721176, 6051.243594550681, 6062.030075187949, 6216.906746398718, 6364.3134569338235], "value": 5153.945322220019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8782004644348, 374.7882446417774, 381.9159784847336, 383.5205992509365, 385.4584309045792, 4484.9551504485025, 4665.300204969256, 4821.734804585746, 5184.637075404723, 5188.195829646402, 3928.705347098965, 4193.5387107418155, 4725.740084295371, 5036.546710796028, 5037.84886453406, 3548.325818094567, 3573.1945478065777, 3740.7007439404783, 3808.219315040424, 4053.756774593519, 4258.7870606469705, 4298.463906295286, 4311.852347786118, 4343.500497442803, 4415.536368681291, 3767.227718317752, 4365.6507479401735, 4372.60076775432, 4376.824927002916, 4423.77881105945, 3458.515807786912, 3755.9295600753653, 4178.310578754502, 4264.530901600806, 4418.182636212295, 3494.9825250873837, 3636.5090712753704, 3749.2003838157566, 4089.977505623594, 4117.785253350269, 4279.079997800488, 4383.473983122046, 4971.776270067856, 4979.676321039121, 5035.244713292998, 4770.403699537558, 4931.482194369575, 4982.57648099912, 4986.626003049786, 5091.414487333967, 4596.873765927336, 5260.842174734764, 5360.9463905360835, 5456.508914197701, 5469.753861076221, 4481.193385190664, 4706.082313948781, 4716.410448693913, 4766.618670506351, 4775.14047471455, 4821.734804585746, 5363.195520671891, 5607.467290607386, 5734.369219385864, 5788.565857560658, 4033.0, 4060.2285565742413, 4685.320628508915, 4732.408448943882, 4754.78603462845, 3983.541892682321, 4591.6353078164775, 4633.907321853544, 4792.856214313576, 4804.246450045708, 4295.78521073945, 4629.953700463019, 4651.511591282934, 5004.3494345734825, 5079.6792833863465, 4371.868843934687, 5307.814226502054, 5313.203019547099, 5328.401479556118, 5413.539849112791, 1401.9158850469005, 1428.0003997202, 1627.397862790775, 1657.7596248543894, 1663.7088509510788, 1132.8753837077916, 1183.4910988275124, 1225.8957988570894, 1257.5095712672064, 1306.8235788168665, 4232.470941132358, 4635.188841952645, 4657.417822772153, 5020.7114340106555, 5053.46938571452, 4613.723176609415, 4805.663603547718, 4854.320395144682, 5547.947259514006, 5549.556035517149, 4239.918820700763, 4477.238869392211, 4554.0, 4803.855884323476, 5023.874403139951, 2778.499091145172, 2812.85935703214, 2842.4883520966423, 2948.9557656635166, 2964.762818974477, 5755.683237571821, 5758.539316854642, 5839.1606643907035, 5850.5027072699295, 5868.122200895672, 5218.66078704883, 5454.699991500505, 5490.752916118784, 5651.208830763697, 5727.971360143172, 5037.750650830194, 5318.8936221276135, 5717.313922329347, 5727.5417966561745, 5755.827325180251, 4745.430548334222, 4753.597688681778, 4785.545373189541, 5323.574114070788, 5498.388265573981, 4575.885602859955, 4978.800847966186, 5248.239005344128, 5451.781928722807, 5492.340919089735, 4708.858734237979, 4953.554180123806, 5602.263298377516, 5606.327240731139, 5677.914831277451, 4080.551668998577, 4225.9577404225565, 4328.095637919306, 4328.415663885336, 4355.1507456045765, 4955.776990035385, 5117.923231151462, 5315.681059136464, 5619.8876022480135, 5654.575906807088, 4234.089670720809, 4877.5613192699775, 5028.969061342489, 5422.945770542244, 5432.864178395572, 5003.399592048978, 5374.328208973879, 5403.189521571796, 5452.5365343946205, 5473.370562385377, 4428.512863585068, 4617.538246175355, 4655.487896331469, 5205.947940520547, 5319.920201197063, 4398.69209155356, 4932.630052745986, 5263.315768950012, 5348.197770334481, 5350.357957045179, 4537.682362234612, 5189.740512974412, 5258.8159414420315, 5315.468453154654, 5390.919136212881], "value": 4132.57989259016, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.2141084102063, 714.6819665248967, 756.5838788666235, 789.6249281591245, 812.7724237213582, 14900.254987250635, 15584.0, 15624.140672263022, 15645.999999999985, 15661.843381566181, 13495.73008539831, 14281.571552853406, 14507.637309067251, 14523.491677791279, 14565.490207842728, 922.1055576091181, 937.4984383354906, 939.6006697153716, 944.1691311645742, 944.3106532231475, 909.7043460875209, 921.8985911549725, 924.97789942114, 930.5533343994887, 942.4580866002076, 988.3081842710096, 991.1723710701536, 992.1864071461405, 992.885818130917, 993.587661120634, 987.244757760314, 987.5407935310044, 988.0613417253602, 989.7921436498344, 990.8067926754286, 741.5402450480683, 741.7737590035038, 744.408195484591, 744.8398594302197, 745.1430854517348, 12404.317762523058, 15464.226788660635, 15607.141607211599, 15628.218589070615, 16139.435119770751, 13920.37358318878, 14195.361208745631, 14226.0, 14310.21293828839, 14316.42734290627, 11867.762644747143, 11884.584039558575, 11920.582779602759, 11942.104342174373, 11989.94005029978, 3349.279904820451, 3617.149969757105, 3645.5260816093737, 3680.3743363628246, 3781.6785573226307, 99346.5032674832, 109084.0, 109834.0, 111758.0, 112145.87854121436, 10146.847797283046, 10630.30902991303, 10693.251472397013, 10936.890631093587, 11360.48877800501, 20945.0, 21978.0, 22324.776752232596, 22490.775092249194, 22674.65988010181, 7628.8855667165035, 7773.494722842997, 7861.646225919847, 7951.0, 8092.919070809335, 4271.124419494058, 4333.15503476819, 4419.535948725337, 4517.435320584927, 4524.7511386873375, 3428.468587368962, 3465.7747246428903, 3474.270403215353, 3494.6155922848466, 3499.2126771476724, 638.7221558622015, 639.7792761497276, 650.6941737383422, 670.0686046395514, 672.5661948043485, 588.5144755576666, 639.3318981664172, 677.9796606101825, 691.19475810681, 700.5971566349267, 9246.691550729458, 9932.304574780384, 9935.13178542509, 9986.900130998742, 11039.724006899893, 557.1725986909436, 575.7437940116608, 583.3728741602794, 640.3916279534461, 687.608063403865, 3703.9074023149096, 4292.248856450171, 4897.1674815281485, 4985.426675932242, 4990.925136122961, 66159.00761488582, 74920.62539687267, 98317.0, 104418.0, 107534.46232768786, 84345.0, 84932.57533712416, 86289.0, 86891.56554217315, 89859.58038611634, 78908.0, 80038.59980700059, 80627.5968620165, 82416.0, 82545.0, 9363.625454981997, 9693.660721874701, 9719.611215551298, 9729.659461918798, 9730.12428881404, 45826.54173458223, 46710.76644616755, 47554.76222618865, 49463.01073978428, 50077.49922500728, 51707.44877653677, 56971.71514142403, 63791.0, 64632.91654868442, 65890.0, 11135.276207046516, 12154.817130228663, 12612.621621351007, 12878.484860605471, 13340.866591333963, 14248.358823852745, 14729.330267832996, 14748.336324865193, 14814.703705926036, 15526.1460619667, 13557.322133893069, 13931.72136557243, 13948.930255348658, 14031.719365612835, 14032.649183770487, 12891.935540322238, 12930.224186548838, 12941.352932353533, 13270.734585308433, 13333.599992000256, 13620.591382258548, 13635.86364136346, 13770.65573360674, 13815.654608634462, 13928.930355348159, 10896.0, 11146.665600032013, 11343.659690209306, 11916.880831191576, 11954.0, 9412.341136120405, 11146.331220126818, 11335.433228338385, 11355.54577816878, 11403.201775875608], "value": 7534.338184238144, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 110.0, 139.0, 101.0, 125.0, 135.0, 111.0, 122.0, 137.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 183.0, 184.0, 184.0, 184.0, 185.0, 184.0, 188.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 90.0, 60.0, 60.0, 61.0, 58.0, 89.0, 83.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 94.0, 100.0, 102.0, 93.0, 82.0, 70.0, 69.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 87.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 93.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 95.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 83.0, 86.0, 86.0, 86.0, 84.0, 84.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 59.0, 60.0, 63.0, 65.0, 64.0, 64.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 58.0, 63.0, 60.0, 57.0, 59.0, 60.0, 59.0, 61.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 84.0, 83.0, 85.0, 87.0, 83.0, 84.0, 94.0, 90.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 139.0, 151.0, 139.0, 143.0, 136.0, 141.0, 187.0, 168.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 164.0, 166.0, 165.0, 166.0, 166.0, 168.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 60.0, 56.0, 82.0, 80.0, 81.0, 64.0, 62.0], "value": 67.8, "unit": "score"}]}]} 02:47:00 INFO - Return code: 0 02:47:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:47:00 ERROR - # TBPL SUCCESS # 02:47:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:47:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:47:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:47:00 INFO - 2017-03-24 02:47:00.659 screenresolution[1920:19945] starting screenresolution argv=screenresolution get 02:47:00 INFO - 2017-03-24 02:47:00.663 screenresolution[1920:19945] Display 0: 1600x1200x32@60 02:47:00 INFO - 2017-03-24 02:47:00.669 screenresolution[1921:19948] starting screenresolution argv=screenresolution list 02:47:00 INFO - Available Modes on Display 0 02:47:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:47:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:47:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:47:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:47:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:47:00 INFO - Intel Iris: 02:47:00 INFO - Chipset Model: Intel Iris 02:47:00 INFO - Type: GPU 02:47:00 INFO - Bus: Built-In 02:47:00 INFO - VRAM (Dynamic, Max): 1536 MB 02:47:00 INFO - Vendor: Intel (0x8086) 02:47:00 INFO - Device ID: 0x0a2e 02:47:00 INFO - Revision ID: 0x0009 02:47:00 INFO - Displays: 02:47:00 INFO - Display: 02:47:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:47:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:47:00 INFO - Display Serial Number: 1600x1200 60 02:47:00 INFO - Main Display: Yes 02:47:00 INFO - Mirror: Off 02:47:00 INFO - Online: Yes 02:47:00 INFO - Rotation: Supported 02:47:00 INFO - Return code: 0 02:47:00 INFO - Running post-action listener: _resource_record_post_action 02:47:00 INFO - [mozharness: 2017-03-24 09:47:00.907645Z] Finished run-tests step (success) 02:47:00 INFO - Running post-run listener: _resource_record_post_run 02:47:00 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 528384; Write bytes: 507267072; Read time: 10; Write time: 1571 02:47:00 INFO - TinderboxPrint: CPU usage
53.8% 02:47:00 INFO - TinderboxPrint: I/O read bytes / time
528,384 / 10 02:47:00 INFO - TinderboxPrint: I/O write bytes / time
507,267,072 / 1,571 02:47:00 INFO - TinderboxPrint: CPU idle
2,218.1 (46.2%) 02:47:00 INFO - TinderboxPrint: CPU system
962.6 (20.0%) 02:47:00 INFO - TinderboxPrint: CPU user
1,625.3 (33.8%) 02:47:00 INFO - TinderboxPrint: Swap in / out
209,539,072 / 0 02:47:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206334464; Write bytes: 199884800; Read time: 15677; Write time: 424 02:47:00 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 487424; Write bytes: 296335360; Read time: 9; Write time: 1108 02:47:01 INFO - Running post-run listener: _upload_blobber_files 02:47:01 INFO - Blob upload gear active. 02:47:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:01 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 02:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:47:01 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:03 INFO - (blobuploader) - INFO - Done attempting. 02:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:03 INFO - (blobuploader) - INFO - Done attempting. 02:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:04 INFO - (blobuploader) - INFO - Done attempting. 02:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:07 INFO - (blobuploader) - INFO - Done attempting. 02:47:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:07 INFO - Return code: 0 02:47:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5cbf1f66c08381cda094e32530a8621dc69ca2bc7e1ef674f34df4bbc9ffff0cd877a904e972cd7e00264a24283a94bb437874715a9087fe8a99c8b5735a82c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebac6e0b3b849a83d10158c52f4654bbc5c0851f88836c134f01fae0876278093f2a1937c080803316ac07617787b53cae97da0794941bb9035304a55fe7ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbc02369507201e703aaa4063407d380c0f5b6dc4f8f7f10473b9acf08b0d5b9a9b5b10e219af85dce3da1b4d0227e7fe09b3b774915920b2ca6c0127317284e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/831e29f2c5103b932ccdf12316fe8d43ed4ce5f3eefa2eacb77aef97b3180085e13273b1dbd39e53f80089160baeb30cc7ab306dded9077881f8fdb455e9f33f"} 02:47:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:07 INFO - Contents: 02:47:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5cbf1f66c08381cda094e32530a8621dc69ca2bc7e1ef674f34df4bbc9ffff0cd877a904e972cd7e00264a24283a94bb437874715a9087fe8a99c8b5735a82c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebac6e0b3b849a83d10158c52f4654bbc5c0851f88836c134f01fae0876278093f2a1937c080803316ac07617787b53cae97da0794941bb9035304a55fe7ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbc02369507201e703aaa4063407d380c0f5b6dc4f8f7f10473b9acf08b0d5b9a9b5b10e219af85dce3da1b4d0227e7fe09b3b774915920b2ca6c0127317284e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/831e29f2c5103b932ccdf12316fe8d43ed4ce5f3eefa2eacb77aef97b3180085e13273b1dbd39e53f80089160baeb30cc7ab306dded9077881f8fdb455e9f33f"} 02:47:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:07 INFO - Copying logs to upload dir... 02:47:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1328.741999 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2017-03-24 02:47:07.543007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 02:47:07.550213) ========= 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.riNj6Wze6O/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.4137Vlo7yA/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5cbf1f66c08381cda094e32530a8621dc69ca2bc7e1ef674f34df4bbc9ffff0cd877a904e972cd7e00264a24283a94bb437874715a9087fe8a99c8b5735a82c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebac6e0b3b849a83d10158c52f4654bbc5c0851f88836c134f01fae0876278093f2a1937c080803316ac07617787b53cae97da0794941bb9035304a55fe7ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbc02369507201e703aaa4063407d380c0f5b6dc4f8f7f10473b9acf08b0d5b9a9b5b10e219af85dce3da1b4d0227e7fe09b3b774915920b2ca6c0127317284e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/831e29f2c5103b932ccdf12316fe8d43ed4ce5f3eefa2eacb77aef97b3180085e13273b1dbd39e53f80089160baeb30cc7ab306dded9077881f8fdb455e9f33f"} build_url:https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5cbf1f66c08381cda094e32530a8621dc69ca2bc7e1ef674f34df4bbc9ffff0cd877a904e972cd7e00264a24283a94bb437874715a9087fe8a99c8b5735a82c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22ebac6e0b3b849a83d10158c52f4654bbc5c0851f88836c134f01fae0876278093f2a1937c080803316ac07617787b53cae97da0794941bb9035304a55fe7ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbc02369507201e703aaa4063407d380c0f5b6dc4f8f7f10473b9acf08b0d5b9a9b5b10e219af85dce3da1b4d0227e7fe09b3b774915920b2ca6c0127317284e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/831e29f2c5103b932ccdf12316fe8d43ed4ce5f3eefa2eacb77aef97b3180085e13273b1dbd39e53f80089160baeb30cc7ab306dded9077881f8fdb455e9f33f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 02:47:07.585243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:47:07.585579) ========= 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.riNj6Wze6O/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.4137Vlo7yA/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005292 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:47:07.634769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 02:47:07.635077) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 02:47:07.635400) ========= ========= Total master_lag: 0.29 =========