builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0007 starttime: 1490930021.95 results: success (0) buildid: 20170330191005 builduid: d26d4ab5430843058661eb7b796b3c91 revision: 1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:41.952019) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:41.952461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:41.952736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:41.980158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:41.980500) ========= 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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-30 20:13:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-03-30 20:13:42 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171441 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:42.439922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:42.440293) ========= 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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.035495 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:42.498336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 20:13:42.498686) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912 --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 1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-30 20:13:42,599 truncating revision to first 12 chars 2017-03-30 20:13:42,599 Setting DEBUG logging. 2017-03-30 20:13:42,599 attempt 1/10 2017-03-30 20:13:42,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1edf2dfa3809?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 20:13:43,796 unpacking tar archive at: mozilla-aurora-1edf2dfa3809/testing/mozharness/ program finished with exit code 0 elapsedTime=1.463605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-30 20:13:43.986239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:43.986563) ========= script_repo_revision: 1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:43.986947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:43.987229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 20:13:44.008434) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-30 20:13:44.008732) ========= /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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:13:44 INFO - MultiFileLogger online at 20170330 20:13:44 in /builds/slave/test 20:13:44 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 20:13:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:13:44 INFO - {'append_to_log': False, 20:13:44 INFO - 'base_work_dir': '/builds/slave/test', 20:13:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:13:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:13:44 INFO - 'branch': 'Mozilla-Aurora', 20:13:44 INFO - 'buildbot_json_path': 'buildprops.json', 20:13:44 INFO - 'config_files': ('talos/mac_config.py',), 20:13:44 INFO - 'default_actions': ('clobber', 20:13:44 INFO - 'read-buildbot-config', 20:13:44 INFO - 'download-and-extract', 20:13:44 INFO - 'populate-webroot', 20:13:44 INFO - 'create-virtualenv', 20:13:44 INFO - 'install', 20:13:44 INFO - 'run-tests'), 20:13:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:13:44 INFO - 'download_minidump_stackwalk': True, 20:13:44 INFO - 'download_symbols': 'ondemand', 20:13:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:13:44 INFO - 'tooltool.py': '/tools/tooltool.py', 20:13:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:13:44 INFO - '/tools/misc-python/virtualenv.py')}, 20:13:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:13:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:13:44 INFO - 'gecko_profile': False, 20:13:44 INFO - 'gecko_profile_interval': 0, 20:13:44 INFO - 'installer_path': 'installer.exe', 20:13:44 INFO - 'log_level': 'info', 20:13:44 INFO - 'log_name': 'talos', 20:13:44 INFO - 'log_to_console': True, 20:13:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:13:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:13:44 INFO - 'opt_config_files': (), 20:13:44 INFO - 'pip_index': False, 20:13:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:13:44 INFO - 'cmd': ('bash', 20:13:44 INFO - '-c', 20:13:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:13:44 INFO - 'enabled': True, 20:13:44 INFO - 'halt_on_failure': False, 20:13:44 INFO - 'name': 'check_screen_resolution'},), 20:13:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:13:44 INFO - 'cmd': ('bash', 20:13:44 INFO - '-c', 20:13:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:13:44 INFO - 'enabled': True, 20:13:44 INFO - 'halt_on_failure': False, 20:13:44 INFO - 'name': 'check_screen_resolution'},), 20:13:44 INFO - 'run_cmd_checks_enabled': True, 20:13:44 INFO - 'suite': 'dromaeojs', 20:13:44 INFO - 'system_bits': '32', 20:13:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:13:44 INFO - 'title': 't-yosemite-r7-0007', 20:13:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:13:44 INFO - 'use_talos_json': True, 20:13:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:13:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:13:44 INFO - 'work_dir': 'build'} 20:13:44 INFO - [mozharness: 2017-03-31 03:13:44.221730Z] Running clobber step. 20:13:44 INFO - Running pre-action listener: _resource_record_pre_action 20:13:44 INFO - Running main action method: clobber 20:13:44 INFO - rmtree: /builds/slave/test/build 20:13:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:13:46 INFO - Running post-action listener: _resource_record_post_action 20:13:46 INFO - [mozharness: 2017-03-31 03:13:46.765658Z] Finished clobber step (success) 20:13:46 INFO - [mozharness: 2017-03-31 03:13:46.765783Z] Running read-buildbot-config step. 20:13:46 INFO - Running pre-action listener: _resource_record_pre_action 20:13:46 INFO - Running main action method: read_buildbot_config 20:13:46 INFO - Using buildbot properties: 20:13:46 INFO - { 20:13:46 INFO - "project": "", 20:13:46 INFO - "product": "firefox", 20:13:46 INFO - "script_repo_revision": "production", 20:13:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 20:13:46 INFO - "repository": "", 20:13:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 20:13:46 INFO - "buildid": "20170330191005", 20:13:46 INFO - "pgo_build": "False", 20:13:46 INFO - "basedir": "/builds/slave/test", 20:13:46 INFO - "buildnumber": 105, 20:13:46 INFO - "slavename": "t-yosemite-r7-0007", 20:13:46 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:13:46 INFO - "platform": "yosemite_r7", 20:13:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:13:46 INFO - "branch": "mozilla-aurora", 20:13:46 INFO - "repo_path": "releases/mozilla-aurora", 20:13:46 INFO - "revision": "1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912", 20:13:46 INFO - "stage_platform": "macosx64", 20:13:46 INFO - "builduid": "d26d4ab5430843058661eb7b796b3c91", 20:13:46 INFO - "slavebuilddir": "test" 20:13:46 INFO - } 20:13:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 20:13:46 INFO - Running post-action listener: _resource_record_post_action 20:13:46 INFO - [mozharness: 2017-03-31 03:13:46.769265Z] Finished read-buildbot-config step (success) 20:13:46 INFO - [mozharness: 2017-03-31 03:13:46.769401Z] Running download-and-extract step. 20:13:46 INFO - Running pre-action listener: _resource_record_pre_action 20:13:46 INFO - Running main action method: download_and_extract 20:13:46 INFO - mkdir: /builds/slave/test/build/tests 20:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:46 INFO - trying https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 20:13:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/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 20:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/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 20:13:47 INFO - Downloaded 1199 bytes. 20:13:47 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 20:13:47 INFO - Using the following test package requirements: 20:13:47 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:13:47 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 20:13:47 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 20:13:47 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'jsshell-mac.zip'], 20:13:47 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 20:13:47 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:13:47 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 20:13:47 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 20:13:47 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 20:13:47 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:13:47 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 20:13:47 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:13:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:13:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:13:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:13:48 INFO - Expected file size: 51792702 20:13:48 INFO - Obtained file size: 51792702 20:14:04 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 20:14:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:14:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:14:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:14:06 INFO - Expected file size: 51792702 20:14:06 INFO - Obtained file size: 51792702 20:14:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 20:14:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:14:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 20:14:23 INFO - Expected file size: 14404438 20:14:23 INFO - Obtained file size: 14404438 20:14:23 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')]} 20:14:23 INFO - trying https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:14:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 20:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/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 20:14:25 INFO - Downloaded 74693775 bytes. 20:14:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:14:25 INFO - mkdir: /builds/slave/test/properties 20:14:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:25 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:25 INFO - Contents: 20:14:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:14:26 INFO - Running post-action listener: _resource_record_post_action 20:14:26 INFO - Running post-action listener: set_extra_try_arguments 20:14:26 INFO - [mozharness: 2017-03-31 03:14:26.557060Z] Finished download-and-extract step (success) 20:14:26 INFO - [mozharness: 2017-03-31 03:14:26.557155Z] Running populate-webroot step. 20:14:26 INFO - Running pre-action listener: _resource_record_pre_action 20:14:26 INFO - Running main action method: populate_webroot 20:14:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:14:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:14:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:14:26 INFO - '--tppagecycles', 20:14:26 INFO - '7'], 20:14:26 INFO - 'tests': ['tsvgm']}}, 20:14:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:14:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:14:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['damp', 'tps']}, 20:14:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'tests': ['damp', 'tps']}, 20:14:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['dromaeo_dom']}, 20:14:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['basic_compositor_video']}, 20:14:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:14:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['a11yr', 20:14:26 INFO - 'ts_paint', 20:14:26 INFO - 'tpaint', 20:14:26 INFO - 'sessionrestore', 20:14:26 INFO - 'sessionrestore_no_auto_restore', 20:14:26 INFO - 'tabpaint']}, 20:14:26 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:26 INFO - 'ts_paint', 20:14:26 INFO - 'tpaint', 20:14:26 INFO - 'sessionrestore', 20:14:26 INFO - 'sessionrestore_no_auto_restore', 20:14:26 INFO - 'tabpaint']}, 20:14:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:14:26 INFO - 'ts_paint', 20:14:26 INFO - 'tpaint', 20:14:26 INFO - 'sessionrestore', 20:14:26 INFO - 'sessionrestore_no_auto_restore', 20:14:26 INFO - 'tabpaint']}, 20:14:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:14:26 INFO - 'ts_paint', 20:14:26 INFO - 'tpaint', 20:14:26 INFO - 'sessionrestore', 20:14:26 INFO - 'sessionrestore_no_auto_restore', 20:14:26 INFO - 'tabpaint']}, 20:14:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['a11yr', 20:14:26 INFO - 'ts_paint', 20:14:26 INFO - 'tpaint', 20:14:26 INFO - 'sessionrestore', 20:14:26 INFO - 'sessionrestore_no_auto_restore', 20:14:26 INFO - 'tabpaint']}, 20:14:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['a11yr', 20:14:26 INFO - 'ts_paint', 20:14:26 INFO - 'tpaint', 20:14:26 INFO - 'sessionrestore', 20:14:26 INFO - 'sessionrestore_no_auto_restore', 20:14:26 INFO - 'tabpaint']}, 20:14:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['tsvgx', 20:14:26 INFO - 'tsvgr_opacity', 20:14:26 INFO - 'tart', 20:14:26 INFO - 'tscrollx', 20:14:26 INFO - 'cart', 20:14:26 INFO - 'tsvg_static']}, 20:14:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:26 INFO - 'tsvgr_opacity', 20:14:26 INFO - 'tart', 20:14:26 INFO - 'tscrollx', 20:14:26 INFO - 'cart', 20:14:26 INFO - 'tsvg_static']}, 20:14:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'talos_options': ['--disable-e10s'], 20:14:26 INFO - 'tests': ['tp5o']}, 20:14:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:14:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'talos_options': ['--disable-e10s', 20:14:26 INFO - '--xperf_path', 20:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:26 INFO - 'tests': ['tp5n']}, 20:14:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:14:26 INFO - 'talos_options': ['--xperf_path', 20:14:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:26 INFO - 'tests': ['tp5n']}}, 20:14:26 INFO - 'talos.zip': {'path': '', 20:14:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:14:26 INFO - Running post-action listener: _resource_record_post_action 20:14:26 INFO - [mozharness: 2017-03-31 03:14:26.575700Z] Finished populate-webroot step (success) 20:14:26 INFO - [mozharness: 2017-03-31 03:14:26.575800Z] Running create-virtualenv step. 20:14:26 INFO - Running pre-action listener: _resource_record_pre_action 20:14:26 INFO - Running main action method: create_virtualenv 20:14:26 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:26 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 20:14:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:14:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:26 INFO - Using real prefix '/tools/python27' 20:14:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:27 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:30 INFO - Installing pip.................done. 20:14:30 INFO - Return code: 0 20:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:14:30 INFO - Reading from file tmpfile_stdout 20:14:30 INFO - Output received: 20:14:30 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) 20:14:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:30 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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:30 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 20:14:30 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 20:14:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:30 INFO - 'HOME': '/Users/cltbld', 20:14:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:30 INFO - 'LOGNAME': 'cltbld', 20:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:30 INFO - 'MOZ_NO_REMOTE': '1', 20:14:30 INFO - 'NO_EM_RESTART': '1', 20:14:30 INFO - 'PAGER': '/bin/cat', 20:14:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:30 INFO - 'PWD': '/builds/slave/test', 20:14:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:30 INFO - 'SHELL': '/bin/bash', 20:14:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:30 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:30 INFO - 'USER': 'cltbld', 20:14:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:30 INFO - 'XPC_FLAGS': '0x0', 20:14:30 INFO - 'XPC_SERVICE_NAME': '0', 20:14:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:30 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 20:14:30 INFO - Cleaning up... 20:14:30 INFO - Return code: 0 20:14:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:30 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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:30 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 20:14:30 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 20:14:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:30 INFO - 'HOME': '/Users/cltbld', 20:14:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:30 INFO - 'LOGNAME': 'cltbld', 20:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:30 INFO - 'MOZ_NO_REMOTE': '1', 20:14:30 INFO - 'NO_EM_RESTART': '1', 20:14:30 INFO - 'PAGER': '/bin/cat', 20:14:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:30 INFO - 'PWD': '/builds/slave/test', 20:14:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:30 INFO - 'SHELL': '/bin/bash', 20:14:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:30 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:30 INFO - 'USER': 'cltbld', 20:14:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:30 INFO - 'XPC_FLAGS': '0x0', 20:14:30 INFO - 'XPC_SERVICE_NAME': '0', 20:14:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:31 INFO - Downloading/unpacking psutil>=3.1.1 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:34 INFO - Installing collected packages: psutil 20:14:34 INFO - Running setup.py install for psutil 20:14:34 INFO - building 'psutil._psutil_osx' extension 20:14:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:14:35 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 20:14:35 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 20:14:35 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 20:14:35 INFO - building 'psutil._psutil_posix' extension 20:14:35 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 20:14:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:14:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:14:35 INFO - ^ 20:14:35 INFO - 1 warning generated. 20:14:35 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 20:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:36 INFO - Successfully installed psutil 20:14:36 INFO - Cleaning up... 20:14:36 INFO - Return code: 0 20:14:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:36 INFO - 'HOME': '/Users/cltbld', 20:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:36 INFO - 'LOGNAME': 'cltbld', 20:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:36 INFO - 'MOZ_NO_REMOTE': '1', 20:14:36 INFO - 'NO_EM_RESTART': '1', 20:14:36 INFO - 'PAGER': '/bin/cat', 20:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:36 INFO - 'PWD': '/builds/slave/test', 20:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:36 INFO - 'SHELL': '/bin/bash', 20:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:36 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:36 INFO - 'USER': 'cltbld', 20:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:36 INFO - 'XPC_FLAGS': '0x0', 20:14:36 INFO - 'XPC_SERVICE_NAME': '0', 20:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:36 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 20:14:36 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 20:14:36 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 20:14:36 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 20:14:36 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 20:14:36 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 20:14:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:39 INFO - Installing collected packages: mozsystemmonitor 20:14:39 INFO - Running setup.py install for mozsystemmonitor 20:14:39 INFO - Successfully installed mozsystemmonitor 20:14:39 INFO - Cleaning up... 20:14:39 INFO - Return code: 0 20:14:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14:39 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')]} 20:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:39 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')]} 20:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:39 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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:39 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 20:14:39 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 20:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:39 INFO - 'HOME': '/Users/cltbld', 20:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:39 INFO - 'LOGNAME': 'cltbld', 20:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:39 INFO - 'MOZ_NO_REMOTE': '1', 20:14:39 INFO - 'NO_EM_RESTART': '1', 20:14:39 INFO - 'PAGER': '/bin/cat', 20:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:39 INFO - 'PWD': '/builds/slave/test', 20:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:39 INFO - 'SHELL': '/bin/bash', 20:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:39 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:39 INFO - 'USER': 'cltbld', 20:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:39 INFO - 'XPC_FLAGS': '0x0', 20:14:39 INFO - 'XPC_SERVICE_NAME': '0', 20:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:39 INFO - Downloading/unpacking jsonschema==2.5.1 20:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:42 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:42 INFO - warning: no files found matching '*.txt' 20:14:42 INFO - no previously-included directories found matching 'build' 20:14:42 INFO - no previously-included directories found matching 'dist' 20:14:42 INFO - no previously-included directories found matching '.git*' 20:14:42 INFO - Installing collected packages: jsonschema, functools32 20:14:42 INFO - Running setup.py install for functools32 20:14:42 INFO - warning: no files found matching '*.txt' 20:14:42 INFO - no previously-included directories found matching 'build' 20:14:42 INFO - no previously-included directories found matching 'dist' 20:14:42 INFO - no previously-included directories found matching '.git*' 20:14:42 INFO - Successfully installed jsonschema functools32 20:14:42 INFO - Cleaning up... 20:14:43 INFO - Return code: 0 20:14:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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', '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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:14: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 functools32==3.2.3-2 20:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:43 INFO - 'HOME': '/Users/cltbld', 20:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:43 INFO - 'LOGNAME': 'cltbld', 20:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:43 INFO - 'MOZ_NO_REMOTE': '1', 20:14:43 INFO - 'NO_EM_RESTART': '1', 20:14:43 INFO - 'PAGER': '/bin/cat', 20:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:43 INFO - 'PWD': '/builds/slave/test', 20:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:43 INFO - 'SHELL': '/bin/bash', 20:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:43 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:43 INFO - 'USER': 'cltbld', 20:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:43 INFO - 'XPC_FLAGS': '0x0', 20:14:43 INFO - 'XPC_SERVICE_NAME': '0', 20:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:14:43 INFO - Cleaning up... 20:14:43 INFO - Return code: 0 20:14:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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', '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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:14: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 blobuploader==1.2.4 20:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:43 INFO - 'HOME': '/Users/cltbld', 20:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:43 INFO - 'LOGNAME': 'cltbld', 20:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:43 INFO - 'MOZ_NO_REMOTE': '1', 20:14:43 INFO - 'NO_EM_RESTART': '1', 20:14:43 INFO - 'PAGER': '/bin/cat', 20:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:43 INFO - 'PWD': '/builds/slave/test', 20:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:43 INFO - 'SHELL': '/bin/bash', 20:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:43 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:43 INFO - 'USER': 'cltbld', 20:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:43 INFO - 'XPC_FLAGS': '0x0', 20:14:43 INFO - 'XPC_SERVICE_NAME': '0', 20:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:43 INFO - Downloading/unpacking blobuploader==1.2.4 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:47 INFO - Downloading docopt-0.6.1.tar.gz 20:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:47 INFO - Running setup.py install for blobuploader 20:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:47 INFO - Running setup.py install for requests 20:14:48 INFO - Running setup.py install for docopt 20:14:48 INFO - Successfully installed blobuploader requests docopt 20:14:48 INFO - Cleaning up... 20:14:48 INFO - Return code: 0 20:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:48 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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:48 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 20:14:48 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 20:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:48 INFO - 'HOME': '/Users/cltbld', 20:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:48 INFO - 'LOGNAME': 'cltbld', 20:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:48 INFO - 'MOZ_NO_REMOTE': '1', 20:14:48 INFO - 'NO_EM_RESTART': '1', 20:14:48 INFO - 'PAGER': '/bin/cat', 20:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:48 INFO - 'PWD': '/builds/slave/test', 20:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:48 INFO - 'SHELL': '/bin/bash', 20:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:48 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:48 INFO - 'USER': 'cltbld', 20:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:48 INFO - 'XPC_FLAGS': '0x0', 20:14:48 INFO - 'XPC_SERVICE_NAME': '0', 20:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ORBXlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-aK3Sth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-zgLThv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-rsmOKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3lBN1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ZIqFiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Eg7EvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-A2L8Xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-rDp6IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-GshFzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Zh60r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-d5XoOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-QiybSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-eDoSCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-7lpn4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-tDR2tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_5s8Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:50 INFO - Running setup.py install for manifestparser 20:14:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozcrash 20:14:50 INFO - Running setup.py install for mozdebug 20:14:50 INFO - Running setup.py install for mozdevice 20:14:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Running setup.py install for mozfile 20:14:51 INFO - Running setup.py install for mozhttpd 20:14:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Running setup.py install for mozinfo 20:14:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Running setup.py install for mozInstall 20:14:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Running setup.py install for mozleak 20:14:51 INFO - Running setup.py install for mozlog 20:14:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:51 INFO - Running setup.py install for moznetwork 20:14:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:52 INFO - Running setup.py install for mozprocess 20:14:52 INFO - Running setup.py install for mozprofile 20:14:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:52 INFO - Running setup.py install for mozrunner 20:14:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:52 INFO - Running setup.py install for mozscreenshot 20:14:52 INFO - Running setup.py install for moztest 20:14:52 INFO - Running setup.py install for mozversion 20:14:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:52 INFO - Cleaning up... 20:14:52 INFO - Return code: 0 20:14:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:52 INFO - 'HOME': '/Users/cltbld', 20:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:52 INFO - 'LOGNAME': 'cltbld', 20:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:52 INFO - 'MOZ_NO_REMOTE': '1', 20:14:52 INFO - 'NO_EM_RESTART': '1', 20:14:52 INFO - 'PAGER': '/bin/cat', 20:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:52 INFO - 'PWD': '/builds/slave/test', 20:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:52 INFO - 'SHELL': '/bin/bash', 20:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:52 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:52 INFO - 'USER': 'cltbld', 20:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:52 INFO - 'XPC_FLAGS': '0x0', 20:14:52 INFO - 'XPC_SERVICE_NAME': '0', 20:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-n0yIYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:53 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)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-dW5iZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-C2dp3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-NxkHXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-gST8wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-GOuECl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-vqIEvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-QdpMTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:54 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)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-gGTuGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:54 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)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-B9ZOYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:54 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)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-L7aSsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:54 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)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-EbAlW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-6iBZ2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-WEcFPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-thpcYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-K0gxdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:54 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-K4DcI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 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)) 20:14:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:55 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 20:14:55 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 20:14:55 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 20:14:55 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 20:14:55 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 20:14:55 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 20:14:57 INFO - Downloading blessings-1.6.tar.gz 20:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:57 INFO - Installing collected packages: blessings 20:14:57 INFO - Running setup.py install for blessings 20:14:57 INFO - Successfully installed blessings 20:14:57 INFO - Cleaning up... 20:14:58 INFO - Return code: 0 20:14:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:58 INFO - Reading from file tmpfile_stdout 20:14:58 INFO - Current package versions: 20:14:58 INFO - blessings == 1.6 20:14:58 INFO - blobuploader == 1.2.4 20:14:58 INFO - docopt == 0.6.1 20:14:58 INFO - functools32 == 3.2.3-2 20:14:58 INFO - jsonschema == 2.5.1 20:14:58 INFO - manifestparser == 1.1 20:14:58 INFO - mozInstall == 1.12 20:14:58 INFO - mozcrash == 1.0 20:14:58 INFO - mozdebug == 0.1 20:14:58 INFO - mozdevice == 0.49 20:14:58 INFO - mozfile == 1.2 20:14:58 INFO - mozhttpd == 0.7 20:14:58 INFO - mozinfo == 0.9 20:14:58 INFO - mozleak == 0.1 20:14:58 INFO - mozlog == 3.4 20:14:58 INFO - moznetwork == 0.27 20:14:58 INFO - mozprocess == 0.25 20:14:58 INFO - mozprofile == 0.28 20:14:58 INFO - mozrunner == 6.13 20:14:58 INFO - mozscreenshot == 0.1 20:14:58 INFO - mozsystemmonitor == 0.3 20:14:58 INFO - moztest == 0.8 20:14:58 INFO - mozversion == 1.4 20:14:58 INFO - psutil == 3.1.1 20:14:58 INFO - requests == 1.2.3 20:14:58 INFO - wsgiref == 0.1.2 20:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:58 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 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:58 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 20:14:58 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 20:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:58 INFO - 'HOME': '/Users/cltbld', 20:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:58 INFO - 'LOGNAME': 'cltbld', 20:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:58 INFO - 'MOZ_NO_REMOTE': '1', 20:14:58 INFO - 'NO_EM_RESTART': '1', 20:14:58 INFO - 'PAGER': '/bin/cat', 20:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:58 INFO - 'PWD': '/builds/slave/test', 20:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:58 INFO - 'SHELL': '/bin/bash', 20:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:58 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:58 INFO - 'USER': 'cltbld', 20:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:58 INFO - 'XPC_FLAGS': '0x0', 20:14:58 INFO - 'XPC_SERVICE_NAME': '0', 20:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:14:58 INFO - Cleaning up... 20:14:58 INFO - Return code: 0 20:14:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b52b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107b55768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff219c767d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, '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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 20:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:14:58 INFO - 'HOME': '/Users/cltbld', 20:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:14:58 INFO - 'LOGNAME': 'cltbld', 20:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:58 INFO - 'MOZ_NO_REMOTE': '1', 20:14:58 INFO - 'NO_EM_RESTART': '1', 20:14:58 INFO - 'PAGER': '/bin/cat', 20:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:58 INFO - 'PWD': '/builds/slave/test', 20:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:14:58 INFO - 'SHELL': '/bin/bash', 20:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:14:58 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:14:58 INFO - 'USER': 'cltbld', 20:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:58 INFO - 'XPC_FLAGS': '0x0', 20:14:58 INFO - 'XPC_SERVICE_NAME': '0', 20:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:14:58 INFO - Cleaning up... 20:14:58 INFO - Return code: 0 20:14:58 INFO - Running post-action listener: _resource_record_post_action 20:14:58 INFO - Running post-action listener: _start_resource_monitoring 20:14:58 INFO - Starting resource monitoring. 20:14:58 INFO - [mozharness: 2017-03-31 03:14:58.830138Z] Finished create-virtualenv step (success) 20:14:58 INFO - [mozharness: 2017-03-31 03:14:58.831072Z] Running install step. 20:14:58 INFO - Running pre-action listener: _resource_record_pre_action 20:14:58 INFO - Running main action method: install 20:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:59 INFO - Reading from file tmpfile_stdout 20:14:59 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:59 INFO - Reading from file tmpfile_stdout 20:14:59 INFO - Output received: 20:14:59 INFO - Usage: mozinstall [options] installer 20:14:59 INFO - Options: 20:14:59 INFO - -h, --help show this help message and exit 20:14:59 INFO - -d DEST, --destination=DEST 20:14:59 INFO - Directory to install application into. [default: 20:14:59 INFO - "/builds/slave/test"] 20:14:59 INFO - --app=APP Application being installed. [default: firefox] 20:14:59 INFO - mkdir: /builds/slave/test/build/application 20:14:59 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'] 20:14:59 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 20:15:19 INFO - Reading from file tmpfile_stdout 20:15:19 INFO - Output received: 20:15:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:15:19 INFO - Running post-action listener: _resource_record_post_action 20:15:19 INFO - [mozharness: 2017-03-31 03:15:19.639020Z] Finished install step (success) 20:15:19 INFO - [mozharness: 2017-03-31 03:15:19.639158Z] Running run-tests step. 20:15:19 INFO - Running pre-action listener: _resource_record_pre_action 20:15:19 INFO - Running main action method: run_tests 20:15:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:15:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:15:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:15:19 INFO - 2017-03-30 20:15:19.653 screenresolution[1627:7549] starting screenresolution argv=screenresolution get 20:15:19 INFO - 2017-03-30 20:15:19.656 screenresolution[1627:7549] Display 0: 1600x1200x32@60 20:15:19 INFO - 2017-03-30 20:15:19.662 screenresolution[1628:7551] starting screenresolution argv=screenresolution list 20:15:19 INFO - Available Modes on Display 0 20:15:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:15:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:15:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:15:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:15:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:15:19 INFO - Intel Iris: 20:15:19 INFO - Chipset Model: Intel Iris 20:15:19 INFO - Type: GPU 20:15:19 INFO - Bus: Built-In 20:15:19 INFO - VRAM (Dynamic, Max): 1536 MB 20:15:19 INFO - Vendor: Intel (0x8086) 20:15:19 INFO - Device ID: 0x0a2e 20:15:19 INFO - Revision ID: 0x0009 20:15:19 INFO - Displays: 20:15:19 INFO - Display: 20:15:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:15:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:15:19 INFO - Display Serial Number: 1600x1200 60 20:15:19 INFO - Main Display: Yes 20:15:19 INFO - Mirror: Off 20:15:19 INFO - Online: Yes 20:15:19 INFO - Rotation: Supported 20:15:19 INFO - Return code: 0 20:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:19 INFO - Python 2.7.3 20:15:19 INFO - Return code: 0 20:15:19 INFO - grabbing minidump binary from tooltool 20:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:15:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107930d30>, '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 0x107857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107925be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:15:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:15:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:15:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:20 INFO - Return code: 0 20:15:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:15:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:20 INFO - ENV: RUST_BACKTRACE is now 1 20:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:20 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/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 20:15:20 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/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --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 20:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XKrx2fpLQ/Render', 20:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:15:20 INFO - 'HOME': '/Users/cltbld', 20:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:15:20 INFO - 'LOGNAME': 'cltbld', 20:15:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:20 INFO - 'MOZ_NO_REMOTE': '1', 20:15:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:20 INFO - 'NO_EM_RESTART': '1', 20:15:20 INFO - 'PAGER': '/bin/cat', 20:15:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:20 INFO - 'PWD': '/builds/slave/test', 20:15:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:15:20 INFO - 'RUST_BACKTRACE': '1', 20:15:20 INFO - 'SHELL': '/bin/bash', 20:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v6S8B2LyQZ/Listeners', 20:15:20 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 20:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:15:20 INFO - 'USER': 'cltbld', 20:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:20 INFO - 'XPC_FLAGS': '0x0', 20:15:20 INFO - 'XPC_SERVICE_NAME': '0', 20:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:15:20 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/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 20:15:20 INFO - mozversion application_buildid: 20170330191005 20:15:20 INFO - mozversion application_changeset: 1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912 20:15:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:15:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:20 INFO - mozversion application_name: Firefox 20:15:20 INFO - mozversion application_remotingname: firefox-dev 20:15:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:15:20 INFO - mozversion application_vendor: Mozilla 20:15:20 INFO - mozversion application_version: 54.0a2 20:15:20 INFO - mozversion platform_buildid: 20170330191005 20:15:20 INFO - mozversion platform_changeset: 1edf2dfa3809bdaaa83a3b8914fe80d4fe91a912 20:15:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:15:20 INFO - mozversion platform_version: 54.0a2 20:15:20 INFO - using testdate: 1490930120 20:15:20 INFO - actual date: 1490930120 20:15:20 INFO - starting webserver on 'localhost:49246' 20:15:20 INFO - SUITE-START | Running 2 tests 20:15:20 INFO - TEST-START | dromaeo_css 20:15:20 INFO - operating with platform_type : mac_ 20:15:20 INFO - Initialising browser for dromaeo_css test... 20:15:20 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpGHaY3o/profile http://localhost:49246/getInfo.html) 20:15:22 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 20:15:22 INFO - PROCESS | 1638 | colorDepth:24 20:15:22 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 20:15:22 INFO - PROCESS | 1638 | __metrics 20:15:22 INFO - PROCESS | 1638 | 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" 20:15:22 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:23 INFO - TEST-INFO | 1638: exit 0 20:15:23 INFO - Browser initialized. 20:15:23 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:23 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpGHaY3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:35 INFO - PROCESS | 1640 | RSS: Main: 215252992 20:15:35 INFO - PROCESS | 1640 | 20:18:39 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 20:18:42 INFO - PROCESS | 1640 | RSS: Main: 339243008 20:18:42 INFO - PROCESS | 1640 | 20:20:25 INFO - PROCESS | 1640 | ************************* 20:20:25 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 20:20:25 INFO - PROCESS | 1640 | 20:20:25 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:20:25 INFO - PROCESS | 1640 | Full stack: 20:20:25 INFO - PROCESS | 1640 | ************************* 20:21:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 20:21:46 INFO - PROCESS | 1640 | RSS: Main: 349515776 20:21:46 INFO - PROCESS | 1640 | 20:24:48 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 20:24:48 INFO - PROCESS | 1640 | RSS: Main: 346320896 20:24:48 INFO - PROCESS | 1640 | 20:27:51 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 20:27:52 INFO - PROCESS | 1640 | RSS: Main: 315187200 20:27:52 INFO - PROCESS | 1640 | 20:30:55 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 20:30:56 INFO - PROCESS | 1640 | RSS: Main: 323735552 20:30:56 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 20:34:00 INFO - PROCESS | 1640 | RSS: Main: 410615808 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | __start_tp_report 20:34:00 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 20:34:00 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 20:34:00 INFO - PROCESS | 1640 | |i|pagename|runs| 20:34:00 INFO - PROCESS | 1640 | |0;dojo.html;3205.4550726376515;3421.9315613687727;3432.5709286339215;3449.9482507762405;3467.4625433057868;6027.879442411149;6036.094585812125;6056.364081771417;6059.697015149247;6087.178230938822;6041.637501749898;6076.574639775217;6095.238095238095;6099.9085013724825;6116.357782432848;5400.513953744162;5427.538659213971;5444.428335024825;5446.700431476267;5573.359063707685;5381.730913454331;5387.919181212285;5412.621116521845;5545.861353466175;5567;5481.862953426156;5498.5876059295515;5520.447955204468;5546.500814926656;5566.55467562594;5534.225208470817;5539.390667026624;5541.113421852484;5553.250311207976;5555.555555555546;4957.107720610289;5360.490753378423;5447.45525447456;5447.5641948644015;5486.753096110685;5876.001079816441;5891.440313170285;5899.911501327483;5910.261217347832;5924.792632257893;6243.594166379171;6246.843828904268;6253.656048917308;6288.52836037299;6328.6835658216905;5236.266922630834;6462.579932304385;6508.6094834309615;6512.088307636887;6520.021996700533;6144.723487443076;6224.937750622481;6227.906581401283;6228.750849966042;6252.187215661935;6335.524835637346;6371.23545174582;6429.549931504844;6542.672866356758;6677.031830384567;6291.056341548804;6294.464970477561;6296.275928268308;6299.244090709144;6303.495720342362;6257.217847769029;6328.367163283727;6354.173957385603;6375.872482550323;6411.96794016027;6370.203724534434;6374.521910856704;6396.5202609804455;6401.3278605746655;6406.23125224976;6155.569110162246;6182.412670796267;6194;6311.274203466568;6338.746450141943;5238.869028274247;5255.76349064293;5268.367795864521;5286.629935904527;5290.285811415487;4549.840755573605;4603.815847366068;4605.746683932416;4618.67669263155;4656.557627025427;6097.085437184458;6113.871604717271;6116.457510225689;6129.695011270001;6130.856783744234;6489.870202595922;6490.188726409199;6507.577007494498;6514.869702605922;6525.2169739631545;5915;5962.105684147413;6113.38866113394;6133.172021777003;6135.049067394561;5645.322561292671;5739.885202295931;5773.826785196451;5818.94181058184;5832.562557808182;6678.298778628174;6697.799066028027;6698.263191049078;6705.362990515893;6707.329267073449;6342.556021078481;6449.774257900951;6471.611703297817;6476;6525.64108974011;6357.586756860789;6422.068800023877;6598.04328372393;6688.632125233159;6701.664916754045;6323.20959880015;6388.329225431448;6395.20059992501;6403.551751377358;6426.29310775805;6408.679566021773;6460.257070436772;6467.482601391972;6480.675966201766;6482.416582507597;6189.35011823752;6253.249610046823;6328.620282782864;6343;6354.90467642995;6244.438000579969;6256.061590761422;6313.936860631335;6330.841728956813;6334.651594162366;6056.152138700673;6097.75608975636;6098.481629061579;6280.780172693934;6290.685465726787;6224.035274532454;6225.782097626561;6271.247450305992;6272.40412160844;6287.528435367274;6275.905861411991;6298.496120310272;6306.211723534559;6308.432241098323;6311.905321420274 20:34:00 INFO - PROCESS | 1640 | |1;ext.html;779.7972527142942;816.5304949653951;854.2781349759452;870.0733718589702;873.2533683700436;36159.276814463694;36682.44976325357;38072.80963595185;38095.23809523811;38144;36775;36871.815640921755;36896.26207475855;36897;36970.815145924236;7276.890846637305;7455.0681164854395;7649.235076492348;7786.532808031508;7800.648970796299;7378.963105184466;7451.1058672959325;7461.291177338144;10714.517846696917;10954.287971281881;10893.83659245112;10922.126229901629;10934.07060399863;10948.343099414022;10975.396353200571;10874.347539147637;10884.510197041152;10935.726606834813;10937.83593246102;10968.890311096866;7300.34296913275;7456.217097204824;10451.268411211218;10745.51645175969;10763.3541987481;37607.811960940024;37914.241715165816;37996.05009874775;38001.80999094987;38006;3786.715996300261;3789.7157713171623;3790.6452789281407;3799.7007797560627;3886.844526218948;26797.598036029474;26899.596506052425;26967.190984270503;27580.172594821986;28480;3030.8939187128344;3069.9693003069906;3096.807599625611;3100.9689903100907;3157.3053928135773;358128.4187158121;361627;361669;362660;362753;42401;42964.14071718611;45095.54904450979;51250.48749512457;51274;52436.47563524392;53143.20285195725;53147;53218.201726974126;53261.66845828808;14543.490977815725;14599.85400145985;14614.488492902698;14617.122972621677;14631.487897923735;12649.494020239272;12709.682257943441;12710.745785084246;12735.108542401942;12745.235285882876;12071.215371000857;12081.275123492618;12099.850514201136;12155.878441215651;12196.024318054535;5616.775328986876;5666.376698563155;5684.658920464785;5689.146628005749;5695.572832037614;959.2661613865398;959.9904000960041;1070.4915165296422;1111.9332840029624;1144.4206994347746;26128.738712613012;26384.736152638612;26482;26639.600405993926;26814.5977810333;1061.8141825180562;1108.8613923259593;1237.5482948723652;1256.5162412471263;1304.562971404571;12622.431990560446;13101.31838730046;13118.475260989644;13285;13405.798913016313;473657;479387;480010;480932;481083.18916811084;45083.323750143776;45100.87247818831;45264;45329.77335113369;45486.31770523445;1382.7649299619088;1420.978685319721;1421.5877395555174;1421.6943357178257;1421.8720315171684;22707;23796.405089872893;24236.030558777453;24528;24769.50460990806;39401.60598394094;39544.60455395524;39589.812305630876;39627.60372396239;39630.80184599059;377796;440830;443052;443171;444337;23478.413039674146;24052.39869003289;26878.32804179911;28155.296117596405;28303.15090547287;35911.1022224436;37330.81334593309;37639.247215054995;37711.24577508379;37769;25768.71156442133;26820.463590728465;27163.72836271691;27399.726002739717;27981.720182798726;27082;27692.307692307855;27793.44413111767;27973.440531188855;28152.718472815828;31122.844385777928;31153.221169470944;31258.062258132293;31713.524297136024;31854.68145318517;25271.620925685762;27330.590041149797;27387.86306068457;27763.167104986882;28173.859130704215;21513.13947442085;22140.667889981985;22328.441788955406;22344.77655223492;22491.550168996855 20:34:00 INFO - PROCESS | 1640 | |2;jquery.html;385.38531042986426;414.4549916859328;424.24272673278193;431.1549363248034;449.9122671079141;14560.56318310451;20736.47479928412;21617.243396481128;21777.67333489997;21826.253899688025;19004;22772.8861355693;23049.04083152934;23511.29466116015;23536.293911182693;6083.087536869483;6531.804045878619;6562.639054851981;6798.932010679904;6831.829204269909;6682.498812589051;6696.296888826676;6739.393454589086;6742.797716068501;6748;6469.74121035158;6649.069130321759;6717.462602991749;6727.529072964894;6729.7308107675635;6329.715162817684;6392.169018027673;6618.8676226475445;6685.331466853324;6687.799366019003;6496.707648155844;6497.350264973512;6503.15458990333;6504.642244676588;6513.967430162867;27411.86294068537;27785.027524036563;27789.444211115664;27837.721622783716;28131.718682813116;2956.689547597493;2982.346625383909;2999.2052106191877;3000;3006.609140811702;14007.805433821226;14915.477958271409;16089.873708840385;16407;16845.747313790303;1990.4824745566111;2040.6938959156098;2050.8769473831467;2055.3525639423683;2086.3115171993204;152089;155208;161019.58470622834;162813;164654.35345646628;15020.774688379683;20224.292149774687;20323.390298291073;20372.28696995598;20422.69365959512;29754.553681694793;30454.695453045628;30459;31396.901108461094;31899.681003190137;8703.347248956354;9064.50145242018;10494.580216791395;10537.736556586147;10573.04842564173;8073.798155046054;8148.633311500997;8702.738917832476;8900.06549312313;9011.188992990663;7742.7677169685;9356.578953947088;9417.670381536751;9583.856242156373;9606.567704453317;4104.794760261975;4129.236091323115;4135.255653982252;4143.212789569972;4163.481857830128;882.8763973043779;892.1702816380828;899.5771987166153;927.420362273579;939.248601119102;21995.780042199694;22813.31560053201;22846.42883927882;22858.08567657275;22900.31299061031;907.2500595568946;920.415536134546;930.0141849639404;936.9063093690577;942.7878727286443;10707.411092389837;10923.453827308604;11740.765184696429;11744.76510469803;11782.234154779911;770646;774453;778467;780587;798408.1353084936;153404;156721;158253;158679.619805703;164015.17992409962;1162.8778978207336;1211.3640338822188;1253.5487224599137;1254.7804134276464;1261.0479088288466;19634.60730785405;19785.505362366057;20341.49146271355;20355.88042657609;20367.388978330673;48274.275885862444;59124;62199.067013993925;63163.6841815788;63434;78656;84219.5789021051;85899.71150432873;86240;88369.79075523163;7412.221716719667;9973.950130249592;11002.944985275022;11318.981291683787;11739.647810565697;12876.35618219104;12909.677258068623;12921;13227.007974402151;13290.867091328962;11014.724631884266;11468.483918223534;11533;11552.6534203974;11561.132915031574;10368.792624147625;10474.266801324138;10485.737856553342;10706.8929310709;10831.025207731342;11505.194636375374;11536.653900383002;11621.256811478346;11775;11801.29192248468;11492.195546312012;11508.424578771195;11765.76468470643;11820.290782553075;11916.52333906634;10673.41296228715;11144.164187685794;11156.721081973015;11286.66140015801;11322.60370887015 20:34:00 INFO - PROCESS | 1640 | |3;mootools.html;1411.65414473454;1532.6015236038627;1535.194023137852;1559.9298031588578;1584.5642448326705;10509.21180911431;11153.163512736557;11192.944035279832;11193.16051296153;11194.776104477916;10697.037266646;11136;11321.773564528705;11322.20744547882;11330.320180789158;2388.22382725614;2433.9513209735796;2435.57377458944;2437.744036876129;2441.6093425051995;2310.1336998625516;2401.327628264089;2404.1585445094165;2405.122130422401;2406.2179791567723;2326.3137374474486;2372.810175185981;2384.654225137354;2424.9757502424927;2431.173401043645;2291.4156889992946;2373.76262373763;2378.084437491561;2385.940351491209;2386.260259319608;2340.2628172125724;2367.9644805327935;2372.110458578033;2373.2049763329132;2378.3935096550267;10877.456127193609;11130.888691113067;11136.443177841156;11141.610043648434;11161.665150045512;5565.1374037024325;5696.401877802812;5729.713514324267;5744.942550574524;5752.913706294409;3054.7861649684532;3458.5330980317585;3606.6213047629885;3635.1093981974323;3664.4320130379833;1169.5672601137549;1183.4201241391743;1205.0841360566033;1216.7019080325376;1218.8415505984253;13375.866241337559;13670.316484175852;14674.853251467563;15318.234088295541;15565.37738490459;4536.977315113403;4631.560001799824;4654.25531914892;4654.883627909262;4672.836450724209;11606.419679016015;11609.36148511823;11627.011704005085;11645.243059201124;11646.825297620542;4817.975910120427;4977.477364876636;5440.809571664972;5572.665640061609;5737.282839645044;5074.238864170404;5218.712970786643;5297.8145764898045;5298;5303.575713942875;3755.3991361382596;3806.9619303807162;3862.3820188769664;3865.6714179294513;3871.4773505576386;974.0892265731563;1000.9049140331657;1006.2302338710892;1008.4403156248353;1010.8534262532039;956.4882787708682;960.5869476125193;961.8701475300885;970.3547141151056;993.4233984390481;6591.43972762311;6643.534952553371;6736.797896063126;6855.485838562127;6872.62200578973;959.3716115944068;968.1335204991634;990.7275499237624;999.3304485994402;1027.8817935937464;3486.372452958492;4039.3940908863906;4166.8749937501925;4256.530927294245;4277.636400905895;12314.261144331369;12769.0423218259;13562.254076025913;14157.85842141586;14223.715525689428;13037.15258508194;13041.869581304256;13041.934790325988;13052.477900884049;13061;9966.20270378368;10224.079832814934;10259.127974122282;10259.794804104025;10295.279330446947;5773;6181.320054794059;6478.4169424752;6883.793486195422;6884.036234927014;11995.220310679779;12463.376831158586;12477.376131193223;12478.625641230778;12486.500539978299;11749.118816088656;12097.274163550215;12258.754824903273;12295.139340246096;12613.243205407705;8571.914280857112;8815.735527934172;8921.286297096087;8948.239399650842;8951.820963580822;9677.001940974525;9844.114029737359;9860.704178874645;9996.300258982092;10050.64822731201;8420.326373889951;8443.282321002784;8529.402941794015;8554.615042322986;8623.137686231326;8226.64722682694;8321.292690121407;8367.037790654153;8421.19998600132;8556.74329770108;7636.389088872988;7641.312281894434;7799.103103143211;7818.140004599376;7826.843463130819;5864.32560255576;5920.496757775465;5958.731857066356;5964.493018093511;6020.096985452042;5669.574781891457;5773.913391299218;5785.132230165509;5937.643741375531;6160.784372546939 20:34:00 INFO - PROCESS | 1640 | |4;prototype.html;381.3288612042805;384.573123832546;385.9266739319529;393.6830851164813;393.8956176613198;4525.66492884599;4640.628749700024;5158.646879528308;5193.2989046478715;5305.373839949221;4078.5105787305492;4178.474856677313;4399.186150562148;5131.794728210867;5141.537261646451;4143.813528391214;4286.39990401344;4291.699581029329;4294.892627684301;4365.5416181300825;3838.3858582626785;3904.5509766376945;4093.897652558695;4145.689073319498;4301.978490107561;3714.962850371502;4308.289132293168;4330.220560299145;4353.760543170124;4367.694261401703;3291.835408229579;3471.3057388522143;3623.945640815377;4225.661727235481;4310.9999999999845;3530.3468858261303;3755.2114056048263;3832.3868181090893;3943.4676318697184;3966.464527288808;4448.197635489621;4808.134535783557;4985.750712464399;5034.471380505068;5060.645754797166;4200.642945349649;4682.548409992879;4826.638002149853;4965.652404331699;4975.303457515951;5323.946760532383;5383.353997520323;5531.363893152258;5556.361018482886;5571.746357069627;3823.445600387928;4242.575742425764;4452.621527170194;4458.3535387368975;4492.607291739571;4763.761811909425;4952.860842006358;5010.323606313137;5070.239464080418;5906.291245050578;4015.9196816063513;4049;4193.783802697184;4367.31858234582;4491.483479399845;4321.719088259253;4606.239970404913;4616.584507394351;4626.83806066786;4649.767511624473;4393;4441.244988351988;4471.597556219956;4553.747719377132;4796.928046079312;4769.664493941702;5245.977034478316;5357.678539287655;5474.370447398521;5536.453231513549;1459.2489013184008;1482.6664000599994;1540.5917431880562;1551.5422950229708;1576.3852097681913;1099.6591056772427;1116.2911551165068;1163.0751106918065;1182.0484509969558;1184.5972369394447;4452.0873220989615;4543.636509079266;4978.377702787152;5030.138848626032;5041.243813427942;4582.564656357641;4977.850664479999;4998.4251811042195;5687.971560142256;5701.429857014348;4259.318509038539;4350.703965998581;4766.737829419346;4864.537868902448;5085.64400491962;2649;2748.8900443982416;2934.618499595039;2942.8969986050815;2949.8495586721197;5564.916526252109;5611.494965453129;5851.297844258716;5873.3245676746865;5947.732352044169;5233.685978841282;5305.336832895888;5490.956718223525;5760.8190320984095;5874.882502350015;5409.83770486886;5720.8558288341665;5731.742071606787;5747.907897499462;5764.971175144097;4567.06375193078;5475.534579560782;5740.885182296247;5769.59612827098;5792;5034.723090230073;5622.522085622768;5632.633878797865;5639.631354830899;5721.25623668937;5679.659220446786;5908.168467775004;5963.493103086286;5975.731092100953;6024;3863.497745293094;4556.65825063115;4560.293154561048;4599.724016559017;4620.537946205487;4760.59534939534;4954.727489988085;5636.6451870723795;5700.971495142498;5734.741936612946;4833.564979151894;5385.980257403474;5538.9169162461785;5541.418151094238;5636.534501029843;4732.834350797705;4985.800567977385;5023.659266587824;5280.894382112413;5330.946690533045;5325.440828712929;5328.920066199088;5359.946400535945;5399.43305952885;5409.729513524229;4758.500357462555;5045.578122501147;5319.723266416109;5491.835244942658;5528.44715528444;5182.714950677749;5310.176922577007;5408.972955135199;5415.6479828811;5453.918191227055 20:34:00 INFO - PROCESS | 1640 | |5;yui.html;716.8781307177783;723.7394537966328;747.7794050755027;818.7502811642448;830.6594296338501;14691.191984440851;15779.921100394511;15797.526074217763;15799.84200157998;15838.445654402098;14471.493497727583;14768.6307842304;14889.776653350182;15056.473023444181;15078.547643570682;871.3377832847034;949.0651708067548;953.0993211415215;955.1022039283087;957.1481381570408;942.9057094290584;944.1219665710886;944.6457578408097;945.6406565505098;947.729896979361;955.0544960489101;981.1464026297132;997.8104160209537;998.7602975285915;1000.0099901097933;984.2765567308023;986.2011770465909;987.2595553334999;988.1551273660988;989.3322007644883;729.2707292707292;731.747547096251;733.101950111115;733.9834329453691;735.1068451831051;15433.5369938902;15687.607809804733;15735.685286294325;15784.842151578452;15919.840801592067;14073.36669849849;14339.54385476527;14356.712865742731;14476.855231447656;14507.492237771732;11353.602623908124;11698.2981021139;11768.117391195694;11795.292282462993;11937.403129843473;3625.0756057205244;3642.1076836175307;3746.2320224353944;3834.9808250958845;3879.8642047528483;103361.4831925843;109689.45155274252;111144;111986;113454.43272783665;9731.659391921248;10502.842457363146;10522.684319470429;10768.461576921123;11508.309501429942;20654.690179647318;21509.46226344354;21765.782342176375;22078;22090.558188836454;7797.532148071134;7812;7893.092294386219;7900.012498437695;8167.469114507538;4271.700980931367;4277.486701595828;4341.826326946887;4360.934585981213;4379.868603941887;3538.876139335111;3634.3639863023864;3637.4907512948207;3641.253543023674;3641.6904563111902;512.7428814196635;639.6993413095837;640.4204195203348;640.9519286053564;640.9551331406757;686.1765880942888;686.9313068693091;705.3052743048196;713.1121753417029;746.6714645555938;9861.408315501092;10204.285700001077;10327.793444131075;10443.68668939933;10649.254552181428;642.8705654293904;673.3636713305976;685.4721864164566;691.7820886420761;697.2156324135348;4787.305840653155;4815.3017812417;5317.468253174651;5440.646357986719;5715.2855893013375;94017;97022.05955880843;97035.02964970401;97861.02138978662;98507;83213.58393208116;84924.72612910811;86292.7056094159;87840.1215987832;88817;76835.61582192164;78043.06488528838;78557.4288514238;78765;79696.80454793182;11014.203339906706;11036.558537658724;11164.995150436174;11237.662870113909;11273.605423810128;41696.58303416927;41902.37146442867;42254.78872605618;43050.78474607607;43392;55616.88766224734;57581.71209143927;58330.12504812516;58628.4137158623;59064.70467647634;12432.609537425878;12823.93588032054;12854.807177892151;13053.934730326668;13492.662683432993;14640.34118464693;14870.330835112229;14951.700965980837;14954;15008.399664013317;13458;13497.932510337385;13995.94117705854;14163.787543187067;14466.566003019927;11857;13360.93319533396;13774.586762397144;14135.293235337986;14753;13334.133281336683;13414.664633384244;13617.86382136166;13921.234332111426;14244.002919795515;10057.748556286151;10339.483025848827;10548;10598.682039538826;10636.680899573024;11229.4385280734;11255.02723553124;11425.31448113116;11561.248518846249;11916.821247681464 20:34:00 INFO - PROCESS | 1640 | __end_tp_report 20:34:00 INFO - PROCESS | 1640 | __start_cc_report 20:34:00 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2401 20:34:00 INFO - PROCESS | 1640 | __end_cc_report 20:34:00 INFO - PROCESS | 1640 | __startTimestamp1490931240314__endTimestamp 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | ------- Summary: start ------- 20:34:00 INFO - PROCESS | 1640 | Number of tests: 6 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5982.13 Median:6227.91 stddev:653.10 (10.5%) stddev-sans-first:617.71 20:34:00 INFO - PROCESS | 1640 | Values: 3205.5 3421.9 3432.6 3449.9 3467.5 6027.9 6036.1 6056.4 6059.7 6087.2 6041.6 6076.6 6095.2 6099.9 6116.4 5400.5 5427.5 5444.4 5446.7 5573.4 5381.7 5387.9 5412.6 5545.9 5567.0 5481.9 5498.6 5520.4 5546.5 5566.6 5534.2 5539.4 5541.1 5553.3 5555.6 4957.1 5360.5 5447.5 5447.6 5486.8 5876.0 5891.4 5899.9 5910.3 5924.8 6243.6 6246.8 6253.7 6288.5 6328.7 5236.3 6462.6 6508.6 6512.1 6520.0 6144.7 6224.9 6227.9 6228.8 6252.2 6335.5 6371.2 6429.5 6542.7 6677.0 6291.1 6294.5 6296.3 6299.2 6303.5 6257.2 6328.4 6354.2 6375.9 6412.0 6370.2 6374.5 6396.5 6401.3 6406.2 6155.6 6182.4 6194.0 6311.3 6338.7 5238.9 5255.8 5268.4 5286.6 5290.3 4549.8 4603.8 4605.7 4618.7 4656.6 6097.1 6113.9 6116.5 6129.7 6130.9 6489.9 6490.2 6507.6 6514.9 6525.2 5915.0 5962.1 6113.4 6133.2 6135.0 5645.3 5739.9 5773.8 5818.9 5832.6 6678.3 6697.8 6698.3 6705.4 6707.3 6342.6 6449.8 6471.6 6476.0 6525.6 6357.6 6422.1 6598.0 6688.6 6701.7 6323.2 6388.3 6395.2 6403.6 6426.3 6408.7 6460.3 6467.5 6480.7 6482.4 6189.4 6253.2 6328.6 6343.0 6354.9 6244.4 6256.1 6313.9 6330.8 6334.7 6056.2 6097.8 6098.5 6280.8 6290.7 6224.0 6225.8 6271.2 6272.4 6287.5 6275.9 6298.5 6306.2 6308.4 6311.9 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:54469.47 Median:3098.89 stddev:113420.47 (3660.0%) stddev-sans-first:113667.01 20:34:00 INFO - PROCESS | 1640 | Values: 779.8 816.5 854.3 870.1 873.3 36159.3 36682.4 38072.8 38095.2 38144.0 36775.0 36871.8 36896.3 36897.0 36970.8 7276.9 7455.1 7649.2 7786.5 7800.6 7379.0 7451.1 7461.3 10714.5 10954.3 10893.8 10922.1 10934.1 10948.3 10975.4 10874.3 10884.5 10935.7 10937.8 10968.9 7300.3 7456.2 10451.3 10745.5 10763.4 37607.8 37914.2 37996.1 38001.8 38006.0 3786.7 3789.7 3790.6 3799.7 3886.8 26797.6 26899.6 26967.2 27580.2 28480.0 3030.9 3070.0 3096.8 3101.0 3157.3 358128.4 361627.0 361669.0 362660.0 362753.0 42401.0 42964.1 45095.5 51250.5 51274.0 52436.5 53143.2 53147.0 53218.2 53261.7 14543.5 14599.9 14614.5 14617.1 14631.5 12649.5 12709.7 12710.7 12735.1 12745.2 12071.2 12081.3 12099.9 12155.9 12196.0 5616.8 5666.4 5684.7 5689.1 5695.6 959.3 960.0 1070.5 1111.9 1144.4 26128.7 26384.7 26482.0 26639.6 26814.6 1061.8 1108.9 1237.5 1256.5 1304.6 12622.4 13101.3 13118.5 13285.0 13405.8 473657.0 479387.0 480010.0 480932.0 481083.2 45083.3 45100.9 45264.0 45329.8 45486.3 1382.8 1421.0 1421.6 1421.7 1421.9 22707.0 23796.4 24236.0 24528.0 24769.5 39401.6 39544.6 39589.8 39627.6 39630.8 377796.0 440830.0 443052.0 443171.0 444337.0 23478.4 24052.4 26878.3 28155.3 28303.2 35911.1 37330.8 37639.2 37711.2 37769.0 25768.7 26820.5 27163.7 27399.7 27981.7 27082.0 27692.3 27793.4 27973.4 28152.7 31122.8 31153.2 31258.1 31713.5 31854.7 25271.6 27330.6 27387.9 27763.2 28173.9 21513.1 22140.7 22328.4 22344.8 22491.6 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:44027.01 Median:25474.08 stddev:130143.95 (510.9%) stddev-sans-first:130467.79 20:34:00 INFO - PROCESS | 1640 | Values: 385.4 414.5 424.2 431.2 449.9 14560.6 20736.5 21617.2 21777.7 21826.3 19004.0 22772.9 23049.0 23511.3 23536.3 6083.1 6531.8 6562.6 6798.9 6831.8 6682.5 6696.3 6739.4 6742.8 6748.0 6469.7 6649.1 6717.5 6727.5 6729.7 6329.7 6392.2 6618.9 6685.3 6687.8 6496.7 6497.4 6503.2 6504.6 6514.0 27411.9 27785.0 27789.4 27837.7 28131.7 2956.7 2982.3 2999.2 3000.0 3006.6 14007.8 14915.5 16089.9 16407.0 16845.7 1990.5 2040.7 2050.9 2055.4 2086.3 152089.0 155208.0 161019.6 162813.0 164654.4 15020.8 20224.3 20323.4 20372.3 20422.7 29754.6 30454.7 30459.0 31396.9 31899.7 8703.3 9064.5 10494.6 10537.7 10573.0 8073.8 8148.6 8702.7 8900.1 9011.2 7742.8 9356.6 9417.7 9583.9 9606.6 4104.8 4129.2 4135.3 4143.2 4163.5 882.9 892.2 899.6 927.4 939.2 21995.8 22813.3 22846.4 22858.1 22900.3 907.3 920.4 930.0 936.9 942.8 10707.4 10923.5 11740.8 11744.8 11782.2 770646.0 774453.0 778467.0 780587.0 798408.1 153404.0 156721.0 158253.0 158679.6 164015.2 1162.9 1211.4 1253.5 1254.8 1261.0 19634.6 19785.5 20341.5 20355.9 20367.4 48274.3 59124.0 62199.1 63163.7 63434.0 78656.0 84219.6 85899.7 86240.0 88369.8 7412.2 9974.0 11002.9 11319.0 11739.6 12876.4 12909.7 12921.0 13227.0 13290.9 11014.7 11468.5 11533.0 11552.7 11561.1 10368.8 10474.3 10485.7 10706.9 10831.0 11505.2 11536.7 11621.3 11775.0 11801.3 11492.2 11508.4 11765.8 11820.3 11916.5 10673.4 11144.2 11156.7 11286.7 11322.6 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6635.79 Median:3256.66 stddev:4134.27 (126.9%) stddev-sans-first:4127.23 20:34:00 INFO - PROCESS | 1640 | Values: 1411.7 1532.6 1535.2 1559.9 1584.6 10509.2 11153.2 11192.9 11193.2 11194.8 10697.0 11136.0 11321.8 11322.2 11330.3 2388.2 2434.0 2435.6 2437.7 2441.6 2310.1 2401.3 2404.2 2405.1 2406.2 2326.3 2372.8 2384.7 2425.0 2431.2 2291.4 2373.8 2378.1 2385.9 2386.3 2340.3 2368.0 2372.1 2373.2 2378.4 10877.5 11130.9 11136.4 11141.6 11161.7 5565.1 5696.4 5729.7 5744.9 5752.9 3054.8 3458.5 3606.6 3635.1 3664.4 1169.6 1183.4 1205.1 1216.7 1218.8 13375.9 13670.3 14674.9 15318.2 15565.4 4537.0 4631.6 4654.3 4654.9 4672.8 11606.4 11609.4 11627.0 11645.2 11646.8 4818.0 4977.5 5440.8 5572.7 5737.3 5074.2 5218.7 5297.8 5298.0 5303.6 3755.4 3807.0 3862.4 3865.7 3871.5 974.1 1000.9 1006.2 1008.4 1010.9 956.5 960.6 961.9 970.4 993.4 6591.4 6643.5 6736.8 6855.5 6872.6 959.4 968.1 990.7 999.3 1027.9 3486.4 4039.4 4166.9 4256.5 4277.6 12314.3 12769.0 13562.3 14157.9 14223.7 13037.2 13041.9 13041.9 13052.5 13061.0 9966.2 10224.1 10259.1 10259.8 10295.3 5773.0 6181.3 6478.4 6883.8 6884.0 11995.2 12463.4 12477.4 12478.6 12486.5 11749.1 12097.3 12258.8 12295.1 12613.2 8571.9 8815.7 8921.3 8948.2 8951.8 9677.0 9844.1 9860.7 9996.3 10050.6 8420.3 8443.3 8529.4 8554.6 8623.1 8226.6 8321.3 8367.0 8421.2 8556.7 7636.4 7641.3 7799.1 7818.1 7826.8 5864.3 5920.5 5958.7 5964.5 6020.1 5669.6 5773.9 5785.1 5937.6 6160.8 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4540.28 Median:4817.39 stddev:1276.93 (26.5%) stddev-sans-first:1241.77 20:34:00 INFO - PROCESS | 1640 | Values: 381.3 384.6 385.9 393.7 393.9 4525.7 4640.6 5158.6 5193.3 5305.4 4078.5 4178.5 4399.2 5131.8 5141.5 4143.8 4286.4 4291.7 4294.9 4365.5 3838.4 3904.6 4093.9 4145.7 4302.0 3715.0 4308.3 4330.2 4353.8 4367.7 3291.8 3471.3 3623.9 4225.7 4311.0 3530.3 3755.2 3832.4 3943.5 3966.5 4448.2 4808.1 4985.8 5034.5 5060.6 4200.6 4682.5 4826.6 4965.7 4975.3 5323.9 5383.4 5531.4 5556.4 5571.7 3823.4 4242.6 4452.6 4458.4 4492.6 4763.8 4952.9 5010.3 5070.2 5906.3 4015.9 4049.0 4193.8 4367.3 4491.5 4321.7 4606.2 4616.6 4626.8 4649.8 4393.0 4441.2 4471.6 4553.7 4796.9 4769.7 5246.0 5357.7 5474.4 5536.5 1459.2 1482.7 1540.6 1551.5 1576.4 1099.7 1116.3 1163.1 1182.0 1184.6 4452.1 4543.6 4978.4 5030.1 5041.2 4582.6 4977.9 4998.4 5688.0 5701.4 4259.3 4350.7 4766.7 4864.5 5085.6 2649.0 2748.9 2934.6 2942.9 2949.8 5564.9 5611.5 5851.3 5873.3 5947.7 5233.7 5305.3 5491.0 5760.8 5874.9 5409.8 5720.9 5731.7 5747.9 5765.0 4567.1 5475.5 5740.9 5769.6 5792.0 5034.7 5622.5 5632.6 5639.6 5721.3 5679.7 5908.2 5963.5 5975.7 6024.0 3863.5 4556.7 4560.3 4599.7 4620.5 4760.6 4954.7 5636.6 5701.0 5734.7 4833.6 5386.0 5538.9 5541.4 5636.5 4732.8 4985.8 5023.7 5280.9 5330.9 5325.4 5328.9 5359.9 5399.4 5409.7 4758.5 5045.6 5319.7 5491.8 5528.4 5182.7 5310.2 5409.0 5415.6 5453.9 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20019.43 Median:3694.17 stddev:28458.38 (770.4%) stddev-sans-first:28501.30 20:34:00 INFO - PROCESS | 1640 | Values: 716.9 723.7 747.8 818.8 830.7 14691.2 15779.9 15797.5 15799.8 15838.4 14471.5 14768.6 14889.8 15056.5 15078.5 871.3 949.1 953.1 955.1 957.1 942.9 944.1 944.6 945.6 947.7 955.1 981.1 997.8 998.8 1000.0 984.3 986.2 987.3 988.2 989.3 729.3 731.7 733.1 734.0 735.1 15433.5 15687.6 15735.7 15784.8 15919.8 14073.4 14339.5 14356.7 14476.9 14507.5 11353.6 11698.3 11768.1 11795.3 11937.4 3625.1 3642.1 3746.2 3835.0 3879.9 103361.5 109689.5 111144.0 111986.0 113454.4 9731.7 10502.8 10522.7 10768.5 11508.3 20654.7 21509.5 21765.8 22078.0 22090.6 7797.5 7812.0 7893.1 7900.0 8167.5 4271.7 4277.5 4341.8 4360.9 4379.9 3538.9 3634.4 3637.5 3641.3 3641.7 512.7 639.7 640.4 641.0 641.0 686.2 686.9 705.3 713.1 746.7 9861.4 10204.3 10327.8 10443.7 10649.3 642.9 673.4 685.5 691.8 697.2 4787.3 4815.3 5317.5 5440.6 5715.3 94017.0 97022.1 97035.0 97861.0 98507.0 83213.6 84924.7 86292.7 87840.1 88817.0 76835.6 78043.1 78557.4 78765.0 79696.8 11014.2 11036.6 11165.0 11237.7 11273.6 41696.6 41902.4 42254.8 43050.8 43392.0 55616.9 57581.7 58330.1 58628.4 59064.7 12432.6 12823.9 12854.8 13053.9 13492.7 14640.3 14870.3 14951.7 14954.0 15008.4 13458.0 13497.9 13995.9 14163.8 14466.6 11857.0 13360.9 13774.6 14135.3 14753.0 13334.1 13414.7 13617.9 13921.2 14244.0 10057.7 10339.5 10548.0 10598.7 10636.7 11229.4 11255.0 11425.3 11561.2 11916.8 20:34:00 INFO - PROCESS | 1640 | -------- Summary: end -------- 20:34:00 INFO - PROCESS | 1640 | 20:34:00 INFO - TEST-INFO | 1640: exit 0 20:34:01 INFO - TEST-OK | dromaeo_css | took 1120767ms 20:34:01 INFO - TEST-START | kraken 20:34:01 INFO - operating with platform_type : mac_ 20:34:01 INFO - Initialising browser for kraken test... 20:34:01 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpNuVYwU/profile http://localhost:49246/getInfo.html) 20:34:03 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 20:34:03 INFO - PROCESS | 1647 | colorDepth:24 20:34:03 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 20:34:03 INFO - PROCESS | 1647 | __metrics 20:34:03 INFO - PROCESS | 1647 | 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" 20:34:03 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:34:04 INFO - TEST-INFO | 1647: exit 0 20:34:04 INFO - Browser initialized. 20:34:04 INFO - Running cycle 1/1 for kraken test... 20:34:04 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpNuVYwU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:16 INFO - PROCESS | 1648 | RSS: Main: 214839296 20:34:16 INFO - PROCESS | 1648 | 20:34:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:19 INFO - PROCESS | 1648 | RSS: Main: 267644928 20:34:19 INFO - PROCESS | 1648 | 20:34:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 20:34:22 INFO - PROCESS | 1648 | RSS: Main: 279056384 20:34:22 INFO - PROCESS | 1648 | 20:34:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 20:34:26 INFO - PROCESS | 1648 | RSS: Main: 375369728 20:34:26 INFO - PROCESS | 1648 | 20:34:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 20:34:29 INFO - PROCESS | 1648 | RSS: Main: 277860352 20:34:29 INFO - PROCESS | 1648 | 20:34:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:32 INFO - PROCESS | 1648 | RSS: Main: 278966272 20:34:32 INFO - PROCESS | 1648 | 20:34:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:35 INFO - PROCESS | 1648 | RSS: Main: 319877120 20:34:35 INFO - PROCESS | 1648 | 20:34:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:39 INFO - PROCESS | 1648 | RSS: Main: 320286720 20:34:39 INFO - PROCESS | 1648 | 20:34:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 20:34:42 INFO - PROCESS | 1648 | RSS: Main: 317804544 20:34:42 INFO - PROCESS | 1648 | 20:34:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:45 INFO - PROCESS | 1648 | RSS: Main: 293724160 20:34:45 INFO - PROCESS | 1648 | 20:34:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:47 INFO - PROCESS | 1648 | RSS: Main: 298332160 20:34:47 INFO - PROCESS | 1648 | 20:34:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:50 INFO - PROCESS | 1648 | RSS: Main: 307175424 20:34:50 INFO - PROCESS | 1648 | 20:34:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:54 INFO - PROCESS | 1648 | RSS: Main: 322818048 20:34:54 INFO - PROCESS | 1648 | 20:34:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:57 INFO - PROCESS | 1648 | RSS: Main: 316129280 20:34:57 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 20:34:59 INFO - PROCESS | 1648 | RSS: Main: 360714240 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | __start_tp_report 20:34:59 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 20:34:59 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 20:34:59 INFO - PROCESS | 1648 | |i|pagename|runs| 20:34:59 INFO - PROCESS | 1648 | |0;ai-astar;115;114;112;113;114;115;115;114;115;114 20:34:59 INFO - PROCESS | 1648 | |1;audio-beat-detection;144;108;108;145;111;107;110;108;124;111 20:34:59 INFO - PROCESS | 1648 | |2;audio-dft;181;184;183;183;183;183;182;181;184;182 20:34:59 INFO - PROCESS | 1648 | |3;audio-fft;81;60;61;81;76;71;90;80;76;62 20:34:59 INFO - PROCESS | 1648 | |4;audio-oscillator;86;69;87;69;69;68;82;67;69;83 20:34:59 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;88;87;87;87;86;85;87;86;87 20:34:59 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;111;148;145;94;95;95;94;95;95 20:34:59 INFO - PROCESS | 1648 | |7;imaging-desaturate;80;87;85;85;85;85;86;87;86;86 20:34:59 INFO - PROCESS | 1648 | |8;json-parse-financial;64;61;60;60;62;65;64;64;63;62 20:34:59 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;54;56;66;64;60;60;61;58;58;58 20:34:59 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;83;85;86;76;83;85;81;84;83;90 20:34:59 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;140;140;141;144;140;135;136;140;180;169 20:34:59 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;165;165;165;167;171;195;222;183;166;167 20:34:59 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;65;74;81;82;61;60;79;80;79;78 20:34:59 INFO - PROCESS | 1648 | __end_tp_report 20:34:59 INFO - PROCESS | 1648 | __start_cc_report 20:34:59 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2168 20:34:59 INFO - PROCESS | 1648 | __end_cc_report 20:34:59 INFO - PROCESS | 1648 | __startTimestamp1490931299802__endTimestamp 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | ------- Summary: start ------- 20:34:59 INFO - PROCESS | 1648 | Number of tests: 14 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:0.99 (0.9%) stddev-sans-first:1.00 20:34:59 INFO - PROCESS | 1648 | Values: 115.0 114.0 112.0 113.0 114.0 115.0 115.0 114.0 115.0 114.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:111.00 stddev:14.99 (13.5%) stddev-sans-first:12.49 20:34:59 INFO - PROCESS | 1648 | Values: 144.0 108.0 108.0 145.0 111.0 107.0 110.0 108.0 124.0 111.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.07 (0.6%) stddev-sans-first:0.97 20:34:59 INFO - PROCESS | 1648 | Values: 181.0 184.0 183.0 183.0 183.0 183.0 182.0 181.0 184.0 182.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:73.80 Median:78.00 stddev:10.09 (12.9%) stddev-sans-first:10.36 20:34:59 INFO - PROCESS | 1648 | Values: 81.0 60.0 61.0 81.0 76.0 71.0 90.0 80.0 76.0 62.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.50 stddev:8.40 (11.1%) stddev-sans-first:7.89 20:34:59 INFO - PROCESS | 1648 | Values: 86.0 69.0 87.0 69.0 69.0 68.0 82.0 67.0 69.0 83.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 20:34:59 INFO - PROCESS | 1648 | Values: 88.0 88.0 87.0 87.0 87.0 86.0 85.0 87.0 86.0 87.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:106.60 Median:94.50 stddev:21.66 (22.9%) stddev-sans-first:22.49 20:34:59 INFO - PROCESS | 1648 | Values: 94.0 111.0 148.0 145.0 94.0 95.0 95.0 94.0 95.0 95.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.99 (2.3%) stddev-sans-first:0.83 20:34:59 INFO - PROCESS | 1648 | Values: 80.0 87.0 85.0 85.0 85.0 85.0 86.0 87.0 86.0 86.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.50 stddev:1.78 (2.8%) stddev-sans-first:1.80 20:34:59 INFO - PROCESS | 1648 | Values: 64.0 61.0 60.0 60.0 62.0 65.0 64.0 64.0 63.0 62.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:3.57 (5.9%) stddev-sans-first:3.18 20:34:59 INFO - PROCESS | 1648 | Values: 54.0 56.0 66.0 64.0 60.0 60.0 61.0 58.0 58.0 58.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.50 stddev:3.60 (4.3%) stddev-sans-first:3.81 20:34:59 INFO - PROCESS | 1648 | Values: 83.0 85.0 86.0 76.0 83.0 85.0 81.0 84.0 83.0 90.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:140.50 stddev:15.19 (10.8%) stddev-sans-first:15.93 20:34:59 INFO - PROCESS | 1648 | Values: 140.0 140.0 141.0 144.0 140.0 135.0 136.0 140.0 180.0 169.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:169.00 stddev:18.77 (11.1%) stddev-sans-first:19.44 20:34:59 INFO - PROCESS | 1648 | Values: 165.0 165.0 165.0 167.0 171.0 195.0 222.0 183.0 166.0 167.0 20:34:59 INFO - PROCESS | 1648 | 20:34:59 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:79.00 stddev:8.57 (10.8%) stddev-sans-first:8.46 20:34:59 INFO - PROCESS | 1648 | Values: 65.0 74.0 81.0 82.0 61.0 60.0 79.0 80.0 79.0 78.0 20:34:59 INFO - PROCESS | 1648 | -------- Summary: end -------- 20:34:59 INFO - PROCESS | 1648 | 20:35:00 INFO - TEST-INFO | 1648: exit 0 20:35:00 INFO - TEST-OK | kraken | took 59680ms 20:35:00 INFO - SUITE-END | took 1180s 20:35:00 INFO - Completed test suite (00:19:40) 20:35:00 INFO - javascript benchmark 20:35:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7620.691752377968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.4550726376515, 3421.9315613687727, 3432.5709286339215, 3449.9482507762405, 3467.4625433057868, 6027.879442411149, 6036.094585812125, 6056.364081771417, 6059.697015149247, 6087.178230938822, 6041.637501749898, 6076.574639775217, 6095.238095238095, 6099.9085013724825, 6116.357782432848, 5400.513953744162, 5427.538659213971, 5444.428335024825, 5446.700431476267, 5573.359063707685, 5381.730913454331, 5387.919181212285, 5412.621116521845, 5545.861353466175, 5567.0, 5481.862953426156, 5498.5876059295515, 5520.447955204468, 5546.500814926656, 5566.55467562594, 5534.225208470817, 5539.390667026624, 5541.113421852484, 5553.250311207976, 5555.555555555546, 4957.107720610289, 5360.490753378423, 5447.45525447456, 5447.5641948644015, 5486.753096110685, 5876.001079816441, 5891.440313170285, 5899.911501327483, 5910.261217347832, 5924.792632257893, 6243.594166379171, 6246.843828904268, 6253.656048917308, 6288.52836037299, 6328.6835658216905, 5236.266922630834, 6462.579932304385, 6508.6094834309615, 6512.088307636887, 6520.021996700533, 6144.723487443076, 6224.937750622481, 6227.906581401283, 6228.750849966042, 6252.187215661935, 6335.524835637346, 6371.23545174582, 6429.549931504844, 6542.672866356758, 6677.031830384567, 6291.056341548804, 6294.464970477561, 6296.275928268308, 6299.244090709144, 6303.495720342362, 6257.217847769029, 6328.367163283727, 6354.173957385603, 6375.872482550323, 6411.96794016027, 6370.203724534434, 6374.521910856704, 6396.5202609804455, 6401.3278605746655, 6406.23125224976, 6155.569110162246, 6182.412670796267, 6194.0, 6311.274203466568, 6338.746450141943, 5238.869028274247, 5255.76349064293, 5268.367795864521, 5286.629935904527, 5290.285811415487, 4549.840755573605, 4603.815847366068, 4605.746683932416, 4618.67669263155, 4656.557627025427, 6097.085437184458, 6113.871604717271, 6116.457510225689, 6129.695011270001, 6130.856783744234, 6489.870202595922, 6490.188726409199, 6507.577007494498, 6514.869702605922, 6525.2169739631545, 5915.0, 5962.105684147413, 6113.38866113394, 6133.172021777003, 6135.049067394561, 5645.322561292671, 5739.885202295931, 5773.826785196451, 5818.94181058184, 5832.562557808182, 6678.298778628174, 6697.799066028027, 6698.263191049078, 6705.362990515893, 6707.329267073449, 6342.556021078481, 6449.774257900951, 6471.611703297817, 6476.0, 6525.64108974011, 6357.586756860789, 6422.068800023877, 6598.04328372393, 6688.632125233159, 6701.664916754045, 6323.20959880015, 6388.329225431448, 6395.20059992501, 6403.551751377358, 6426.29310775805, 6408.679566021773, 6460.257070436772, 6467.482601391972, 6480.675966201766, 6482.416582507597, 6189.35011823752, 6253.249610046823, 6328.620282782864, 6343.0, 6354.90467642995, 6244.438000579969, 6256.061590761422, 6313.936860631335, 6330.841728956813, 6334.651594162366, 6056.152138700673, 6097.75608975636, 6098.481629061579, 6280.780172693934, 6290.685465726787, 6224.035274532454, 6225.782097626561, 6271.247450305992, 6272.40412160844, 6287.528435367274, 6275.905861411991, 6298.496120310272, 6306.211723534559, 6308.432241098323, 6311.905321420274], "value": 5939.682685023321, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.7972527142942, 816.5304949653951, 854.2781349759452, 870.0733718589702, 873.2533683700436, 36159.276814463694, 36682.44976325357, 38072.80963595185, 38095.23809523811, 38144.0, 36775.0, 36871.815640921755, 36896.26207475855, 36897.0, 36970.815145924236, 7276.890846637305, 7455.0681164854395, 7649.235076492348, 7786.532808031508, 7800.648970796299, 7378.963105184466, 7451.1058672959325, 7461.291177338144, 10714.517846696917, 10954.287971281881, 10893.83659245112, 10922.126229901629, 10934.07060399863, 10948.343099414022, 10975.396353200571, 10874.347539147637, 10884.510197041152, 10935.726606834813, 10937.83593246102, 10968.890311096866, 7300.34296913275, 7456.217097204824, 10451.268411211218, 10745.51645175969, 10763.3541987481, 37607.811960940024, 37914.241715165816, 37996.05009874775, 38001.80999094987, 38006.0, 3786.715996300261, 3789.7157713171623, 3790.6452789281407, 3799.7007797560627, 3886.844526218948, 26797.598036029474, 26899.596506052425, 26967.190984270503, 27580.172594821986, 28480.0, 3030.8939187128344, 3069.9693003069906, 3096.807599625611, 3100.9689903100907, 3157.3053928135773, 358128.4187158121, 361627.0, 361669.0, 362660.0, 362753.0, 42401.0, 42964.14071718611, 45095.54904450979, 51250.48749512457, 51274.0, 52436.47563524392, 53143.20285195725, 53147.0, 53218.201726974126, 53261.66845828808, 14543.490977815725, 14599.85400145985, 14614.488492902698, 14617.122972621677, 14631.487897923735, 12649.494020239272, 12709.682257943441, 12710.745785084246, 12735.108542401942, 12745.235285882876, 12071.215371000857, 12081.275123492618, 12099.850514201136, 12155.878441215651, 12196.024318054535, 5616.775328986876, 5666.376698563155, 5684.658920464785, 5689.146628005749, 5695.572832037614, 959.2661613865398, 959.9904000960041, 1070.4915165296422, 1111.9332840029624, 1144.4206994347746, 26128.738712613012, 26384.736152638612, 26482.0, 26639.600405993926, 26814.5977810333, 1061.8141825180562, 1108.8613923259593, 1237.5482948723652, 1256.5162412471263, 1304.562971404571, 12622.431990560446, 13101.31838730046, 13118.475260989644, 13285.0, 13405.798913016313, 473657.0, 479387.0, 480010.0, 480932.0, 481083.18916811084, 45083.323750143776, 45100.87247818831, 45264.0, 45329.77335113369, 45486.31770523445, 1382.7649299619088, 1420.978685319721, 1421.5877395555174, 1421.6943357178257, 1421.8720315171684, 22707.0, 23796.405089872893, 24236.030558777453, 24528.0, 24769.50460990806, 39401.60598394094, 39544.60455395524, 39589.812305630876, 39627.60372396239, 39630.80184599059, 377796.0, 440830.0, 443052.0, 443171.0, 444337.0, 23478.413039674146, 24052.39869003289, 26878.32804179911, 28155.296117596405, 28303.15090547287, 35911.1022224436, 37330.81334593309, 37639.247215054995, 37711.24577508379, 37769.0, 25768.71156442133, 26820.463590728465, 27163.72836271691, 27399.726002739717, 27981.720182798726, 27082.0, 27692.307692307855, 27793.44413111767, 27973.440531188855, 28152.718472815828, 31122.844385777928, 31153.221169470944, 31258.062258132293, 31713.524297136024, 31854.68145318517, 25271.620925685762, 27330.590041149797, 27387.86306068457, 27763.167104986882, 28173.859130704215, 21513.13947442085, 22140.667889981985, 22328.441788955406, 22344.77655223492, 22491.550168996855], "value": 17734.79311715476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.38531042986426, 414.4549916859328, 424.24272673278193, 431.1549363248034, 449.9122671079141, 14560.56318310451, 20736.47479928412, 21617.243396481128, 21777.67333489997, 21826.253899688025, 19004.0, 22772.8861355693, 23049.04083152934, 23511.29466116015, 23536.293911182693, 6083.087536869483, 6531.804045878619, 6562.639054851981, 6798.932010679904, 6831.829204269909, 6682.498812589051, 6696.296888826676, 6739.393454589086, 6742.797716068501, 6748.0, 6469.74121035158, 6649.069130321759, 6717.462602991749, 6727.529072964894, 6729.7308107675635, 6329.715162817684, 6392.169018027673, 6618.8676226475445, 6685.331466853324, 6687.799366019003, 6496.707648155844, 6497.350264973512, 6503.15458990333, 6504.642244676588, 6513.967430162867, 27411.86294068537, 27785.027524036563, 27789.444211115664, 27837.721622783716, 28131.718682813116, 2956.689547597493, 2982.346625383909, 2999.2052106191877, 3000.0, 3006.609140811702, 14007.805433821226, 14915.477958271409, 16089.873708840385, 16407.0, 16845.747313790303, 1990.4824745566111, 2040.6938959156098, 2050.8769473831467, 2055.3525639423683, 2086.3115171993204, 152089.0, 155208.0, 161019.58470622834, 162813.0, 164654.35345646628, 15020.774688379683, 20224.292149774687, 20323.390298291073, 20372.28696995598, 20422.69365959512, 29754.553681694793, 30454.695453045628, 30459.0, 31396.901108461094, 31899.681003190137, 8703.347248956354, 9064.50145242018, 10494.580216791395, 10537.736556586147, 10573.04842564173, 8073.798155046054, 8148.633311500997, 8702.738917832476, 8900.06549312313, 9011.188992990663, 7742.7677169685, 9356.578953947088, 9417.670381536751, 9583.856242156373, 9606.567704453317, 4104.794760261975, 4129.236091323115, 4135.255653982252, 4143.212789569972, 4163.481857830128, 882.8763973043779, 892.1702816380828, 899.5771987166153, 927.420362273579, 939.248601119102, 21995.780042199694, 22813.31560053201, 22846.42883927882, 22858.08567657275, 22900.31299061031, 907.2500595568946, 920.415536134546, 930.0141849639404, 936.9063093690577, 942.7878727286443, 10707.411092389837, 10923.453827308604, 11740.765184696429, 11744.76510469803, 11782.234154779911, 770646.0, 774453.0, 778467.0, 780587.0, 798408.1353084936, 153404.0, 156721.0, 158253.0, 158679.619805703, 164015.17992409962, 1162.8778978207336, 1211.3640338822188, 1253.5487224599137, 1254.7804134276464, 1261.0479088288466, 19634.60730785405, 19785.505362366057, 20341.49146271355, 20355.88042657609, 20367.388978330673, 48274.275885862444, 59124.0, 62199.067013993925, 63163.6841815788, 63434.0, 78656.0, 84219.5789021051, 85899.71150432873, 86240.0, 88369.79075523163, 7412.221716719667, 9973.950130249592, 11002.944985275022, 11318.981291683787, 11739.647810565697, 12876.35618219104, 12909.677258068623, 12921.0, 13227.007974402151, 13290.867091328962, 11014.724631884266, 11468.483918223534, 11533.0, 11552.6534203974, 11561.132915031574, 10368.792624147625, 10474.266801324138, 10485.737856553342, 10706.8929310709, 10831.025207731342, 11505.194636375374, 11536.653900383002, 11621.256811478346, 11775.0, 11801.29192248468, 11492.195546312012, 11508.424578771195, 11765.76468470643, 11820.290782553075, 11916.52333906634, 10673.41296228715, 11144.164187685794, 11156.721081973015, 11286.66140015801, 11322.60370887015], "value": 11506.223951889202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.65414473454, 1532.6015236038627, 1535.194023137852, 1559.9298031588578, 1584.5642448326705, 10509.21180911431, 11153.163512736557, 11192.944035279832, 11193.16051296153, 11194.776104477916, 10697.037266646, 11136.0, 11321.773564528705, 11322.20744547882, 11330.320180789158, 2388.22382725614, 2433.9513209735796, 2435.57377458944, 2437.744036876129, 2441.6093425051995, 2310.1336998625516, 2401.327628264089, 2404.1585445094165, 2405.122130422401, 2406.2179791567723, 2326.3137374474486, 2372.810175185981, 2384.654225137354, 2424.9757502424927, 2431.173401043645, 2291.4156889992946, 2373.76262373763, 2378.084437491561, 2385.940351491209, 2386.260259319608, 2340.2628172125724, 2367.9644805327935, 2372.110458578033, 2373.2049763329132, 2378.3935096550267, 10877.456127193609, 11130.888691113067, 11136.443177841156, 11141.610043648434, 11161.665150045512, 5565.1374037024325, 5696.401877802812, 5729.713514324267, 5744.942550574524, 5752.913706294409, 3054.7861649684532, 3458.5330980317585, 3606.6213047629885, 3635.1093981974323, 3664.4320130379833, 1169.5672601137549, 1183.4201241391743, 1205.0841360566033, 1216.7019080325376, 1218.8415505984253, 13375.866241337559, 13670.316484175852, 14674.853251467563, 15318.234088295541, 15565.37738490459, 4536.977315113403, 4631.560001799824, 4654.25531914892, 4654.883627909262, 4672.836450724209, 11606.419679016015, 11609.36148511823, 11627.011704005085, 11645.243059201124, 11646.825297620542, 4817.975910120427, 4977.477364876636, 5440.809571664972, 5572.665640061609, 5737.282839645044, 5074.238864170404, 5218.712970786643, 5297.8145764898045, 5298.0, 5303.575713942875, 3755.3991361382596, 3806.9619303807162, 3862.3820188769664, 3865.6714179294513, 3871.4773505576386, 974.0892265731563, 1000.9049140331657, 1006.2302338710892, 1008.4403156248353, 1010.8534262532039, 956.4882787708682, 960.5869476125193, 961.8701475300885, 970.3547141151056, 993.4233984390481, 6591.43972762311, 6643.534952553371, 6736.797896063126, 6855.485838562127, 6872.62200578973, 959.3716115944068, 968.1335204991634, 990.7275499237624, 999.3304485994402, 1027.8817935937464, 3486.372452958492, 4039.3940908863906, 4166.8749937501925, 4256.530927294245, 4277.636400905895, 12314.261144331369, 12769.0423218259, 13562.254076025913, 14157.85842141586, 14223.715525689428, 13037.15258508194, 13041.869581304256, 13041.934790325988, 13052.477900884049, 13061.0, 9966.20270378368, 10224.079832814934, 10259.127974122282, 10259.794804104025, 10295.279330446947, 5773.0, 6181.320054794059, 6478.4169424752, 6883.793486195422, 6884.036234927014, 11995.220310679779, 12463.376831158586, 12477.376131193223, 12478.625641230778, 12486.500539978299, 11749.118816088656, 12097.274163550215, 12258.754824903273, 12295.139340246096, 12613.243205407705, 8571.914280857112, 8815.735527934172, 8921.286297096087, 8948.239399650842, 8951.820963580822, 9677.001940974525, 9844.114029737359, 9860.704178874645, 9996.300258982092, 10050.64822731201, 8420.326373889951, 8443.282321002784, 8529.402941794015, 8554.615042322986, 8623.137686231326, 8226.64722682694, 8321.292690121407, 8367.037790654153, 8421.19998600132, 8556.74329770108, 7636.389088872988, 7641.312281894434, 7799.103103143211, 7818.140004599376, 7826.843463130819, 5864.32560255576, 5920.496757775465, 5958.731857066356, 5964.493018093511, 6020.096985452042, 5669.574781891457, 5773.913391299218, 5785.132230165509, 5937.643741375531, 6160.784372546939], "value": 5072.8081638558315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.3288612042805, 384.573123832546, 385.9266739319529, 393.6830851164813, 393.8956176613198, 4525.66492884599, 4640.628749700024, 5158.646879528308, 5193.2989046478715, 5305.373839949221, 4078.5105787305492, 4178.474856677313, 4399.186150562148, 5131.794728210867, 5141.537261646451, 4143.813528391214, 4286.39990401344, 4291.699581029329, 4294.892627684301, 4365.5416181300825, 3838.3858582626785, 3904.5509766376945, 4093.897652558695, 4145.689073319498, 4301.978490107561, 3714.962850371502, 4308.289132293168, 4330.220560299145, 4353.760543170124, 4367.694261401703, 3291.835408229579, 3471.3057388522143, 3623.945640815377, 4225.661727235481, 4310.9999999999845, 3530.3468858261303, 3755.2114056048263, 3832.3868181090893, 3943.4676318697184, 3966.464527288808, 4448.197635489621, 4808.134535783557, 4985.750712464399, 5034.471380505068, 5060.645754797166, 4200.642945349649, 4682.548409992879, 4826.638002149853, 4965.652404331699, 4975.303457515951, 5323.946760532383, 5383.353997520323, 5531.363893152258, 5556.361018482886, 5571.746357069627, 3823.445600387928, 4242.575742425764, 4452.621527170194, 4458.3535387368975, 4492.607291739571, 4763.761811909425, 4952.860842006358, 5010.323606313137, 5070.239464080418, 5906.291245050578, 4015.9196816063513, 4049.0, 4193.783802697184, 4367.31858234582, 4491.483479399845, 4321.719088259253, 4606.239970404913, 4616.584507394351, 4626.83806066786, 4649.767511624473, 4393.0, 4441.244988351988, 4471.597556219956, 4553.747719377132, 4796.928046079312, 4769.664493941702, 5245.977034478316, 5357.678539287655, 5474.370447398521, 5536.453231513549, 1459.2489013184008, 1482.6664000599994, 1540.5917431880562, 1551.5422950229708, 1576.3852097681913, 1099.6591056772427, 1116.2911551165068, 1163.0751106918065, 1182.0484509969558, 1184.5972369394447, 4452.0873220989615, 4543.636509079266, 4978.377702787152, 5030.138848626032, 5041.243813427942, 4582.564656357641, 4977.850664479999, 4998.4251811042195, 5687.971560142256, 5701.429857014348, 4259.318509038539, 4350.703965998581, 4766.737829419346, 4864.537868902448, 5085.64400491962, 2649.0, 2748.8900443982416, 2934.618499595039, 2942.8969986050815, 2949.8495586721197, 5564.916526252109, 5611.494965453129, 5851.297844258716, 5873.3245676746865, 5947.732352044169, 5233.685978841282, 5305.336832895888, 5490.956718223525, 5760.8190320984095, 5874.882502350015, 5409.83770486886, 5720.8558288341665, 5731.742071606787, 5747.907897499462, 5764.971175144097, 4567.06375193078, 5475.534579560782, 5740.885182296247, 5769.59612827098, 5792.0, 5034.723090230073, 5622.522085622768, 5632.633878797865, 5639.631354830899, 5721.25623668937, 5679.659220446786, 5908.168467775004, 5963.493103086286, 5975.731092100953, 6024.0, 3863.497745293094, 4556.65825063115, 4560.293154561048, 4599.724016559017, 4620.537946205487, 4760.59534939534, 4954.727489988085, 5636.6451870723795, 5700.971495142498, 5734.741936612946, 4833.564979151894, 5385.980257403474, 5538.9169162461785, 5541.418151094238, 5636.534501029843, 4732.834350797705, 4985.800567977385, 5023.659266587824, 5280.894382112413, 5330.946690533045, 5325.440828712929, 5328.920066199088, 5359.946400535945, 5399.43305952885, 5409.729513524229, 4758.500357462555, 5045.578122501147, 5319.723266416109, 5491.835244942658, 5528.44715528444, 5182.714950677749, 5310.176922577007, 5408.972955135199, 5415.6479828811, 5453.918191227055], "value": 4174.121957581176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.8781307177783, 723.7394537966328, 747.7794050755027, 818.7502811642448, 830.6594296338501, 14691.191984440851, 15779.921100394511, 15797.526074217763, 15799.84200157998, 15838.445654402098, 14471.493497727583, 14768.6307842304, 14889.776653350182, 15056.473023444181, 15078.547643570682, 871.3377832847034, 949.0651708067548, 953.0993211415215, 955.1022039283087, 957.1481381570408, 942.9057094290584, 944.1219665710886, 944.6457578408097, 945.6406565505098, 947.729896979361, 955.0544960489101, 981.1464026297132, 997.8104160209537, 998.7602975285915, 1000.0099901097933, 984.2765567308023, 986.2011770465909, 987.2595553334999, 988.1551273660988, 989.3322007644883, 729.2707292707292, 731.747547096251, 733.101950111115, 733.9834329453691, 735.1068451831051, 15433.5369938902, 15687.607809804733, 15735.685286294325, 15784.842151578452, 15919.840801592067, 14073.36669849849, 14339.54385476527, 14356.712865742731, 14476.855231447656, 14507.492237771732, 11353.602623908124, 11698.2981021139, 11768.117391195694, 11795.292282462993, 11937.403129843473, 3625.0756057205244, 3642.1076836175307, 3746.2320224353944, 3834.9808250958845, 3879.8642047528483, 103361.4831925843, 109689.45155274252, 111144.0, 111986.0, 113454.43272783665, 9731.659391921248, 10502.842457363146, 10522.684319470429, 10768.461576921123, 11508.309501429942, 20654.690179647318, 21509.46226344354, 21765.782342176375, 22078.0, 22090.558188836454, 7797.532148071134, 7812.0, 7893.092294386219, 7900.012498437695, 8167.469114507538, 4271.700980931367, 4277.486701595828, 4341.826326946887, 4360.934585981213, 4379.868603941887, 3538.876139335111, 3634.3639863023864, 3637.4907512948207, 3641.253543023674, 3641.6904563111902, 512.7428814196635, 639.6993413095837, 640.4204195203348, 640.9519286053564, 640.9551331406757, 686.1765880942888, 686.9313068693091, 705.3052743048196, 713.1121753417029, 746.6714645555938, 9861.408315501092, 10204.285700001077, 10327.793444131075, 10443.68668939933, 10649.254552181428, 642.8705654293904, 673.3636713305976, 685.4721864164566, 691.7820886420761, 697.2156324135348, 4787.305840653155, 4815.3017812417, 5317.468253174651, 5440.646357986719, 5715.2855893013375, 94017.0, 97022.05955880843, 97035.02964970401, 97861.02138978662, 98507.0, 83213.58393208116, 84924.72612910811, 86292.7056094159, 87840.1215987832, 88817.0, 76835.61582192164, 78043.06488528838, 78557.4288514238, 78765.0, 79696.80454793182, 11014.203339906706, 11036.558537658724, 11164.995150436174, 11237.662870113909, 11273.605423810128, 41696.58303416927, 41902.37146442867, 42254.78872605618, 43050.78474607607, 43392.0, 55616.88766224734, 57581.71209143927, 58330.12504812516, 58628.4137158623, 59064.70467647634, 12432.609537425878, 12823.93588032054, 12854.807177892151, 13053.934730326668, 13492.662683432993, 14640.34118464693, 14870.330835112229, 14951.700965980837, 14954.0, 15008.399664013317, 13458.0, 13497.932510337385, 13995.94117705854, 14163.787543187067, 14466.566003019927, 11857.0, 13360.93319533396, 13774.586762397144, 14135.293235337986, 14753.0, 13334.133281336683, 13414.664633384244, 13617.86382136166, 13921.234332111426, 14244.002919795515, 10057.748556286151, 10339.483025848827, 10548.0, 10598.682039538826, 10636.680899573024, 11229.4385280734, 11255.02723553124, 11425.31448113116, 11561.248518846249, 11916.821247681464], "value": 7631.161267055332, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 112.0, 113.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 108.0, 145.0, 111.0, 107.0, 110.0, 108.0, 124.0, 111.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 183.0, 183.0, 183.0, 183.0, 182.0, 181.0, 184.0, 182.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 61.0, 81.0, 76.0, 71.0, 90.0, 80.0, 76.0, 62.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 87.0, 69.0, 69.0, 68.0, 82.0, 67.0, 69.0, 83.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 87.0, 86.0, 85.0, 87.0, 86.0, 87.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 111.0, 148.0, 145.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 106.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 85.0, 85.0, 85.0, 85.0, 86.0, 87.0, 86.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 60.0, 60.0, 62.0, 65.0, 64.0, 64.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 66.0, 64.0, 60.0, 60.0, 61.0, 58.0, 58.0, 58.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 76.0, 83.0, 85.0, 81.0, 84.0, 83.0, 90.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 141.0, 144.0, 140.0, 135.0, 136.0, 140.0, 180.0, 169.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 167.0, 171.0, 195.0, 222.0, 183.0, 166.0, 167.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 81.0, 82.0, 61.0, 60.0, 79.0, 80.0, 79.0, 78.0], "value": 73.9, "unit": "score"}]}]} 20:35:01 INFO - Return code: 0 20:35:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:35:01 ERROR - # TBPL SUCCESS # 20:35:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:35:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:35:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:35:01 INFO - 2017-03-30 20:35:01.100 screenresolution[1652:9928] starting screenresolution argv=screenresolution get 20:35:01 INFO - 2017-03-30 20:35:01.103 screenresolution[1652:9928] Display 0: 1600x1200x32@60 20:35:01 INFO - 2017-03-30 20:35:01.109 screenresolution[1653:9931] starting screenresolution argv=screenresolution list 20:35:01 INFO - Available Modes on Display 0 20:35:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:35:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:35:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:35:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:35:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:35:01 INFO - Intel Iris: 20:35:01 INFO - Chipset Model: Intel Iris 20:35:01 INFO - Type: GPU 20:35:01 INFO - Bus: Built-In 20:35:01 INFO - VRAM (Dynamic, Max): 1536 MB 20:35:01 INFO - Vendor: Intel (0x8086) 20:35:01 INFO - Device ID: 0x0a2e 20:35:01 INFO - Revision ID: 0x0009 20:35:01 INFO - Displays: 20:35:01 INFO - Display: 20:35:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:35:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:35:01 INFO - Display Serial Number: 1600x1200 60 20:35:01 INFO - Main Display: Yes 20:35:01 INFO - Mirror: Off 20:35:01 INFO - Online: Yes 20:35:01 INFO - Rotation: Supported 20:35:01 INFO - Return code: 0 20:35:01 INFO - Running post-action listener: _resource_record_post_action 20:35:01 INFO - [mozharness: 2017-03-31 03:35:01.352294Z] Finished run-tests step (success) 20:35:01 INFO - Running post-run listener: _resource_record_post_run 20:35:01 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 36815872; Write bytes: 510010880; Read time: 372; Write time: 2042 20:35:01 INFO - TinderboxPrint: CPU usage
53.9% 20:35:01 INFO - TinderboxPrint: I/O read bytes / time
36,815,872 / 372 20:35:01 INFO - TinderboxPrint: I/O write bytes / time
510,010,880 / 2,042 20:35:01 INFO - TinderboxPrint: CPU idle
2,218.2 (46.1%) 20:35:01 INFO - TinderboxPrint: CPU system
961.0 (20.0%) 20:35:01 INFO - TinderboxPrint: CPU user
1,630.5 (33.9%) 20:35:01 INFO - TinderboxPrint: Swap in / out
243,523,584 / 0 20:35:01 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205931008; Write bytes: 203069440; Read time: 15463; Write time: 461 20:35:01 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30546944; Write bytes: 297029120; Read time: 293; Write time: 1546 20:35:01 INFO - Running post-run listener: _upload_blobber_files 20:35:01 INFO - Blob upload gear active. 20:35:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:35:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:35:02 INFO - (blobuploader) - INFO - Open directory for files ... 20:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:03 INFO - (blobuploader) - INFO - Done attempting. 20:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:04 INFO - (blobuploader) - INFO - Done attempting. 20:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:05 INFO - (blobuploader) - INFO - Done attempting. 20:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:35:07 INFO - (blobuploader) - INFO - Done attempting. 20:35:07 INFO - (blobuploader) - INFO - Iteration through files over. 20:35:07 INFO - Return code: 0 20:35:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:35:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:35:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20f4583ca81c9db83204502335960deb3abcb265ecd193805eade65dcf1ea18c433a78a5150cdfb7d0abec2e3780972cb93936eaa96bf1ab46955ce775639c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31cb1ddefeabf68cce8bd152acaec7ee1ced8140fc2dbfea45bd07c1059914d7961a1264f512330c73c074b7ad50d9ef796bb0b348cf573541addc7219ca27e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5183b7e8714ad979a8411e9cfe40bf50ce88bc8497012886bfb2dcfb642ac569544a5fb244f7f1bb704789e0db7b2dcf279e70bf37d2abd65a24a6d24d79d6da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98b8932527130708b37beaaca4def8711dca21366c2a9d2b75c489b612510c9edc513df8d8c220d59f10bf2555742fca25de201a0d506866aa686a56648c1f8f"} 20:35:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:35:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:35:07 INFO - Contents: 20:35:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20f4583ca81c9db83204502335960deb3abcb265ecd193805eade65dcf1ea18c433a78a5150cdfb7d0abec2e3780972cb93936eaa96bf1ab46955ce775639c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31cb1ddefeabf68cce8bd152acaec7ee1ced8140fc2dbfea45bd07c1059914d7961a1264f512330c73c074b7ad50d9ef796bb0b348cf573541addc7219ca27e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5183b7e8714ad979a8411e9cfe40bf50ce88bc8497012886bfb2dcfb642ac569544a5fb244f7f1bb704789e0db7b2dcf279e70bf37d2abd65a24a6d24d79d6da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98b8932527130708b37beaaca4def8711dca21366c2a9d2b75c489b612510c9edc513df8d8c220d59f10bf2555742fca25de201a0d506866aa686a56648c1f8f"} 20:35:07 INFO - Running post-run listener: copy_logs_to_upload_dir 20:35:07 INFO - Copying logs to upload dir... 20:35:07 INFO - mkdir: /builds/slave/test/build/upload/logs 20:35:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.239529 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-30 20:35:07.287107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 20:35:07.290537) ========= 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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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/20f4583ca81c9db83204502335960deb3abcb265ecd193805eade65dcf1ea18c433a78a5150cdfb7d0abec2e3780972cb93936eaa96bf1ab46955ce775639c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31cb1ddefeabf68cce8bd152acaec7ee1ced8140fc2dbfea45bd07c1059914d7961a1264f512330c73c074b7ad50d9ef796bb0b348cf573541addc7219ca27e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5183b7e8714ad979a8411e9cfe40bf50ce88bc8497012886bfb2dcfb642ac569544a5fb244f7f1bb704789e0db7b2dcf279e70bf37d2abd65a24a6d24d79d6da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98b8932527130708b37beaaca4def8711dca21366c2a9d2b75c489b612510c9edc513df8d8c220d59f10bf2555742fca25de201a0d506866aa686a56648c1f8f"} build_url:https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/Y5bytFK8RF6wKksiE3s5XQ/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/20f4583ca81c9db83204502335960deb3abcb265ecd193805eade65dcf1ea18c433a78a5150cdfb7d0abec2e3780972cb93936eaa96bf1ab46955ce775639c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31cb1ddefeabf68cce8bd152acaec7ee1ced8140fc2dbfea45bd07c1059914d7961a1264f512330c73c074b7ad50d9ef796bb0b348cf573541addc7219ca27e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5183b7e8714ad979a8411e9cfe40bf50ce88bc8497012886bfb2dcfb642ac569544a5fb244f7f1bb704789e0db7b2dcf279e70bf37d2abd65a24a6d24d79d6da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/98b8932527130708b37beaaca4def8711dca21366c2a9d2b75c489b612510c9edc513df8d8c220d59f10bf2555742fca25de201a0d506866aa686a56648c1f8f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 20:35:07.324456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:35:07.324793) ========= 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.8XKrx2fpLQ/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.v6S8B2LyQZ/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005181 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:35:07.375350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 20:35:07.375676) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 20:35:07.376007) ========= ========= Total master_lag: 0.44 =========