builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0295 starttime: 1490270218.37 results: success (0) buildid: 20170323040624 builduid: c928be24e8104df98f3178840f5a447b revision: 0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.373783) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.374223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.374507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.399594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.401149) ========= 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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-23 04:56:58-- 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% 6.83M=0.002s 2017-03-23 04:56:58 (6.83 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.527162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.527670) ========= 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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.020977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.578997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:58.579573) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2 --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 0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P94Z4SAMKA/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.8rjmpfGzdk/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-23 04:56:58,670 truncating revision to first 12 chars 2017-03-23 04:56:58,670 Setting DEBUG logging. 2017-03-23 04:56:58,670 attempt 1/10 2017-03-23 04:56:58,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0dd7f3ab57f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 04:56:58,989 unpacking tar archive at: mozilla-aurora-0dd7f3ab57f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:59.441739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:59.442063) ========= script_repo_revision: 0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:59.442489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:59.442775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 04:56:59.462828) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-23 04:56:59.463217) ========= /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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:56:59 INFO - MultiFileLogger online at 20170323 04:56:59 in /builds/slave/test 04:56:59 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 04:56:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:59 INFO - {'append_to_log': False, 04:56:59 INFO - 'base_work_dir': '/builds/slave/test', 04:56:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:56:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:59 INFO - 'branch': 'Mozilla-Aurora', 04:56:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:59 INFO - 'config_files': ('talos/mac_config.py',), 04:56:59 INFO - 'default_actions': ('clobber', 04:56:59 INFO - 'read-buildbot-config', 04:56:59 INFO - 'download-and-extract', 04:56:59 INFO - 'populate-webroot', 04:56:59 INFO - 'create-virtualenv', 04:56:59 INFO - 'install', 04:56:59 INFO - 'run-tests'), 04:56:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:59 INFO - 'download_minidump_stackwalk': True, 04:56:59 INFO - 'download_symbols': 'ondemand', 04:56:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:59 INFO - 'gecko_profile': False, 04:56:59 INFO - 'gecko_profile_interval': 0, 04:56:59 INFO - 'installer_path': 'installer.exe', 04:56:59 INFO - 'log_level': 'info', 04:56:59 INFO - 'log_name': 'talos', 04:56:59 INFO - 'log_to_console': True, 04:56:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:56:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:56:59 INFO - 'opt_config_files': (), 04:56:59 INFO - 'pip_index': False, 04:56:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:59 INFO - 'cmd': ('bash', 04:56:59 INFO - '-c', 04:56:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:59 INFO - 'enabled': True, 04:56:59 INFO - 'halt_on_failure': False, 04:56:59 INFO - 'name': 'check_screen_resolution'},), 04:56:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:59 INFO - 'cmd': ('bash', 04:56:59 INFO - '-c', 04:56:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:59 INFO - 'enabled': True, 04:56:59 INFO - 'halt_on_failure': False, 04:56:59 INFO - 'name': 'check_screen_resolution'},), 04:56:59 INFO - 'run_cmd_checks_enabled': True, 04:56:59 INFO - 'suite': 'dromaeojs', 04:56:59 INFO - 'system_bits': '32', 04:56:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:59 INFO - 'title': 't-yosemite-r7-0295', 04:56:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:59 INFO - 'use_talos_json': True, 04:56:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:59 INFO - 'work_dir': 'build'} 04:56:59 INFO - [mozharness: 2017-03-23 11:56:59.676761Z] Running clobber step. 04:56:59 INFO - Running pre-action listener: _resource_record_pre_action 04:56:59 INFO - Running main action method: clobber 04:56:59 INFO - rmtree: /builds/slave/test/build 04:56:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:59 INFO - Running post-action listener: _resource_record_post_action 04:56:59 INFO - [mozharness: 2017-03-23 11:56:59.874165Z] Finished clobber step (success) 04:56:59 INFO - [mozharness: 2017-03-23 11:56:59.874416Z] Running read-buildbot-config step. 04:56:59 INFO - Running pre-action listener: _resource_record_pre_action 04:56:59 INFO - Running main action method: read_buildbot_config 04:56:59 INFO - Using buildbot properties: 04:56:59 INFO - { 04:56:59 INFO - "project": "", 04:56:59 INFO - "product": "firefox", 04:56:59 INFO - "script_repo_revision": "production", 04:56:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:56:59 INFO - "repository": "", 04:56:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:56:59 INFO - "buildid": "20170323040624", 04:56:59 INFO - "pgo_build": "False", 04:56:59 INFO - "basedir": "/builds/slave/test", 04:56:59 INFO - "buildnumber": 97, 04:56:59 INFO - "slavename": "t-yosemite-r7-0295", 04:56:59 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:56:59 INFO - "platform": "yosemite_r7", 04:56:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:56:59 INFO - "branch": "mozilla-aurora", 04:56:59 INFO - "repo_path": "releases/mozilla-aurora", 04:56:59 INFO - "revision": "0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2", 04:56:59 INFO - "stage_platform": "macosx64", 04:56:59 INFO - "builduid": "c928be24e8104df98f3178840f5a447b", 04:56:59 INFO - "slavebuilddir": "test" 04:56:59 INFO - } 04:56:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 04:56:59 INFO - Running post-action listener: _resource_record_post_action 04:56:59 INFO - [mozharness: 2017-03-23 11:56:59.877802Z] Finished read-buildbot-config step (success) 04:56:59 INFO - [mozharness: 2017-03-23 11:56:59.877942Z] Running download-and-extract step. 04:56:59 INFO - Running pre-action listener: _resource_record_pre_action 04:56:59 INFO - Running main action method: download_and_extract 04:56:59 INFO - mkdir: /builds/slave/test/build/tests 04:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:59 INFO - trying https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 04:56:59 INFO - Downloading https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/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 04:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/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 04:57:01 INFO - Downloaded 1199 bytes. 04:57:01 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:57:01 INFO - Using the following test package requirements: 04:57:01 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:57:01 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 04:57:01 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 04:57:01 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'jsshell-mac.zip'], 04:57:01 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 04:57:01 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:57:01 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 04:57:01 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 04:57:01 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 04:57:01 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:57:01 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 04:57:01 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:57:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:57:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:57:01 INFO - Fetch https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:57:02 INFO - Expected file size: 51782021 04:57:02 INFO - Obtained file size: 51782021 04:57:18 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 04:57:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:57:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:57:18 INFO - Fetch https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:57:20 INFO - Expected file size: 51782021 04:57:20 INFO - Obtained file size: 51782021 04:57:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 04:57:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:57:35 INFO - Fetch https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 04:57:36 INFO - Expected file size: 14404438 04:57:36 INFO - Obtained file size: 14404438 04:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:36 INFO - trying https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:57:36 INFO - Downloading https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 04:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/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 04:57:38 INFO - Downloaded 74758429 bytes. 04:57:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:57:38 INFO - mkdir: /builds/slave/test/properties 04:57:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:38 INFO - Contents: 04:57:38 INFO - build_url:https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:57:39 INFO - Running post-action listener: _resource_record_post_action 04:57:39 INFO - Running post-action listener: set_extra_try_arguments 04:57:39 INFO - [mozharness: 2017-03-23 11:57:39.391229Z] Finished download-and-extract step (success) 04:57:39 INFO - [mozharness: 2017-03-23 11:57:39.391392Z] Running populate-webroot step. 04:57:39 INFO - Running pre-action listener: _resource_record_pre_action 04:57:39 INFO - Running main action method: populate_webroot 04:57:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:39 INFO - '--tppagecycles', 04:57:39 INFO - '7'], 04:57:39 INFO - 'tests': ['tsvgm']}}, 04:57:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:57:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:57:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['damp', 'tps']}, 04:57:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'tests': ['damp', 'tps']}, 04:57:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['dromaeo_dom']}, 04:57:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['basic_compositor_video']}, 04:57:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:57:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['a11yr', 04:57:39 INFO - 'ts_paint', 04:57:39 INFO - 'tpaint', 04:57:39 INFO - 'sessionrestore', 04:57:39 INFO - 'sessionrestore_no_auto_restore', 04:57:39 INFO - 'tabpaint']}, 04:57:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:57:39 INFO - 'ts_paint', 04:57:39 INFO - 'tpaint', 04:57:39 INFO - 'sessionrestore', 04:57:39 INFO - 'sessionrestore_no_auto_restore', 04:57:39 INFO - 'tabpaint']}, 04:57:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:57:39 INFO - 'ts_paint', 04:57:39 INFO - 'tpaint', 04:57:39 INFO - 'sessionrestore', 04:57:39 INFO - 'sessionrestore_no_auto_restore', 04:57:39 INFO - 'tabpaint']}, 04:57:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:57:39 INFO - 'ts_paint', 04:57:39 INFO - 'tpaint', 04:57:39 INFO - 'sessionrestore', 04:57:39 INFO - 'sessionrestore_no_auto_restore', 04:57:39 INFO - 'tabpaint']}, 04:57:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['a11yr', 04:57:39 INFO - 'ts_paint', 04:57:39 INFO - 'tpaint', 04:57:39 INFO - 'sessionrestore', 04:57:39 INFO - 'sessionrestore_no_auto_restore', 04:57:39 INFO - 'tabpaint']}, 04:57:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['a11yr', 04:57:39 INFO - 'ts_paint', 04:57:39 INFO - 'tpaint', 04:57:39 INFO - 'sessionrestore', 04:57:39 INFO - 'sessionrestore_no_auto_restore', 04:57:39 INFO - 'tabpaint']}, 04:57:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['tsvgx', 04:57:39 INFO - 'tsvgr_opacity', 04:57:39 INFO - 'tart', 04:57:39 INFO - 'tscrollx', 04:57:39 INFO - 'cart', 04:57:39 INFO - 'tsvg_static']}, 04:57:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:57:39 INFO - 'tsvgr_opacity', 04:57:39 INFO - 'tart', 04:57:39 INFO - 'tscrollx', 04:57:39 INFO - 'cart', 04:57:39 INFO - 'tsvg_static']}, 04:57:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'talos_options': ['--disable-e10s'], 04:57:39 INFO - 'tests': ['tp5o']}, 04:57:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:57:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'talos_options': ['--disable-e10s', 04:57:39 INFO - '--xperf_path', 04:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:39 INFO - 'tests': ['tp5n']}, 04:57:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:57:39 INFO - 'talos_options': ['--xperf_path', 04:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:39 INFO - 'tests': ['tp5n']}}, 04:57:39 INFO - 'talos.zip': {'path': '', 04:57:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:39 INFO - Running post-action listener: _resource_record_post_action 04:57:39 INFO - [mozharness: 2017-03-23 11:57:39.409528Z] Finished populate-webroot step (success) 04:57:39 INFO - [mozharness: 2017-03-23 11:57:39.409633Z] Running create-virtualenv step. 04:57:39 INFO - Running pre-action listener: _resource_record_pre_action 04:57:39 INFO - Running main action method: create_virtualenv 04:57:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:39 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 04:57:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:39 INFO - Using real prefix '/tools/python27' 04:57:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:43 INFO - Installing pip.................done. 04:57:43 INFO - Return code: 0 04:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:57:43 INFO - Reading from file tmpfile_stdout 04:57:43 INFO - Output received: 04:57:43 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) 04:57:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:57:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:57:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:43 INFO - 'HOME': '/Users/cltbld', 04:57:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PAGER': '/bin/cat', 04:57:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test', 04:57:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:57:43 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:57:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - 'XPC_FLAGS': '0x0', 04:57:43 INFO - 'XPC_SERVICE_NAME': '0', 04:57:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:43 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 04:57:43 INFO - Cleaning up... 04:57:43 INFO - Return code: 0 04:57:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:57:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:57:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:57:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:43 INFO - 'HOME': '/Users/cltbld', 04:57:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:43 INFO - 'LOGNAME': 'cltbld', 04:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:43 INFO - 'MOZ_NO_REMOTE': '1', 04:57:43 INFO - 'NO_EM_RESTART': '1', 04:57:43 INFO - 'PAGER': '/bin/cat', 04:57:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:43 INFO - 'PWD': '/builds/slave/test', 04:57:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:43 INFO - 'SHELL': '/bin/bash', 04:57:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:57:43 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:57:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:43 INFO - 'USER': 'cltbld', 04:57:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:43 INFO - 'XPC_FLAGS': '0x0', 04:57:43 INFO - 'XPC_SERVICE_NAME': '0', 04:57:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:43 INFO - Downloading/unpacking psutil>=3.1.1 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:47 INFO - Installing collected packages: psutil 04:57:47 INFO - Running setup.py install for psutil 04:57:47 INFO - building 'psutil._psutil_osx' extension 04:57:47 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 04:57:47 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 04:57:47 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 04:57:47 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 04:57:48 INFO - building 'psutil._psutil_posix' extension 04:57:48 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 04:57:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:57:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:57:48 INFO - ^ 04:57:48 INFO - 1 warning generated. 04:57:48 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 04:57:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:48 INFO - Successfully installed psutil 04:57:48 INFO - Cleaning up... 04:57:48 INFO - Return code: 0 04:57:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57:48 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')]} 04:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:48 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')]} 04:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:48 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:57:48 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 04:57:48 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 04:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:48 INFO - 'HOME': '/Users/cltbld', 04:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:48 INFO - 'LOGNAME': 'cltbld', 04:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:48 INFO - 'MOZ_NO_REMOTE': '1', 04:57:48 INFO - 'NO_EM_RESTART': '1', 04:57:48 INFO - 'PAGER': '/bin/cat', 04:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:48 INFO - 'PWD': '/builds/slave/test', 04:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:48 INFO - 'SHELL': '/bin/bash', 04:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:57:48 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:48 INFO - 'USER': 'cltbld', 04:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:48 INFO - 'XPC_FLAGS': '0x0', 04:57:48 INFO - 'XPC_SERVICE_NAME': '0', 04:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:51 INFO - Installing collected packages: mozsystemmonitor 04:57:51 INFO - Running setup.py install for mozsystemmonitor 04:57:51 INFO - Successfully installed mozsystemmonitor 04:57:51 INFO - Cleaning up... 04:57:51 INFO - Return code: 0 04:57:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:51 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:57:51 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 04:57:51 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 04:57:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:57:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:51 INFO - 'HOME': '/Users/cltbld', 04:57:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:51 INFO - 'LOGNAME': 'cltbld', 04:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:51 INFO - 'MOZ_NO_REMOTE': '1', 04:57:51 INFO - 'NO_EM_RESTART': '1', 04:57:51 INFO - 'PAGER': '/bin/cat', 04:57:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:51 INFO - 'PWD': '/builds/slave/test', 04:57:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:51 INFO - 'SHELL': '/bin/bash', 04:57:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:57:51 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:57:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:51 INFO - 'USER': 'cltbld', 04:57:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:51 INFO - 'XPC_FLAGS': '0x0', 04:57:51 INFO - 'XPC_SERVICE_NAME': '0', 04:57:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:51 INFO - Downloading/unpacking jsonschema==2.5.1 04:57:51 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 04:57:51 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 04:57:51 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 04:57:51 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 04:57:51 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 04:57:51 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 04:57:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:54 INFO - warning: no files found matching '*.txt' 04:57:54 INFO - no previously-included directories found matching 'build' 04:57:54 INFO - no previously-included directories found matching 'dist' 04:57:54 INFO - no previously-included directories found matching '.git*' 04:57:54 INFO - Installing collected packages: jsonschema, functools32 04:57:55 INFO - Running setup.py install for functools32 04:57:55 INFO - warning: no files found matching '*.txt' 04:57:55 INFO - no previously-included directories found matching 'build' 04:57:55 INFO - no previously-included directories found matching 'dist' 04:57:55 INFO - no previously-included directories found matching '.git*' 04:57:55 INFO - Successfully installed jsonschema functools32 04:57:55 INFO - Cleaning up... 04:57:55 INFO - Return code: 0 04:57:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:55 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:57:55 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 04:57:55 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 04:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:55 INFO - 'HOME': '/Users/cltbld', 04:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:55 INFO - 'LOGNAME': 'cltbld', 04:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:55 INFO - 'MOZ_NO_REMOTE': '1', 04:57:55 INFO - 'NO_EM_RESTART': '1', 04:57:55 INFO - 'PAGER': '/bin/cat', 04:57:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:55 INFO - 'PWD': '/builds/slave/test', 04:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:55 INFO - 'SHELL': '/bin/bash', 04:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:57:55 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:55 INFO - 'USER': 'cltbld', 04:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:55 INFO - 'XPC_FLAGS': '0x0', 04:57:55 INFO - 'XPC_SERVICE_NAME': '0', 04:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:57:56 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:57:56 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 04:57:56 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 04:57:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:57:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:56 INFO - 'HOME': '/Users/cltbld', 04:57:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PAGER': '/bin/cat', 04:57:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test', 04:57:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:57:56 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:57:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - 'XPC_FLAGS': '0x0', 04:57:56 INFO - 'XPC_SERVICE_NAME': '0', 04:57:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:56 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 04:57:56 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 04:57:56 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 04:57:56 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 04:57:56 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 04:57:56 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 04:57:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:59 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 04:57:59 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 04:57:59 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 04:57:59 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 04:57:59 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 04:57:59 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 04:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:00 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 04:58:00 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 04:58:00 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 04:58:00 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 04:58:00 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 04:58:00 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 04:58:00 INFO - Downloading docopt-0.6.1.tar.gz 04:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:00 INFO - Running setup.py install for blobuploader 04:58:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:01 INFO - Running setup.py install for requests 04:58:01 INFO - Running setup.py install for docopt 04:58:01 INFO - Successfully installed blobuploader requests docopt 04:58:01 INFO - Cleaning up... 04:58:01 INFO - Return code: 0 04:58:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:01 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')]} 04:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:01 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')]} 04:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:01 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:58:01 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 04:58:01 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 04:58:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:58:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:01 INFO - 'HOME': '/Users/cltbld', 04:58:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:01 INFO - 'LOGNAME': 'cltbld', 04:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:01 INFO - 'MOZ_NO_REMOTE': '1', 04:58:01 INFO - 'NO_EM_RESTART': '1', 04:58:01 INFO - 'PAGER': '/bin/cat', 04:58:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:01 INFO - 'PWD': '/builds/slave/test', 04:58:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:01 INFO - 'SHELL': '/bin/bash', 04:58:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:58:01 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:58:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:01 INFO - 'USER': 'cltbld', 04:58:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:01 INFO - 'XPC_FLAGS': '0x0', 04:58:01 INFO - 'XPC_SERVICE_NAME': '0', 04:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-yHMNsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-sL3JsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ytlirE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0qS6CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-6eoCEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-EwkAgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-7HjlvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-wdNlk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-pMy9J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dIRwL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Psxx3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-tGBGWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-SzIPn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-NWth48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-1pyS9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-AUf2GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:03 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-rNNPKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:03 INFO - Running setup.py install for manifestparser 04:58:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:03 INFO - Running setup.py install for mozcrash 04:58:04 INFO - Running setup.py install for mozdebug 04:58:04 INFO - Running setup.py install for mozdevice 04:58:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:04 INFO - Running setup.py install for mozfile 04:58:04 INFO - Running setup.py install for mozhttpd 04:58:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:04 INFO - Running setup.py install for mozinfo 04:58:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:04 INFO - Running setup.py install for mozInstall 04:58:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Running setup.py install for mozleak 04:58:05 INFO - Running setup.py install for mozlog 04:58:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Running setup.py install for moznetwork 04:58:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Running setup.py install for mozprocess 04:58:05 INFO - Running setup.py install for mozprofile 04:58:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:05 INFO - Running setup.py install for mozrunner 04:58:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:06 INFO - Running setup.py install for mozscreenshot 04:58:06 INFO - Running setup.py install for moztest 04:58:06 INFO - Running setup.py install for mozversion 04:58:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:06 INFO - Cleaning up... 04:58:06 INFO - Return code: 0 04:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:06 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')]} 04:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 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')]} 04:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:58:06 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 04:58:06 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 04:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:06 INFO - 'HOME': '/Users/cltbld', 04:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:06 INFO - 'LOGNAME': 'cltbld', 04:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:06 INFO - 'MOZ_NO_REMOTE': '1', 04:58:06 INFO - 'NO_EM_RESTART': '1', 04:58:06 INFO - 'PAGER': '/bin/cat', 04:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:06 INFO - 'PWD': '/builds/slave/test', 04:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:06 INFO - 'SHELL': '/bin/bash', 04:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:58:06 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:06 INFO - 'USER': 'cltbld', 04:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:06 INFO - 'XPC_FLAGS': '0x0', 04:58:06 INFO - 'XPC_SERVICE_NAME': '0', 04:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:06 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-OjjV6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:06 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-m3yoOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:06 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-22G1U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Oj8zGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-MZY8fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-RM58Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-AQuPZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Z0L27P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-sKoysB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-WvAWk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-6qDaeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:07 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5_vKId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:08 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)) 04:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:08 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-9bmDYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:08 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)) 04:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:08 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-8QkZEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:08 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)) 04:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:08 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-tDeA4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:08 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)) 04:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:08 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-4ZxLAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:08 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)) 04:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:08 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-N6MQ56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 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)) 04:58:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:11 INFO - Downloading blessings-1.6.tar.gz 04:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:11 INFO - Installing collected packages: blessings 04:58:11 INFO - Running setup.py install for blessings 04:58:11 INFO - Successfully installed blessings 04:58:11 INFO - Cleaning up... 04:58:11 INFO - Return code: 0 04:58:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:11 INFO - Reading from file tmpfile_stdout 04:58:11 INFO - Current package versions: 04:58:11 INFO - blessings == 1.6 04:58:11 INFO - blobuploader == 1.2.4 04:58:11 INFO - docopt == 0.6.1 04:58:11 INFO - functools32 == 3.2.3-2 04:58:11 INFO - jsonschema == 2.5.1 04:58:11 INFO - manifestparser == 1.1 04:58:11 INFO - mozInstall == 1.12 04:58:11 INFO - mozcrash == 1.0 04:58:11 INFO - mozdebug == 0.1 04:58:11 INFO - mozdevice == 0.49 04:58:11 INFO - mozfile == 1.2 04:58:11 INFO - mozhttpd == 0.7 04:58:11 INFO - mozinfo == 0.9 04:58:11 INFO - mozleak == 0.1 04:58:11 INFO - mozlog == 3.4 04:58:11 INFO - moznetwork == 0.27 04:58:11 INFO - mozprocess == 0.25 04:58:11 INFO - mozprofile == 0.28 04:58:11 INFO - mozrunner == 6.13 04:58:11 INFO - mozscreenshot == 0.1 04:58:11 INFO - mozsystemmonitor == 0.3 04:58:11 INFO - moztest == 0.8 04:58:11 INFO - mozversion == 1.4 04:58:11 INFO - psutil == 3.1.1 04:58:11 INFO - requests == 1.2.3 04:58:11 INFO - wsgiref == 0.1.2 04:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:11 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:58:11 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 04:58:11 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 04:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:11 INFO - 'HOME': '/Users/cltbld', 04:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:11 INFO - 'LOGNAME': 'cltbld', 04:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:11 INFO - 'MOZ_NO_REMOTE': '1', 04:58:11 INFO - 'NO_EM_RESTART': '1', 04:58:11 INFO - 'PAGER': '/bin/cat', 04:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:11 INFO - 'PWD': '/builds/slave/test', 04:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:11 INFO - 'SHELL': '/bin/bash', 04:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:58:11 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:11 INFO - 'USER': 'cltbld', 04:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:11 INFO - 'XPC_FLAGS': '0x0', 04:58:11 INFO - 'XPC_SERVICE_NAME': '0', 04:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 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)) 04:58:12 INFO - Cleaning up... 04:58:12 INFO - Return code: 0 04:58:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:12 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')]} 04:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 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')]} 04:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 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 0x10563fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f922ad826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, '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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 04:58:12 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 04:58:12 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 04:58:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:58:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:12 INFO - 'HOME': '/Users/cltbld', 04:58:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:12 INFO - 'LOGNAME': 'cltbld', 04:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:12 INFO - 'MOZ_NO_REMOTE': '1', 04:58:12 INFO - 'NO_EM_RESTART': '1', 04:58:12 INFO - 'PAGER': '/bin/cat', 04:58:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:12 INFO - 'PWD': '/builds/slave/test', 04:58:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:12 INFO - 'SHELL': '/bin/bash', 04:58:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:58:12 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:58:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:12 INFO - 'USER': 'cltbld', 04:58:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:12 INFO - 'XPC_FLAGS': '0x0', 04:58:12 INFO - 'XPC_SERVICE_NAME': '0', 04:58:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:58:12 INFO - Cleaning up... 04:58:12 INFO - Return code: 0 04:58:12 INFO - Running post-action listener: _resource_record_post_action 04:58:12 INFO - Running post-action listener: _start_resource_monitoring 04:58:12 INFO - Starting resource monitoring. 04:58:12 INFO - [mozharness: 2017-03-23 11:58:12.423328Z] Finished create-virtualenv step (success) 04:58:12 INFO - [mozharness: 2017-03-23 11:58:12.424390Z] Running install step. 04:58:12 INFO - Running pre-action listener: _resource_record_pre_action 04:58:12 INFO - Running main action method: install 04:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:12 INFO - Reading from file tmpfile_stdout 04:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:12 INFO - Reading from file tmpfile_stdout 04:58:12 INFO - Output received: 04:58:12 INFO - Usage: mozinstall [options] installer 04:58:12 INFO - Options: 04:58:12 INFO - -h, --help show this help message and exit 04:58:12 INFO - -d DEST, --destination=DEST 04:58:12 INFO - Directory to install application into. [default: 04:58:12 INFO - "/builds/slave/test"] 04:58:12 INFO - --app=APP Application being installed. [default: firefox] 04:58:12 INFO - mkdir: /builds/slave/test/build/application 04:58:12 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'] 04:58:12 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 04:58:32 INFO - Reading from file tmpfile_stdout 04:58:32 INFO - Output received: 04:58:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:58:32 INFO - Running post-action listener: _resource_record_post_action 04:58:32 INFO - [mozharness: 2017-03-23 11:58:32.617514Z] Finished install step (success) 04:58:32 INFO - [mozharness: 2017-03-23 11:58:32.617686Z] Running run-tests step. 04:58:32 INFO - Running pre-action listener: _resource_record_pre_action 04:58:32 INFO - Running main action method: run_tests 04:58:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:32 INFO - 2017-03-23 04:58:32.633 screenresolution[1892:8882] starting screenresolution argv=screenresolution get 04:58:32 INFO - 2017-03-23 04:58:32.635 screenresolution[1892:8882] Display 0: 1600x1200x32@60 04:58:32 INFO - 2017-03-23 04:58:32.641 screenresolution[1893:8884] starting screenresolution argv=screenresolution list 04:58:32 INFO - Available Modes on Display 0 04:58:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:32 INFO - Intel Iris: 04:58:32 INFO - Chipset Model: Intel Iris 04:58:32 INFO - Type: GPU 04:58:32 INFO - Bus: Built-In 04:58:32 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:32 INFO - Vendor: Intel (0x8086) 04:58:32 INFO - Device ID: 0x0a2e 04:58:32 INFO - Revision ID: 0x0009 04:58:32 INFO - Displays: 04:58:32 INFO - Display: 04:58:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:32 INFO - Display Serial Number: 1600x1200 60 04:58:32 INFO - Main Display: Yes 04:58:32 INFO - Mirror: Off 04:58:32 INFO - Online: Yes 04:58:32 INFO - Rotation: Supported 04:58:32 INFO - Return code: 0 04:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:32 INFO - Python 2.7.3 04:58:32 INFO - Return code: 0 04:58:32 INFO - grabbing minidump binary from tooltool 04:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:58:32 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 0x10541dd30>, '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 0x105344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105412be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:32 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 04:58:32 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 04:58:32 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 04:58:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:33 INFO - Return code: 0 04:58:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:58:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:33 INFO - ENV: RUST_BACKTRACE is now 1 04:58:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:58:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:33 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/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 04:58:33 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/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --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 04:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P94Z4SAMKA/Render', 04:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:33 INFO - 'HOME': '/Users/cltbld', 04:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:33 INFO - 'LOGNAME': 'cltbld', 04:58:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:33 INFO - 'MOZ_NO_REMOTE': '1', 04:58:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:33 INFO - 'NO_EM_RESTART': '1', 04:58:33 INFO - 'PAGER': '/bin/cat', 04:58:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:33 INFO - 'PWD': '/builds/slave/test', 04:58:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:33 INFO - 'RUST_BACKTRACE': '1', 04:58:33 INFO - 'SHELL': '/bin/bash', 04:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8rjmpfGzdk/Listeners', 04:58:33 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 04:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:33 INFO - 'USER': 'cltbld', 04:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:33 INFO - 'XPC_FLAGS': '0x0', 04:58:33 INFO - 'XPC_SERVICE_NAME': '0', 04:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:33 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/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 04:58:33 INFO - mozversion application_buildid: 20170323040624 04:58:33 INFO - mozversion application_changeset: 0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2 04:58:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:58:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:33 INFO - mozversion application_name: Firefox 04:58:33 INFO - mozversion application_remotingname: firefox-dev 04:58:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:58:33 INFO - mozversion application_vendor: Mozilla 04:58:33 INFO - mozversion application_version: 54.0a2 04:58:33 INFO - mozversion platform_buildid: 20170323040624 04:58:33 INFO - mozversion platform_changeset: 0dd7f3ab57f92ea7f1e3b3cadbf986fcb39889e2 04:58:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:58:33 INFO - mozversion platform_version: 54.0a2 04:58:33 INFO - using testdate: 1490270313 04:58:33 INFO - actual date: 1490270313 04:58:33 INFO - starting webserver on 'localhost:49416' 04:58:33 INFO - SUITE-START | Running 2 tests 04:58:33 INFO - TEST-START | dromaeo_css 04:58:33 INFO - operating with platform_type : mac_ 04:58:33 INFO - Initialising browser for dromaeo_css test... 04:58:33 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpZLfKIZ/profile http://localhost:49416/getInfo.html) 04:58:35 INFO - PROCESS | 1903 | __metrics Screen width/height:1600/1200 04:58:35 INFO - PROCESS | 1903 | colorDepth:24 04:58:35 INFO - PROCESS | 1903 | Browser inner width/height: 1024/689 04:58:35 INFO - PROCESS | 1903 | __metrics 04:58:35 INFO - PROCESS | 1903 | 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" 04:58:35 INFO - PROCESS | 1903 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:36 INFO - TEST-INFO | 1903: exit 0 04:58:36 INFO - Browser initialized. 04:58:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:36 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpZLfKIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:48 INFO - PROCESS | 1905 | RSS: Main: 215072768 04:58:48 INFO - PROCESS | 1905 | 05:01:52 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49416/tests/dromaeo/cssquery-ext.html) 05:01:54 INFO - PROCESS | 1905 | RSS: Main: 367886336 05:01:54 INFO - PROCESS | 1905 | 05:03:38 INFO - PROCESS | 1905 | ************************* 05:03:38 INFO - PROCESS | 1905 | A coding exception was thrown and uncaught in a Task. 05:03:38 INFO - PROCESS | 1905 | 05:03:38 ERROR - PROCESS | 1905 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:03:38 INFO - PROCESS | 1905 | Full stack: 05:03:38 INFO - PROCESS | 1905 | ************************* 05:04:57 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49416/tests/dromaeo/cssquery-ext.html (next: http://localhost:49416/tests/dromaeo/cssquery-jquery.html) 05:04:58 INFO - PROCESS | 1905 | RSS: Main: 351248384 05:04:58 INFO - PROCESS | 1905 | 05:08:00 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49416/tests/dromaeo/cssquery-mootools.html) 05:08:01 INFO - PROCESS | 1905 | RSS: Main: 333012992 05:08:01 INFO - PROCESS | 1905 | 05:11:03 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49416/tests/dromaeo/cssquery-prototype.html) 05:11:04 INFO - PROCESS | 1905 | RSS: Main: 345825280 05:11:04 INFO - PROCESS | 1905 | 05:14:08 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49416/tests/dromaeo/cssquery-yui.html) 05:14:09 INFO - PROCESS | 1905 | RSS: Main: 321216512 05:14:09 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:49416/tests/dromaeo/cssquery-yui.html (next: http://localhost:49416/tests/dromaeo/cssquery-dojo.html) 05:17:12 INFO - PROCESS | 1905 | RSS: Main: 381562880 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | __start_tp_report 05:17:12 INFO - PROCESS | 1905 | _x_x_mozilla_page_load 05:17:12 INFO - PROCESS | 1905 | _x_x_mozilla_page_load_details 05:17:12 INFO - PROCESS | 1905 | |i|pagename|runs| 05:17:12 INFO - PROCESS | 1905 | |0;dojo.html;2819.9013034543796;3374.4938259261094;3390.3049874775675;3393.6436674149204;3441.1913200397917;5840.970795146029;5859.443352881475;5868.85327866803;5876.942150412924;5921;5855;5963.761449542013;5965.254343207099;5978.9402105978925;5992.400759924006;5334.493223143805;5360.624756267063;5394.298741163643;5449.482299181572;5453.536449401786;5293.550048245904;5297.993381257549;5349.037173308803;5467.644603100785;5469.371022332443;5382.650127741685;5424;5431.619786614939;5467.234587157781;5469.781208751645;4871.634627402924;5067.721275329855;5460.726963651801;5460.890782184374;5460.918086228709;4453.844115455943;4504.729716217004;5209.635325527214;5297.993381257587;5405.243265942771;5791.044477661181;5838.036723940545;5906.202662640574;5966.433188847052;5997.7001149942325;6288.748450061992;6317.05244213367;6340.682965851735;6343.302236753953;6345.809625711236;6381.298057213703;6383.776567820104;6392.680365981682;6393.648349340784;6404.455621272197;5948.583599148104;5991.940080599225;5996.430339117776;6084.178635884187;6152.261728592553;6426.196725409324;6486.578372405778;6537.313582073813;6583.63789991555;6588.604683718992;6273.215848018997;6288.937110628926;6294.276158241769;6310.652914089677;6313.810585682437;6206.751729930752;6229.56393052482;6383.648899310582;6399.168108145911;6412.839679007969;6208.2239720034995;6229.3770622937345;6259.968700156561;6274.090256912722;6301.6534090625455;6274.309825919146;6277.183966084471;6288.119663247149;6291.811245662638;6344.49244060474;5037.899242015213;5155.432902380735;5157.948420515747;5173.637845350864;5202;4577.130345234395;4594.356790049395;4634.95365046352;4637.350770892078;4651.348811166439;5766.481016708516;5812.273465816773;5846.590738648339;5911.940880591225;6007;5230.450802665741;6321;6334.113224148623;6335.714892829834;6362.045693146065;5812.680302583314;5822.446867547576;5822.970885145547;5823.854403639943;5836.299644042742;5422.53908417781;5491.341039075336;5507.586930980193;5511.366192887869;5517.062099443105;6352.460040896575;6487.513436492282;6520.869582608321;6613.966930165318;6641.169853768279;6388.872222555616;6407.679616019273;6414.486841052611;6415.711292991733;6423.42189202974;6613.900791488035;6620.238672552526;6625.370589793962;6629.138212032598;6638.402543771083;6158.107074474086;6226.533010024175;6301.905471418024;6306.527010474141;6405.487560995016;5618.044932361427;6308.747650093945;6349.238091429058;6377.7767778127545;6379.106925030406;6265.373462653698;6266.498680105489;6271;6283.874322513433;6287.654179020198;5963.314218864886;6053.606515576474;6218.875622487434;6335.081413194969;6336.049592561153;6091;6175.382461753788;6179.721912513858;6184.907226391698;6185.938140618537;6315.621062736251;6317.842053948688;6319.146915166578;6326.019466982625;6331.556791024584;5900.881982360243;5967.373425790403;6135.233095863017;6160.383961603804;6171.9691401544505 05:17:12 INFO - PROCESS | 1905 | |1;ext.html;682.4847240333547;725.0682872508827;741.7366834773653;787.3111027850634;800.4836880212267;28264.85867570662;28644;29430.264243393925;29470.705292947092;29512;28693.85224591019;41327.58672413275;41616.95957601062;43865.12269754603;43951;8990.235829954461;9146.862797058016;9152.771180720501;9160.17558419742;9186.356955013152;7300.306470885284;9013.188813006827;9108.499032553207;9114.635414583408;9124;7441.776746697607;10865.891341086566;11031.613893513728;11239.943800280987;11290.491927863266;11015.614453494129;11030;11055.72360690981;11060.059894908942;11077.889221107807;7317.670704818296;10810.945945270301;10893.128549716004;10905.400202988832;10950.06924411426;28255;28445.00442484524;28490.715092849012;28541;39491.60508394908;3369.326134773031;3819.579846216914;3820.8280627371555;3835.5972622874756;3854.8650797221962;28144.29639259035;28455.430891382264;28490;28968.710312896812;29770.85114574435;2640.366312085105;3086.213015680987;3133.576967109434;3151.9684803151904;3184.2039490127468;278309;336529;336855;337335;337920;42951.57048429476;52404.951900961765;52571.47428525742;52682;52784;55267.72366138224;55456.72271638616;55472;55476.44523554794;55591.72204139034;14613.488527901472;15067.698646027018;15087.924560377129;15089.47186848455;15109.168995705342;12916.483340666457;12926.741465170644;12930.418131184118;12937.482500700055;12969.41637626309;10824.567017319376;11034.062104721028;12236.959858411956;12642.683932901567;12685.556005539946;4713.158967228389;4897.069556784199;5016.648834581544;5470.699111548903;5536.4186760390385;1113.565709373329;1121.7812526557243;1122.646366394583;1150.9231258952743;1157.4964890272759;23756.643650345257;26752.464950701265;27250.5912411314;27282.454350913267;27292.181234562995;1054.3094273251033;1105.4583254205381;1217.4095563651622;1232.125191114301;1234.154604096197;10868.565257389773;13691.452341906212;13904.652383690287;14101.78847317291;14134.010619256553;418786;419607;420116;420327;420770;58100.4189958095;58207;58226;58306.7084664574;58401.70799145977;1370.2669072046408;1434.189682829198;1438.5828109848237;1439.8704116629763;1444.075791493445;24734;25449.982000719763;26066.95732170768;26277;26376.20871373862;48024.27963580479;48097.75951120222;48253.03493930031;48271.75864120657;48305.27542086801;402842;404141.9585804222;404570;405047;405423;27502;28088.578671320356;29302.12093637109;29409.411811764072;35169.29661406809;36412.81793591015;36956.44565331468;37651.43522847105;37707;38102.618973809906;28584.428311434072;31122.68877311198;31398.843005784824;31875;32173.03480895577;30765.23086922845;31286;31639.367212655157;33797.83101084479;34926.47610285797;28348.71651283543;33955.66044339525;34602.788902388296;34906.30187396289;35452.46821297631;29068.7093129066;30435.847820760755;30467.2383190422;30563.847180763954;30578.694213057584;21309.25417610376;22159;23575.821208939826;23721.88139059294;23892.402689932194 05:17:12 INFO - PROCESS | 1905 | |2;jquery.html;381.64316364199493;428.4366395162997;429.465315681976;434.1989030239209;441.4834643467145;15483.690326193484;20340;21649.025793839275;21753.891230543864;21889;20759.79240207601;21519.81641009744;22182.88908555459;23445.17941872035;23445.827708614586;6588.242352129495;6686.197656281253;6768.661566921659;6811.523193376441;6914.274001229849;4162.209180255757;6766.627835469048;6769.323067693241;6825.726970921157;6832.863342733142;4657.534246575332;7843.37253019757;7871.763847084597;7895.32889704373;7901.130875603679;7649.961750191269;7772.80567985802;7829.217078292125;7839.333656639164;7864.016997875266;7453.8509229815645;7494.85010299791;7535.284148005931;7594.164641889388;7606.619669016527;22593.661095083586;22797.658035129487;24662.766861657026;26544.336391590365;26625.733742662713;2878.7409133178116;2890.8554572271514;2915.5043642580813;2941.264683829043;2948.43979643867;16229.918850405791;16360.754588681179;16475.093869837154;16622.33510659572;17298.3945561906;1750.4661078371091;2040.9795902040937;2067.2764532413535;2138.7754285799924;2152.1283880028614;155738;156000.2199989004;159645;165173;165327.1733641324;15159.634181023594;20462.488437788877;20509.871957042207;20519.692204616942;20833;30248.48757562113;30616.693833061385;30620;31640.367192656016;31785.682143178736;9814.362066465657;10236.283460157718;10321.122704570045;10351.896481035094;10491.737706557244;8508.276796472246;8522.957385213158;8523.190296921783;8680.178941843926;8708.998465176586;9363.063693630718;9445.338826282232;9584.712458626253;9596.345772300429;9635.518224088768;3258.332041931398;3817.6182381762155;3908.785016824102;3910.550286717064;3959.3862951242604;984.3700031979539;985.5417230987625;1005.7284533176002;1009.1674368645896;1029.9073083422527;17041.659166816593;20507.794922050885;21283.574328513343;21414.57170856574;21494;989.9752506187403;998.7053819123377;1025.1132770153763;1037.2531777120462;1045.46158728255;10349.63776267827;10671.146308295318;10707.464626768631;10737.78524429507;10795.514201860935;702808;731464;738498;738970;746357;150299;150446;153216.23391883192;156278;159394.40605593796;1128.497818470789;1135.73310272086;1164.441068287227;1169.1114752787942;1173.5951096871565;13975.440982360591;17020.89364191373;18275.26898924028;18477.81522184761;18503;30949.535756963214;46112.7694361526;58727;62297.68851155715;62773.68613156905;67945;82487.5875620618;83603.16396835954;83621;86663;10899.128069754559;11270.549178033114;11453.541858325574;11676.06591472697;11688.357140357022;12422.440990155645;12790.808137877753;12819.16675416095;12893.161944473579;12923.870761292266;10608.787824243625;10697.679069627924;10730.195235357223;11011.889881101086;11029.062529685067;9166.266698663958;9253.352265341631;10794.190435717195;11038.889611104107;11340.319580824847;6120.877582448237;10973.23187376876;11354.829677554679;11401.714957125807;11502.252353596989;11159;11451.535377860986;11532.711682208012;11598.536058557564;11682.4742886572;9557.378770379903;9565.426074435556;10813.243072984815;11001.449927503432;11136.49885755159 05:17:12 INFO - PROCESS | 1905 | |3;mootools.html;1449.7535418978773;1546.2423412527864;1561.5237352607458;1583.8416158384157;1601.3994751968007;10626;11205.21563490556;11222.102231821455;11222.551097956071;11223.38271395073;9295.535223238829;10596.152307815375;11013.779724405507;11178.720531986684;11186.944065279662;2394.0304176808377;2438.9878050609723;2442.120836498859;2442.9511409771794;2443.8044956403446;2392.234484964812;2421.673074134987;2423.115562819567;2424.854508729473;2427.5751743444916;2376.835350678164;2395.4849707312924;2399.0283935006264;2399.700037495313;2407.6027455469825;2320.0951628864755;2345.519168570439;2346.495503466763;2346.5306938612175;2363.550925324183;2294.8737819419925;2296.0930432479076;2353.576356255873;2364.99487717721;2376.619740841474;11093.057090147347;11208.943955280252;11252.212345135844;11269.774604507946;11322.490487928064;4728.4798672146035;5906.9704651476895;5908.438698323653;5914.4381283777975;5915.852103697399;3333.76650639265;3471.1322169457635;3692.4276737105793;3751.212245428463;3779.4141908004303;1181.090560268597;1181.9763604727943;1241.5344245907784;1266.4807428954177;1266.8986481081492;13721.862781372158;14147.363368648332;14479.493217737434;14973.850261497355;15180.696386072217;4677.766111694402;4847.830325938575;4860.3681521401995;4876.658633895664;4883.951160488421;12062.035037197003;12070.69823254408;12071.517139314505;12079.818802717966;12085.516579336729;4974;5012.824551140692;5185.9740701297005;5643.830685079454;5665.5467562594895;5236.92144617831;5273.762680679379;5385.434529374437;5455.781768729285;5462.289902312674;3888.747231429948;3901.1612503311358;3942.4874766280773;3980.601939805996;3990.5610382857863;1047.3977462958828;1054.5992522841425;1056.841473778924;1064.5954537275786;1071.9624813131502;916.9587368568431;927.2118699105706;939.6758118449125;939.9530023498797;988.728099772554;5789.81180372605;6353.396427339396;6631.237407698177;6668.599884006975;6678.165229346332;957.1194501059042;976.9560369783377;982.8967958364411;987.9357841740264;1012.7620009297809;4129.628333449944;4155.667546596325;4160.396742472385;4211.052513184509;4279.037216626234;10168.745781355525;13932.233727145105;13954.302284885714;13962.232077235647;14019.08875923082;13844.30778461073;13854.445822167201;13855;13870.237136957363;13879.583612491642;9870.950645246729;10031.946645602253;10116.038976297386;10330.173586113093;10348.327358721659;5296.973515132399;5657.462541058593;6437.485001199986;6454.774082907264;6676.83307917306;10013.649522266685;11523.423828808358;12066.517339306329;12223.327716975651;12406.937965310477;12296.877031229931;12672.176308539916;12809.231446113263;12836.973042156791;12893.677658058623;6892.586444813327;8588.957055214683;8604.741857744277;8614.78463038404;8704.695335663222;10128.291019628556;10223.437710925971;10259.794804104025;10391.532381043022;10399;9023;9028.503432311287;9106.726798196065;9163.99196088443;9375.906240937504;8721.215090641872;8771;8790.692325768567;8912.509811960144;9035.0061493237;7646;7818.765437036898;8011.879821802794;8012.198780122174;8019.278264956182;5740.569457290803;5776.884462310646;5875.529957603467;5941.37615550361;6015.819525414245;5792.4497172768515;5901.970490147522;5913.05391137416;5938.287405511366;6131.957567213673 05:17:12 INFO - PROCESS | 1905 | |4;prototype.html;371.76021466154333;381.9637134472225;386.4300157268028;388.9805509724513;393.2174971806105;4646.976765116178;4852.36072945291;4965.28003439501;5229.712365819878;5296.576273898084;4388.736675799454;4587.977060114703;4708.62331013519;4896.926546101811;4899.750563606284;3598.316319899224;3931.3709806430975;4201.747895126302;4319.244132276839;4461.442319710036;3629.4192929131345;3920;4335.43639326887;4425.336199570074;4448.933266001012;3667.064898450905;4290.528041915402;4346.695731298811;4353.519803266889;4400.933985990213;4089;4248.660107191417;4298.61312481875;4302.870913872557;4310.159518893817;3694.9630503695157;4053.27735712324;4086.264472394968;4096.795160241976;4118.794060296973;4265.33887247474;4564.406627138451;4931.309616653672;4947.678400903929;4970.900581988376;3949.8025098744947;4606.055758569519;4764.785584648699;4898.510148985109;5123.308353372322;4937.864291213005;5131.589472842164;5405.459454054602;5412.648177868426;5417.810376636839;4032.971592243988;4233.576642335773;4515.729056256602;4656.254999200111;4806.447258565275;4522.377021327622;4832.758362081917;5128.128263161289;5218.478152184751;5290.365156181244;4129.566395528486;4791.47293797682;4827.286313358707;4836.5888899443235;4851.74393906835;4722.8429034885985;4784.72246511141;4947.356843610308;5019.247112933089;5023.9401845244;4766.428028636586;4909.26361045846;4919.532644398776;4937.21004639256;5120.61595380348;5132.820351287687;5144.6655967362;5187.57341731027;5328.520433161034;5357.16962371906;1346.6498710335384;1560;1578.936842526309;1583.4062226665;1661.479746032391;1194.4266751959108;1198.2451055834767;1294.449858810002;1321.729045545661;1374.3471850870756;4564.3838081859185;4712.986707857827;4976.303317535548;5057.165567681292;5072.847814565569;4786.712797232177;4871.3667223261455;5343.893122137535;5549.139883318092;5636.774529018793;4235.724677895927;4477.619402350771;5047.470015648378;5052.317937078447;5055.974720126376;2582.2124252102913;2834.803900050224;2882.5155045151764;2942.955855662167;2965.2438628150117;5322.445226291402;5357.624966252325;5391.757370918318;5756.366799652035;5793.710314484259;5037.546620804145;5217.747535758344;5501;5561.332640083216;5897.734601942923;5000;5386.003589335985;5843.574916409642;5854.258050978721;5902.520941204619;4842.903141937212;5073.34046573943;5521.47545983147;5539.695316757617;5680.68756218412;4726.338312636165;5005.998800239894;5269.262303277467;5480.479354461319;5509.146082357241;4906.803727850846;5264.657797243167;5332.733363331896;5550.000999820071;5691.800786972436;4080.7755573443746;4095.9795201023803;4545.863444181229;4666.973265881501;4863.367762190893;5251.737413129405;5442.102053161184;5567.916481252865;5681.857953551194;5730.971345143247;4385.934210986901;5049.510394433578;5273.709945953009;5410.83767486976;5527.723613819373;4232.407462955251;4690.390249267573;5060.418051924076;5126.2054381570915;5325;4785.928211076906;5038.521340472649;5181.549166233461;5238.449962754008;5369;4795.832145874878;5300.761465733974;5363.812266570807;5365.490278423544;5383.569314454756;4755.976220118877;4838.427511058991;4995.825146119869;5039.0929632665;5345.41200467956 05:17:12 INFO - PROCESS | 1905 | |5;yui.html;693.4071368979523;711.3526690711453;736.6905899522196;785.9685612575497;824.6371596497543;12367.814482782765;15851.128187949658;15855.84144158558;15862.682746345066;15882.047077175363;14299.642508937282;14459.421623135062;14462;14477.78283325751;14988.10071395717;913.5249670171523;937.1331518345537;938.7700013496703;941.3598752848061;959.6209497248583;938.723076692374;957.6696039866235;958.1281034258826;958.6980101268113;959.3620242538703;1004.3521928356206;1004.5780772075746;1004.8643433136542;1005.6379703306803;1005.6781829814425;996.6063404955074;999.6101520407084;999.8150342186682;999.8900120986685;999.9900100898072;743.9628018599102;744.2631794523437;744.7430636430423;745.1133151549639;745.6868115391549;13400.93299533496;14426;15515.456959006493;15564.92217538905;16244.269007894673;14088;14166.716665666629;14243.359048842723;14377.78433323501;14431;11754.706132346675;11759.591022892544;11770.646880593511;11891.345975971319;12214.26714397139;3605.4591811228265;3740.9251814963823;3815.4849095372047;3886.6113388661192;3898.8050597470015;111161;117889.41055294669;118819.4059029708;120660.79339206671;121413.78586214113;10658.094062004817;10808.891911080946;10923.617673381394;11128.221024528368;11431.485583148611;23103.88448057749;23235.883820581126;23287.88356058209;23291;23299.18452854142;7609.885851712229;7624.504407213513;7651.062177326662;7704.26809453101;7801.9609901950125;4224.640905523003;4277.508086570084;4356.564343565618;4409.647228221798;4534.251848444969;3492.5983511895947;3515.226650137017;3528.8588456461453;3587.695045921074;3594.3530164570107;639.2424976402884;648.8507643241986;662.2483481248721;695.9756408525778;697.6133497827298;564.3538148819579;678.7488629207224;688.7313947560456;691.9757808476679;733.2081352139676;8796.34027447944;8994.460332379947;9757.268204884662;9842.60629574809;10485.586188303183;661.2329697550817;692.6605963078056;693.6739732325799;704.5631708340759;716.5235118646146;4721.055788842245;4987.700737955662;4988.201887697951;4992.750362481861;4995.25071239317;85837.57081214554;108977;109161.45419272853;109281.45359273153;111433.44283278532;51386.48613513817;73162;79318.6034069826;88829;98066;78327.60836195896;79573;80438;82203;82629.58685206655;10875.293105948089;10897.67306980792;10939.617113400993;11052.258122545401;11204.383758893338;49148;49470;49961.37341194847;52016.479835201164;52307.73846130745;64747.35252647413;65768.6711566439;66775;68274;68385;10703.143748500257;11139.554417823196;11571.594994175164;12313.87686123163;12587;13436.529721459701;13450.12574182675;13749.725005500035;13757;14283.285835707966;12503.374831258583;12789.296588687712;13623.114497557626;13659.658508537366;14689.779653305422;13892.444302227797;13953.162810231419;13989.23059231752;14116.929415352857;14644.341004654603;11162.553497859995;13302.534411295559;13845.459191521148;13846.723065538834;14344.49794257196;10784.946075269574;11063.834042489209;11335.716607084889;11398.544058237909;11463.656090317303;11275.154363422613;11408.258463199865;11453.713657158638;11518.209741114417;11613.30320180792 05:17:12 INFO - PROCESS | 1905 | __end_tp_report 05:17:12 INFO - PROCESS | 1905 | __start_cc_report 05:17:12 INFO - PROCESS | 1905 | _x_x_mozilla_cycle_collect,1526 05:17:12 INFO - PROCESS | 1905 | __end_cc_report 05:17:12 INFO - PROCESS | 1905 | __startTimestamp1490271432960__endTimestamp 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | ------- Summary: start ------- 05:17:12 INFO - PROCESS | 1905 | Number of tests: 6 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | [#0] dojo.html Cycles:165 Average:5879.49 Median:6152.26 stddev:683.01 (11.1%) stddev-sans-first:641.55 05:17:12 INFO - PROCESS | 1905 | Values: 2819.9 3374.5 3390.3 3393.6 3441.2 5841.0 5859.4 5868.9 5876.9 5921.0 5855.0 5963.8 5965.3 5978.9 5992.4 5334.5 5360.6 5394.3 5449.5 5453.5 5293.6 5298.0 5349.0 5467.6 5469.4 5382.7 5424.0 5431.6 5467.2 5469.8 4871.6 5067.7 5460.7 5460.9 5460.9 4453.8 4504.7 5209.6 5298.0 5405.2 5791.0 5838.0 5906.2 5966.4 5997.7 6288.7 6317.1 6340.7 6343.3 6345.8 6381.3 6383.8 6392.7 6393.6 6404.5 5948.6 5991.9 5996.4 6084.2 6152.3 6426.2 6486.6 6537.3 6583.6 6588.6 6273.2 6288.9 6294.3 6310.7 6313.8 6206.8 6229.6 6383.6 6399.2 6412.8 6208.2 6229.4 6260.0 6274.1 6301.7 6274.3 6277.2 6288.1 6291.8 6344.5 5037.9 5155.4 5157.9 5173.6 5202.0 4577.1 4594.4 4635.0 4637.4 4651.3 5766.5 5812.3 5846.6 5911.9 6007.0 5230.5 6321.0 6334.1 6335.7 6362.0 5812.7 5822.4 5823.0 5823.9 5836.3 5422.5 5491.3 5507.6 5511.4 5517.1 6352.5 6487.5 6520.9 6614.0 6641.2 6388.9 6407.7 6414.5 6415.7 6423.4 6613.9 6620.2 6625.4 6629.1 6638.4 6158.1 6226.5 6301.9 6306.5 6405.5 5618.0 6308.7 6349.2 6377.8 6379.1 6265.4 6266.5 6271.0 6283.9 6287.7 5963.3 6053.6 6218.9 6335.1 6336.0 6091.0 6175.4 6179.7 6184.9 6185.9 6315.6 6317.8 6319.1 6326.0 6331.6 5900.9 5967.4 6135.2 6160.4 6172.0 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | [#1] ext.html Cycles:180 Average:52202.04 Median:30671.96 stddev:102122.43 (333.0%) stddev-sans-first:102335.66 05:17:12 INFO - PROCESS | 1905 | Values: 682.5 725.1 741.7 787.3 800.5 28264.9 28644.0 29430.3 29470.7 29512.0 28693.9 41327.6 41617.0 43865.1 43951.0 8990.2 9146.9 9152.8 9160.2 9186.4 7300.3 9013.2 9108.5 9114.6 9124.0 7441.8 10865.9 11031.6 11239.9 11290.5 11015.6 11030.0 11055.7 11060.1 11077.9 7317.7 10810.9 10893.1 10905.4 10950.1 28255.0 28445.0 28490.7 28541.0 39491.6 3369.3 3819.6 3820.8 3835.6 3854.9 28144.3 28455.4 28490.0 28968.7 29770.9 2640.4 3086.2 3133.6 3152.0 3184.2 278309.0 336529.0 336855.0 337335.0 337920.0 42951.6 52405.0 52571.5 52682.0 52784.0 55267.7 55456.7 55472.0 55476.4 55591.7 14613.5 15067.7 15087.9 15089.5 15109.2 12916.5 12926.7 12930.4 12937.5 12969.4 10824.6 11034.1 12237.0 12642.7 12685.6 4713.2 4897.1 5016.6 5470.7 5536.4 1113.6 1121.8 1122.6 1150.9 1157.5 23756.6 26752.5 27250.6 27282.5 27292.2 1054.3 1105.5 1217.4 1232.1 1234.2 10868.6 13691.5 13904.7 14101.8 14134.0 418786.0 419607.0 420116.0 420327.0 420770.0 58100.4 58207.0 58226.0 58306.7 58401.7 1370.3 1434.2 1438.6 1439.9 1444.1 24734.0 25450.0 26067.0 26277.0 26376.2 48024.3 48097.8 48253.0 48271.8 48305.3 402842.0 404142.0 404570.0 405047.0 405423.0 27502.0 28088.6 29302.1 29409.4 35169.3 36412.8 36956.4 37651.4 37707.0 38102.6 28584.4 31122.7 31398.8 31875.0 32173.0 30765.2 31286.0 31639.4 33797.8 34926.5 28348.7 33955.7 34602.8 34906.3 35452.5 29068.7 30435.8 30467.2 30563.8 30578.7 21309.3 22159.0 23575.8 23721.9 23892.4 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | [#2] jquery.html Cycles:180 Average:42087.67 Median:21821.45 stddev:122363.22 (560.7%) stddev-sans-first:122666.41 05:17:12 INFO - PROCESS | 1905 | Values: 381.6 428.4 429.5 434.2 441.5 15483.7 20340.0 21649.0 21753.9 21889.0 20759.8 21519.8 22182.9 23445.2 23445.8 6588.2 6686.2 6768.7 6811.5 6914.3 4162.2 6766.6 6769.3 6825.7 6832.9 4657.5 7843.4 7871.8 7895.3 7901.1 7650.0 7772.8 7829.2 7839.3 7864.0 7453.9 7494.9 7535.3 7594.2 7606.6 22593.7 22797.7 24662.8 26544.3 26625.7 2878.7 2890.9 2915.5 2941.3 2948.4 16229.9 16360.8 16475.1 16622.3 17298.4 1750.5 2041.0 2067.3 2138.8 2152.1 155738.0 156000.2 159645.0 165173.0 165327.2 15159.6 20462.5 20509.9 20519.7 20833.0 30248.5 30616.7 30620.0 31640.4 31785.7 9814.4 10236.3 10321.1 10351.9 10491.7 8508.3 8523.0 8523.2 8680.2 8709.0 9363.1 9445.3 9584.7 9596.3 9635.5 3258.3 3817.6 3908.8 3910.6 3959.4 984.4 985.5 1005.7 1009.2 1029.9 17041.7 20507.8 21283.6 21414.6 21494.0 990.0 998.7 1025.1 1037.3 1045.5 10349.6 10671.1 10707.5 10737.8 10795.5 702808.0 731464.0 738498.0 738970.0 746357.0 150299.0 150446.0 153216.2 156278.0 159394.4 1128.5 1135.7 1164.4 1169.1 1173.6 13975.4 17020.9 18275.3 18477.8 18503.0 30949.5 46112.8 58727.0 62297.7 62773.7 67945.0 82487.6 83603.2 83621.0 86663.0 10899.1 11270.5 11453.5 11676.1 11688.4 12422.4 12790.8 12819.2 12893.2 12923.9 10608.8 10697.7 10730.2 11011.9 11029.1 9166.3 9253.4 10794.2 11038.9 11340.3 6120.9 10973.2 11354.8 11401.7 11502.3 11159.0 11451.5 11532.7 11598.5 11682.5 9557.4 9565.4 10813.2 11001.4 11136.5 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | [#3] mootools.html Cycles:180 Average:6680.09 Median:2440.55 stddev:4176.78 (171.1%) stddev-sans-first:4170.00 05:17:12 INFO - PROCESS | 1905 | Values: 1449.8 1546.2 1561.5 1583.8 1601.4 10626.0 11205.2 11222.1 11222.6 11223.4 9295.5 10596.2 11013.8 11178.7 11186.9 2394.0 2439.0 2442.1 2443.0 2443.8 2392.2 2421.7 2423.1 2424.9 2427.6 2376.8 2395.5 2399.0 2399.7 2407.6 2320.1 2345.5 2346.5 2346.5 2363.6 2294.9 2296.1 2353.6 2365.0 2376.6 11093.1 11208.9 11252.2 11269.8 11322.5 4728.5 5907.0 5908.4 5914.4 5915.9 3333.8 3471.1 3692.4 3751.2 3779.4 1181.1 1182.0 1241.5 1266.5 1266.9 13721.9 14147.4 14479.5 14973.9 15180.7 4677.8 4847.8 4860.4 4876.7 4884.0 12062.0 12070.7 12071.5 12079.8 12085.5 4974.0 5012.8 5186.0 5643.8 5665.5 5236.9 5273.8 5385.4 5455.8 5462.3 3888.7 3901.2 3942.5 3980.6 3990.6 1047.4 1054.6 1056.8 1064.6 1072.0 917.0 927.2 939.7 940.0 988.7 5789.8 6353.4 6631.2 6668.6 6678.2 957.1 977.0 982.9 987.9 1012.8 4129.6 4155.7 4160.4 4211.1 4279.0 10168.7 13932.2 13954.3 13962.2 14019.1 13844.3 13854.4 13855.0 13870.2 13879.6 9871.0 10031.9 10116.0 10330.2 10348.3 5297.0 5657.5 6437.5 6454.8 6676.8 10013.6 11523.4 12066.5 12223.3 12406.9 12296.9 12672.2 12809.2 12837.0 12893.7 6892.6 8589.0 8604.7 8614.8 8704.7 10128.3 10223.4 10259.8 10391.5 10399.0 9023.0 9028.5 9106.7 9164.0 9375.9 8721.2 8771.0 8790.7 8912.5 9035.0 7646.0 7818.8 8011.9 8012.2 8019.3 5740.6 5776.9 5875.5 5941.4 6015.8 5792.4 5902.0 5913.1 5938.3 6132.0 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | [#4] prototype.html Cycles:180 Average:4528.42 Median:4897.72 stddev:1211.19 (24.7%) stddev-sans-first:1173.72 05:17:12 INFO - PROCESS | 1905 | Values: 371.8 382.0 386.4 389.0 393.2 4647.0 4852.4 4965.3 5229.7 5296.6 4388.7 4588.0 4708.6 4896.9 4899.8 3598.3 3931.4 4201.7 4319.2 4461.4 3629.4 3920.0 4335.4 4425.3 4448.9 3667.1 4290.5 4346.7 4353.5 4400.9 4089.0 4248.7 4298.6 4302.9 4310.2 3695.0 4053.3 4086.3 4096.8 4118.8 4265.3 4564.4 4931.3 4947.7 4970.9 3949.8 4606.1 4764.8 4898.5 5123.3 4937.9 5131.6 5405.5 5412.6 5417.8 4033.0 4233.6 4515.7 4656.3 4806.4 4522.4 4832.8 5128.1 5218.5 5290.4 4129.6 4791.5 4827.3 4836.6 4851.7 4722.8 4784.7 4947.4 5019.2 5023.9 4766.4 4909.3 4919.5 4937.2 5120.6 5132.8 5144.7 5187.6 5328.5 5357.2 1346.6 1560.0 1578.9 1583.4 1661.5 1194.4 1198.2 1294.4 1321.7 1374.3 4564.4 4713.0 4976.3 5057.2 5072.8 4786.7 4871.4 5343.9 5549.1 5636.8 4235.7 4477.6 5047.5 5052.3 5056.0 2582.2 2834.8 2882.5 2943.0 2965.2 5322.4 5357.6 5391.8 5756.4 5793.7 5037.5 5217.7 5501.0 5561.3 5897.7 5000.0 5386.0 5843.6 5854.3 5902.5 4842.9 5073.3 5521.5 5539.7 5680.7 4726.3 5006.0 5269.3 5480.5 5509.1 4906.8 5264.7 5332.7 5550.0 5691.8 4080.8 4096.0 4545.9 4667.0 4863.4 5251.7 5442.1 5567.9 5681.9 5731.0 4385.9 5049.5 5273.7 5410.8 5527.7 4232.4 4690.4 5060.4 5126.2 5325.0 4785.9 5038.5 5181.5 5238.4 5369.0 4795.8 5300.8 5363.8 5365.5 5383.6 4756.0 4838.4 4995.8 5039.1 5345.4 05:17:12 INFO - PROCESS | 1905 | 05:17:12 INFO - PROCESS | 1905 | [#5] yui.html Cycles:180 Average:20706.31 Median:3503.91 stddev:30201.97 (861.9%) stddev-sans-first:30249.31 05:17:12 INFO - PROCESS | 1905 | Values: 693.4 711.4 736.7 786.0 824.6 12367.8 15851.1 15855.8 15862.7 15882.0 14299.6 14459.4 14462.0 14477.8 14988.1 913.5 937.1 938.8 941.4 959.6 938.7 957.7 958.1 958.7 959.4 1004.4 1004.6 1004.9 1005.6 1005.7 996.6 999.6 999.8 999.9 1000.0 744.0 744.3 744.7 745.1 745.7 13400.9 14426.0 15515.5 15564.9 16244.3 14088.0 14166.7 14243.4 14377.8 14431.0 11754.7 11759.6 11770.6 11891.3 12214.3 3605.5 3740.9 3815.5 3886.6 3898.8 111161.0 117889.4 118819.4 120660.8 121413.8 10658.1 10808.9 10923.6 11128.2 11431.5 23103.9 23235.9 23287.9 23291.0 23299.2 7609.9 7624.5 7651.1 7704.3 7802.0 4224.6 4277.5 4356.6 4409.6 4534.3 3492.6 3515.2 3528.9 3587.7 3594.4 639.2 648.9 662.2 696.0 697.6 564.4 678.7 688.7 692.0 733.2 8796.3 8994.5 9757.3 9842.6 10485.6 661.2 692.7 693.7 704.6 716.5 4721.1 4987.7 4988.2 4992.8 4995.3 85837.6 108977.0 109161.5 109281.5 111433.4 51386.5 73162.0 79318.6 88829.0 98066.0 78327.6 79573.0 80438.0 82203.0 82629.6 10875.3 10897.7 10939.6 11052.3 11204.4 49148.0 49470.0 49961.4 52016.5 52307.7 64747.4 65768.7 66775.0 68274.0 68385.0 10703.1 11139.6 11571.6 12313.9 12587.0 13436.5 13450.1 13749.7 13757.0 14283.3 12503.4 12789.3 13623.1 13659.7 14689.8 13892.4 13953.2 13989.2 14116.9 14644.3 11162.6 13302.5 13845.5 13846.7 14344.5 10784.9 11063.8 11335.7 11398.5 11463.7 11275.2 11408.3 11453.7 11518.2 11613.3 05:17:12 INFO - PROCESS | 1905 | -------- Summary: end -------- 05:17:12 INFO - PROCESS | 1905 | 05:17:13 INFO - TEST-INFO | 1905: exit 0 05:17:13 INFO - TEST-OK | dromaeo_css | took 1120394ms 05:17:13 INFO - TEST-START | kraken 05:17:13 INFO - operating with platform_type : mac_ 05:17:13 INFO - Initialising browser for kraken test... 05:17:13 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpv_3F8G/profile http://localhost:49416/getInfo.html) 05:17:16 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 05:17:16 INFO - PROCESS | 1910 | colorDepth:24 05:17:16 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 05:17:16 INFO - PROCESS | 1910 | __metrics 05:17:16 INFO - PROCESS | 1910 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:17:16 INFO - PROCESS | 1910 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:17 INFO - TEST-INFO | 1910: exit 0 05:17:17 INFO - Browser initialized. 05:17:17 INFO - Running cycle 1/1 for kraken test... 05:17:17 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpv_3F8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:29 INFO - PROCESS | 1911 | RSS: Main: 215248896 05:17:29 INFO - PROCESS | 1911 | 05:17:31 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49416/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:32 INFO - PROCESS | 1911 | RSS: Main: 268201984 05:17:32 INFO - PROCESS | 1911 | 05:17:35 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49416/tests/kraken/driver.html?testName=audio-dft) 05:17:36 INFO - PROCESS | 1911 | RSS: Main: 279416832 05:17:36 INFO - PROCESS | 1911 | 05:17:39 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49416/tests/kraken/driver.html?testName=audio-fft) 05:17:39 INFO - PROCESS | 1911 | RSS: Main: 377364480 05:17:39 INFO - PROCESS | 1911 | 05:17:41 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49416/tests/kraken/driver.html?testName=audio-oscillator) 05:17:42 INFO - PROCESS | 1911 | RSS: Main: 279584768 05:17:42 INFO - PROCESS | 1911 | 05:17:44 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:45 INFO - PROCESS | 1911 | RSS: Main: 281186304 05:17:45 INFO - PROCESS | 1911 | 05:17:48 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49416/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:48 INFO - PROCESS | 1911 | RSS: Main: 320442368 05:17:48 INFO - PROCESS | 1911 | 05:17:52 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49416/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:52 INFO - PROCESS | 1911 | RSS: Main: 322498560 05:17:52 INFO - PROCESS | 1911 | 05:17:55 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49416/tests/kraken/driver.html?testName=json-parse-financial) 05:17:56 INFO - PROCESS | 1911 | RSS: Main: 319995904 05:17:56 INFO - PROCESS | 1911 | 05:17:58 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:58 INFO - PROCESS | 1911 | RSS: Main: 295608320 05:17:58 INFO - PROCESS | 1911 | 05:18:00 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:01 INFO - PROCESS | 1911 | RSS: Main: 297672704 05:18:01 INFO - PROCESS | 1911 | 05:18:03 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:04 INFO - PROCESS | 1911 | RSS: Main: 300576768 05:18:04 INFO - PROCESS | 1911 | 05:18:06 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:07 INFO - PROCESS | 1911 | RSS: Main: 317915136 05:18:07 INFO - PROCESS | 1911 | 05:18:10 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:11 INFO - PROCESS | 1911 | RSS: Main: 311767040 05:18:11 INFO - PROCESS | 1911 | 05:18:12 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:49416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49416/tests/kraken/driver.html?testName=ai-astar) 05:18:13 INFO - PROCESS | 1911 | RSS: Main: 356380672 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | __start_tp_report 05:18:13 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 05:18:13 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 05:18:13 INFO - PROCESS | 1911 | |i|pagename|runs| 05:18:13 INFO - PROCESS | 1911 | |0;ai-astar;117;115;115;115;116;115;114;116;115;115 05:18:13 INFO - PROCESS | 1911 | |1;audio-beat-detection;138;110;109;143;111;108;108;112;125;108 05:18:13 INFO - PROCESS | 1911 | |2;audio-dft;186;187;185;184;185;184;185;182;185;184 05:18:13 INFO - PROCESS | 1911 | |3;audio-fft;84;68;71;117;87;66;60;61;77;59 05:18:13 INFO - PROCESS | 1911 | |4;audio-oscillator;88;68;87;70;69;68;82;69;69;85 05:18:13 INFO - PROCESS | 1911 | |5;imaging-gaussian-blur;94;89;92;86;87;87;89;87;88;89 05:18:13 INFO - PROCESS | 1911 | |6;imaging-darkroom;140;151;95;113;150;101;96;96;95;94 05:18:13 INFO - PROCESS | 1911 | |7;imaging-desaturate;84;84;97;128;139;118;129;89;85;83 05:18:13 INFO - PROCESS | 1911 | |8;json-parse-financial;63;59;58;61;65;64;64;64;62;62 05:18:13 INFO - PROCESS | 1911 | |9;json-stringify-tinderbox;53;68;53;58;63;58;58;58;57;56 05:18:13 INFO - PROCESS | 1911 | |10;stanford-crypto-aes;84;82;85;91;75;99;100;99;100;83 05:18:13 INFO - PROCESS | 1911 | |11;stanford-crypto-ccm;138;142;145;146;144;137;141;139;173;136 05:18:13 INFO - PROCESS | 1911 | |12;stanford-crypto-pbkdf2;162;164;165;166;163;163;163;162;165;163 05:18:13 INFO - PROCESS | 1911 | |13;stanford-crypto-sha256-iterative;67;65;64;66;63;62;64;63;63;64 05:18:13 INFO - PROCESS | 1911 | __end_tp_report 05:18:13 INFO - PROCESS | 1911 | __start_cc_report 05:18:13 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,2119 05:18:13 INFO - PROCESS | 1911 | __end_cc_report 05:18:13 INFO - PROCESS | 1911 | __startTimestamp1490271493195__endTimestamp 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | ------- Summary: start ------- 05:18:13 INFO - PROCESS | 1911 | Number of tests: 14 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 05:18:13 INFO - PROCESS | 1911 | Values: 117.0 115.0 115.0 115.0 116.0 115.0 114.0 116.0 115.0 115.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:111.50 stddev:13.32 (11.9%) stddev-sans-first:11.82 05:18:13 INFO - PROCESS | 1911 | Values: 138.0 110.0 109.0 143.0 111.0 108.0 108.0 112.0 125.0 108.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.34 (0.7%) stddev-sans-first:1.33 05:18:13 INFO - PROCESS | 1911 | Values: 186.0 187.0 185.0 184.0 185.0 184.0 185.0 182.0 185.0 184.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#3] audio-fft Cycles:10 Average:75.00 Median:69.50 stddev:17.69 (25.5%) stddev-sans-first:18.46 05:18:13 INFO - PROCESS | 1911 | Values: 84.0 68.0 71.0 117.0 87.0 66.0 60.0 61.0 77.0 59.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:8.76 (11.5%) stddev-sans-first:8.04 05:18:13 INFO - PROCESS | 1911 | Values: 88.0 68.0 87.0 70.0 69.0 68.0 82.0 69.0 69.0 85.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:2.49 (2.8%) stddev-sans-first:1.79 05:18:13 INFO - PROCESS | 1911 | Values: 94.0 89.0 92.0 86.0 87.0 87.0 89.0 87.0 88.0 89.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#6] imaging-darkroom Cycles:10 Average:113.10 Median:94.50 stddev:24.20 (25.6%) stddev-sans-first:23.63 05:18:13 INFO - PROCESS | 1911 | Values: 140.0 151.0 95.0 113.0 150.0 101.0 96.0 96.0 95.0 94.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#7] imaging-desaturate Cycles:10 Average:103.60 Median:84.00 stddev:22.35 (26.6%) stddev-sans-first:22.55 05:18:13 INFO - PROCESS | 1911 | Values: 84.0 84.0 97.0 128.0 139.0 118.0 129.0 89.0 85.0 83.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.50 stddev:2.30 (3.6%) stddev-sans-first:2.42 05:18:13 INFO - PROCESS | 1911 | Values: 63.0 59.0 58.0 61.0 65.0 64.0 64.0 64.0 62.0 62.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:4.47 (7.7%) stddev-sans-first:4.32 05:18:13 INFO - PROCESS | 1911 | Values: 53.0 68.0 53.0 58.0 63.0 58.0 58.0 58.0 57.0 56.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:84.50 stddev:9.20 (10.9%) stddev-sans-first:9.51 05:18:13 INFO - PROCESS | 1911 | Values: 84.0 82.0 85.0 91.0 75.0 99.0 100.0 99.0 100.0 83.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:143.00 stddev:10.71 (7.5%) stddev-sans-first:11.13 05:18:13 INFO - PROCESS | 1911 | Values: 138.0 142.0 145.0 146.0 144.0 137.0 141.0 139.0 173.0 136.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 05:18:13 INFO - PROCESS | 1911 | Values: 162.0 164.0 165.0 166.0 163.0 163.0 163.0 162.0 165.0 163.0 05:18:13 INFO - PROCESS | 1911 | 05:18:13 INFO - PROCESS | 1911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.20 05:18:13 INFO - PROCESS | 1911 | Values: 67.0 65.0 64.0 66.0 63.0 62.0 64.0 63.0 63.0 64.0 05:18:13 INFO - PROCESS | 1911 | -------- Summary: end -------- 05:18:13 INFO - PROCESS | 1911 | 05:18:14 INFO - TEST-INFO | 1911: exit 0 05:18:14 INFO - TEST-OK | kraken | took 60474ms 05:18:14 INFO - SUITE-END | took 1180s 05:18:14 INFO - Completed test suite (00:19:41) 05:18:14 INFO - javascript benchmark 05:18:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7629.3390328447695, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2819.9013034543796, 3374.4938259261094, 3390.3049874775675, 3393.6436674149204, 3441.1913200397917, 5840.970795146029, 5859.443352881475, 5868.85327866803, 5876.942150412924, 5921.0, 5855.0, 5963.761449542013, 5965.254343207099, 5978.9402105978925, 5992.400759924006, 5334.493223143805, 5360.624756267063, 5394.298741163643, 5449.482299181572, 5453.536449401786, 5293.550048245904, 5297.993381257549, 5349.037173308803, 5467.644603100785, 5469.371022332443, 5382.650127741685, 5424.0, 5431.619786614939, 5467.234587157781, 5469.781208751645, 4871.634627402924, 5067.721275329855, 5460.726963651801, 5460.890782184374, 5460.918086228709, 4453.844115455943, 4504.729716217004, 5209.635325527214, 5297.993381257587, 5405.243265942771, 5791.044477661181, 5838.036723940545, 5906.202662640574, 5966.433188847052, 5997.7001149942325, 6288.748450061992, 6317.05244213367, 6340.682965851735, 6343.302236753953, 6345.809625711236, 6381.298057213703, 6383.776567820104, 6392.680365981682, 6393.648349340784, 6404.455621272197, 5948.583599148104, 5991.940080599225, 5996.430339117776, 6084.178635884187, 6152.261728592553, 6426.196725409324, 6486.578372405778, 6537.313582073813, 6583.63789991555, 6588.604683718992, 6273.215848018997, 6288.937110628926, 6294.276158241769, 6310.652914089677, 6313.810585682437, 6206.751729930752, 6229.56393052482, 6383.648899310582, 6399.168108145911, 6412.839679007969, 6208.2239720034995, 6229.3770622937345, 6259.968700156561, 6274.090256912722, 6301.6534090625455, 6274.309825919146, 6277.183966084471, 6288.119663247149, 6291.811245662638, 6344.49244060474, 5037.899242015213, 5155.432902380735, 5157.948420515747, 5173.637845350864, 5202.0, 4577.130345234395, 4594.356790049395, 4634.95365046352, 4637.350770892078, 4651.348811166439, 5766.481016708516, 5812.273465816773, 5846.590738648339, 5911.940880591225, 6007.0, 5230.450802665741, 6321.0, 6334.113224148623, 6335.714892829834, 6362.045693146065, 5812.680302583314, 5822.446867547576, 5822.970885145547, 5823.854403639943, 5836.299644042742, 5422.53908417781, 5491.341039075336, 5507.586930980193, 5511.366192887869, 5517.062099443105, 6352.460040896575, 6487.513436492282, 6520.869582608321, 6613.966930165318, 6641.169853768279, 6388.872222555616, 6407.679616019273, 6414.486841052611, 6415.711292991733, 6423.42189202974, 6613.900791488035, 6620.238672552526, 6625.370589793962, 6629.138212032598, 6638.402543771083, 6158.107074474086, 6226.533010024175, 6301.905471418024, 6306.527010474141, 6405.487560995016, 5618.044932361427, 6308.747650093945, 6349.238091429058, 6377.7767778127545, 6379.106925030406, 6265.373462653698, 6266.498680105489, 6271.0, 6283.874322513433, 6287.654179020198, 5963.314218864886, 6053.606515576474, 6218.875622487434, 6335.081413194969, 6336.049592561153, 6091.0, 6175.382461753788, 6179.721912513858, 6184.907226391698, 6185.938140618537, 6315.621062736251, 6317.842053948688, 6319.146915166578, 6326.019466982625, 6331.556791024584, 5900.881982360243, 5967.373425790403, 6135.233095863017, 6160.383961603804, 6171.9691401544505], "value": 5833.488303123885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.4847240333547, 725.0682872508827, 741.7366834773653, 787.3111027850634, 800.4836880212267, 28264.85867570662, 28644.0, 29430.264243393925, 29470.705292947092, 29512.0, 28693.85224591019, 41327.58672413275, 41616.95957601062, 43865.12269754603, 43951.0, 8990.235829954461, 9146.862797058016, 9152.771180720501, 9160.17558419742, 9186.356955013152, 7300.306470885284, 9013.188813006827, 9108.499032553207, 9114.635414583408, 9124.0, 7441.776746697607, 10865.891341086566, 11031.613893513728, 11239.943800280987, 11290.491927863266, 11015.614453494129, 11030.0, 11055.72360690981, 11060.059894908942, 11077.889221107807, 7317.670704818296, 10810.945945270301, 10893.128549716004, 10905.400202988832, 10950.06924411426, 28255.0, 28445.00442484524, 28490.715092849012, 28541.0, 39491.60508394908, 3369.326134773031, 3819.579846216914, 3820.8280627371555, 3835.5972622874756, 3854.8650797221962, 28144.29639259035, 28455.430891382264, 28490.0, 28968.710312896812, 29770.85114574435, 2640.366312085105, 3086.213015680987, 3133.576967109434, 3151.9684803151904, 3184.2039490127468, 278309.0, 336529.0, 336855.0, 337335.0, 337920.0, 42951.57048429476, 52404.951900961765, 52571.47428525742, 52682.0, 52784.0, 55267.72366138224, 55456.72271638616, 55472.0, 55476.44523554794, 55591.72204139034, 14613.488527901472, 15067.698646027018, 15087.924560377129, 15089.47186848455, 15109.168995705342, 12916.483340666457, 12926.741465170644, 12930.418131184118, 12937.482500700055, 12969.41637626309, 10824.567017319376, 11034.062104721028, 12236.959858411956, 12642.683932901567, 12685.556005539946, 4713.158967228389, 4897.069556784199, 5016.648834581544, 5470.699111548903, 5536.4186760390385, 1113.565709373329, 1121.7812526557243, 1122.646366394583, 1150.9231258952743, 1157.4964890272759, 23756.643650345257, 26752.464950701265, 27250.5912411314, 27282.454350913267, 27292.181234562995, 1054.3094273251033, 1105.4583254205381, 1217.4095563651622, 1232.125191114301, 1234.154604096197, 10868.565257389773, 13691.452341906212, 13904.652383690287, 14101.78847317291, 14134.010619256553, 418786.0, 419607.0, 420116.0, 420327.0, 420770.0, 58100.4189958095, 58207.0, 58226.0, 58306.7084664574, 58401.70799145977, 1370.2669072046408, 1434.189682829198, 1438.5828109848237, 1439.8704116629763, 1444.075791493445, 24734.0, 25449.982000719763, 26066.95732170768, 26277.0, 26376.20871373862, 48024.27963580479, 48097.75951120222, 48253.03493930031, 48271.75864120657, 48305.27542086801, 402842.0, 404141.9585804222, 404570.0, 405047.0, 405423.0, 27502.0, 28088.578671320356, 29302.12093637109, 29409.411811764072, 35169.29661406809, 36412.81793591015, 36956.44565331468, 37651.43522847105, 37707.0, 38102.618973809906, 28584.428311434072, 31122.68877311198, 31398.843005784824, 31875.0, 32173.03480895577, 30765.23086922845, 31286.0, 31639.367212655157, 33797.83101084479, 34926.47610285797, 28348.71651283543, 33955.66044339525, 34602.788902388296, 34906.30187396289, 35452.46821297631, 29068.7093129066, 30435.847820760755, 30467.2383190422, 30563.847180763954, 30578.694213057584, 21309.25417610376, 22159.0, 23575.821208939826, 23721.88139059294, 23892.402689932194], "value": 18095.326829378613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.64316364199493, 428.4366395162997, 429.465315681976, 434.1989030239209, 441.4834643467145, 15483.690326193484, 20340.0, 21649.025793839275, 21753.891230543864, 21889.0, 20759.79240207601, 21519.81641009744, 22182.88908555459, 23445.17941872035, 23445.827708614586, 6588.242352129495, 6686.197656281253, 6768.661566921659, 6811.523193376441, 6914.274001229849, 4162.209180255757, 6766.627835469048, 6769.323067693241, 6825.726970921157, 6832.863342733142, 4657.534246575332, 7843.37253019757, 7871.763847084597, 7895.32889704373, 7901.130875603679, 7649.961750191269, 7772.80567985802, 7829.217078292125, 7839.333656639164, 7864.016997875266, 7453.8509229815645, 7494.85010299791, 7535.284148005931, 7594.164641889388, 7606.619669016527, 22593.661095083586, 22797.658035129487, 24662.766861657026, 26544.336391590365, 26625.733742662713, 2878.7409133178116, 2890.8554572271514, 2915.5043642580813, 2941.264683829043, 2948.43979643867, 16229.918850405791, 16360.754588681179, 16475.093869837154, 16622.33510659572, 17298.3945561906, 1750.4661078371091, 2040.9795902040937, 2067.2764532413535, 2138.7754285799924, 2152.1283880028614, 155738.0, 156000.2199989004, 159645.0, 165173.0, 165327.1733641324, 15159.634181023594, 20462.488437788877, 20509.871957042207, 20519.692204616942, 20833.0, 30248.48757562113, 30616.693833061385, 30620.0, 31640.367192656016, 31785.682143178736, 9814.362066465657, 10236.283460157718, 10321.122704570045, 10351.896481035094, 10491.737706557244, 8508.276796472246, 8522.957385213158, 8523.190296921783, 8680.178941843926, 8708.998465176586, 9363.063693630718, 9445.338826282232, 9584.712458626253, 9596.345772300429, 9635.518224088768, 3258.332041931398, 3817.6182381762155, 3908.785016824102, 3910.550286717064, 3959.3862951242604, 984.3700031979539, 985.5417230987625, 1005.7284533176002, 1009.1674368645896, 1029.9073083422527, 17041.659166816593, 20507.794922050885, 21283.574328513343, 21414.57170856574, 21494.0, 989.9752506187403, 998.7053819123377, 1025.1132770153763, 1037.2531777120462, 1045.46158728255, 10349.63776267827, 10671.146308295318, 10707.464626768631, 10737.78524429507, 10795.514201860935, 702808.0, 731464.0, 738498.0, 738970.0, 746357.0, 150299.0, 150446.0, 153216.23391883192, 156278.0, 159394.40605593796, 1128.497818470789, 1135.73310272086, 1164.441068287227, 1169.1114752787942, 1173.5951096871565, 13975.440982360591, 17020.89364191373, 18275.26898924028, 18477.81522184761, 18503.0, 30949.535756963214, 46112.7694361526, 58727.0, 62297.68851155715, 62773.68613156905, 67945.0, 82487.5875620618, 83603.16396835954, 83621.0, 86663.0, 10899.128069754559, 11270.549178033114, 11453.541858325574, 11676.06591472697, 11688.357140357022, 12422.440990155645, 12790.808137877753, 12819.16675416095, 12893.161944473579, 12923.870761292266, 10608.787824243625, 10697.679069627924, 10730.195235357223, 11011.889881101086, 11029.062529685067, 9166.266698663958, 9253.352265341631, 10794.190435717195, 11038.889611104107, 11340.319580824847, 6120.877582448237, 10973.23187376876, 11354.829677554679, 11401.714957125807, 11502.252353596989, 11159.0, 11451.535377860986, 11532.711682208012, 11598.536058557564, 11682.4742886572, 9557.378770379903, 9565.426074435556, 10813.243072984815, 11001.449927503432, 11136.49885755159], "value": 11385.455478404476, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.7535418978773, 1546.2423412527864, 1561.5237352607458, 1583.8416158384157, 1601.3994751968007, 10626.0, 11205.21563490556, 11222.102231821455, 11222.551097956071, 11223.38271395073, 9295.535223238829, 10596.152307815375, 11013.779724405507, 11178.720531986684, 11186.944065279662, 2394.0304176808377, 2438.9878050609723, 2442.120836498859, 2442.9511409771794, 2443.8044956403446, 2392.234484964812, 2421.673074134987, 2423.115562819567, 2424.854508729473, 2427.5751743444916, 2376.835350678164, 2395.4849707312924, 2399.0283935006264, 2399.700037495313, 2407.6027455469825, 2320.0951628864755, 2345.519168570439, 2346.495503466763, 2346.5306938612175, 2363.550925324183, 2294.8737819419925, 2296.0930432479076, 2353.576356255873, 2364.99487717721, 2376.619740841474, 11093.057090147347, 11208.943955280252, 11252.212345135844, 11269.774604507946, 11322.490487928064, 4728.4798672146035, 5906.9704651476895, 5908.438698323653, 5914.4381283777975, 5915.852103697399, 3333.76650639265, 3471.1322169457635, 3692.4276737105793, 3751.212245428463, 3779.4141908004303, 1181.090560268597, 1181.9763604727943, 1241.5344245907784, 1266.4807428954177, 1266.8986481081492, 13721.862781372158, 14147.363368648332, 14479.493217737434, 14973.850261497355, 15180.696386072217, 4677.766111694402, 4847.830325938575, 4860.3681521401995, 4876.658633895664, 4883.951160488421, 12062.035037197003, 12070.69823254408, 12071.517139314505, 12079.818802717966, 12085.516579336729, 4974.0, 5012.824551140692, 5185.9740701297005, 5643.830685079454, 5665.5467562594895, 5236.92144617831, 5273.762680679379, 5385.434529374437, 5455.781768729285, 5462.289902312674, 3888.747231429948, 3901.1612503311358, 3942.4874766280773, 3980.601939805996, 3990.5610382857863, 1047.3977462958828, 1054.5992522841425, 1056.841473778924, 1064.5954537275786, 1071.9624813131502, 916.9587368568431, 927.2118699105706, 939.6758118449125, 939.9530023498797, 988.728099772554, 5789.81180372605, 6353.396427339396, 6631.237407698177, 6668.599884006975, 6678.165229346332, 957.1194501059042, 976.9560369783377, 982.8967958364411, 987.9357841740264, 1012.7620009297809, 4129.628333449944, 4155.667546596325, 4160.396742472385, 4211.052513184509, 4279.037216626234, 10168.745781355525, 13932.233727145105, 13954.302284885714, 13962.232077235647, 14019.08875923082, 13844.30778461073, 13854.445822167201, 13855.0, 13870.237136957363, 13879.583612491642, 9870.950645246729, 10031.946645602253, 10116.038976297386, 10330.173586113093, 10348.327358721659, 5296.973515132399, 5657.462541058593, 6437.485001199986, 6454.774082907264, 6676.83307917306, 10013.649522266685, 11523.423828808358, 12066.517339306329, 12223.327716975651, 12406.937965310477, 12296.877031229931, 12672.176308539916, 12809.231446113263, 12836.973042156791, 12893.677658058623, 6892.586444813327, 8588.957055214683, 8604.741857744277, 8614.78463038404, 8704.695335663222, 10128.291019628556, 10223.437710925971, 10259.794804104025, 10391.532381043022, 10399.0, 9023.0, 9028.503432311287, 9106.726798196065, 9163.99196088443, 9375.906240937504, 8721.215090641872, 8771.0, 8790.692325768567, 8912.509811960144, 9035.0061493237, 7646.0, 7818.765437036898, 8011.879821802794, 8012.198780122174, 8019.278264956182, 5740.569457290803, 5776.884462310646, 5875.529957603467, 5941.37615550361, 6015.819525414245, 5792.4497172768515, 5901.970490147522, 5913.05391137416, 5938.287405511366, 6131.957567213673], "value": 5109.581332244313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.76021466154333, 381.9637134472225, 386.4300157268028, 388.9805509724513, 393.2174971806105, 4646.976765116178, 4852.36072945291, 4965.28003439501, 5229.712365819878, 5296.576273898084, 4388.736675799454, 4587.977060114703, 4708.62331013519, 4896.926546101811, 4899.750563606284, 3598.316319899224, 3931.3709806430975, 4201.747895126302, 4319.244132276839, 4461.442319710036, 3629.4192929131345, 3920.0, 4335.43639326887, 4425.336199570074, 4448.933266001012, 3667.064898450905, 4290.528041915402, 4346.695731298811, 4353.519803266889, 4400.933985990213, 4089.0, 4248.660107191417, 4298.61312481875, 4302.870913872557, 4310.159518893817, 3694.9630503695157, 4053.27735712324, 4086.264472394968, 4096.795160241976, 4118.794060296973, 4265.33887247474, 4564.406627138451, 4931.309616653672, 4947.678400903929, 4970.900581988376, 3949.8025098744947, 4606.055758569519, 4764.785584648699, 4898.510148985109, 5123.308353372322, 4937.864291213005, 5131.589472842164, 5405.459454054602, 5412.648177868426, 5417.810376636839, 4032.971592243988, 4233.576642335773, 4515.729056256602, 4656.254999200111, 4806.447258565275, 4522.377021327622, 4832.758362081917, 5128.128263161289, 5218.478152184751, 5290.365156181244, 4129.566395528486, 4791.47293797682, 4827.286313358707, 4836.5888899443235, 4851.74393906835, 4722.8429034885985, 4784.72246511141, 4947.356843610308, 5019.247112933089, 5023.9401845244, 4766.428028636586, 4909.26361045846, 4919.532644398776, 4937.21004639256, 5120.61595380348, 5132.820351287687, 5144.6655967362, 5187.57341731027, 5328.520433161034, 5357.16962371906, 1346.6498710335384, 1560.0, 1578.936842526309, 1583.4062226665, 1661.479746032391, 1194.4266751959108, 1198.2451055834767, 1294.449858810002, 1321.729045545661, 1374.3471850870756, 4564.3838081859185, 4712.986707857827, 4976.303317535548, 5057.165567681292, 5072.847814565569, 4786.712797232177, 4871.3667223261455, 5343.893122137535, 5549.139883318092, 5636.774529018793, 4235.724677895927, 4477.619402350771, 5047.470015648378, 5052.317937078447, 5055.974720126376, 2582.2124252102913, 2834.803900050224, 2882.5155045151764, 2942.955855662167, 2965.2438628150117, 5322.445226291402, 5357.624966252325, 5391.757370918318, 5756.366799652035, 5793.710314484259, 5037.546620804145, 5217.747535758344, 5501.0, 5561.332640083216, 5897.734601942923, 5000.0, 5386.003589335985, 5843.574916409642, 5854.258050978721, 5902.520941204619, 4842.903141937212, 5073.34046573943, 5521.47545983147, 5539.695316757617, 5680.68756218412, 4726.338312636165, 5005.998800239894, 5269.262303277467, 5480.479354461319, 5509.146082357241, 4906.803727850846, 5264.657797243167, 5332.733363331896, 5550.000999820071, 5691.800786972436, 4080.7755573443746, 4095.9795201023803, 4545.863444181229, 4666.973265881501, 4863.367762190893, 5251.737413129405, 5442.102053161184, 5567.916481252865, 5681.857953551194, 5730.971345143247, 4385.934210986901, 5049.510394433578, 5273.709945953009, 5410.83767486976, 5527.723613819373, 4232.407462955251, 4690.390249267573, 5060.418051924076, 5126.2054381570915, 5325.0, 4785.928211076906, 5038.521340472649, 5181.549166233461, 5238.449962754008, 5369.0, 4795.832145874878, 5300.761465733974, 5363.812266570807, 5365.490278423544, 5383.569314454756, 4755.976220118877, 4838.427511058991, 4995.825146119869, 5039.0929632665, 5345.41200467956], "value": 4184.51659414719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.4071368979523, 711.3526690711453, 736.6905899522196, 785.9685612575497, 824.6371596497543, 12367.814482782765, 15851.128187949658, 15855.84144158558, 15862.682746345066, 15882.047077175363, 14299.642508937282, 14459.421623135062, 14462.0, 14477.78283325751, 14988.10071395717, 913.5249670171523, 937.1331518345537, 938.7700013496703, 941.3598752848061, 959.6209497248583, 938.723076692374, 957.6696039866235, 958.1281034258826, 958.6980101268113, 959.3620242538703, 1004.3521928356206, 1004.5780772075746, 1004.8643433136542, 1005.6379703306803, 1005.6781829814425, 996.6063404955074, 999.6101520407084, 999.8150342186682, 999.8900120986685, 999.9900100898072, 743.9628018599102, 744.2631794523437, 744.7430636430423, 745.1133151549639, 745.6868115391549, 13400.93299533496, 14426.0, 15515.456959006493, 15564.92217538905, 16244.269007894673, 14088.0, 14166.716665666629, 14243.359048842723, 14377.78433323501, 14431.0, 11754.706132346675, 11759.591022892544, 11770.646880593511, 11891.345975971319, 12214.26714397139, 3605.4591811228265, 3740.9251814963823, 3815.4849095372047, 3886.6113388661192, 3898.8050597470015, 111161.0, 117889.41055294669, 118819.4059029708, 120660.79339206671, 121413.78586214113, 10658.094062004817, 10808.891911080946, 10923.617673381394, 11128.221024528368, 11431.485583148611, 23103.88448057749, 23235.883820581126, 23287.88356058209, 23291.0, 23299.18452854142, 7609.885851712229, 7624.504407213513, 7651.062177326662, 7704.26809453101, 7801.9609901950125, 4224.640905523003, 4277.508086570084, 4356.564343565618, 4409.647228221798, 4534.251848444969, 3492.5983511895947, 3515.226650137017, 3528.8588456461453, 3587.695045921074, 3594.3530164570107, 639.2424976402884, 648.8507643241986, 662.2483481248721, 695.9756408525778, 697.6133497827298, 564.3538148819579, 678.7488629207224, 688.7313947560456, 691.9757808476679, 733.2081352139676, 8796.34027447944, 8994.460332379947, 9757.268204884662, 9842.60629574809, 10485.586188303183, 661.2329697550817, 692.6605963078056, 693.6739732325799, 704.5631708340759, 716.5235118646146, 4721.055788842245, 4987.700737955662, 4988.201887697951, 4992.750362481861, 4995.25071239317, 85837.57081214554, 108977.0, 109161.45419272853, 109281.45359273153, 111433.44283278532, 51386.48613513817, 73162.0, 79318.6034069826, 88829.0, 98066.0, 78327.60836195896, 79573.0, 80438.0, 82203.0, 82629.58685206655, 10875.293105948089, 10897.67306980792, 10939.617113400993, 11052.258122545401, 11204.383758893338, 49148.0, 49470.0, 49961.37341194847, 52016.479835201164, 52307.73846130745, 64747.35252647413, 65768.6711566439, 66775.0, 68274.0, 68385.0, 10703.143748500257, 11139.554417823196, 11571.594994175164, 12313.87686123163, 12587.0, 13436.529721459701, 13450.12574182675, 13749.725005500035, 13757.0, 14283.285835707966, 12503.374831258583, 12789.296588687712, 13623.114497557626, 13659.658508537366, 14689.779653305422, 13892.444302227797, 13953.162810231419, 13989.23059231752, 14116.929415352857, 14644.341004654603, 11162.553497859995, 13302.534411295559, 13845.459191521148, 13846.723065538834, 14344.49794257196, 10784.946075269574, 11063.834042489209, 11335.716607084889, 11398.544058237909, 11463.656090317303, 11275.154363422613, 11408.258463199865, 11453.713657158638, 11518.209741114417, 11613.30320180792], "value": 7673.708352961762, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 115.0, 115.0, 116.0, 115.0, 114.0, 116.0, 115.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 109.0, 143.0, 111.0, 108.0, 108.0, 112.0, 125.0, 108.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 185.0, 184.0, 185.0, 184.0, 185.0, 182.0, 185.0, 184.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 71.0, 117.0, 87.0, 66.0, 60.0, 61.0, 77.0, 59.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 87.0, 70.0, 69.0, 68.0, 82.0, 69.0, 69.0, 85.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 89.0, 92.0, 86.0, 87.0, 87.0, 89.0, 87.0, 88.0, 89.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 151.0, 95.0, 113.0, 150.0, 101.0, 96.0, 96.0, 95.0, 94.0], "value": 113.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 97.0, 128.0, 139.0, 118.0, 129.0, 89.0, 85.0, 83.0], "value": 103.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 58.0, 61.0, 65.0, 64.0, 64.0, 64.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 68.0, 53.0, 58.0, 63.0, 58.0, 58.0, 58.0, 57.0, 56.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 85.0, 91.0, 75.0, 99.0, 100.0, 99.0, 100.0, 83.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 145.0, 146.0, 144.0, 137.0, 141.0, 139.0, 173.0, 136.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 166.0, 163.0, 163.0, 163.0, 162.0, 165.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 66.0, 63.0, 62.0, 64.0, 63.0, 63.0, 64.0], "value": 64.1, "unit": "score"}]}]} 05:18:14 INFO - Return code: 0 05:18:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:18:14 ERROR - # TBPL SUCCESS # 05:18:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:14 INFO - 2017-03-23 05:18:14.551 screenresolution[1915:10944] starting screenresolution argv=screenresolution get 05:18:14 INFO - 2017-03-23 05:18:14.554 screenresolution[1915:10944] Display 0: 1600x1200x32@60 05:18:14 INFO - 2017-03-23 05:18:14.560 screenresolution[1916:10947] starting screenresolution argv=screenresolution list 05:18:14 INFO - Available Modes on Display 0 05:18:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:14 INFO - Intel Iris: 05:18:14 INFO - Chipset Model: Intel Iris 05:18:14 INFO - Type: GPU 05:18:14 INFO - Bus: Built-In 05:18:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:14 INFO - Vendor: Intel (0x8086) 05:18:14 INFO - Device ID: 0x0a2e 05:18:14 INFO - Revision ID: 0x0009 05:18:14 INFO - Displays: 05:18:14 INFO - Display: 05:18:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:14 INFO - Display Serial Number: 1600x1200 60 05:18:14 INFO - Main Display: Yes 05:18:14 INFO - Mirror: Off 05:18:14 INFO - Online: Yes 05:18:14 INFO - Rotation: Supported 05:18:14 INFO - Return code: 0 05:18:14 INFO - Running post-action listener: _resource_record_post_action 05:18:14 INFO - [mozharness: 2017-03-23 12:18:14.797484Z] Finished run-tests step (success) 05:18:14 INFO - Running post-run listener: _resource_record_post_run 05:18:14 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 2064384; Write bytes: 509059072; Read time: 19; Write time: 1583 05:18:14 INFO - TinderboxPrint: CPU usage
53.8% 05:18:14 INFO - TinderboxPrint: I/O read bytes / time
2,064,384 / 19 05:18:14 INFO - TinderboxPrint: I/O write bytes / time
509,059,072 / 1,583 05:18:14 INFO - TinderboxPrint: CPU idle
2,218.1 (46.2%) 05:18:14 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 05:18:14 INFO - TinderboxPrint: CPU user
1,628.9 (33.9%) 05:18:14 INFO - TinderboxPrint: Swap in / out
211,128,320 / 0 05:18:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208421376; Write bytes: 205167616; Read time: 15948; Write time: 434 05:18:14 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 1019904; Write bytes: 293753856; Read time: 14; Write time: 1111 05:18:15 INFO - Running post-run listener: _upload_blobber_files 05:18:15 INFO - Blob upload gear active. 05:18:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:15 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:16 INFO - (blobuploader) - INFO - Done attempting. 05:18:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:17 INFO - (blobuploader) - INFO - Done attempting. 05:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:18:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:18 INFO - (blobuploader) - INFO - Done attempting. 05:18:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:18:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:20 INFO - (blobuploader) - INFO - Done attempting. 05:18:20 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:20 INFO - Return code: 0 05:18:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7807af6434f12f02d271ba020bf6aa3e3bd30b05653b2c84f2e4219d9b19500f7891fc212ed2b96a55289b16a14ab559bc71e0a8acac2629131fa3d37bf70274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f57edf78705c9b7ac4e1c0c59cc7563e0f06a11385256c8c97db0983e34264ad9b8ed9294ecd4e16439850ac0798e31daa5235f45765b8bead4feafd4584669d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32456994f51ac2c39603d3c24ae6e4505ccb9483a1c28197704befdbc27db71812962eff0093acde785a54fc9f56f570499be1dadc4ceba95d2617564847a155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de8fa5d2dbeeae9990f805d9f3056d7df49b067185b9a987a44716b9da7c6c3fde0e8f3a21030ba3dcec37cf9ea6418330d52e857b4175aa2be83ae78407ef"} 05:18:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:20 INFO - Contents: 05:18:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7807af6434f12f02d271ba020bf6aa3e3bd30b05653b2c84f2e4219d9b19500f7891fc212ed2b96a55289b16a14ab559bc71e0a8acac2629131fa3d37bf70274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f57edf78705c9b7ac4e1c0c59cc7563e0f06a11385256c8c97db0983e34264ad9b8ed9294ecd4e16439850ac0798e31daa5235f45765b8bead4feafd4584669d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32456994f51ac2c39603d3c24ae6e4505ccb9483a1c28197704befdbc27db71812962eff0093acde785a54fc9f56f570499be1dadc4ceba95d2617564847a155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de8fa5d2dbeeae9990f805d9f3056d7df49b067185b9a987a44716b9da7c6c3fde0e8f3a21030ba3dcec37cf9ea6418330d52e857b4175aa2be83ae78407ef"} 05:18:20 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:20 INFO - Copying logs to upload dir... 05:18:20 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.484567 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-23 05:18:20.988493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 05:18:20.991957) ========= 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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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/7807af6434f12f02d271ba020bf6aa3e3bd30b05653b2c84f2e4219d9b19500f7891fc212ed2b96a55289b16a14ab559bc71e0a8acac2629131fa3d37bf70274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f57edf78705c9b7ac4e1c0c59cc7563e0f06a11385256c8c97db0983e34264ad9b8ed9294ecd4e16439850ac0798e31daa5235f45765b8bead4feafd4584669d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32456994f51ac2c39603d3c24ae6e4505ccb9483a1c28197704befdbc27db71812962eff0093acde785a54fc9f56f570499be1dadc4ceba95d2617564847a155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de8fa5d2dbeeae9990f805d9f3056d7df49b067185b9a987a44716b9da7c6c3fde0e8f3a21030ba3dcec37cf9ea6418330d52e857b4175aa2be83ae78407ef"} build_url:https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/RaDyJhC3Tym7d1nXY_WZrA/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/7807af6434f12f02d271ba020bf6aa3e3bd30b05653b2c84f2e4219d9b19500f7891fc212ed2b96a55289b16a14ab559bc71e0a8acac2629131fa3d37bf70274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f57edf78705c9b7ac4e1c0c59cc7563e0f06a11385256c8c97db0983e34264ad9b8ed9294ecd4e16439850ac0798e31daa5235f45765b8bead4feafd4584669d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32456994f51ac2c39603d3c24ae6e4505ccb9483a1c28197704befdbc27db71812962eff0093acde785a54fc9f56f570499be1dadc4ceba95d2617564847a155", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4de8fa5d2dbeeae9990f805d9f3056d7df49b067185b9a987a44716b9da7c6c3fde0e8f3a21030ba3dcec37cf9ea6418330d52e857b4175aa2be83ae78407ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 05:18:21.027325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:18:21.027692) ========= 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.P94Z4SAMKA/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.8rjmpfGzdk/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.005238 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:18:21.076532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 05:18:21.076875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 05:18:21.077234) ========= ========= Total master_lag: 0.19 =========