builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0269 starttime: 1476999149.24 results: success (0) buildid: 20161020121550 builduid: df46d3e069294611bedfab2b84ec744f revision: 22963ffebf2833b64e9cd692e02b268ffb32c6c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.242117) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.242544) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.242816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.265398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.265744) ========= 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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 --2016-10-20 14:32:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.23M=0.001s 2016-10-20 14:32:29 (8.23 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.372924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.373243) ========= 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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.021391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:29.421322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 14:32:29.421677) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 22963ffebf2833b64e9cd692e02b268ffb32c6c9 --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 22963ffebf2833b64e9cd692e02b268ffb32c6c9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 2016-10-20 14:32:29,501 truncating revision to first 12 chars 2016-10-20 14:32:29,501 Setting DEBUG logging. 2016-10-20 14:32:29,501 attempt 1/10 2016-10-20 14:32:29,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/22963ffebf28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 14:32:30,563 unpacking tar archive at: mozilla-aurora-22963ffebf28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 14:32:30.792338) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:30.792670) ========= script_repo_revision: 22963ffebf2833b64e9cd692e02b268ffb32c6c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:30.793080) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:30.793348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 14:32:30.811165) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-20 14:32:30.811449) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:32:31 INFO - MultiFileLogger online at 20161020 14:32:31 in /builds/slave/test 14:32:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:32:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:31 INFO - {'append_to_log': False, 14:32:31 INFO - 'base_work_dir': '/builds/slave/test', 14:32:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:32:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:31 INFO - 'branch': 'Mozilla-Aurora', 14:32:31 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:31 INFO - 'config_files': ('talos/mac_config.py',), 14:32:31 INFO - 'default_actions': ('clobber', 14:32:31 INFO - 'read-buildbot-config', 14:32:31 INFO - 'download-and-extract', 14:32:31 INFO - 'populate-webroot', 14:32:31 INFO - 'create-virtualenv', 14:32:31 INFO - 'install', 14:32:31 INFO - 'run-tests'), 14:32:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:31 INFO - 'download_minidump_stackwalk': True, 14:32:31 INFO - 'download_symbols': 'ondemand', 14:32:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:31 INFO - 'installer_path': 'installer.exe', 14:32:31 INFO - 'log_level': 'info', 14:32:31 INFO - 'log_name': 'talos', 14:32:31 INFO - 'log_to_console': True, 14:32:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:31 INFO - 'opt_config_files': (), 14:32:31 INFO - 'pip_index': False, 14:32:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:31 INFO - 'cmd': ('bash', 14:32:31 INFO - '-c', 14:32:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:31 INFO - 'enabled': True, 14:32:31 INFO - 'halt_on_failure': False, 14:32:31 INFO - 'name': 'check_screen_resolution'},), 14:32:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:31 INFO - 'cmd': ('bash', 14:32:31 INFO - '-c', 14:32:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:31 INFO - 'enabled': True, 14:32:31 INFO - 'halt_on_failure': False, 14:32:31 INFO - 'name': 'check_screen_resolution'},), 14:32:31 INFO - 'run_cmd_checks_enabled': True, 14:32:31 INFO - 'sps_profile': False, 14:32:31 INFO - 'sps_profile_interval': 0, 14:32:31 INFO - 'suite': 'dromaeojs-e10s', 14:32:31 INFO - 'system_bits': '32', 14:32:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:31 INFO - 'title': 't-yosemite-r7-0269', 14:32:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:31 INFO - 'use_talos_json': True, 14:32:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:31 INFO - 'work_dir': 'build'} 14:32:31 INFO - [mozharness: 2016-10-20 21:32:31.014522Z] Running clobber step. 14:32:31 INFO - Running pre-action listener: _resource_record_pre_action 14:32:31 INFO - Running main action method: clobber 14:32:31 INFO - rmtree: /builds/slave/test/build 14:32:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:31 INFO - Running post-action listener: _resource_record_post_action 14:32:31 INFO - [mozharness: 2016-10-20 21:32:31.258473Z] Finished clobber step (success) 14:32:31 INFO - [mozharness: 2016-10-20 21:32:31.258654Z] Running read-buildbot-config step. 14:32:31 INFO - Running pre-action listener: _resource_record_pre_action 14:32:31 INFO - Running main action method: read_buildbot_config 14:32:31 INFO - Using buildbot properties: 14:32:31 INFO - { 14:32:31 INFO - "project": "", 14:32:31 INFO - "product": "firefox", 14:32:31 INFO - "script_repo_revision": "production", 14:32:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:32:31 INFO - "repository": "", 14:32:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:32:31 INFO - "buildid": "20161020121550", 14:32:31 INFO - "pgo_build": "False", 14:32:31 INFO - "basedir": "/builds/slave/test", 14:32:31 INFO - "buildnumber": 3, 14:32:31 INFO - "slavename": "t-yosemite-r7-0269", 14:32:31 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:32:31 INFO - "platform": "yosemite_r7", 14:32:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:32:31 INFO - "branch": "mozilla-aurora", 14:32:31 INFO - "repo_path": "releases/mozilla-aurora", 14:32:31 INFO - "revision": "22963ffebf2833b64e9cd692e02b268ffb32c6c9", 14:32:31 INFO - "stage_platform": "macosx64", 14:32:31 INFO - "builduid": "df46d3e069294611bedfab2b84ec744f", 14:32:31 INFO - "slavebuilddir": "test" 14:32:31 INFO - } 14:32:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:32:31 INFO - Running post-action listener: _resource_record_post_action 14:32:31 INFO - [mozharness: 2016-10-20 21:32:31.262345Z] Finished read-buildbot-config step (success) 14:32:31 INFO - [mozharness: 2016-10-20 21:32:31.262482Z] Running download-and-extract step. 14:32:31 INFO - Running pre-action listener: _resource_record_pre_action 14:32:31 INFO - Running main action method: download_and_extract 14:32:31 INFO - mkdir: /builds/slave/test/build/tests 14:32:31 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')]} 14:32:31 INFO - trying https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:32:31 INFO - Downloading https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 14:32:32 INFO - Downloaded 1199 bytes. 14:32:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:32:32 INFO - Using the following test package requirements: 14:32:32 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:32:32 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:32:32 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:32:32 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'jsshell-mac.zip'], 14:32:32 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:32:32 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:32:32 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:32:32 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:32:32 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:32:32 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:32:32 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:32:32 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:32:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:32:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:32:32 INFO - Fetch https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:32:32 INFO - Expected file size: 16436494 14:32:39 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:32:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:32:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:32:39 INFO - Fetch https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:32:40 INFO - Expected file size: 16436494 14:32:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:32:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:32:46 INFO - Fetch https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:32:47 INFO - Expected file size: 14414081 14:32: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')]} 14:32:48 INFO - trying https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:32:48 INFO - Downloading https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:32:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 14:32:51 INFO - Downloaded 115426785 bytes. 14:32:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:32:51 INFO - mkdir: /builds/slave/test/properties 14:32:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:51 INFO - Contents: 14:32:51 INFO - build_url:https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:32:51 INFO - Running post-action listener: _resource_record_post_action 14:32:51 INFO - Running post-action listener: set_extra_try_arguments 14:32:51 INFO - [mozharness: 2016-10-20 21:32:51.887327Z] Finished download-and-extract step (success) 14:32:51 INFO - [mozharness: 2016-10-20 21:32:51.887455Z] Running populate-webroot step. 14:32:51 INFO - Running pre-action listener: _resource_record_pre_action 14:32:51 INFO - Running main action method: populate_webroot 14:32:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:51 INFO - '--tppagecycles', 14:32:51 INFO - '7'], 14:32:51 INFO - 'tests': ['tsvgm']}}, 14:32:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['damp', 'tps']}, 14:32:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'tests': ['damp', 'tps']}, 14:32:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['dromaeo_dom']}, 14:32:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['basic_compositor_video']}, 14:32:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['a11yr', 14:32:51 INFO - 'ts_paint', 14:32:51 INFO - 'tpaint', 14:32:51 INFO - 'sessionrestore', 14:32:51 INFO - 'sessionrestore_no_auto_restore', 14:32:51 INFO - 'tabpaint']}, 14:32:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:51 INFO - 'ts_paint', 14:32:51 INFO - 'tpaint', 14:32:51 INFO - 'sessionrestore', 14:32:51 INFO - 'sessionrestore_no_auto_restore', 14:32:51 INFO - 'tabpaint']}, 14:32:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:51 INFO - 'ts_paint', 14:32:51 INFO - 'tpaint', 14:32:51 INFO - 'sessionrestore', 14:32:51 INFO - 'sessionrestore_no_auto_restore', 14:32:51 INFO - 'tabpaint']}, 14:32:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:51 INFO - 'ts_paint', 14:32:51 INFO - 'tpaint', 14:32:51 INFO - 'sessionrestore', 14:32:51 INFO - 'sessionrestore_no_auto_restore', 14:32:51 INFO - 'tabpaint']}, 14:32:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['a11yr', 14:32:51 INFO - 'ts_paint', 14:32:51 INFO - 'tpaint', 14:32:51 INFO - 'sessionrestore', 14:32:51 INFO - 'sessionrestore_no_auto_restore', 14:32:51 INFO - 'tabpaint']}, 14:32:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['a11yr', 14:32:51 INFO - 'ts_paint', 14:32:51 INFO - 'tpaint', 14:32:51 INFO - 'sessionrestore', 14:32:51 INFO - 'sessionrestore_no_auto_restore', 14:32:51 INFO - 'tabpaint']}, 14:32:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['tsvgx', 14:32:51 INFO - 'tsvgr_opacity', 14:32:51 INFO - 'tart', 14:32:51 INFO - 'tscrollx', 14:32:51 INFO - 'cart']}, 14:32:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:51 INFO - 'tsvgr_opacity', 14:32:51 INFO - 'tart', 14:32:51 INFO - 'tscrollx', 14:32:51 INFO - 'cart']}, 14:32:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'talos_options': ['--disable-e10s'], 14:32:51 INFO - 'tests': ['tp5o']}, 14:32:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'tests': ['tp5o']}, 14:32:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'talos_options': ['--disable-e10s', 14:32:51 INFO - '--xperf_path', 14:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:51 INFO - 'tests': ['tp5n']}, 14:32:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:51 INFO - 'talos_options': ['--xperf_path', 14:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:51 INFO - 'tests': ['tp5n']}}, 14:32:51 INFO - 'talos.zip': {'path': '', 14:32:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:51 INFO - Running post-action listener: _resource_record_post_action 14:32:51 INFO - [mozharness: 2016-10-20 21:32:51.905985Z] Finished populate-webroot step (success) 14:32:51 INFO - [mozharness: 2016-10-20 21:32:51.906088Z] Running create-virtualenv step. 14:32:51 INFO - Running pre-action listener: _resource_record_pre_action 14:32:51 INFO - Running main action method: create_virtualenv 14:32:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:51 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 14:32:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:52 INFO - Using real prefix '/tools/python27' 14:32:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:52 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:55 INFO - Installing pip.................done. 14:32:55 INFO - Return code: 0 14:32:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:55 INFO - 'HOME': '/Users/cltbld', 14:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:55 INFO - 'LOGNAME': 'cltbld', 14:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:55 INFO - 'MOZ_NO_REMOTE': '1', 14:32:55 INFO - 'NO_EM_RESTART': '1', 14:32:55 INFO - 'PAGER': '/bin/cat', 14:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:55 INFO - 'PWD': '/builds/slave/test', 14:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:55 INFO - 'SHELL': '/bin/bash', 14:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:32:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:55 INFO - 'USER': 'cltbld', 14:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:55 INFO - 'XPC_FLAGS': '0x0', 14:32:55 INFO - 'XPC_SERVICE_NAME': '0', 14:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:55 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 14:32:55 INFO - Cleaning up... 14:32:55 INFO - Return code: 0 14:32:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:55 INFO - 'HOME': '/Users/cltbld', 14:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:55 INFO - 'LOGNAME': 'cltbld', 14:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:55 INFO - 'MOZ_NO_REMOTE': '1', 14:32:55 INFO - 'NO_EM_RESTART': '1', 14:32:55 INFO - 'PAGER': '/bin/cat', 14:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:55 INFO - 'PWD': '/builds/slave/test', 14:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:55 INFO - 'SHELL': '/bin/bash', 14:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:32:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:55 INFO - 'USER': 'cltbld', 14:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:55 INFO - 'XPC_FLAGS': '0x0', 14:32:55 INFO - 'XPC_SERVICE_NAME': '0', 14:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:56 INFO - Downloading/unpacking psutil>=3.1.1 14:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:59 INFO - Installing collected packages: psutil 14:32:59 INFO - Running setup.py install for psutil 14:32:59 INFO - building 'psutil._psutil_osx' extension 14:32:59 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 14:32:59 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 14:32:59 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 14:32:59 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 14:32:59 INFO - building 'psutil._psutil_posix' extension 14:32:59 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 14:33:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:33:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:33:00 INFO - ^ 14:33:00 INFO - 1 warning generated. 14:33:00 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 14:33:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:33:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:33:00 INFO - Successfully installed psutil 14:33:00 INFO - Cleaning up... 14:33:00 INFO - Return code: 0 14:33:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:00 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:00 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 14:33:00 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 14:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:00 INFO - 'HOME': '/Users/cltbld', 14:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:00 INFO - 'LOGNAME': 'cltbld', 14:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:00 INFO - 'MOZ_NO_REMOTE': '1', 14:33:00 INFO - 'NO_EM_RESTART': '1', 14:33:00 INFO - 'PAGER': '/bin/cat', 14:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:00 INFO - 'PWD': '/builds/slave/test', 14:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:00 INFO - 'SHELL': '/bin/bash', 14:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:00 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:00 INFO - 'USER': 'cltbld', 14:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:00 INFO - 'XPC_FLAGS': '0x0', 14:33:00 INFO - 'XPC_SERVICE_NAME': '0', 14:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:33:03 INFO - Installing collected packages: mozsystemmonitor 14:33:03 INFO - Running setup.py install for mozsystemmonitor 14:33:03 INFO - Successfully installed mozsystemmonitor 14:33:03 INFO - Cleaning up... 14:33:03 INFO - Return code: 0 14:33:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:33:03 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')]} 14:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:03 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')]} 14:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:03 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:03 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 14:33:03 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 14:33:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:03 INFO - 'HOME': '/Users/cltbld', 14:33:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:03 INFO - 'LOGNAME': 'cltbld', 14:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:03 INFO - 'MOZ_NO_REMOTE': '1', 14:33:03 INFO - 'NO_EM_RESTART': '1', 14:33:03 INFO - 'PAGER': '/bin/cat', 14:33:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:03 INFO - 'PWD': '/builds/slave/test', 14:33:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:03 INFO - 'SHELL': '/bin/bash', 14:33:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:03 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:03 INFO - 'USER': 'cltbld', 14:33:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:03 INFO - 'XPC_FLAGS': '0x0', 14:33:03 INFO - 'XPC_SERVICE_NAME': '0', 14:33:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:03 INFO - Downloading/unpacking jsonschema==2.5.1 14:33:03 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 14:33:03 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 14:33:03 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 14:33:03 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 14:33:03 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 14:33:03 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 14:33:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:33:06 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 14:33:06 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 14:33:06 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 14:33:06 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 14:33:06 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 14:33:06 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 14:33:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:06 INFO - warning: no files found matching '*.txt' 14:33:06 INFO - no previously-included directories found matching 'build' 14:33:06 INFO - no previously-included directories found matching 'dist' 14:33:06 INFO - no previously-included directories found matching '.git*' 14:33:06 INFO - Installing collected packages: jsonschema, functools32 14:33:06 INFO - Running setup.py install for functools32 14:33:06 INFO - warning: no files found matching '*.txt' 14:33:06 INFO - no previously-included directories found matching 'build' 14:33:06 INFO - no previously-included directories found matching 'dist' 14:33:06 INFO - no previously-included directories found matching '.git*' 14:33:06 INFO - Successfully installed jsonschema functools32 14:33:06 INFO - Cleaning up... 14:33:06 INFO - Return code: 0 14:33:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:06 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 14:33:06 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 14:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:06 INFO - 'HOME': '/Users/cltbld', 14:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:06 INFO - 'LOGNAME': 'cltbld', 14:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:06 INFO - 'MOZ_NO_REMOTE': '1', 14:33:06 INFO - 'NO_EM_RESTART': '1', 14:33:06 INFO - 'PAGER': '/bin/cat', 14:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:06 INFO - 'PWD': '/builds/slave/test', 14:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:06 INFO - 'SHELL': '/bin/bash', 14:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:06 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:06 INFO - 'USER': 'cltbld', 14:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:06 INFO - 'XPC_FLAGS': '0x0', 14:33:06 INFO - 'XPC_SERVICE_NAME': '0', 14:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:33:07 INFO - Cleaning up... 14:33:07 INFO - Return code: 0 14:33:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:07 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:07 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 14:33:07 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 14:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:07 INFO - 'HOME': '/Users/cltbld', 14:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:07 INFO - 'LOGNAME': 'cltbld', 14:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:07 INFO - 'MOZ_NO_REMOTE': '1', 14:33:07 INFO - 'NO_EM_RESTART': '1', 14:33:07 INFO - 'PAGER': '/bin/cat', 14:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:07 INFO - 'PWD': '/builds/slave/test', 14:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:07 INFO - 'SHELL': '/bin/bash', 14:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:07 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:07 INFO - 'USER': 'cltbld', 14:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:07 INFO - 'XPC_FLAGS': '0x0', 14:33:07 INFO - 'XPC_SERVICE_NAME': '0', 14:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:33:07 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 14:33:07 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 14:33:07 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 14:33:07 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 14:33:07 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 14:33:07 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 14:33:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:33:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:33:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:10 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 14:33:11 INFO - Downloading docopt-0.6.1.tar.gz 14:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:33:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:33:11 INFO - Running setup.py install for blobuploader 14:33:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:33:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:33:11 INFO - Running setup.py install for requests 14:33:11 INFO - Running setup.py install for docopt 14:33:11 INFO - Successfully installed blobuploader requests docopt 14:33:11 INFO - Cleaning up... 14:33:12 INFO - Return code: 0 14:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:12 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:12 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 14:33:12 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 14:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:12 INFO - 'HOME': '/Users/cltbld', 14:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:12 INFO - 'LOGNAME': 'cltbld', 14:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:12 INFO - 'MOZ_NO_REMOTE': '1', 14:33:12 INFO - 'NO_EM_RESTART': '1', 14:33:12 INFO - 'PAGER': '/bin/cat', 14:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:12 INFO - 'PWD': '/builds/slave/test', 14:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:12 INFO - 'SHELL': '/bin/bash', 14:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:12 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:12 INFO - 'USER': 'cltbld', 14:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:12 INFO - 'XPC_FLAGS': '0x0', 14:33:12 INFO - 'XPC_SERVICE_NAME': '0', 14:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-39UNaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-FsTJZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-jZYh7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Qxll7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-aJHvKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-VoEkqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:12 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-yso1Gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-url6K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-n47KRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-omXwjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-XzIXOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-50GPUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-UvilVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-n07pGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-b93DTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-zZ1I_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-uXQr0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:33:14 INFO - Running setup.py install for manifestparser 14:33:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:33:14 INFO - Running setup.py install for mozcrash 14:33:14 INFO - Running setup.py install for mozdebug 14:33:14 INFO - Running setup.py install for mozdevice 14:33:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:33:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:33:14 INFO - Running setup.py install for mozfile 14:33:14 INFO - Running setup.py install for mozhttpd 14:33:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozinfo 14:33:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozInstall 14:33:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozleak 14:33:15 INFO - Running setup.py install for mozlog 14:33:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for moznetwork 14:33:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:33:15 INFO - Running setup.py install for mozprocess 14:33:15 INFO - Running setup.py install for mozprofile 14:33:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozrunner 14:33:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Running setup.py install for mozscreenshot 14:33:16 INFO - Running setup.py install for moztest 14:33:16 INFO - Running setup.py install for mozversion 14:33:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:33:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:33:16 INFO - Cleaning up... 14:33:16 INFO - Return code: 0 14:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:16 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')]} 14:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 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')]} 14:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:16 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 14:33:16 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 14:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:16 INFO - 'HOME': '/Users/cltbld', 14:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:16 INFO - 'LOGNAME': 'cltbld', 14:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:16 INFO - 'MOZ_NO_REMOTE': '1', 14:33:16 INFO - 'NO_EM_RESTART': '1', 14:33:16 INFO - 'PAGER': '/bin/cat', 14:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:16 INFO - 'PWD': '/builds/slave/test', 14:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:16 INFO - 'SHELL': '/bin/bash', 14:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:16 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:16 INFO - 'USER': 'cltbld', 14:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:16 INFO - 'XPC_FLAGS': '0x0', 14:33:16 INFO - 'XPC_SERVICE_NAME': '0', 14:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:16 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-AEO9E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-2d_nA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-YLn2Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-fWwAc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-c6iNSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-nfjMwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-NGPNJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-CYTEXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-jsaBlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:17 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)) 14:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:17 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-aIbcnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-7b8ZGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-UO_aKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_KhC8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZWNQtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Uc2RCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:18 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-kcYKdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 14:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ojtmHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:18 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)) 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:18 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)) 14:33:18 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:18 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33:18 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 14:33:18 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 14:33:18 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 14:33:18 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 14:33:18 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 14:33:18 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 14:33:21 INFO - Downloading blessings-1.6.tar.gz 14:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:21 INFO - Installing collected packages: blessings 14:33:21 INFO - Running setup.py install for blessings 14:33:21 INFO - Successfully installed blessings 14:33:21 INFO - Cleaning up... 14:33:21 INFO - Return code: 0 14:33:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:21 INFO - Reading from file tmpfile_stdout 14:33:21 INFO - Current package versions: 14:33:21 INFO - blessings == 1.6 14:33:21 INFO - blobuploader == 1.2.4 14:33:21 INFO - docopt == 0.6.1 14:33:21 INFO - functools32 == 3.2.3-2 14:33:21 INFO - jsonschema == 2.5.1 14:33:21 INFO - manifestparser == 1.1 14:33:21 INFO - mozInstall == 1.12 14:33:21 INFO - mozcrash == 0.17 14:33:21 INFO - mozdebug == 0.1 14:33:21 INFO - mozdevice == 0.48 14:33:21 INFO - mozfile == 1.2 14:33:21 INFO - mozhttpd == 0.7 14:33:21 INFO - mozinfo == 0.9 14:33:21 INFO - mozleak == 0.1 14:33:21 INFO - mozlog == 3.4 14:33:21 INFO - moznetwork == 0.27 14:33:21 INFO - mozprocess == 0.23 14:33:21 INFO - mozprofile == 0.28 14:33:21 INFO - mozrunner == 6.12 14:33:21 INFO - mozscreenshot == 0.1 14:33:21 INFO - mozsystemmonitor == 0.3 14:33:21 INFO - moztest == 0.7 14:33:21 INFO - mozversion == 1.4 14:33:21 INFO - psutil == 3.1.1 14:33:21 INFO - requests == 1.2.3 14:33:21 INFO - wsgiref == 0.1.2 14:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:21 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')]} 14:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:21 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')]} 14:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:21 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:21 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 14:33:21 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 14:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:21 INFO - 'HOME': '/Users/cltbld', 14:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:21 INFO - 'LOGNAME': 'cltbld', 14:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:21 INFO - 'MOZ_NO_REMOTE': '1', 14:33:21 INFO - 'NO_EM_RESTART': '1', 14:33:21 INFO - 'PAGER': '/bin/cat', 14:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:21 INFO - 'PWD': '/builds/slave/test', 14:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:21 INFO - 'SHELL': '/bin/bash', 14:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:21 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:21 INFO - 'USER': 'cltbld', 14:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:21 INFO - 'XPC_FLAGS': '0x0', 14:33:21 INFO - 'XPC_SERVICE_NAME': '0', 14:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 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)) 14:33:22 INFO - Cleaning up... 14:33:22 INFO - Return code: 0 14:33:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:22 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 0x10df1d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de93570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d049cd80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, '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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 14:33:22 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 14:33:22 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 14:33:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:22 INFO - 'HOME': '/Users/cltbld', 14:33:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:22 INFO - 'LOGNAME': 'cltbld', 14:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:22 INFO - 'MOZ_NO_REMOTE': '1', 14:33:22 INFO - 'NO_EM_RESTART': '1', 14:33:22 INFO - 'PAGER': '/bin/cat', 14:33:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:22 INFO - 'PWD': '/builds/slave/test', 14:33:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:22 INFO - 'SHELL': '/bin/bash', 14:33:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:22 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:22 INFO - 'USER': 'cltbld', 14:33:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:22 INFO - 'XPC_FLAGS': '0x0', 14:33:22 INFO - 'XPC_SERVICE_NAME': '0', 14:33:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:33:22 INFO - Cleaning up... 14:33:22 INFO - Return code: 0 14:33:22 INFO - Running post-action listener: _resource_record_post_action 14:33:22 INFO - Running post-action listener: _start_resource_monitoring 14:33:22 INFO - Starting resource monitoring. 14:33:22 INFO - [mozharness: 2016-10-20 21:33:22.426380Z] Finished create-virtualenv step (success) 14:33:22 INFO - [mozharness: 2016-10-20 21:33:22.427389Z] Running install step. 14:33:22 INFO - Running pre-action listener: _resource_record_pre_action 14:33:22 INFO - Running main action method: install 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:22 INFO - Reading from file tmpfile_stdout 14:33:22 INFO - Output received: 14:33:22 INFO - Usage: mozinstall [options] installer 14:33:22 INFO - Options: 14:33:22 INFO - -h, --help show this help message and exit 14:33:22 INFO - -d DEST, --destination=DEST 14:33:22 INFO - Directory to install application into. [default: 14:33:22 INFO - "/builds/slave/test"] 14:33:22 INFO - --app=APP Application being installed. [default: firefox] 14:33:22 INFO - mkdir: /builds/slave/test/build/application 14:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:33:55 INFO - Reading from file tmpfile_stdout 14:33:55 INFO - Output received: 14:33:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:33:55 INFO - Running post-action listener: _resource_record_post_action 14:33:55 INFO - [mozharness: 2016-10-20 21:33:55.376660Z] Finished install step (success) 14:33:55 INFO - [mozharness: 2016-10-20 21:33:55.376820Z] Running run-tests step. 14:33:55 INFO - Running pre-action listener: _resource_record_pre_action 14:33:55 INFO - Running main action method: run_tests 14:33:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:55 INFO - 2016-10-20 14:33:55.391 screenresolution[1914:9375] starting screenresolution argv=screenresolution get 14:33:55 INFO - 2016-10-20 14:33:55.393 screenresolution[1914:9375] Display 0: 1600x1200x32@60 14:33:55 INFO - 2016-10-20 14:33:55.399 screenresolution[1915:9377] starting screenresolution argv=screenresolution list 14:33:55 INFO - Available Modes on Display 0 14:33:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:55 INFO - Intel Iris: 14:33:55 INFO - Chipset Model: Intel Iris 14:33:55 INFO - Type: GPU 14:33:55 INFO - Bus: Built-In 14:33:55 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:55 INFO - Vendor: Intel (0x8086) 14:33:55 INFO - Device ID: 0x0a2e 14:33:55 INFO - Revision ID: 0x0009 14:33:55 INFO - Displays: 14:33:55 INFO - Display: 14:33:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:55 INFO - Display Serial Number: 1600x1200 60 14:33:55 INFO - Main Display: Yes 14:33:55 INFO - Mirror: Off 14:33:55 INFO - Online: Yes 14:33:55 INFO - Rotation: Supported 14:33:55 INFO - Return code: 0 14:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:55 INFO - Python 2.7.3 14:33:55 INFO - Return code: 0 14:33:55 INFO - grabbing minidump binary from tooltool 14:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:55 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 0x10dd31d30>, '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 0x10db97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd29b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:55 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 14:33:55 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 14:33:55 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 14:33:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:55 INFO - Return code: 0 14:33:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:55 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:33:55 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Lm5Hur5IGB/Render', 14:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:55 INFO - 'HOME': '/Users/cltbld', 14:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:55 INFO - 'LOGNAME': 'cltbld', 14:33:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:55 INFO - 'MOZ_NO_REMOTE': '1', 14:33:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:55 INFO - 'NO_EM_RESTART': '1', 14:33:55 INFO - 'PAGER': '/bin/cat', 14:33:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:55 INFO - 'PWD': '/builds/slave/test', 14:33:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:55 INFO - 'SHELL': '/bin/bash', 14:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f25Zdcy6P3/Listeners', 14:33:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 14:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:55 INFO - 'USER': 'cltbld', 14:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:55 INFO - 'XPC_FLAGS': '0x0', 14:33:55 INFO - 'XPC_SERVICE_NAME': '0', 14:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:33:55 INFO - mozversion application_buildid: 20161020121550 14:33:55 INFO - mozversion application_changeset: 22963ffebf2833b64e9cd692e02b268ffb32c6c9 14:33:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:33:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:55 INFO - mozversion application_name: Firefox 14:33:55 INFO - mozversion application_remotingname: firefox-dev 14:33:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:33:55 INFO - mozversion application_vendor: Mozilla 14:33:55 INFO - mozversion application_version: 51.0a2 14:33:55 INFO - mozversion platform_buildid: 20161020121550 14:33:55 INFO - mozversion platform_changeset: 22963ffebf2833b64e9cd692e02b268ffb32c6c9 14:33:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:33:55 INFO - mozversion platform_version: 51.0a2 14:33:55 INFO - using testdate: 1476999235 14:33:55 INFO - actual date: 1476999235 14:33:55 INFO - starting webserver on 'localhost:49451' 14:33:55 INFO - SUITE-START | Running 2 tests 14:33:55 INFO - TEST-START | dromaeo_css 14:33:55 INFO - operating with platform_type : mac_ 14:33:55 INFO - Initialising browser for dromaeo_css test... 14:33:56 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpaM1M_d/profile http://localhost:49451/getInfo.html) 14:33:58 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 14:33:58 INFO - PROCESS | 1925 | colorDepth:24 14:33:58 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 14:33:58 INFO - PROCESS | 1925 | __metrics 14:33:58 ERROR - PROCESS | 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 14:33:59 INFO - TEST-INFO | 1925: exit 0 14:33:59 INFO - Browser initialized. 14:33:59 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:59 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpaM1M_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:11 INFO - PROCESS | 1928 | RSS: Main: 225144832 14:34:11 INFO - PROCESS | 1928 | 14:35:01 INFO - PROCESS | 1928 | 1476999301157 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:37:13 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49451/tests/dromaeo/cssquery-ext.html) 14:37:14 INFO - PROCESS | 1928 | RSS: Main: 238546944 14:37:14 INFO - PROCESS | 1928 | 14:40:16 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-ext.html (next: http://localhost:49451/tests/dromaeo/cssquery-jquery.html) 14:40:17 INFO - PROCESS | 1928 | RSS: Main: 248029184 14:40:17 INFO - PROCESS | 1928 | 14:43:19 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49451/tests/dromaeo/cssquery-mootools.html) 14:43:20 INFO - PROCESS | 1928 | RSS: Main: 251138048 14:43:20 INFO - PROCESS | 1928 | 14:46:21 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49451/tests/dromaeo/cssquery-prototype.html) 14:46:22 INFO - PROCESS | 1928 | RSS: Main: 251547648 14:46:22 INFO - PROCESS | 1928 | 14:49:25 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49451/tests/dromaeo/cssquery-yui.html) 14:49:26 INFO - PROCESS | 1928 | RSS: Main: 255979520 14:49:26 INFO - PROCESS | 1928 | 14:52:28 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-yui.html (next: http://localhost:49451/tests/dromaeo/cssquery-dojo.html) 14:52:29 INFO - PROCESS | 1928 | RSS: Main: 257679360 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | __start_tp_report 14:52:29 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 14:52:29 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 14:52:29 INFO - PROCESS | 1928 | |i|pagename|runs| 14:52:29 INFO - PROCESS | 1928 | |0;dojo.html;3420.5382273393084;3434.8626054957804;3450.051235910126;3470.3753324401614;3471.6875481206703;5928.051511758114;5982.8803423931495;6007.068904319826;6009.2788865336115;6015.939840601593;5973.611715238518;5997.6101553399;6027.306859711134;6029;6030.457258846703;5366.356037275523;5401.108817045183;5415.241866138724;5461.2354270402175;5533.833984980457;5449.155380915964;5472.753726082336;5473.343198816147;5478.506934375905;5506.201600767887;5351.384590772052;5354.732263386834;5459.481349271813;5459.727013649302;5465.316835395575;5374.167004114369;5387;5460.34475862895;5496.038193316153;5524.419935906712;5250.291210686547;5357.1696387060065;5407.864803379907;5411.107167317388;5430;5756.7985120521;5932.970335148297;5989.520838332923;6071.51427885768;6074.817755467343;5969.820905372846;6137.9286238596105;6145.340757995361;6237.750489980395;6295.244570651551;5263.34208223972;5729.541636669098;6321.020241862473;6331.746730130789;6332.176817013805;5996.340402555716;6003.219581454383;6022.819315420545;6033.909491357633;6036.456718895321;6264.968675156595;6284;6330.715117819709;6380.202474690664;6380.840478988062;5097.8215762448135;5372.597055220874;5544.833654990357;6277.686115694289;6333.904991425133;5234.476552344735;6344.143540622049;6344.968275158687;6352.936470635234;6361.045843123568;5197.7141257231215;6136.4578081083455;6272.247330320391;6301.40136687014;6314.968425157845;5253.947460525423;5465.535429488538;5573;6291.874162516724;6340.207474065742;5015.724135172528;5016.44819069902;5028.874278143003;5040.7731652075745;5074.82238121664;4475.082608065404;4484.529124441952;4489.9775501122285;4536.5236650151255;4543.25036369002;5296.92054619181;5943.881122377528;5945.286565612154;5979.252593425822;6048.092786082123;6291.653959032205;6342.651154186564;6355.459785918156;6361.268454127742;6362.745490180433;5159.097157997336;5864.149698293809;5937.317208520989;5953.226080609493;5991.340952495222;5563.304586926634;5573.442655734394;5583.022970980062;5585.553155747531;5619.943800561942;6472.676366181672;6489.448396886129;6495.805125846232;6498.545101842826;6499.480041596756;6215.751369945332;6225.128482012612;6289.528285378524;6376.649284289409;6406.455451286693;6314.273858506331;6432.839179020375;6435.292117866938;6449.774257900951;6450.516211284266;6266.68666566679;6274.466670333073;6296.401841825019;6311.368863113652;6312.652804095819;5368.946310536845;6200.627962322275;6253.405926436982;6354.205724284465;6393.456556192589;6075.36208698098;6232.781852635136;6289.7169627365965;6313.747450101944;6317.210348706411;6273.121762953281;6307.90538141919;6317.273513546001;6332.651704156316;6361.840953976188;5942.970285148546;6044.032954727222;6145.8156255312415;6159.907601386072;6220.191375121205;6212.534059945612;6221.5333849960525;6227.314995350417;6252.906206406817;6301.842453938688;6216.44052035319;6235.407636274546;6242.875142497215;6252.343503932204;6259.906101408392 14:52:29 INFO - PROCESS | 1928 | |1;ext.html;496.59527485099665;510.8722819295176;515.4304493534642;518.5118709304296;521.353521633175;37967.24065518688;39742.20515589687;39742.602573974254;39872.601273987326;39953.801385958395;39749.801250993776;40431.797841010826;40433;40589.797051014706;40732.592674073254;9708.951455242732;9934.155596774282;9943.850842237372;9955.153811925959;9960.103590676837;9802.460864652441;9873.012698730105;9880.555375008105;9930.404175749478;9937.403755774676;8413.368997325226;8538.615762290712;8960.731178064669;9906.950465247664;9919.057689519484;9842.70471885841;9887.703368898945;9888.901110988942;9891.752706182331;10045.397276163454;9788.608455661764;9852.852207216898;9865.112139907444;9874.358166719212;9878.851817222676;32648;39344;39416.80291598552;39419;39450.210995779926;3161.2571045804216;3302.108430723715;3782.167923056923;3884.6309600587897;4153.0447996960565;28925.710742892723;29543.704562954525;30096.548551771742;30318.54522182147;30496.69503304983;3078.1688943985223;3126.796758210709;3181.1410919051727;3190.441672707267;3203.855826487814;444260;524010;525614.7438525604;528246;529941.3502932499;60586.39413605896;61004;61265;61318.69340653357;61381.772364553355;33923;33974.810881619516;34675;35571.644283557354;35666.64333356685;16628.418005369753;16789.664206716043;16829.242684079247;16830.663386732198;16838.831611683727;12889.935550322376;12964.28696421687;12986.961043116527;12996.415161317764;12997.415116319788;17594.560135996704;18017.459476215736;18564.25742970293;18590.907045464955;18789.62420751577;6861.55399899015;7919.683212671429;8120.512769233865;8135.1051384347675;8177.550234737147;810.805406702399;813.4631143445298;938.7887725261761;944.6835310171032;1037.6108959140322;25923;28547.57178642322;28621.425821580015;29152;30081.849590751906;966.3235734985539;1018.9620758483034;1033.7932413517326;1060.8726952765717;1132.5866058888612;14919.030263032868;15217.61955951088;15275.618109547127;15460.226988650522;15560.45538406173;661623;675804;677777;678517;678737;54184;54490;54675.179872301946;54678;54768.72615636896;1314.5399110311314;1350.6015725361042;1368.2679766324968;1370.8766211041054;1373.0937581196363;24200.394990125387;28846.7115328844;29259.85370073136;29610.851945740134;30073.849630751705;47597.76201118972;47813;47923.52076479191;47927.76036119797;48076.27885581789;575734;577610.1119494544;579860.2013979806;580170;580853;25632.102876399236;25858.87070564635;26071.73928260693;26091.739082608932;26378.604320935585;40152.19695606013;44470;44966;46376.768116159205;46415.76792116018;32630.673693263714;33551.83224083961;37738.43392349062;37805.24389512139;37933;36982.63017369792;37310.62689373072;38418;38540.80729596334;38660.6133938657;36012.09969750777;36253;36775.816120919226;36998;37045.81477092597;32417.83791081124;33700.66299337073;34126.82936585301;34211.31577368389;34227.4865877007;20187.899060504602;24895.751042489344;24917.127900523396;25231.354657475687;25329.551809538643 14:52:29 INFO - PROCESS | 1928 | |2;jquery.html;371.0815731065613;374.771389452434;383.1474968195765;384.03798484795584;395.59253968412526;19686.606267874653;22018;22134.88932555337;22258.443538911535;22338.664920026193;20300.59398812023;20564.280250191245;20733.792662073374;20753.584928301425;21266.680999785014;5858;5922.170896074553;6086.908696369536;6130.325664176937;6138.938610613904;3973.403989401584;4181.853635122771;6066.150738896558;6080.331163572004;6119.938800611982;6364.968175159118;6662.267150613428;6732.798016059526;6770.018347339657;6779.62712050837;6569.901451478232;6744.7976560703255;6832.4192443642105;6850.6574671266735;6851.828704282383;5199.688018718851;5914.172015917775;5948.583599148062;5961.374055724174;5968.283805943272;24089.879550602134;24296.149634762874;25266.621000685005;25431.237062888144;25432.872835635702;2225.9109635614554;2241.1931704586336;2245.708057952456;2274.627367754518;2920.4305160493714;10032.899671003343;10161.949190254076;10229.335093218917;12913.483460661562;13704.931475342559;1634.7466142747894;1640.9179541022902;1837.118183272037;1843.769528808899;1857.749203857489;99180;116406;116770;122429.77570224361;125647;11589.24669896454;11688.532458701557;11861.169718119649;11898.881011189776;12043.397830108635;14684.926575367268;14803.925980370244;14806.037607555474;14814.481493147689;14820.3330850112;8600.913990860012;8749.431286966326;8764.56177191138;8765.91234087651;8772.824543509094;7594.658240379196;8400.781886626404;8712.21590056898;8808.603612837438;8875.644974201088;4544.863654090383;4561.156186105581;4621.514740952219;4626.7223966562115;4631.930521042187;1564.593205766486;1596.5370042687723;1600.4958438091965;1929.2668785861283;1948.1720268885667;653.9967300163564;839.1482645115213;854.4147259127518;865.9176029962547;888.853339199025;20871.58256834855;21359.25242616501;21398.358049258546;21423.57152856934;21533.569328613652;890.2788741119714;895.0959530873864;921.2952091649893;936.4755736787421;988.1748739802346;9873.703788886345;10842.403667798348;11285.887141128647;11302.660920172408;11353.091752659768;594201.0289948522;598242.0087899619;601316;614965;619318;121794.3910280443;130531.38937221392;131922.02116968253;135039.32480337535;135390;902.7427183252872;938.7043081429327;948.4167237149242;952.2524818017823;952.7332346942867;17593.82406175922;18393.98833064141;18962.86222826635;18975.90512047486;19000.52498687544;48852.75573622251;48895.77760556014;49224.75387623039;49708.508744737715;51022.74488627533;68802.28809463391;70220;72446;72577;72597.6370118146;6231.594946328474;7205.71177152929;7249.347558719741;7382.4094072473;7455.888161677688;9038.954805225932;11917.582884598998;12507.93746031264;12661.113722039368;12905;8593.238386130954;10438.11276041545;10692.732681683021;11394.829077563678;11769.646910592695;11009.559617615205;11117;11388.202825802115;11438.82841757391;11672.88327116718;11307.886921131012;11378.943105284421;11537.711557211136;11586.594469193538;11805.763884722086;8200.794980125545;8297.377696672653;8371.790705232417;8377.83244335122;8430.83138337242;10645.414502202453;11092.667219983414;11207.66377008691;11270.718232044264;11449.656510304705 14:52:29 INFO - PROCESS | 1928 | |3;mootools.html;1501.7071671024148;1538.7614919687446;1736.609262915844;1795.3626462605782;1844.797072322045;8117.9594102029405;8342.374321925865;8640.308775297977;9250.629974801008;9251.398659087172;8605.870911936327;8963.327750418712;8985.595648195831;8997.685081022166;9073.727788166349;2237.026893301411;2309.538092381522;2395.2694428199393;2423.4789520253144;2448.6449464827588;2414.987925060372;2424.5514579802707;2444.8899799508977;2458.0659349447274;2463.581191197492;2338.7895089441945;2349.3186975777003;2364.9527009459803;2365.82256330775;2368.2539999899977;2392.6650268962358;2393.401649587603;2401.6037353836596;2429.2226487524;2439.8536087834786;2405.530921470314;2426.8179886508583;2428.417179876817;2429.8906549205153;2434.5982912819363;9004.279657627374;9132.634694612207;9133.041030691747;9154.40496367734;9160.129787670161;4124.546299907038;4540.9772951135365;4699.318598803188;4767.213409787381;5142.742862856842;3295.505674148873;3389.8983030509125;3587.1749497615433;3737.7009839212797;3766.0773110587807;1061.3260579531975;1069.3316677076828;1106.950187241576;1129.570763110021;1813.8548916086681;9754.219662426989;11734.00260977818;11867.287962722177;12075.93962030193;12089.818652720216;4005;4505.008898042425;4652.464966528893;4735.455422626442;4740.265258884879;8569.671700886372;9296.907030929739;9368.2973776967;9389.38968967015;9409.341346105706;5148.613853960968;5338.839834804962;5357.464253574612;5357.9819834231375;5393.6763794172475;4483.372327874035;4623.976880115578;4874.488178741181;5015.924761128586;5033.1695270280725;3898.2593307272095;3902.726809123391;3926.155876486569;4035.1526179502634;4043.474348334698;995.5221493683073;1186.9703257418462;1193.6538403862783;1200.3578085724096;1213.9757204855853;847.2798121596717;858.6393714639867;872.376250980552;891.6656253904786;896.0815164456484;5829.242198514251;5925.288965324103;5981.910271345933;6045.33501314855;6197.070439434121;872.284726524244;895.2256298302052;901.4230892228978;919.94940278284;966.9661561845302;3666;3843.9039024024623;3855.9228815424094;3870.40008798631;3901.668358189586;10941.28881622692;11295.887041129648;11323.037541808873;11344.773104537862;11375.488103035383;11136.109111271078;11174.60888868902;11197.888021119685;11214.775704485864;11261.436928153724;8020.679172833138;8430.6206220719;8443.915560844436;8460.450070745383;8577.656893724306;5420.945790542044;5921.348651648229;5929.644221346733;5983.521318294439;6071.453569178795;9970.50147492637;10188.541515631667;10324.22568307365;10345.689629311133;10447.850736418835;8900.332475064526;10338.689839304832;10549.841752373566;10707.304025238334;10708.678739637824;7644.197359277196;7805.804854878674;7810.960945195465;7850.2542258485355;7931.444798864024;8379.287760540423;8444.619992100248;8466.238038576557;8523;8532.402731808714;7455.329020388191;7688.884666729891;7697.384209263358;7773.41699372538;7886.250806173404;7500.62496875165;7517.887231691419;7568.356689681439;7618.923810762043;7661.88507172404;7047.6828542714675;7115.897035959435;7116.644167791486;7121.9643901780155;7122.358987691133;4781.641376896816;4837.395325584302;4950.133726597903;4976.0047990401345;5067.974660126823;4913.950860491493;4938.209886418156;4985.800567977385;5008.298838162587;5047.192449208109 14:52:29 INFO - PROCESS | 1928 | |4;prototype.html;238.86981595030713;253.56387014335343;257.86795965710536;272.3409349374515;284.33323855558706;4529.139463501941;5441.395362776337;5551.222828803966;5591.30108736408;5627.240322556454;4316.784160791955;5277.788888444467;5428.240046393508;5502.394736578973;5518.806841760539;3868.8065596720053;4204.285271503852;4242.109157077018;4243.856852289589;4252.319628859384;3413.4026545354463;3511.806850623215;4141.772202528859;4237.597428244328;4268.487781466213;3751.9437208441896;3808.409696497047;4082.387456954516;4087.4481944937497;4149.315362965122;3413.7098346640564;3449.965500345015;3691.9630803692157;3951.932978095927;4139.710220284582;3390.237196630763;3544.805035723034;3546.7871927684164;3566.286742651454;3574.874879379235;4486.945567791567;5359.437259087778;5385.515303622654;5458.342910250142;5484.478974497416;4709.599684026862;4756.643251756098;4765.833195838129;4787.611592638131;4802;5121.334226550524;5299.046171689094;5498.762778374874;5655.434456554352;5893.322267939199;3642.453631955228;3901.5708272090046;3901.707371947087;3921.666658334045;3930.6658933990643;5112;5152.4963025142515;6122.479589234876;6215.316315205324;6263.498920086382;3506.5967413747235;3802.8098595070137;3933.2920074386884;3976.204759048202;3979.1245925896255;3730.9440358394645;3922.2743792398496;4034.9105741449644;4039.9596004040172;4066.268071747055;4748.548887855648;4749.453812811571;4755.001449695534;4777.140114779373;4790.96384036783;4859.854204373874;4976.726280054631;5662.858428539237;5902.675352855548;5967.910481342697;1276.2151276964785;1290.458007636776;1333.8866196373224;1336.211635135275;1376.6076668149728;768.4390395011673;886.1537231943479;915.5925613102106;920.40173886974;922.0456827183832;5080.120355468501;5221.6083793715625;5350.357957045179;5404.91892621611;5437.564994800407;5915;5918.81623675258;5921.40785921413;5939.881202375928;5976.581639285295;4914.680545764514;5309.469053094737;5311.017461769585;5362.812301569426;5462.180672899097;2158.7409510858483;2309.330294214659;2423.515296940619;2665.18711792905;2697.204324724211;4384.956150438518;4486.5962063414445;4642.375168690931;4774.785134668949;5138.974305128525;4690.695104818176;5114.008305141534;5116.539511443988;5121.9743901281;5127.53852153308;4749.527646429618;4791.089133638049;5104.846854594294;5127.307813445212;5155.819546315861;4352.303631419084;4690.3433519306645;4820.566149046603;4934.9753251233515;4935.062338155739;4180.432337873298;4890.853274401774;5030.798768049237;5483.40981115488;6232.5325600581045;6293.590916590407;6308.495320374451;6313.737252549417;6337.746490140527;6348.428886301055;3255.6418793932176;3998.4602078719;4023.1953609277675;4040.9797951010055;4056.939145912873;5014.398272207212;5222.524070152907;5878.941210587839;6056.818295451144;6107.633541987495;5102;5244.606654500852;5685.123909109901;5888.4700376966275;5908.350081490947;5213.426523082382;5832.62087964281;5871.119332100219;5900.7049647518315;5908.336831164534;4698.707855339809;4925.655204135819;5436.314742429701;5749.367569567428;5780.121460525262;4954.380702412199;5887.911681324869;5969.73136208863;5969.731502029201;5978.372270911492;5345.65253258537;5800.50695690871;5837.869177750175;5842.737076831638;5859.414058594107 14:52:29 INFO - PROCESS | 1928 | |5;yui.html;691.2051141187634;700.2717174138896;710.6304721544797;719.4532155561778;730.2405498281787;15405.229738513086;15418.229088545584;15720.999999999985;15851.128187949658;15870.603234919134;14083.29583520825;14291.857081429183;14295.285235738198;14381.065230759994;14392.640183995405;825.3768404854342;848.4781859156606;852.0542198160038;853.6585365853646;854.6325080215505;676.3067855448156;689.5690193628982;841.1798496465958;866.7529754020105;873.9956300218522;868.8479516084692;901.7565257380503;905.8867641544807;905.9229965452912;907.4101833808012;872.3326655108815;895.5208963204719;897.851854444016;900.2977677411629;900.6217388696763;650.4146268358468;667.349334398962;667.3926726678748;667.9398854103106;668.2682462703332;15003.924980375137;15028.774568381483;15030.624234394227;15037.548873533811;15040;14825.332860021217;14880.925595371953;14923.179225142612;14983.625409364744;15195.772063419057;10131.746706332327;10910.127189824794;11801.94099029508;11979.10156738248;12092.516299348103;3714.572824125233;3752.6052833650906;3814.561325447581;3890.9416358754643;3900.2394533066063;102869;108324;120034.39982800117;122113;130006.6999330004;10270.794584108276;10501.264911456277;10954.452277386259;11298.661040168809;11500.482478288497;17299.827001730075;21394.35816925495;21443;21482.892585537284;21531.246406375703;7644.770656880191;7684.154742978268;7718.266764657348;7783.649735761905;7857.489263197874;4296.013823511905;4348.586884245991;4396.934045989313;4401.779911004437;4441.0673758511075;3388.728901687859;3494.790312581253;3509.105178179599;3509.5788505379005;3524.6827785499427;628.8302158417201;643.6331291163991;648.5460177875411;650.9381608747257;656.3731636287334;587.4859497939303;596.3350863786933;600.9278886533557;610.2829175718513;635.1330433957614;8710;9070.637174513078;9094.408863423856;9274.489903055262;9465.337426380087;551.7131091832225;565.9784089718016;595.8986972214648;620.5190976992776;624.4536030972898;4310.396544483775;4494.595486406174;4499.280115181556;4509.075639493962;4585.358049873021;102062;102998;148243;152493.47506524794;153038.23480882746;106825.79522614178;115941;120011;126815.36592317164;128744.35627821801;105602;105844.47077764562;109253;113781.86218137878;115636;9372.906270937476;10048.69853904384;10144.898551014396;10261.127804136731;10310.123639490726;46252.84367890695;51508.74245628748;54249.91500169896;61511.6924415375;64720.35279647143;67076.32923670701;72075.55848883098;95251.52374238084;96468;97066.5146674262;14241.857581424054;14323.212223327817;14341.9282903589;14416.279186040865;14695.41218351254;14709.55871323862;14804;14848.480303189337;15278.936702824793;15959.760603591189;13793.586192414243;13870.612938706048;13997;14001.369938352595;14658.70682586321;14216.786748198578;14330.57008289753;14869.330880110205;14893.287271963864;15014.024088434217;13489.730205396034;13730.65673358174;13799.931000344934;14092.718145637235;14540.41838326455;11437.59968401102;11582.88417115818;11665.883341166818;11922.52309907594;12076.45655945467;11624.535018599161;11639.47622357013;11667.76664466689;11808.409579521162;11941.880581194077 14:52:29 INFO - PROCESS | 1928 | __end_tp_report 14:52:29 INFO - PROCESS | 1928 | __start_cc_report 14:52:29 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,372 14:52:29 INFO - PROCESS | 1928 | __end_cc_report 14:52:29 INFO - PROCESS | 1928 | __startTimestamp1477000349044__endTimestamp 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | ------- Summary: start ------- 14:52:29 INFO - PROCESS | 1928 | Number of tests: 6 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | [#0] dojo.html Cycles:165 Average:5836.58 Median:6030.46 stddev:638.16 (10.6%) stddev-sans-first:611.32 14:52:29 INFO - PROCESS | 1928 | Values: 3420.5 3434.9 3450.1 3470.4 3471.7 5928.1 5982.9 6007.1 6009.3 6015.9 5973.6 5997.6 6027.3 6029.0 6030.5 5366.4 5401.1 5415.2 5461.2 5533.8 5449.2 5472.8 5473.3 5478.5 5506.2 5351.4 5354.7 5459.5 5459.7 5465.3 5374.2 5387.0 5460.3 5496.0 5524.4 5250.3 5357.2 5407.9 5411.1 5430.0 5756.8 5933.0 5989.5 6071.5 6074.8 5969.8 6137.9 6145.3 6237.8 6295.2 5263.3 5729.5 6321.0 6331.7 6332.2 5996.3 6003.2 6022.8 6033.9 6036.5 6265.0 6284.0 6330.7 6380.2 6380.8 5097.8 5372.6 5544.8 6277.7 6333.9 5234.5 6344.1 6345.0 6352.9 6361.0 5197.7 6136.5 6272.2 6301.4 6315.0 5253.9 5465.5 5573.0 6291.9 6340.2 5015.7 5016.4 5028.9 5040.8 5074.8 4475.1 4484.5 4490.0 4536.5 4543.3 5296.9 5943.9 5945.3 5979.3 6048.1 6291.7 6342.7 6355.5 6361.3 6362.7 5159.1 5864.1 5937.3 5953.2 5991.3 5563.3 5573.4 5583.0 5585.6 5619.9 6472.7 6489.4 6495.8 6498.5 6499.5 6215.8 6225.1 6289.5 6376.6 6406.5 6314.3 6432.8 6435.3 6449.8 6450.5 6266.7 6274.5 6296.4 6311.4 6312.7 5368.9 6200.6 6253.4 6354.2 6393.5 6075.4 6232.8 6289.7 6313.7 6317.2 6273.1 6307.9 6317.3 6332.7 6361.8 5943.0 6044.0 6145.8 6159.9 6220.2 6212.5 6221.5 6227.3 6252.9 6301.8 6216.4 6235.4 6242.9 6252.3 6259.9 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | [#1] ext.html Cycles:180 Average:70446.48 Median:21272.62 stddev:158592.86 (745.5%) stddev-sans-first:158950.79 14:52:29 INFO - PROCESS | 1928 | Values: 496.6 510.9 515.4 518.5 521.4 37967.2 39742.2 39742.6 39872.6 39953.8 39749.8 40431.8 40433.0 40589.8 40732.6 9709.0 9934.2 9943.9 9955.2 9960.1 9802.5 9873.0 9880.6 9930.4 9937.4 8413.4 8538.6 8960.7 9907.0 9919.1 9842.7 9887.7 9888.9 9891.8 10045.4 9788.6 9852.9 9865.1 9874.4 9878.9 32648.0 39344.0 39416.8 39419.0 39450.2 3161.3 3302.1 3782.2 3884.6 4153.0 28925.7 29543.7 30096.5 30318.5 30496.7 3078.2 3126.8 3181.1 3190.4 3203.9 444260.0 524010.0 525614.7 528246.0 529941.4 60586.4 61004.0 61265.0 61318.7 61381.8 33923.0 33974.8 34675.0 35571.6 35666.6 16628.4 16789.7 16829.2 16830.7 16838.8 12889.9 12964.3 12987.0 12996.4 12997.4 17594.6 18017.5 18564.3 18590.9 18789.6 6861.6 7919.7 8120.5 8135.1 8177.6 810.8 813.5 938.8 944.7 1037.6 25923.0 28547.6 28621.4 29152.0 30081.8 966.3 1019.0 1033.8 1060.9 1132.6 14919.0 15217.6 15275.6 15460.2 15560.5 661623.0 675804.0 677777.0 678517.0 678737.0 54184.0 54490.0 54675.2 54678.0 54768.7 1314.5 1350.6 1368.3 1370.9 1373.1 24200.4 28846.7 29259.9 29610.9 30073.8 47597.8 47813.0 47923.5 47927.8 48076.3 575734.0 577610.1 579860.2 580170.0 580853.0 25632.1 25858.9 26071.7 26091.7 26378.6 40152.2 44470.0 44966.0 46376.8 46415.8 32630.7 33551.8 37738.4 37805.2 37933.0 36982.6 37310.6 38418.0 38540.8 38660.6 36012.1 36253.0 36775.8 36998.0 37045.8 32417.8 33700.7 34126.8 34211.3 34227.5 20187.9 24895.8 24917.1 25231.4 25329.6 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | [#2] jquery.html Cycles:180 Average:35076.49 Median:1645.76 stddev:100959.47 (6134.5%) stddev-sans-first:101209.05 14:52:29 INFO - PROCESS | 1928 | Values: 371.1 374.8 383.1 384.0 395.6 19686.6 22018.0 22134.9 22258.4 22338.7 20300.6 20564.3 20733.8 20753.6 21266.7 5858.0 5922.2 6086.9 6130.3 6138.9 3973.4 4181.9 6066.2 6080.3 6119.9 6365.0 6662.3 6732.8 6770.0 6779.6 6569.9 6744.8 6832.4 6850.7 6851.8 5199.7 5914.2 5948.6 5961.4 5968.3 24089.9 24296.1 25266.6 25431.2 25432.9 2225.9 2241.2 2245.7 2274.6 2920.4 10032.9 10161.9 10229.3 12913.5 13704.9 1634.7 1640.9 1837.1 1843.8 1857.7 99180.0 116406.0 116770.0 122429.8 125647.0 11589.2 11688.5 11861.2 11898.9 12043.4 14684.9 14803.9 14806.0 14814.5 14820.3 8600.9 8749.4 8764.6 8765.9 8772.8 7594.7 8400.8 8712.2 8808.6 8875.6 4544.9 4561.2 4621.5 4626.7 4631.9 1564.6 1596.5 1600.5 1929.3 1948.2 654.0 839.1 854.4 865.9 888.9 20871.6 21359.3 21398.4 21423.6 21533.6 890.3 895.1 921.3 936.5 988.2 9873.7 10842.4 11285.9 11302.7 11353.1 594201.0 598242.0 601316.0 614965.0 619318.0 121794.4 130531.4 131922.0 135039.3 135390.0 902.7 938.7 948.4 952.3 952.7 17593.8 18394.0 18962.9 18975.9 19000.5 48852.8 48895.8 49224.8 49708.5 51022.7 68802.3 70220.0 72446.0 72577.0 72597.6 6231.6 7205.7 7249.3 7382.4 7455.9 9039.0 11917.6 12507.9 12661.1 12905.0 8593.2 10438.1 10692.7 11394.8 11769.6 11009.6 11117.0 11388.2 11438.8 11672.9 11307.9 11378.9 11537.7 11586.6 11805.8 8200.8 8297.4 8371.8 8377.8 8430.8 10645.4 11092.7 11207.7 11270.7 11449.7 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | [#3] mootools.html Cycles:180 Average:5770.57 Median:4926.08 stddev:3273.65 (66.5%) stddev-sans-first:3267.12 14:52:29 INFO - PROCESS | 1928 | Values: 1501.7 1538.8 1736.6 1795.4 1844.8 8118.0 8342.4 8640.3 9250.6 9251.4 8605.9 8963.3 8985.6 8997.7 9073.7 2237.0 2309.5 2395.3 2423.5 2448.6 2415.0 2424.6 2444.9 2458.1 2463.6 2338.8 2349.3 2365.0 2365.8 2368.3 2392.7 2393.4 2401.6 2429.2 2439.9 2405.5 2426.8 2428.4 2429.9 2434.6 9004.3 9132.6 9133.0 9154.4 9160.1 4124.5 4541.0 4699.3 4767.2 5142.7 3295.5 3389.9 3587.2 3737.7 3766.1 1061.3 1069.3 1107.0 1129.6 1813.9 9754.2 11734.0 11867.3 12075.9 12089.8 4005.0 4505.0 4652.5 4735.5 4740.3 8569.7 9296.9 9368.3 9389.4 9409.3 5148.6 5338.8 5357.5 5358.0 5393.7 4483.4 4624.0 4874.5 5015.9 5033.2 3898.3 3902.7 3926.2 4035.2 4043.5 995.5 1187.0 1193.7 1200.4 1214.0 847.3 858.6 872.4 891.7 896.1 5829.2 5925.3 5981.9 6045.3 6197.1 872.3 895.2 901.4 919.9 967.0 3666.0 3843.9 3855.9 3870.4 3901.7 10941.3 11295.9 11323.0 11344.8 11375.5 11136.1 11174.6 11197.9 11214.8 11261.4 8020.7 8430.6 8443.9 8460.5 8577.7 5420.9 5921.3 5929.6 5983.5 6071.5 9970.5 10188.5 10324.2 10345.7 10447.9 8900.3 10338.7 10549.8 10707.3 10708.7 7644.2 7805.8 7811.0 7850.3 7931.4 8379.3 8444.6 8466.2 8523.0 8532.4 7455.3 7688.9 7697.4 7773.4 7886.3 7500.6 7517.9 7568.4 7618.9 7661.9 7047.7 7115.9 7116.6 7122.0 7122.4 4781.6 4837.4 4950.1 4976.0 5068.0 4914.0 4938.2 4985.8 5008.3 5047.2 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | [#4] prototype.html Cycles:180 Average:4528.73 Median:4944.72 stddev:1428.56 (28.9%) stddev-sans-first:1395.81 14:52:29 INFO - PROCESS | 1928 | Values: 238.9 253.6 257.9 272.3 284.3 4529.1 5441.4 5551.2 5591.3 5627.2 4316.8 5277.8 5428.2 5502.4 5518.8 3868.8 4204.3 4242.1 4243.9 4252.3 3413.4 3511.8 4141.8 4237.6 4268.5 3751.9 3808.4 4082.4 4087.4 4149.3 3413.7 3450.0 3692.0 3951.9 4139.7 3390.2 3544.8 3546.8 3566.3 3574.9 4486.9 5359.4 5385.5 5458.3 5484.5 4709.6 4756.6 4765.8 4787.6 4802.0 5121.3 5299.0 5498.8 5655.4 5893.3 3642.5 3901.6 3901.7 3921.7 3930.7 5112.0 5152.5 6122.5 6215.3 6263.5 3506.6 3802.8 3933.3 3976.2 3979.1 3730.9 3922.3 4034.9 4040.0 4066.3 4748.5 4749.5 4755.0 4777.1 4791.0 4859.9 4976.7 5662.9 5902.7 5967.9 1276.2 1290.5 1333.9 1336.2 1376.6 768.4 886.2 915.6 920.4 922.0 5080.1 5221.6 5350.4 5404.9 5437.6 5915.0 5918.8 5921.4 5939.9 5976.6 4914.7 5309.5 5311.0 5362.8 5462.2 2158.7 2309.3 2423.5 2665.2 2697.2 4385.0 4486.6 4642.4 4774.8 5139.0 4690.7 5114.0 5116.5 5122.0 5127.5 4749.5 4791.1 5104.8 5127.3 5155.8 4352.3 4690.3 4820.6 4935.0 4935.1 4180.4 4890.9 5030.8 5483.4 6232.5 6293.6 6308.5 6313.7 6337.7 6348.4 3255.6 3998.5 4023.2 4041.0 4056.9 5014.4 5222.5 5878.9 6056.8 6107.6 5102.0 5244.6 5685.1 5888.5 5908.4 5213.4 5832.6 5871.1 5900.7 5908.3 4698.7 4925.7 5436.3 5749.4 5780.1 4954.4 5887.9 5969.7 5969.7 5978.4 5345.7 5800.5 5837.9 5842.7 5859.4 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - PROCESS | 1928 | [#5] yui.html Cycles:180 Average:24098.94 Median:21418.68 stddev:37777.37 (176.4%) stddev-sans-first:37842.46 14:52:29 INFO - PROCESS | 1928 | Values: 691.2 700.3 710.6 719.5 730.2 15405.2 15418.2 15721.0 15851.1 15870.6 14083.3 14291.9 14295.3 14381.1 14392.6 825.4 848.5 852.1 853.7 854.6 676.3 689.6 841.2 866.8 874.0 868.8 901.8 905.9 905.9 907.4 872.3 895.5 897.9 900.3 900.6 650.4 667.3 667.4 667.9 668.3 15003.9 15028.8 15030.6 15037.5 15040.0 14825.3 14880.9 14923.2 14983.6 15195.8 10131.7 10910.1 11801.9 11979.1 12092.5 3714.6 3752.6 3814.6 3890.9 3900.2 102869.0 108324.0 120034.4 122113.0 130006.7 10270.8 10501.3 10954.5 11298.7 11500.5 17299.8 21394.4 21443.0 21482.9 21531.2 7644.8 7684.2 7718.3 7783.6 7857.5 4296.0 4348.6 4396.9 4401.8 4441.1 3388.7 3494.8 3509.1 3509.6 3524.7 628.8 643.6 648.5 650.9 656.4 587.5 596.3 600.9 610.3 635.1 8710.0 9070.6 9094.4 9274.5 9465.3 551.7 566.0 595.9 620.5 624.5 4310.4 4494.6 4499.3 4509.1 4585.4 102062.0 102998.0 148243.0 152493.5 153038.2 106825.8 115941.0 120011.0 126815.4 128744.4 105602.0 105844.5 109253.0 113781.9 115636.0 9372.9 10048.7 10144.9 10261.1 10310.1 46252.8 51508.7 54249.9 61511.7 64720.4 67076.3 72075.6 95251.5 96468.0 97066.5 14241.9 14323.2 14341.9 14416.3 14695.4 14709.6 14804.0 14848.5 15278.9 15959.8 13793.6 13870.6 13997.0 14001.4 14658.7 14216.8 14330.6 14869.3 14893.3 15014.0 13489.7 13730.7 13799.9 14092.7 14540.4 11437.6 11582.9 11665.9 11922.5 12076.5 11624.5 11639.5 11667.8 11808.4 11941.9 14:52:29 INFO - PROCESS | 1928 | -------- Summary: end -------- 14:52:29 INFO - PROCESS | 1928 | 14:52:29 INFO - TEST-INFO | 1928: exit 0 14:52:29 INFO - TEST-OK | dromaeo_css | took 1113670ms 14:52:29 INFO - TEST-START | kraken 14:52:29 INFO - operating with platform_type : mac_ 14:52:29 INFO - Initialising browser for kraken test... 14:52:29 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpiN6tJ_/profile http://localhost:49451/getInfo.html) 14:52:32 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 14:52:32 INFO - PROCESS | 1935 | colorDepth:24 14:52:32 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 14:52:32 INFO - PROCESS | 1935 | __metrics 14:52:32 ERROR - PROCESS | 1935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 14:52:33 INFO - TEST-INFO | 1935: exit 0 14:52:33 INFO - Browser initialized. 14:52:33 INFO - Running cycle 1/1 for kraken test... 14:52:33 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpiN6tJ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:45 INFO - PROCESS | 1937 | RSS: Main: 225202176 14:52:45 INFO - PROCESS | 1937 | 14:52:48 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:49 INFO - PROCESS | 1937 | RSS: Main: 237912064 14:52:49 INFO - PROCESS | 1937 | 14:52:51 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-dft) 14:52:52 INFO - PROCESS | 1937 | RSS: Main: 245342208 14:52:52 INFO - PROCESS | 1937 | 14:52:55 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-fft) 14:52:56 INFO - PROCESS | 1937 | RSS: Main: 249122816 14:52:56 INFO - PROCESS | 1937 | 14:52:58 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-oscillator) 14:52:58 INFO - PROCESS | 1937 | RSS: Main: 249421824 14:52:58 INFO - PROCESS | 1937 | 14:53:01 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:53:01 INFO - PROCESS | 1937 | RSS: Main: 250826752 14:53:01 INFO - PROCESS | 1937 | 14:53:04 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49451/tests/kraken/driver.html?testName=imaging-darkroom) 14:53:05 INFO - PROCESS | 1937 | RSS: Main: 251764736 14:53:05 INFO - PROCESS | 1937 | 14:53:08 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49451/tests/kraken/driver.html?testName=imaging-desaturate) 14:53:09 INFO - PROCESS | 1937 | RSS: Main: 251920384 14:53:09 INFO - PROCESS | 1937 | 14:53:12 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49451/tests/kraken/driver.html?testName=json-parse-financial) 14:53:13 INFO - PROCESS | 1937 | RSS: Main: 251826176 14:53:13 INFO - PROCESS | 1937 | 14:53:14 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:53:15 INFO - PROCESS | 1937 | RSS: Main: 251199488 14:53:15 INFO - PROCESS | 1937 | 14:53:17 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:53:18 INFO - PROCESS | 1937 | RSS: Main: 251248640 14:53:18 INFO - PROCESS | 1937 | 14:53:20 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:53:20 INFO - PROCESS | 1937 | RSS: Main: 251363328 14:53:20 INFO - PROCESS | 1937 | 14:53:23 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:53:24 INFO - PROCESS | 1937 | RSS: Main: 251559936 14:53:24 INFO - PROCESS | 1937 | 14:53:27 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:53:27 INFO - PROCESS | 1937 | RSS: Main: 251437056 14:53:27 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49451/tests/kraken/driver.html?testName=ai-astar) 14:53:29 INFO - PROCESS | 1937 | RSS: Main: 252936192 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | __start_tp_report 14:53:29 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 14:53:29 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 14:53:29 INFO - PROCESS | 1937 | |i|pagename|runs| 14:53:29 INFO - PROCESS | 1937 | |0;ai-astar;104;119;116;116;120;118;122;171;174;117 14:53:29 INFO - PROCESS | 1937 | |1;audio-beat-detection;152;110;131;179;141;112;113;112;136;112 14:53:29 INFO - PROCESS | 1937 | |2;audio-dft;200;206;195;197;202;196;223;283;205;194 14:53:29 INFO - PROCESS | 1937 | |3;audio-fft;94;72;52;87;52;56;63;51;78;83 14:53:29 INFO - PROCESS | 1937 | |4;audio-oscillator;116;102;124;93;70;72;90;72;100;121 14:53:29 INFO - PROCESS | 1937 | |5;imaging-gaussian-blur;135;132;89;87;91;106;119;76;133;133 14:53:29 INFO - PROCESS | 1937 | |6;imaging-darkroom;99;97;172;172;141;171;100;99;102;99 14:53:29 INFO - PROCESS | 1937 | |7;imaging-desaturate;113;117;91;125;94;149;146;81;155;151 14:53:29 INFO - PROCESS | 1937 | |8;json-parse-financial;52;56;58;57;62;60;60;62;66;82 14:53:29 INFO - PROCESS | 1937 | |9;json-stringify-tinderbox;68;69;75;81;76;69;71;72;73;69 14:53:29 INFO - PROCESS | 1937 | |10;stanford-crypto-aes;84;83;84;82;88;87;82;89;85;86 14:53:29 INFO - PROCESS | 1937 | |11;stanford-crypto-ccm;139;140;156;150;158;156;146;145;171;154 14:53:29 INFO - PROCESS | 1937 | |12;stanford-crypto-pbkdf2;166;167;169;165;167;184;209;169;167;169 14:53:29 INFO - PROCESS | 1937 | |13;stanford-crypto-sha256-iterative;69;68;68;66;84;66;63;63;86;87 14:53:29 INFO - PROCESS | 1937 | __end_tp_report 14:53:29 INFO - PROCESS | 1937 | __start_cc_report 14:53:29 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,943 14:53:29 INFO - PROCESS | 1937 | __end_cc_report 14:53:29 INFO - PROCESS | 1937 | __startTimestamp1477000409925__endTimestamp 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | ------- Summary: start ------- 14:53:29 INFO - PROCESS | 1937 | Number of tests: 14 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#0] ai-astar Cycles:10 Average:127.70 Median:119.50 stddev:24.11 (20.2%) stddev-sans-first:23.99 14:53:29 INFO - PROCESS | 1937 | Values: 104.0 119.0 116.0 116.0 120.0 118.0 122.0 171.0 174.0 117.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:133.50 stddev:22.86 (17.1%) stddev-sans-first:22.79 14:53:29 INFO - PROCESS | 1937 | Values: 152.0 110.0 131.0 179.0 141.0 112.0 113.0 112.0 136.0 112.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#2] audio-dft Cycles:10 Average:210.10 Median:203.50 stddev:26.98 (13.3%) stddev-sans-first:28.36 14:53:29 INFO - PROCESS | 1937 | Values: 200.0 206.0 195.0 197.0 202.0 196.0 223.0 283.0 205.0 194.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#3] audio-fft Cycles:10 Average:68.80 Median:75.00 stddev:16.13 (21.5%) stddev-sans-first:14.30 14:53:29 INFO - PROCESS | 1937 | Values: 94.0 72.0 52.0 87.0 52.0 56.0 63.0 51.0 78.0 83.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:71.00 stddev:20.37 (28.7%) stddev-sans-first:20.28 14:53:29 INFO - PROCESS | 1937 | Values: 116.0 102.0 124.0 93.0 70.0 72.0 90.0 72.0 100.0 121.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:105.50 stddev:22.98 (21.8%) stddev-sans-first:22.53 14:53:29 INFO - PROCESS | 1937 | Values: 135.0 132.0 89.0 87.0 91.0 106.0 119.0 76.0 133.0 133.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#6] imaging-darkroom Cycles:10 Average:125.20 Median:134.50 stddev:34.57 (25.7%) stddev-sans-first:35.34 14:53:29 INFO - PROCESS | 1937 | Values: 99.0 97.0 172.0 172.0 141.0 171.0 100.0 99.0 102.0 99.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#7] imaging-desaturate Cycles:10 Average:122.20 Median:153.00 stddev:27.44 (17.9%) stddev-sans-first:28.90 14:53:29 INFO - PROCESS | 1937 | Values: 113.0 117.0 91.0 125.0 94.0 149.0 146.0 81.0 155.0 151.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.00 stddev:8.15 (13.4%) stddev-sans-first:7.89 14:53:29 INFO - PROCESS | 1937 | Values: 52.0 56.0 58.0 57.0 62.0 60.0 60.0 62.0 66.0 82.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:4.08 (5.6%) stddev-sans-first:4.02 14:53:29 INFO - PROCESS | 1937 | Values: 68.0 69.0 75.0 81.0 76.0 69.0 71.0 72.0 73.0 69.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:2.45 (2.9%) stddev-sans-first:2.57 14:53:29 INFO - PROCESS | 1937 | Values: 84.0 83.0 84.0 82.0 88.0 87.0 82.0 89.0 85.0 86.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:155.00 stddev:9.62 (6.2%) stddev-sans-first:9.08 14:53:29 INFO - PROCESS | 1937 | Values: 139.0 140.0 156.0 150.0 158.0 156.0 146.0 145.0 171.0 154.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:169.00 stddev:13.69 (8.1%) stddev-sans-first:14.27 14:53:29 INFO - PROCESS | 1937 | Values: 166.0 167.0 169.0 165.0 167.0 184.0 209.0 169.0 167.0 169.0 14:53:29 INFO - PROCESS | 1937 | 14:53:29 INFO - PROCESS | 1937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:68.50 stddev:9.66 (14.1%) stddev-sans-first:10.19 14:53:29 INFO - PROCESS | 1937 | Values: 69.0 68.0 68.0 66.0 84.0 66.0 63.0 63.0 86.0 87.0 14:53:29 INFO - PROCESS | 1937 | -------- Summary: end -------- 14:53:29 INFO - PROCESS | 1937 | 14:53:30 INFO - TEST-INFO | 1937: exit 0 14:53:30 INFO - TEST-OK | kraken | took 61167ms 14:53:30 INFO - SUITE-END | took 1174s 14:53:31 INFO - Completed test suite (00:19:35) 14:53:31 INFO - javascript benchmark 14:53:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7345.507637488682, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.5382273393084, 3434.8626054957804, 3450.051235910126, 3470.3753324401614, 3471.6875481206703, 5928.051511758114, 5982.8803423931495, 6007.068904319826, 6009.2788865336115, 6015.939840601593, 5973.611715238518, 5997.6101553399, 6027.306859711134, 6029.0, 6030.457258846703, 5366.356037275523, 5401.108817045183, 5415.241866138724, 5461.2354270402175, 5533.833984980457, 5449.155380915964, 5472.753726082336, 5473.343198816147, 5478.506934375905, 5506.201600767887, 5351.384590772052, 5354.732263386834, 5459.481349271813, 5459.727013649302, 5465.316835395575, 5374.167004114369, 5387.0, 5460.34475862895, 5496.038193316153, 5524.419935906712, 5250.291210686547, 5357.1696387060065, 5407.864803379907, 5411.107167317388, 5430.0, 5756.7985120521, 5932.970335148297, 5989.520838332923, 6071.51427885768, 6074.817755467343, 5969.820905372846, 6137.9286238596105, 6145.340757995361, 6237.750489980395, 6295.244570651551, 5263.34208223972, 5729.541636669098, 6321.020241862473, 6331.746730130789, 6332.176817013805, 5996.340402555716, 6003.219581454383, 6022.819315420545, 6033.909491357633, 6036.456718895321, 6264.968675156595, 6284.0, 6330.715117819709, 6380.202474690664, 6380.840478988062, 5097.8215762448135, 5372.597055220874, 5544.833654990357, 6277.686115694289, 6333.904991425133, 5234.476552344735, 6344.143540622049, 6344.968275158687, 6352.936470635234, 6361.045843123568, 5197.7141257231215, 6136.4578081083455, 6272.247330320391, 6301.40136687014, 6314.968425157845, 5253.947460525423, 5465.535429488538, 5573.0, 6291.874162516724, 6340.207474065742, 5015.724135172528, 5016.44819069902, 5028.874278143003, 5040.7731652075745, 5074.82238121664, 4475.082608065404, 4484.529124441952, 4489.9775501122285, 4536.5236650151255, 4543.25036369002, 5296.92054619181, 5943.881122377528, 5945.286565612154, 5979.252593425822, 6048.092786082123, 6291.653959032205, 6342.651154186564, 6355.459785918156, 6361.268454127742, 6362.745490180433, 5159.097157997336, 5864.149698293809, 5937.317208520989, 5953.226080609493, 5991.340952495222, 5563.304586926634, 5573.442655734394, 5583.022970980062, 5585.553155747531, 5619.943800561942, 6472.676366181672, 6489.448396886129, 6495.805125846232, 6498.545101842826, 6499.480041596756, 6215.751369945332, 6225.128482012612, 6289.528285378524, 6376.649284289409, 6406.455451286693, 6314.273858506331, 6432.839179020375, 6435.292117866938, 6449.774257900951, 6450.516211284266, 6266.68666566679, 6274.466670333073, 6296.401841825019, 6311.368863113652, 6312.652804095819, 5368.946310536845, 6200.627962322275, 6253.405926436982, 6354.205724284465, 6393.456556192589, 6075.36208698098, 6232.781852635136, 6289.7169627365965, 6313.747450101944, 6317.210348706411, 6273.121762953281, 6307.90538141919, 6317.273513546001, 6332.651704156316, 6361.840953976188, 5942.970285148546, 6044.032954727222, 6145.8156255312415, 6159.907601386072, 6220.191375121205, 6212.534059945612, 6221.5333849960525, 6227.314995350417, 6252.906206406817, 6301.842453938688, 6216.44052035319, 6235.407636274546, 6242.875142497215, 6252.343503932204, 6259.906101408392], "value": 5799.053091392296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.59527485099665, 510.8722819295176, 515.4304493534642, 518.5118709304296, 521.353521633175, 37967.24065518688, 39742.20515589687, 39742.602573974254, 39872.601273987326, 39953.801385958395, 39749.801250993776, 40431.797841010826, 40433.0, 40589.797051014706, 40732.592674073254, 9708.951455242732, 9934.155596774282, 9943.850842237372, 9955.153811925959, 9960.103590676837, 9802.460864652441, 9873.012698730105, 9880.555375008105, 9930.404175749478, 9937.403755774676, 8413.368997325226, 8538.615762290712, 8960.731178064669, 9906.950465247664, 9919.057689519484, 9842.70471885841, 9887.703368898945, 9888.901110988942, 9891.752706182331, 10045.397276163454, 9788.608455661764, 9852.852207216898, 9865.112139907444, 9874.358166719212, 9878.851817222676, 32648.0, 39344.0, 39416.80291598552, 39419.0, 39450.210995779926, 3161.2571045804216, 3302.108430723715, 3782.167923056923, 3884.6309600587897, 4153.0447996960565, 28925.710742892723, 29543.704562954525, 30096.548551771742, 30318.54522182147, 30496.69503304983, 3078.1688943985223, 3126.796758210709, 3181.1410919051727, 3190.441672707267, 3203.855826487814, 444260.0, 524010.0, 525614.7438525604, 528246.0, 529941.3502932499, 60586.39413605896, 61004.0, 61265.0, 61318.69340653357, 61381.772364553355, 33923.0, 33974.810881619516, 34675.0, 35571.644283557354, 35666.64333356685, 16628.418005369753, 16789.664206716043, 16829.242684079247, 16830.663386732198, 16838.831611683727, 12889.935550322376, 12964.28696421687, 12986.961043116527, 12996.415161317764, 12997.415116319788, 17594.560135996704, 18017.459476215736, 18564.25742970293, 18590.907045464955, 18789.62420751577, 6861.55399899015, 7919.683212671429, 8120.512769233865, 8135.1051384347675, 8177.550234737147, 810.805406702399, 813.4631143445298, 938.7887725261761, 944.6835310171032, 1037.6108959140322, 25923.0, 28547.57178642322, 28621.425821580015, 29152.0, 30081.849590751906, 966.3235734985539, 1018.9620758483034, 1033.7932413517326, 1060.8726952765717, 1132.5866058888612, 14919.030263032868, 15217.61955951088, 15275.618109547127, 15460.226988650522, 15560.45538406173, 661623.0, 675804.0, 677777.0, 678517.0, 678737.0, 54184.0, 54490.0, 54675.179872301946, 54678.0, 54768.72615636896, 1314.5399110311314, 1350.6015725361042, 1368.2679766324968, 1370.8766211041054, 1373.0937581196363, 24200.394990125387, 28846.7115328844, 29259.85370073136, 29610.851945740134, 30073.849630751705, 47597.76201118972, 47813.0, 47923.52076479191, 47927.76036119797, 48076.27885581789, 575734.0, 577610.1119494544, 579860.2013979806, 580170.0, 580853.0, 25632.102876399236, 25858.87070564635, 26071.73928260693, 26091.739082608932, 26378.604320935585, 40152.19695606013, 44470.0, 44966.0, 46376.768116159205, 46415.76792116018, 32630.673693263714, 33551.83224083961, 37738.43392349062, 37805.24389512139, 37933.0, 36982.63017369792, 37310.62689373072, 38418.0, 38540.80729596334, 38660.6133938657, 36012.09969750777, 36253.0, 36775.816120919226, 36998.0, 37045.81477092597, 32417.83791081124, 33700.66299337073, 34126.82936585301, 34211.31577368389, 34227.4865877007, 20187.899060504602, 24895.751042489344, 24917.127900523396, 25231.354657475687, 25329.551809538643], "value": 19430.30986800745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.0815731065613, 374.771389452434, 383.1474968195765, 384.03798484795584, 395.59253968412526, 19686.606267874653, 22018.0, 22134.88932555337, 22258.443538911535, 22338.664920026193, 20300.59398812023, 20564.280250191245, 20733.792662073374, 20753.584928301425, 21266.680999785014, 5858.0, 5922.170896074553, 6086.908696369536, 6130.325664176937, 6138.938610613904, 3973.403989401584, 4181.853635122771, 6066.150738896558, 6080.331163572004, 6119.938800611982, 6364.968175159118, 6662.267150613428, 6732.798016059526, 6770.018347339657, 6779.62712050837, 6569.901451478232, 6744.7976560703255, 6832.4192443642105, 6850.6574671266735, 6851.828704282383, 5199.688018718851, 5914.172015917775, 5948.583599148062, 5961.374055724174, 5968.283805943272, 24089.879550602134, 24296.149634762874, 25266.621000685005, 25431.237062888144, 25432.872835635702, 2225.9109635614554, 2241.1931704586336, 2245.708057952456, 2274.627367754518, 2920.4305160493714, 10032.899671003343, 10161.949190254076, 10229.335093218917, 12913.483460661562, 13704.931475342559, 1634.7466142747894, 1640.9179541022902, 1837.118183272037, 1843.769528808899, 1857.749203857489, 99180.0, 116406.0, 116770.0, 122429.77570224361, 125647.0, 11589.24669896454, 11688.532458701557, 11861.169718119649, 11898.881011189776, 12043.397830108635, 14684.926575367268, 14803.925980370244, 14806.037607555474, 14814.481493147689, 14820.3330850112, 8600.913990860012, 8749.431286966326, 8764.56177191138, 8765.91234087651, 8772.824543509094, 7594.658240379196, 8400.781886626404, 8712.21590056898, 8808.603612837438, 8875.644974201088, 4544.863654090383, 4561.156186105581, 4621.514740952219, 4626.7223966562115, 4631.930521042187, 1564.593205766486, 1596.5370042687723, 1600.4958438091965, 1929.2668785861283, 1948.1720268885667, 653.9967300163564, 839.1482645115213, 854.4147259127518, 865.9176029962547, 888.853339199025, 20871.58256834855, 21359.25242616501, 21398.358049258546, 21423.57152856934, 21533.569328613652, 890.2788741119714, 895.0959530873864, 921.2952091649893, 936.4755736787421, 988.1748739802346, 9873.703788886345, 10842.403667798348, 11285.887141128647, 11302.660920172408, 11353.091752659768, 594201.0289948522, 598242.0087899619, 601316.0, 614965.0, 619318.0, 121794.3910280443, 130531.38937221392, 131922.02116968253, 135039.32480337535, 135390.0, 902.7427183252872, 938.7043081429327, 948.4167237149242, 952.2524818017823, 952.7332346942867, 17593.82406175922, 18393.98833064141, 18962.86222826635, 18975.90512047486, 19000.52498687544, 48852.75573622251, 48895.77760556014, 49224.75387623039, 49708.508744737715, 51022.74488627533, 68802.28809463391, 70220.0, 72446.0, 72577.0, 72597.6370118146, 6231.594946328474, 7205.71177152929, 7249.347558719741, 7382.4094072473, 7455.888161677688, 9038.954805225932, 11917.582884598998, 12507.93746031264, 12661.113722039368, 12905.0, 8593.238386130954, 10438.11276041545, 10692.732681683021, 11394.829077563678, 11769.646910592695, 11009.559617615205, 11117.0, 11388.202825802115, 11438.82841757391, 11672.88327116718, 11307.886921131012, 11378.943105284421, 11537.711557211136, 11586.594469193538, 11805.763884722086, 8200.794980125545, 8297.377696672653, 8371.790705232417, 8377.83244335122, 8430.83138337242, 10645.414502202453, 11092.667219983414, 11207.66377008691, 11270.718232044264, 11449.656510304705], "value": 9549.682360384379, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.7071671024148, 1538.7614919687446, 1736.609262915844, 1795.3626462605782, 1844.797072322045, 8117.9594102029405, 8342.374321925865, 8640.308775297977, 9250.629974801008, 9251.398659087172, 8605.870911936327, 8963.327750418712, 8985.595648195831, 8997.685081022166, 9073.727788166349, 2237.026893301411, 2309.538092381522, 2395.2694428199393, 2423.4789520253144, 2448.6449464827588, 2414.987925060372, 2424.5514579802707, 2444.8899799508977, 2458.0659349447274, 2463.581191197492, 2338.7895089441945, 2349.3186975777003, 2364.9527009459803, 2365.82256330775, 2368.2539999899977, 2392.6650268962358, 2393.401649587603, 2401.6037353836596, 2429.2226487524, 2439.8536087834786, 2405.530921470314, 2426.8179886508583, 2428.417179876817, 2429.8906549205153, 2434.5982912819363, 9004.279657627374, 9132.634694612207, 9133.041030691747, 9154.40496367734, 9160.129787670161, 4124.546299907038, 4540.9772951135365, 4699.318598803188, 4767.213409787381, 5142.742862856842, 3295.505674148873, 3389.8983030509125, 3587.1749497615433, 3737.7009839212797, 3766.0773110587807, 1061.3260579531975, 1069.3316677076828, 1106.950187241576, 1129.570763110021, 1813.8548916086681, 9754.219662426989, 11734.00260977818, 11867.287962722177, 12075.93962030193, 12089.818652720216, 4005.0, 4505.008898042425, 4652.464966528893, 4735.455422626442, 4740.265258884879, 8569.671700886372, 9296.907030929739, 9368.2973776967, 9389.38968967015, 9409.341346105706, 5148.613853960968, 5338.839834804962, 5357.464253574612, 5357.9819834231375, 5393.6763794172475, 4483.372327874035, 4623.976880115578, 4874.488178741181, 5015.924761128586, 5033.1695270280725, 3898.2593307272095, 3902.726809123391, 3926.155876486569, 4035.1526179502634, 4043.474348334698, 995.5221493683073, 1186.9703257418462, 1193.6538403862783, 1200.3578085724096, 1213.9757204855853, 847.2798121596717, 858.6393714639867, 872.376250980552, 891.6656253904786, 896.0815164456484, 5829.242198514251, 5925.288965324103, 5981.910271345933, 6045.33501314855, 6197.070439434121, 872.284726524244, 895.2256298302052, 901.4230892228978, 919.94940278284, 966.9661561845302, 3666.0, 3843.9039024024623, 3855.9228815424094, 3870.40008798631, 3901.668358189586, 10941.28881622692, 11295.887041129648, 11323.037541808873, 11344.773104537862, 11375.488103035383, 11136.109111271078, 11174.60888868902, 11197.888021119685, 11214.775704485864, 11261.436928153724, 8020.679172833138, 8430.6206220719, 8443.915560844436, 8460.450070745383, 8577.656893724306, 5420.945790542044, 5921.348651648229, 5929.644221346733, 5983.521318294439, 6071.453569178795, 9970.50147492637, 10188.541515631667, 10324.22568307365, 10345.689629311133, 10447.850736418835, 8900.332475064526, 10338.689839304832, 10549.841752373566, 10707.304025238334, 10708.678739637824, 7644.197359277196, 7805.804854878674, 7810.960945195465, 7850.2542258485355, 7931.444798864024, 8379.287760540423, 8444.619992100248, 8466.238038576557, 8523.0, 8532.402731808714, 7455.329020388191, 7688.884666729891, 7697.384209263358, 7773.41699372538, 7886.250806173404, 7500.62496875165, 7517.887231691419, 7568.356689681439, 7618.923810762043, 7661.88507172404, 7047.6828542714675, 7115.897035959435, 7116.644167791486, 7121.9643901780155, 7122.358987691133, 4781.641376896816, 4837.395325584302, 4950.133726597903, 4976.0047990401345, 5067.974660126823, 4913.950860491493, 4938.209886418156, 4985.800567977385, 5008.298838162587, 5047.192449208109], "value": 4624.422070080026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [238.86981595030713, 253.56387014335343, 257.86795965710536, 272.3409349374515, 284.33323855558706, 4529.139463501941, 5441.395362776337, 5551.222828803966, 5591.30108736408, 5627.240322556454, 4316.784160791955, 5277.788888444467, 5428.240046393508, 5502.394736578973, 5518.806841760539, 3868.8065596720053, 4204.285271503852, 4242.109157077018, 4243.856852289589, 4252.319628859384, 3413.4026545354463, 3511.806850623215, 4141.772202528859, 4237.597428244328, 4268.487781466213, 3751.9437208441896, 3808.409696497047, 4082.387456954516, 4087.4481944937497, 4149.315362965122, 3413.7098346640564, 3449.965500345015, 3691.9630803692157, 3951.932978095927, 4139.710220284582, 3390.237196630763, 3544.805035723034, 3546.7871927684164, 3566.286742651454, 3574.874879379235, 4486.945567791567, 5359.437259087778, 5385.515303622654, 5458.342910250142, 5484.478974497416, 4709.599684026862, 4756.643251756098, 4765.833195838129, 4787.611592638131, 4802.0, 5121.334226550524, 5299.046171689094, 5498.762778374874, 5655.434456554352, 5893.322267939199, 3642.453631955228, 3901.5708272090046, 3901.707371947087, 3921.666658334045, 3930.6658933990643, 5112.0, 5152.4963025142515, 6122.479589234876, 6215.316315205324, 6263.498920086382, 3506.5967413747235, 3802.8098595070137, 3933.2920074386884, 3976.204759048202, 3979.1245925896255, 3730.9440358394645, 3922.2743792398496, 4034.9105741449644, 4039.9596004040172, 4066.268071747055, 4748.548887855648, 4749.453812811571, 4755.001449695534, 4777.140114779373, 4790.96384036783, 4859.854204373874, 4976.726280054631, 5662.858428539237, 5902.675352855548, 5967.910481342697, 1276.2151276964785, 1290.458007636776, 1333.8866196373224, 1336.211635135275, 1376.6076668149728, 768.4390395011673, 886.1537231943479, 915.5925613102106, 920.40173886974, 922.0456827183832, 5080.120355468501, 5221.6083793715625, 5350.357957045179, 5404.91892621611, 5437.564994800407, 5915.0, 5918.81623675258, 5921.40785921413, 5939.881202375928, 5976.581639285295, 4914.680545764514, 5309.469053094737, 5311.017461769585, 5362.812301569426, 5462.180672899097, 2158.7409510858483, 2309.330294214659, 2423.515296940619, 2665.18711792905, 2697.204324724211, 4384.956150438518, 4486.5962063414445, 4642.375168690931, 4774.785134668949, 5138.974305128525, 4690.695104818176, 5114.008305141534, 5116.539511443988, 5121.9743901281, 5127.53852153308, 4749.527646429618, 4791.089133638049, 5104.846854594294, 5127.307813445212, 5155.819546315861, 4352.303631419084, 4690.3433519306645, 4820.566149046603, 4934.9753251233515, 4935.062338155739, 4180.432337873298, 4890.853274401774, 5030.798768049237, 5483.40981115488, 6232.5325600581045, 6293.590916590407, 6308.495320374451, 6313.737252549417, 6337.746490140527, 6348.428886301055, 3255.6418793932176, 3998.4602078719, 4023.1953609277675, 4040.9797951010055, 4056.939145912873, 5014.398272207212, 5222.524070152907, 5878.941210587839, 6056.818295451144, 6107.633541987495, 5102.0, 5244.606654500852, 5685.123909109901, 5888.4700376966275, 5908.350081490947, 5213.426523082382, 5832.62087964281, 5871.119332100219, 5900.7049647518315, 5908.336831164534, 4698.707855339809, 4925.655204135819, 5436.314742429701, 5749.367569567428, 5780.121460525262, 4954.380702412199, 5887.911681324869, 5969.73136208863, 5969.731502029201, 5978.372270911492, 5345.65253258537, 5800.50695690871, 5837.869177750175, 5842.737076831638, 5859.414058594107], "value": 4059.090006956083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.2051141187634, 700.2717174138896, 710.6304721544797, 719.4532155561778, 730.2405498281787, 15405.229738513086, 15418.229088545584, 15720.999999999985, 15851.128187949658, 15870.603234919134, 14083.29583520825, 14291.857081429183, 14295.285235738198, 14381.065230759994, 14392.640183995405, 825.3768404854342, 848.4781859156606, 852.0542198160038, 853.6585365853646, 854.6325080215505, 676.3067855448156, 689.5690193628982, 841.1798496465958, 866.7529754020105, 873.9956300218522, 868.8479516084692, 901.7565257380503, 905.8867641544807, 905.9229965452912, 907.4101833808012, 872.3326655108815, 895.5208963204719, 897.851854444016, 900.2977677411629, 900.6217388696763, 650.4146268358468, 667.349334398962, 667.3926726678748, 667.9398854103106, 668.2682462703332, 15003.924980375137, 15028.774568381483, 15030.624234394227, 15037.548873533811, 15040.0, 14825.332860021217, 14880.925595371953, 14923.179225142612, 14983.625409364744, 15195.772063419057, 10131.746706332327, 10910.127189824794, 11801.94099029508, 11979.10156738248, 12092.516299348103, 3714.572824125233, 3752.6052833650906, 3814.561325447581, 3890.9416358754643, 3900.2394533066063, 102869.0, 108324.0, 120034.39982800117, 122113.0, 130006.6999330004, 10270.794584108276, 10501.264911456277, 10954.452277386259, 11298.661040168809, 11500.482478288497, 17299.827001730075, 21394.35816925495, 21443.0, 21482.892585537284, 21531.246406375703, 7644.770656880191, 7684.154742978268, 7718.266764657348, 7783.649735761905, 7857.489263197874, 4296.013823511905, 4348.586884245991, 4396.934045989313, 4401.779911004437, 4441.0673758511075, 3388.728901687859, 3494.790312581253, 3509.105178179599, 3509.5788505379005, 3524.6827785499427, 628.8302158417201, 643.6331291163991, 648.5460177875411, 650.9381608747257, 656.3731636287334, 587.4859497939303, 596.3350863786933, 600.9278886533557, 610.2829175718513, 635.1330433957614, 8710.0, 9070.637174513078, 9094.408863423856, 9274.489903055262, 9465.337426380087, 551.7131091832225, 565.9784089718016, 595.8986972214648, 620.5190976992776, 624.4536030972898, 4310.396544483775, 4494.595486406174, 4499.280115181556, 4509.075639493962, 4585.358049873021, 102062.0, 102998.0, 148243.0, 152493.47506524794, 153038.23480882746, 106825.79522614178, 115941.0, 120011.0, 126815.36592317164, 128744.35627821801, 105602.0, 105844.47077764562, 109253.0, 113781.86218137878, 115636.0, 9372.906270937476, 10048.69853904384, 10144.898551014396, 10261.127804136731, 10310.123639490726, 46252.84367890695, 51508.74245628748, 54249.91500169896, 61511.6924415375, 64720.35279647143, 67076.32923670701, 72075.55848883098, 95251.52374238084, 96468.0, 97066.5146674262, 14241.857581424054, 14323.212223327817, 14341.9282903589, 14416.279186040865, 14695.41218351254, 14709.55871323862, 14804.0, 14848.480303189337, 15278.936702824793, 15959.760603591189, 13793.586192414243, 13870.612938706048, 13997.0, 14001.369938352595, 14658.70682586321, 14216.786748198578, 14330.57008289753, 14869.330880110205, 14893.287271963864, 15014.024088434217, 13489.730205396034, 13730.65673358174, 13799.931000344934, 14092.718145637235, 14540.41838326455, 11437.59968401102, 11582.88417115818, 11665.883341166818, 11922.52309907594, 12076.45655945467, 11624.535018599161, 11639.47622357013, 11667.76664466689, 11808.409579521162, 11941.880581194077], "value": 7776.322875482148, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 116.0, 116.0, 120.0, 118.0, 122.0, 171.0, 174.0, 117.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 110.0, 131.0, 179.0, 141.0, 112.0, 113.0, 112.0, 136.0, 112.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 206.0, 195.0, 197.0, 202.0, 196.0, 223.0, 283.0, 205.0, 194.0], "value": 210.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 72.0, 52.0, 87.0, 52.0, 56.0, 63.0, 51.0, 78.0, 83.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 102.0, 124.0, 93.0, 70.0, 72.0, 90.0, 72.0, 100.0, 121.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 89.0, 87.0, 91.0, 106.0, 119.0, 76.0, 133.0, 133.0], "value": 110.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 172.0, 172.0, 141.0, 171.0, 100.0, 99.0, 102.0, 99.0], "value": 125.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 91.0, 125.0, 94.0, 149.0, 146.0, 81.0, 155.0, 151.0], "value": 122.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 58.0, 57.0, 62.0, 60.0, 60.0, 62.0, 66.0, 82.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 75.0, 81.0, 76.0, 69.0, 71.0, 72.0, 73.0, 69.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 82.0, 88.0, 87.0, 82.0, 89.0, 85.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 156.0, 150.0, 158.0, 156.0, 146.0, 145.0, 171.0, 154.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 169.0, 165.0, 167.0, 184.0, 209.0, 169.0, 167.0, 169.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 66.0, 84.0, 66.0, 63.0, 63.0, 86.0, 87.0], "value": 72.0, "unit": "score"}]}]} 14:53:31 INFO - Return code: 0 14:53:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:53:31 ERROR - # TBPL SUCCESS # 14:53:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:31 INFO - 2016-10-20 14:53:31.250 screenresolution[1943:12228] starting screenresolution argv=screenresolution get 14:53:31 INFO - 2016-10-20 14:53:31.254 screenresolution[1943:12228] Display 0: 1600x1200x32@60 14:53:31 INFO - 2016-10-20 14:53:31.260 screenresolution[1944:12231] starting screenresolution argv=screenresolution list 14:53:31 INFO - Available Modes on Display 0 14:53:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:31 INFO - Intel Iris: 14:53:31 INFO - Chipset Model: Intel Iris 14:53:31 INFO - Type: GPU 14:53:31 INFO - Bus: Built-In 14:53:31 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:31 INFO - Vendor: Intel (0x8086) 14:53:31 INFO - Device ID: 0x0a2e 14:53:31 INFO - Revision ID: 0x0009 14:53:31 INFO - Displays: 14:53:31 INFO - Display: 14:53:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:31 INFO - Display Serial Number: 1600x1200 60 14:53:31 INFO - Main Display: Yes 14:53:31 INFO - Mirror: Off 14:53:31 INFO - Online: Yes 14:53:31 INFO - Rotation: Supported 14:53:31 INFO - Return code: 0 14:53:31 INFO - Running post-action listener: _resource_record_post_action 14:53:31 INFO - [mozharness: 2016-10-20 21:53:31.494275Z] Finished run-tests step (success) 14:53:31 INFO - Running post-run listener: _resource_record_post_run 14:53:31 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 2183168; Write bytes: 664542208; Read time: 22; Write time: 1937 14:53:31 INFO - TinderboxPrint: CPU usage
54.2% 14:53:31 INFO - TinderboxPrint: I/O read bytes / time
2,183,168 / 22 14:53:31 INFO - TinderboxPrint: I/O write bytes / time
664,542,208 / 1,937 14:53:31 INFO - TinderboxPrint: CPU idle
2,212.6 (45.8%) 14:53:31 INFO - TinderboxPrint: CPU system
975.1 (20.2%) 14:53:31 INFO - TinderboxPrint: CPU user
1,646.0 (34.1%) 14:53:31 INFO - TinderboxPrint: Swap in / out
366,497,792 / 0 14:53:31 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 353755648; Write bytes: 349571072; Read time: 27415; Write time: 737 14:53:31 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 2183168; Write bytes: 296985600; Read time: 22; Write time: 1144 14:53:31 INFO - Running post-run listener: _upload_blobber_files 14:53:31 INFO - Blob upload gear active. 14:53:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:31 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 14:53:31 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'] 14:53:31 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 14:53:32 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:53:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:33 INFO - (blobuploader) - INFO - Done attempting. 14:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:53:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:34 INFO - (blobuploader) - INFO - Done attempting. 14:53:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:53:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:53:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:36 INFO - (blobuploader) - INFO - Done attempting. 14:53:36 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:36 INFO - Return code: 0 14:53:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6601974c9717410783de75b9883ba3e441bc99fb865ce8fd5ca583c20a28d63adb6f2ff0d9363baec67864e808ddca0821282d9287b3fb7cf1c906df72e0f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b46d21643318a1b812136471006b1ac24fb3cdd3285d81469fb5b37f839490b23fa5aaef32b11796e5cd7834f4d3cb3d69dd9f902e69e46a9189381acf366fc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9f6e60faf3ff9e25a5f4f83a732f88be7d921cb2cb8b52f0bc3fa8cd7b6874e4304cfbeb9359e73cc65c0c799733518e3538f422dae36a6633c94b9d181e3e7"} 14:53:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:36 INFO - Contents: 14:53:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6601974c9717410783de75b9883ba3e441bc99fb865ce8fd5ca583c20a28d63adb6f2ff0d9363baec67864e808ddca0821282d9287b3fb7cf1c906df72e0f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b46d21643318a1b812136471006b1ac24fb3cdd3285d81469fb5b37f839490b23fa5aaef32b11796e5cd7834f4d3cb3d69dd9f902e69e46a9189381acf366fc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9f6e60faf3ff9e25a5f4f83a732f88be7d921cb2cb8b52f0bc3fa8cd7b6874e4304cfbeb9359e73cc65c0c799733518e3538f422dae36a6633c94b9d181e3e7"} 14:53:36 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:36 INFO - Copying logs to upload dir... 14:53:36 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.043261 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-20 14:53:36.990094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:36.993859) ========= 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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6601974c9717410783de75b9883ba3e441bc99fb865ce8fd5ca583c20a28d63adb6f2ff0d9363baec67864e808ddca0821282d9287b3fb7cf1c906df72e0f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b46d21643318a1b812136471006b1ac24fb3cdd3285d81469fb5b37f839490b23fa5aaef32b11796e5cd7834f4d3cb3d69dd9f902e69e46a9189381acf366fc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9f6e60faf3ff9e25a5f4f83a732f88be7d921cb2cb8b52f0bc3fa8cd7b6874e4304cfbeb9359e73cc65c0c799733518e3538f422dae36a6633c94b9d181e3e7"} build_url:https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010840 build_url: 'https://queue.taskcluster.net/v1/task/DzMNXO6ZQs-7oIKQ3b5rEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a6601974c9717410783de75b9883ba3e441bc99fb865ce8fd5ca583c20a28d63adb6f2ff0d9363baec67864e808ddca0821282d9287b3fb7cf1c906df72e0f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b46d21643318a1b812136471006b1ac24fb3cdd3285d81469fb5b37f839490b23fa5aaef32b11796e5cd7834f4d3cb3d69dd9f902e69e46a9189381acf366fc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9f6e60faf3ff9e25a5f4f83a732f88be7d921cb2cb8b52f0bc3fa8cd7b6874e4304cfbeb9359e73cc65c0c799733518e3538f422dae36a6633c94b9d181e3e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:37.027102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:37.027546) ========= 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.Lm5Hur5IGB/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.f25Zdcy6P3/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005347 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 14:53:37.076424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 14:53:37.076733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 14:53:37.077052) ========= ========= Total master_lag: 0.27 =========