builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0191 starttime: 1489616893.17 results: success (0) buildid: 20170315140636 builduid: 2ce8d55b507a4245bf14896ef4a40eab revision: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.169518) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.170022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.170367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.195707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.196087) ========= 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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-15 15:28:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 79.0M=0s 2017-03-15 15:28:13 (79.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.346219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.346592) ========= 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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.021946 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:13.395428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-15 15:28:13.395835) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q7yP1mmedi/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.fYBz4B3wWq/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-15 15:28:13,475 truncating revision to first 12 chars 2017-03-15 15:28:13,475 Setting DEBUG logging. 2017-03-15 15:28:13,475 attempt 1/10 2017-03-15 15:28:13,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c4d97d1bc61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 15:28:15,356 unpacking tar archive at: mozilla-central-1c4d97d1bc61/testing/mozharness/ program finished with exit code 0 elapsedTime=2.135349 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-15 15:28:15.558948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:15.559352) ========= script_repo_revision: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:15.559832) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:15.560168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 15:28:15.580533) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-15 15:28:15.581476) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q7yP1mmedi/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.fYBz4B3wWq/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:28:15 INFO - MultiFileLogger online at 20170315 15:28:15 in /builds/slave/test 15:28:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:28:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:15 INFO - {'append_to_log': False, 15:28:15 INFO - 'base_work_dir': '/builds/slave/test', 15:28:15 INFO - 'blob_upload_branch': 'Firefox', 15:28:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:15 INFO - 'branch': 'Firefox', 15:28:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:15 INFO - 'config_files': ('talos/mac_config.py',), 15:28:15 INFO - 'default_actions': ('clobber', 15:28:15 INFO - 'read-buildbot-config', 15:28:15 INFO - 'download-and-extract', 15:28:15 INFO - 'populate-webroot', 15:28:15 INFO - 'create-virtualenv', 15:28:15 INFO - 'install', 15:28:15 INFO - 'run-tests'), 15:28:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:15 INFO - 'download_minidump_stackwalk': True, 15:28:15 INFO - 'download_symbols': 'ondemand', 15:28:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:15 INFO - 'gecko_profile': False, 15:28:15 INFO - 'gecko_profile_interval': 0, 15:28:15 INFO - 'installer_path': 'installer.exe', 15:28:15 INFO - 'log_level': 'info', 15:28:15 INFO - 'log_name': 'talos', 15:28:15 INFO - 'log_to_console': True, 15:28:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:28:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:28:15 INFO - 'opt_config_files': (), 15:28:15 INFO - 'pip_index': False, 15:28:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:28:15 INFO - 'cmd': ('bash', 15:28:15 INFO - '-c', 15:28:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:28:15 INFO - 'enabled': True, 15:28:15 INFO - 'halt_on_failure': False, 15:28:15 INFO - 'name': 'check_screen_resolution'},), 15:28:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:28:15 INFO - 'cmd': ('bash', 15:28:15 INFO - '-c', 15:28:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:28:15 INFO - 'enabled': True, 15:28:15 INFO - 'halt_on_failure': False, 15:28:15 INFO - 'name': 'check_screen_resolution'},), 15:28:15 INFO - 'run_cmd_checks_enabled': True, 15:28:15 INFO - 'suite': 'dromaeojs-e10s', 15:28:15 INFO - 'system_bits': '32', 15:28:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:15 INFO - 'title': 't-yosemite-r7-0191', 15:28:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:15 INFO - 'use_talos_json': True, 15:28:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:15 INFO - 'work_dir': 'build'} 15:28:15 INFO - [mozharness: 2017-03-15 22:28:15.786447Z] Running clobber step. 15:28:15 INFO - Running pre-action listener: _resource_record_pre_action 15:28:15 INFO - Running main action method: clobber 15:28:15 INFO - rmtree: /builds/slave/test/build 15:28:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:18 INFO - Running post-action listener: _resource_record_post_action 15:28:18 INFO - [mozharness: 2017-03-15 22:28:18.001174Z] Finished clobber step (success) 15:28:18 INFO - [mozharness: 2017-03-15 22:28:18.001430Z] Running read-buildbot-config step. 15:28:18 INFO - Running pre-action listener: _resource_record_pre_action 15:28:18 INFO - Running main action method: read_buildbot_config 15:28:18 INFO - Using buildbot properties: 15:28:18 INFO - { 15:28:18 INFO - "project": "", 15:28:18 INFO - "product": "firefox", 15:28:18 INFO - "script_repo_revision": "production", 15:28:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:28:18 INFO - "repository": "", 15:28:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:28:18 INFO - "buildid": "20170315140636", 15:28:18 INFO - "pgo_build": "False", 15:28:18 INFO - "basedir": "/builds/slave/test", 15:28:18 INFO - "buildnumber": 125, 15:28:18 INFO - "slavename": "t-yosemite-r7-0191", 15:28:18 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:28:18 INFO - "platform": "yosemite_r7", 15:28:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:28:18 INFO - "branch": "mozilla-central", 15:28:18 INFO - "repo_path": "mozilla-central", 15:28:18 INFO - "revision": "1c4d97d1bc61468c82e55a09bab660e52bb2e9b5", 15:28:18 INFO - "stage_platform": "macosx64", 15:28:18 INFO - "builduid": "2ce8d55b507a4245bf14896ef4a40eab", 15:28:18 INFO - "slavebuilddir": "test" 15:28:18 INFO - } 15:28:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:28:18 INFO - Running post-action listener: _resource_record_post_action 15:28:18 INFO - [mozharness: 2017-03-15 22:28:18.007143Z] Finished read-buildbot-config step (success) 15:28:18 INFO - [mozharness: 2017-03-15 22:28:18.007369Z] Running download-and-extract step. 15:28:18 INFO - Running pre-action listener: _resource_record_pre_action 15:28:18 INFO - Running main action method: download_and_extract 15:28:18 INFO - mkdir: /builds/slave/test/build/tests 15:28:18 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')]} 15:28:18 INFO - trying https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:28:18 INFO - Downloading https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:28:18 INFO - Downloaded 1199 bytes. 15:28:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:28:18 INFO - Using the following test package requirements: 15:28:18 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:28:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:28:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:28:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'jsshell-mac.zip'], 15:28:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:28:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:28:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:28:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:28:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:28:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:28:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:28:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:28:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:28:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:28:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:28:20 INFO - Expected file size: 52474331 15:28:20 INFO - Obtained file size: 52474331 15:28:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:28:36 INFO - Fetch https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:28:38 INFO - Expected file size: 52474331 15:28:38 INFO - Obtained file size: 52474331 15:28:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:28:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:28:53 INFO - Fetch https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:28:54 INFO - Expected file size: 14404452 15:28:54 INFO - Obtained file size: 14404452 15:28: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')]} 15:28:55 INFO - trying https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:28:55 INFO - Downloading https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:28:57 INFO - Downloaded 75086874 bytes. 15:28:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:28:57 INFO - mkdir: /builds/slave/test/properties 15:28:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:28:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:28:57 INFO - Contents: 15:28:57 INFO - build_url:https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:28:57 INFO - Running post-action listener: _resource_record_post_action 15:28:57 INFO - Running post-action listener: set_extra_try_arguments 15:28:57 INFO - [mozharness: 2017-03-15 22:28:57.952674Z] Finished download-and-extract step (success) 15:28:57 INFO - [mozharness: 2017-03-15 22:28:57.952818Z] Running populate-webroot step. 15:28:57 INFO - Running pre-action listener: _resource_record_pre_action 15:28:57 INFO - Running main action method: populate_webroot 15:28:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:57 INFO - '--tppagecycles', 15:28:57 INFO - '7'], 15:28:57 INFO - 'tests': ['tsvgm']}}, 15:28:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:28:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:28:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:28:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['damp', 'tps']}, 15:28:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'tests': ['damp', 'tps']}, 15:28:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['dromaeo_dom']}, 15:28:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['basic_compositor_video']}, 15:28:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:28:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['a11yr', 15:28:57 INFO - 'ts_paint', 15:28:57 INFO - 'tpaint', 15:28:57 INFO - 'sessionrestore', 15:28:57 INFO - 'sessionrestore_no_auto_restore', 15:28:57 INFO - 'tabpaint']}, 15:28:57 INFO - 'other-e10s': {'tests': ['a11yr', 15:28:57 INFO - 'ts_paint', 15:28:57 INFO - 'tpaint', 15:28:57 INFO - 'sessionrestore', 15:28:57 INFO - 'sessionrestore_no_auto_restore', 15:28:57 INFO - 'tabpaint']}, 15:28:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:28:57 INFO - 'ts_paint', 15:28:57 INFO - 'tpaint', 15:28:57 INFO - 'sessionrestore', 15:28:57 INFO - 'sessionrestore_no_auto_restore', 15:28:57 INFO - 'tabpaint']}, 15:28:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:28:57 INFO - 'ts_paint', 15:28:57 INFO - 'tpaint', 15:28:57 INFO - 'sessionrestore', 15:28:57 INFO - 'sessionrestore_no_auto_restore', 15:28:57 INFO - 'tabpaint']}, 15:28:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['a11yr', 15:28:57 INFO - 'ts_paint', 15:28:57 INFO - 'tpaint', 15:28:57 INFO - 'sessionrestore', 15:28:57 INFO - 'sessionrestore_no_auto_restore', 15:28:57 INFO - 'tabpaint']}, 15:28:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['a11yr', 15:28:57 INFO - 'ts_paint', 15:28:57 INFO - 'tpaint', 15:28:57 INFO - 'sessionrestore', 15:28:57 INFO - 'sessionrestore_no_auto_restore', 15:28:57 INFO - 'tabpaint']}, 15:28:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['tsvgx', 15:28:57 INFO - 'tsvgr_opacity', 15:28:57 INFO - 'tart', 15:28:57 INFO - 'tscrollx', 15:28:57 INFO - 'cart', 15:28:57 INFO - 'tsvg_static']}, 15:28:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:28:57 INFO - 'tsvgr_opacity', 15:28:57 INFO - 'tart', 15:28:57 INFO - 'tscrollx', 15:28:57 INFO - 'cart', 15:28:57 INFO - 'tsvg_static']}, 15:28:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'talos_options': ['--disable-e10s'], 15:28:57 INFO - 'tests': ['tp5o']}, 15:28:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:28:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'talos_options': ['--disable-e10s', 15:28:57 INFO - '--xperf_path', 15:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:57 INFO - 'tests': ['tp5n']}, 15:28:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:28:57 INFO - 'talos_options': ['--xperf_path', 15:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:57 INFO - 'tests': ['tp5n']}}, 15:28:57 INFO - 'talos.zip': {'path': '', 15:28:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:57 INFO - Running post-action listener: _resource_record_post_action 15:28:57 INFO - [mozharness: 2017-03-15 22:28:57.971325Z] Finished populate-webroot step (success) 15:28:57 INFO - [mozharness: 2017-03-15 22:28:57.971462Z] Running create-virtualenv step. 15:28:57 INFO - Running pre-action listener: _resource_record_pre_action 15:28:57 INFO - Running main action method: create_virtualenv 15:28:57 INFO - Creating virtualenv /builds/slave/test/build/venv 15:28:57 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 15:28:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:28:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:58 INFO - Using real prefix '/tools/python27' 15:28:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:28:58 INFO - Installing distribute.............................................................................................................................................................................................done. 15:29:01 INFO - Installing pip.................done. 15:29:01 INFO - Return code: 0 15:29:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:29:02 INFO - Reading from file tmpfile_stdout 15:29:02 INFO - Output received: 15:29:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:29:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:29:02 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')]} 15:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:02 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')]} 15:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:02 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:02 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 15:29:02 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 15:29:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:02 INFO - 'HOME': '/Users/cltbld', 15:29:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:02 INFO - 'LOGNAME': 'cltbld', 15:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:02 INFO - 'MOZ_NO_REMOTE': '1', 15:29:02 INFO - 'NO_EM_RESTART': '1', 15:29:02 INFO - 'PAGER': '/bin/cat', 15:29:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:02 INFO - 'PWD': '/builds/slave/test', 15:29:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:02 INFO - 'SHELL': '/bin/bash', 15:29:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:02 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:02 INFO - 'USER': 'cltbld', 15:29:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:02 INFO - 'XPC_FLAGS': '0x0', 15:29:02 INFO - 'XPC_SERVICE_NAME': '0', 15:29:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:02 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 15:29:02 INFO - Cleaning up... 15:29:02 INFO - Return code: 0 15:29:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:29:02 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')]} 15:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:02 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')]} 15:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:02 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:02 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 15:29:02 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 15:29:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:02 INFO - 'HOME': '/Users/cltbld', 15:29:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:02 INFO - 'LOGNAME': 'cltbld', 15:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:02 INFO - 'MOZ_NO_REMOTE': '1', 15:29:02 INFO - 'NO_EM_RESTART': '1', 15:29:02 INFO - 'PAGER': '/bin/cat', 15:29:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:02 INFO - 'PWD': '/builds/slave/test', 15:29:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:02 INFO - 'SHELL': '/bin/bash', 15:29:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:02 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:02 INFO - 'USER': 'cltbld', 15:29:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:02 INFO - 'XPC_FLAGS': '0x0', 15:29:02 INFO - 'XPC_SERVICE_NAME': '0', 15:29:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:02 INFO - Downloading/unpacking psutil>=3.1.1 15:29:02 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 15:29:02 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 15:29:02 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 15:29:02 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 15:29:02 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 15:29:02 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 15:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:29:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:06 INFO - Installing collected packages: psutil 15:29:06 INFO - Running setup.py install for psutil 15:29:06 INFO - building 'psutil._psutil_osx' extension 15:29:06 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 15:29:06 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 15:29:06 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 15:29:06 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 15:29:06 INFO - building 'psutil._psutil_posix' extension 15:29:06 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 15:29:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:29:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:29:06 INFO - ^ 15:29:06 INFO - 1 warning generated. 15:29:06 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 15:29:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:29:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:29:06 INFO - Successfully installed psutil 15:29:06 INFO - Cleaning up... 15:29:06 INFO - Return code: 0 15:29:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:29: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')]} 15:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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')]} 15:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:29: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 mozsystemmonitor==0.3 15:29:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:07 INFO - 'HOME': '/Users/cltbld', 15:29:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:07 INFO - 'LOGNAME': 'cltbld', 15:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:07 INFO - 'MOZ_NO_REMOTE': '1', 15:29:07 INFO - 'NO_EM_RESTART': '1', 15:29:07 INFO - 'PAGER': '/bin/cat', 15:29:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:07 INFO - 'PWD': '/builds/slave/test', 15:29:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:07 INFO - 'SHELL': '/bin/bash', 15:29:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:07 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:07 INFO - 'USER': 'cltbld', 15:29:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:07 INFO - 'XPC_FLAGS': '0x0', 15:29:07 INFO - 'XPC_SERVICE_NAME': '0', 15:29:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:29: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 15:29: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 15:29: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 15:29: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 15:29: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 15:29: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 15:29:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:29:09 INFO - Installing collected packages: mozsystemmonitor 15:29:09 INFO - Running setup.py install for mozsystemmonitor 15:29:10 INFO - Successfully installed mozsystemmonitor 15:29:10 INFO - Cleaning up... 15:29:10 INFO - Return code: 0 15:29:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:29:10 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')]} 15:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:10 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')]} 15:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:11 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:11 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 15:29:11 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 15:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:11 INFO - 'HOME': '/Users/cltbld', 15:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:11 INFO - 'LOGNAME': 'cltbld', 15:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:11 INFO - 'MOZ_NO_REMOTE': '1', 15:29:11 INFO - 'NO_EM_RESTART': '1', 15:29:11 INFO - 'PAGER': '/bin/cat', 15:29:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:11 INFO - 'PWD': '/builds/slave/test', 15:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:11 INFO - 'SHELL': '/bin/bash', 15:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:11 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:11 INFO - 'USER': 'cltbld', 15:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:11 INFO - 'XPC_FLAGS': '0x0', 15:29:11 INFO - 'XPC_SERVICE_NAME': '0', 15:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:11 INFO - Downloading/unpacking jsonschema==2.5.1 15:29:11 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 15:29:11 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 15:29:11 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 15:29:11 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 15:29:11 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 15:29:11 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 15:29:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:29:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:14 INFO - Downloading functools32-3.2.3-2.tar.gz 15:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:29:14 INFO - warning: no files found matching '*.txt' 15:29:14 INFO - no previously-included directories found matching 'build' 15:29:14 INFO - no previously-included directories found matching 'dist' 15:29:14 INFO - no previously-included directories found matching '.git*' 15:29:14 INFO - Installing collected packages: jsonschema, functools32 15:29:14 INFO - Running setup.py install for functools32 15:29:15 INFO - warning: no files found matching '*.txt' 15:29:15 INFO - no previously-included directories found matching 'build' 15:29:15 INFO - no previously-included directories found matching 'dist' 15:29:15 INFO - no previously-included directories found matching '.git*' 15:29:15 INFO - Successfully installed jsonschema functools32 15:29:15 INFO - Cleaning up... 15:29:15 INFO - Return code: 0 15:29:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:29:15 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')]} 15:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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')]} 15:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:15 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 15:29:15 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 15:29:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:15 INFO - 'HOME': '/Users/cltbld', 15:29:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:15 INFO - 'LOGNAME': 'cltbld', 15:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:15 INFO - 'MOZ_NO_REMOTE': '1', 15:29:15 INFO - 'NO_EM_RESTART': '1', 15:29:15 INFO - 'PAGER': '/bin/cat', 15:29:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:15 INFO - 'PWD': '/builds/slave/test', 15:29:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:15 INFO - 'SHELL': '/bin/bash', 15:29:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:15 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:15 INFO - 'USER': 'cltbld', 15:29:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:15 INFO - 'XPC_FLAGS': '0x0', 15:29:15 INFO - 'XPC_SERVICE_NAME': '0', 15:29:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:29:15 INFO - Cleaning up... 15:29:15 INFO - Return code: 0 15:29:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:29:15 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')]} 15:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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')]} 15:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:15 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:15 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 15:29:15 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 15:29:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:15 INFO - 'HOME': '/Users/cltbld', 15:29:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:15 INFO - 'LOGNAME': 'cltbld', 15:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:15 INFO - 'MOZ_NO_REMOTE': '1', 15:29:15 INFO - 'NO_EM_RESTART': '1', 15:29:15 INFO - 'PAGER': '/bin/cat', 15:29:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:15 INFO - 'PWD': '/builds/slave/test', 15:29:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:15 INFO - 'SHELL': '/bin/bash', 15:29:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:15 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:15 INFO - 'USER': 'cltbld', 15:29:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:15 INFO - 'XPC_FLAGS': '0x0', 15:29:15 INFO - 'XPC_SERVICE_NAME': '0', 15:29:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:15 INFO - Downloading/unpacking blobuploader==1.2.4 15:29:15 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 15:29:15 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 15:29:15 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 15:29:15 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 15:29:15 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 15:29:15 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 15:29:18 INFO - Downloading blobuploader-1.2.4.tar.gz 15:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:29:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:29: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 15:29: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 15:29: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 15:29: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 15:29: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 15:29: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 15:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:29:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:19 INFO - Downloading docopt-0.6.1.tar.gz 15:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:29:19 INFO - Installing collected packages: blobuploader, requests, docopt 15:29:19 INFO - Running setup.py install for blobuploader 15:29:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:29:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:29:19 INFO - Running setup.py install for requests 15:29:20 INFO - Running setup.py install for docopt 15:29:20 INFO - Successfully installed blobuploader requests docopt 15:29:20 INFO - Cleaning up... 15:29:20 INFO - Return code: 0 15:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:20 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')]} 15:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:20 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')]} 15:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:20 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:20 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 15:29:20 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 15:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:20 INFO - 'HOME': '/Users/cltbld', 15:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:20 INFO - 'LOGNAME': 'cltbld', 15:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:20 INFO - 'MOZ_NO_REMOTE': '1', 15:29:20 INFO - 'NO_EM_RESTART': '1', 15:29:20 INFO - 'PAGER': '/bin/cat', 15:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:20 INFO - 'PWD': '/builds/slave/test', 15:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:20 INFO - 'SHELL': '/bin/bash', 15:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:20 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:20 INFO - 'USER': 'cltbld', 15:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:20 INFO - 'XPC_FLAGS': '0x0', 15:29:20 INFO - 'XPC_SERVICE_NAME': '0', 15:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bd4gfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zFn3HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:20 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-SE8dJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-IurpQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ydVdck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-mTYRFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-gVNIO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yWqc6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EEmbWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8MN2Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-MFGMC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:21 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-edqISq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-VRPm7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_rc9_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yMr_43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-h1NpyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:22 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-tAL1QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:29:22 INFO - Running setup.py install for manifestparser 15:29:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:29:22 INFO - Running setup.py install for mozcrash 15:29:22 INFO - Running setup.py install for mozdebug 15:29:22 INFO - Running setup.py install for mozdevice 15:29:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Running setup.py install for mozfile 15:29:23 INFO - Running setup.py install for mozhttpd 15:29:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Running setup.py install for mozinfo 15:29:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Running setup.py install for mozInstall 15:29:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:29:23 INFO - Running setup.py install for mozleak 15:29:23 INFO - Running setup.py install for mozlog 15:29:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for moznetwork 15:29:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozprocess 15:29:24 INFO - Running setup.py install for mozprofile 15:29:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozrunner 15:29:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:29:24 INFO - Running setup.py install for mozscreenshot 15:29:24 INFO - Running setup.py install for moztest 15:29:24 INFO - Running setup.py install for mozversion 15:29:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:29:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:25 INFO - Cleaning up... 15:29:25 INFO - Return code: 0 15:29:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:25 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')]} 15:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:25 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')]} 15:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:25 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:25 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 15:29:25 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 15:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:25 INFO - 'HOME': '/Users/cltbld', 15:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:25 INFO - 'LOGNAME': 'cltbld', 15:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:25 INFO - 'MOZ_NO_REMOTE': '1', 15:29:25 INFO - 'NO_EM_RESTART': '1', 15:29:25 INFO - 'PAGER': '/bin/cat', 15:29:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:25 INFO - 'PWD': '/builds/slave/test', 15:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:25 INFO - 'SHELL': '/bin/bash', 15:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:25 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:25 INFO - 'USER': 'cltbld', 15:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:25 INFO - 'XPC_FLAGS': '0x0', 15:29:25 INFO - 'XPC_SERVICE_NAME': '0', 15:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:25 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-QuHWxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:25 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)) 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:25 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7BQiiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:25 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hU5bKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:25 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)) 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:25 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YEPYiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:25 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1ACLAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:25 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)) 15:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:25 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-V_3U_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hmWl6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-IW5FDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iLB4Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-eiTl1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-SsjCLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iqZi8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hOrQj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:26 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)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-QR_ik3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:26 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-RHiio2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:27 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)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-WofuQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:27 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-CnUs1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:27 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)) 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:29:27 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)) 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:27 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 15:29:27 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 15:29:27 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 15:29:27 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 15:29:27 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 15:29:27 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 15:29:29 INFO - Downloading blessings-1.6.tar.gz 15:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:29 INFO - Installing collected packages: blessings 15:29:29 INFO - Running setup.py install for blessings 15:29:30 INFO - Successfully installed blessings 15:29:30 INFO - Cleaning up... 15:29:30 INFO - Return code: 0 15:29:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:30 INFO - Reading from file tmpfile_stdout 15:29:30 INFO - Current package versions: 15:29:30 INFO - blessings == 1.6 15:29:30 INFO - blobuploader == 1.2.4 15:29:30 INFO - docopt == 0.6.1 15:29:30 INFO - functools32 == 3.2.3-2 15:29:30 INFO - jsonschema == 2.5.1 15:29:30 INFO - manifestparser == 1.1 15:29:30 INFO - mozInstall == 1.12 15:29:30 INFO - mozcrash == 1.0 15:29:30 INFO - mozdebug == 0.1 15:29:30 INFO - mozdevice == 0.49 15:29:30 INFO - mozfile == 1.2 15:29:30 INFO - mozhttpd == 0.7 15:29:30 INFO - mozinfo == 0.9 15:29:30 INFO - mozleak == 0.1 15:29:30 INFO - mozlog == 3.4 15:29:30 INFO - moznetwork == 0.27 15:29:30 INFO - mozprocess == 0.25 15:29:30 INFO - mozprofile == 0.28 15:29:30 INFO - mozrunner == 6.13 15:29:30 INFO - mozscreenshot == 0.1 15:29:30 INFO - mozsystemmonitor == 0.3 15:29:30 INFO - moztest == 0.8 15:29:30 INFO - mozversion == 1.4 15:29:30 INFO - psutil == 3.1.1 15:29:30 INFO - requests == 1.2.3 15:29:30 INFO - wsgiref == 0.1.2 15:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 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 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:30 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 15:29:30 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 15:29:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:30 INFO - 'HOME': '/Users/cltbld', 15:29:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:30 INFO - 'LOGNAME': 'cltbld', 15:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:30 INFO - 'MOZ_NO_REMOTE': '1', 15:29:30 INFO - 'NO_EM_RESTART': '1', 15:29:30 INFO - 'PAGER': '/bin/cat', 15:29:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:30 INFO - 'PWD': '/builds/slave/test', 15:29:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:30 INFO - 'SHELL': '/bin/bash', 15:29:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:30 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:30 INFO - 'USER': 'cltbld', 15:29:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:30 INFO - 'XPC_FLAGS': '0x0', 15:29:30 INFO - 'XPC_SERVICE_NAME': '0', 15:29:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 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)) 15:29:30 INFO - Cleaning up... 15:29:30 INFO - Return code: 0 15:29:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1030dbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030de768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9335d3cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, '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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 15:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:29:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:30 INFO - 'HOME': '/Users/cltbld', 15:29:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:30 INFO - 'LOGNAME': 'cltbld', 15:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:30 INFO - 'MOZ_NO_REMOTE': '1', 15:29:30 INFO - 'NO_EM_RESTART': '1', 15:29:30 INFO - 'PAGER': '/bin/cat', 15:29:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:30 INFO - 'PWD': '/builds/slave/test', 15:29:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:30 INFO - 'SHELL': '/bin/bash', 15:29:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:30 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:30 INFO - 'USER': 'cltbld', 15:29:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:30 INFO - 'XPC_FLAGS': '0x0', 15:29:30 INFO - 'XPC_SERVICE_NAME': '0', 15:29:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:29:31 INFO - Cleaning up... 15:29:31 INFO - Return code: 0 15:29:31 INFO - Running post-action listener: _resource_record_post_action 15:29:31 INFO - Running post-action listener: _start_resource_monitoring 15:29:31 INFO - Starting resource monitoring. 15:29:31 INFO - [mozharness: 2017-03-15 22:29:31.085015Z] Finished create-virtualenv step (success) 15:29:31 INFO - [mozharness: 2017-03-15 22:29:31.086104Z] Running install step. 15:29:31 INFO - Running pre-action listener: _resource_record_pre_action 15:29:31 INFO - Running main action method: install 15:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:31 INFO - Reading from file tmpfile_stdout 15:29:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:29:31 INFO - Reading from file tmpfile_stdout 15:29:31 INFO - Output received: 15:29:31 INFO - Usage: mozinstall [options] installer 15:29:31 INFO - Options: 15:29:31 INFO - -h, --help show this help message and exit 15:29:31 INFO - -d DEST, --destination=DEST 15:29:31 INFO - Directory to install application into. [default: 15:29:31 INFO - "/builds/slave/test"] 15:29:31 INFO - --app=APP Application being installed. [default: firefox] 15:29:31 INFO - mkdir: /builds/slave/test/build/application 15:29:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:29:52 INFO - Reading from file tmpfile_stdout 15:29:52 INFO - Output received: 15:29:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:29:52 INFO - Running post-action listener: _resource_record_post_action 15:29:52 INFO - [mozharness: 2017-03-15 22:29:52.279926Z] Finished install step (success) 15:29:52 INFO - [mozharness: 2017-03-15 22:29:52.280058Z] Running run-tests step. 15:29:52 INFO - Running pre-action listener: _resource_record_pre_action 15:29:52 INFO - Running main action method: run_tests 15:29:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:29:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:29:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:29:52 INFO - 2017-03-15 15:29:52.294 screenresolution[1902:18778] starting screenresolution argv=screenresolution get 15:29:52 INFO - 2017-03-15 15:29:52.297 screenresolution[1902:18778] Display 0: 1600x1200x32@60 15:29:52 INFO - 2017-03-15 15:29:52.303 screenresolution[1903:18781] starting screenresolution argv=screenresolution list 15:29:52 INFO - Available Modes on Display 0 15:29:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:29:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:29:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:29:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:29:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:29:52 INFO - Intel Iris: 15:29:52 INFO - Chipset Model: Intel Iris 15:29:52 INFO - Type: GPU 15:29:52 INFO - Bus: Built-In 15:29:52 INFO - VRAM (Dynamic, Max): 1536 MB 15:29:52 INFO - Vendor: Intel (0x8086) 15:29:52 INFO - Device ID: 0x0a2e 15:29:52 INFO - Revision ID: 0x0009 15:29:52 INFO - Displays: 15:29:52 INFO - Display: 15:29:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:29:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:29:52 INFO - Display Serial Number: 1600x1200 60 15:29:52 INFO - Main Display: Yes 15:29:52 INFO - Mirror: Off 15:29:52 INFO - Online: Yes 15:29:52 INFO - Rotation: Supported 15:29:52 INFO - Return code: 0 15:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:29:52 INFO - Python 2.7.3 15:29:52 INFO - Return code: 0 15:29:52 INFO - grabbing minidump binary from tooltool 15:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:52 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 0x102eb9d30>, '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 0x102de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:29:52 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 15:29:52 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 15:29:52 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 15:29:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:52 INFO - Return code: 0 15:29:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:29:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:29:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:29:52 INFO - ENV: RUST_BACKTRACE is now 1 15:29:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:29:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 15:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 15:29:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q7yP1mmedi/Render', 15:29:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:29:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:29:52 INFO - 'HOME': '/Users/cltbld', 15:29:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:29:52 INFO - 'LOGNAME': 'cltbld', 15:29:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:52 INFO - 'MOZ_NO_REMOTE': '1', 15:29:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:52 INFO - 'NO_EM_RESTART': '1', 15:29:52 INFO - 'PAGER': '/bin/cat', 15:29:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:52 INFO - 'PWD': '/builds/slave/test', 15:29:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:29:52 INFO - 'RUST_BACKTRACE': '1', 15:29:52 INFO - 'SHELL': '/bin/bash', 15:29:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fYBz4B3wWq/Listeners', 15:29:52 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 15:29:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:29:52 INFO - 'USER': 'cltbld', 15:29:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:29:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:52 INFO - 'XPC_FLAGS': '0x0', 15:29:52 INFO - 'XPC_SERVICE_NAME': '0', 15:29:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:29:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 15:29:52 INFO - mozversion application_buildid: 20170315140636 15:29:52 INFO - mozversion application_changeset: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 15:29:52 INFO - mozversion application_display_name: Nightly 15:29:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:52 INFO - mozversion application_name: Firefox 15:29:52 INFO - mozversion application_remotingname: firefox 15:29:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:29:52 INFO - mozversion application_vendor: Mozilla 15:29:52 INFO - mozversion application_version: 55.0a1 15:29:52 INFO - mozversion platform_buildid: 20170315140636 15:29:52 INFO - mozversion platform_changeset: 1c4d97d1bc61468c82e55a09bab660e52bb2e9b5 15:29:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:29:52 INFO - mozversion platform_version: 55.0a1 15:29:52 INFO - using testdate: 1489616992 15:29:52 INFO - actual date: 1489616992 15:29:52 INFO - starting webserver on 'localhost:56579' 15:29:52 INFO - SUITE-START | Running 2 tests 15:29:52 INFO - TEST-START | dromaeo_css 15:29:52 INFO - operating with platform_type : mac_ 15:29:52 INFO - Initialising browser for dromaeo_css test... 15:29:52 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpecSlDD/profile http://localhost:56579/getInfo.html) 15:29:56 INFO - PID 1913 | 2017-03-15 15:29:56.036 plugin-container[1915:18960] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e33, name = 'com.apple.tsm.portname' 15:29:56 INFO - PID 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:29:56 INFO - PID 1913 | 2017-03-15 15:29:56.039 plugin-container[1915:18960] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 15:29:56 INFO - PID 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:29:56 INFO - PID 1913 | 2017-03-15 15:29:56.039 plugin-container[1915:18960] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:29:56 INFO - PID 1913 | __metrics Screen width/height:1600/1200 15:29:56 INFO - PID 1913 | colorDepth:24 15:29:56 INFO - PID 1913 | Browser inner width/height: 1024/689 15:29:56 INFO - PID 1913 | __metrics 15:29:56 ERROR - PID 1913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 15:29:56 INFO - TEST-INFO | 1913: exit 0 15:29:56 INFO - Browser initialized. 15:29:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:29:56 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpecSlDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:59 INFO - PID 1916 | 2017-03-15 15:29:59.566 plugin-container[1917:19087] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464b, name = 'com.apple.tsm.portname' 15:29:59 INFO - PID 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:29:59 INFO - PID 1916 | 2017-03-15 15:29:59.567 plugin-container[1917:19087] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464f, name = 'com.apple.CFPasteboardClient' 15:29:59 INFO - PID 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:29:59 INFO - PID 1916 | 2017-03-15 15:29:59.567 plugin-container[1917:19087] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:30:09 INFO - PID 1916 | RSS: Main: 228098048 15:30:09 INFO - PID 1916 | 15:33:12 INFO - PID 1916 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56579/tests/dromaeo/cssquery-ext.html) 15:33:14 INFO - PID 1916 | RSS: Main: 252743680 15:33:14 INFO - PID 1916 | 15:34:57 INFO - PID 1916 | ************************* 15:34:57 INFO - PID 1916 | A coding exception was thrown and uncaught in a Task. 15:34:57 INFO - PID 1916 | 15:34:57 ERROR - PID 1916 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:34:57 INFO - PID 1916 | Full stack: 15:34:57 INFO - PID 1916 | ************************* 15:36:16 INFO - PID 1916 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-ext.html (next: http://localhost:56579/tests/dromaeo/cssquery-jquery.html) 15:36:17 INFO - PID 1916 | RSS: Main: 260395008 15:36:17 INFO - PID 1916 | 15:39:19 INFO - PID 1916 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56579/tests/dromaeo/cssquery-mootools.html) 15:39:19 INFO - PID 1916 | RSS: Main: 271482880 15:39:19 INFO - PID 1916 | 15:42:21 INFO - PID 1916 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56579/tests/dromaeo/cssquery-prototype.html) 15:42:22 INFO - PID 1916 | RSS: Main: 263852032 15:42:22 INFO - PID 1916 | 15:45:25 INFO - PID 1916 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56579/tests/dromaeo/cssquery-yui.html) 15:45:25 INFO - PID 1916 | RSS: Main: 273993728 15:45:25 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-yui.html (next: http://localhost:56579/tests/dromaeo/cssquery-dojo.html) 15:48:28 INFO - PID 1916 | RSS: Main: 268271616 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | __start_tp_report 15:48:28 INFO - PID 1916 | _x_x_mozilla_page_load 15:48:28 INFO - PID 1916 | _x_x_mozilla_page_load_details 15:48:28 INFO - PID 1916 | |i|pagename|runs| 15:48:28 INFO - PID 1916 | |0;dojo.html;3133.2166958260436;3404.0979140527766;3455.533502977097;3477.3045390921816;3480.477928310753;5791.7972870949525;5932.970335148324;5958.821235362941;5960.612560183585;6006.339302676702;5824.825255242339;5968.40315968403;6050.788222412217;6085.4218849209365;6088.299845517767;5321.467853214686;5380.515753582186;5412.395489836216;5495.258140151089;5533.861653458655;5343.625946183769;5362.1420572708375;5377.381601115863;5443.2107344435035;5484.561235101182;4837.516248375152;5448.45515448456;5459.12653975366;5477.20580515825;5492.972535137339;4340.500842403132;5311.389190243094;5380.381256155514;5401.297831281948;5446.128619420873;5296.841094767125;5342.786288548454;5343.145096784496;5353.785848566053;5359.08895487768;5050.621203409759;5561.972190139023;6005.519558435359;6056.303525094627;6073.665948372838;6209.782657606962;6250.87498250037;6264.091706702548;6287.842803929892;6287.937120628781;6407;6437.259715132773;6438.871222575523;6453.870922581522;6456.774012909573;6134.355892631299;6138.938610613836;6154.692265386713;6182.907256391158;6192.535559832985;5727.968965586151;6289.7484100636375;6451.580647257913;6497.252815926135;6637.933620663828;6145.661988590581;6228.283747369111;6233.750649974041;6236.812895613139;6243.594166379171;6099.854599951442;6180.721867515883;6226.9213665049465;6273.843153921097;6359.046143078483;5176;5424.969255841377;6310.936890631035;6316.431521163117;6322.620642761449;5323.361196656426;6226.221722284715;6295.150154729053;6300.180976473029;6313.337099604567;4862.881537246453;5096.23556466533;5103.617228707862;5142.254373115952;5166.586673066221;3921.254961557295;4338.414314067623;4620.8151673933335;4623.976880115645;4636.907261854744;6163.506919446433;6169.321374648785;6169.660668663267;6183.5671502994355;6199.318075011745;6196.287426945959;6236.750529978841;6318.557700960889;6333.271673757485;6414.839629009219;6109.4653969264045;6111.774065234738;6133.82435864808;6148.569600127948;6153.569250152446;5591.944080559224;5653;5654.830355089354;5677.290338707661;5688.601797874109;6337.081123237197;6397.360263973565;6469.353064693493;6613.041109039163;6658.334166583303;6334.144890439732;6355.269144048493;6374.840628984312;6380.968095159495;6385.904211436925;6626.933730662825;6636.966815166086;6645.3022432643875;6648.434883034996;6648.700808463534;6216.409441103088;6267.874642507216;6270.310265870842;6284.780032698834;6330.113784070142;6221.160143380585;6271.372862713874;6294.339094395205;6314.526410519137;6314.905276420949;6060;6265.49876009909;6272.937270627418;6281.842953926006;6294.181756371642;6147.723352449061;6207.565470417027;6243.750249989949;6254.8123556293385;6295.685215739103;6149.354317796567;6155.599886007395;6171.290301615371;6295.653739044214;6298.464630506458;6267.811965641038;6267.9373206267355;6291.433770960635;6297.118403423616;6336.7148478319505;6081.331053584014;6127.019676851683;6131.386861313833;6272.372762723874;6309.3690630936535 15:48:28 INFO - PID 1916 | |1;ext.html;711.8789805733028;773.9922600773992;802.2939812964593;936.5551363102527;939.6617217801595;37964.43053354202;38696.419553706684;38699;38759;38798.80600597;37282.62717372825;37633.43549846748;37702.8114859426;37741.867743967654;37797.811010944904;7699.268569485904;7842.686292548291;10820.891791082067;11056.170787190993;11059.557617695324;11057.50241239146;11234.943825280861;11263;11406.486708098155;11438.142139339541;11341;11382.886171138265;11386.886131138666;11450.198486105975;11453.14101442391;8730.650773969033;10235.948820255926;11357.091432685365;11358.091352691807;11418.486168122412;9330.766730831716;9551.331406801526;10993.725156871062;11058.447077646166;11071.280366776135;38488.422673659916;38645;38684.41973370402;38717.80641096805;38736.80631596824;3043.5130379139455;3571.714262858965;3715.758475699071;3735.719821013408;3781.7920014399197;28249;28297;28316.85841570779;28433.857830710713;29160.416791664262;2707.891684332624;3084.4447999360104;3147.6222853257527;3160.115167753033;3250.366178595175;330061;330214;332550;332777.6722232771;333551;49518.009639807;49537.75231123821;49562.50437495579;49751.50248497541;49824.75087624539;52251.47748522542;52285.95428091417;52461.7376913113;52572.73713631484;52673.7366313166;13830.308484575731;14033.649158770908;14188.290585470686;14199.645008874653;14206.289685515683;9555.61777528891;11335.489902954387;11347.20569560123;11364.943175284236;11365.204435689588;13780.379882905294;13905.096168749;14007.509737159151;14027.71944561103;14142.646433839236;5316.707581083;6243.188385509855;6254.906176407358;6264.248290205204;6270.655113968775;1091.8908109189017;1130.9377984210782;1135.1429670598645;1142.1833389126648;1159.0032571988083;22608;24389.39026524351;25885.835137418486;26067.869660651955;26699;1219.664592237142;1237.3751255616037;1243.403743142637;1249.6251124662565;1266.4997326056157;10918.50866711;12751.808722869164;13018.763217494323;13722.862771372158;13864.584062478141;443789.15370500815;448568;449346;449461;450155.73987690697;55902.16146757802;55963.44036559582;56220.71889640608;56294;56327.71836140793;1160.1414952934936;1246.7070238493948;1404.2838152542276;1407.5917983784589;1416.157386355117;23601.52796944086;28852;29096.418071638873;29613.25966850846;29776;43808;44081;44301.33547996847;44329.11341773082;44362.11275774531;344484.27757862053;346086;347401;348002;348047;31695.513493515235;32395.838020809744;32532.83733581317;32569.34861302808;33076.503852441754;41490.58509414867;41642.958926027095;41910.580894190665;42468.513602023784;43310.78344608257;35374.29251415009;35577.82211088928;35752.82123589365;36917.63082369142;36976.44535332026;30572.08283751491;32894.67105328916;33361.49957750587;36687.816560917025;36725.63274367222;35441.64558354383;36377.337398880845;36486.817565913065;36938.8153059233;37139.442908356934;29611.407771844013;30627.387452251274;31265.531017034307;32065.198370040936;32077.198070048435;24423.633645494978;24472.14347497829;24622.261332160066;24790.628140577544;24817.875910620332 15:48:28 INFO - PID 1916 | |2;jquery.html;400.16365795487445;402.8207447685781;403.886911664734;408.5261097127332;430.9269917904419;20319.59360812785;20684.27605033826;21359.786402135975;21577.46056348588;21733.456663583398;19919.40241792745;21656.783432165674;21705.891470542625;21913;22037.33887983359;6412.262589802174;6738.090357801683;6761.594304341731;6763.729450821961;6803.625800580966;6355.523335749815;6520.152380190569;6569.967150164242;6586.769463068794;6592.307807680172;6511.958086706128;6527.804165875032;6561.540692151551;6591.670416479157;6597.043428702859;6426.518011149159;6562.081308616797;6604.603723776589;6604.900926486131;6606.8017959461295;6127.172831667757;6343.714532846033;6418.839529011765;6421.101045853584;6436.710348034349;26390.208293751217;26412.47175056488;26465;26857.328566785985;26988.46023079547;2261.683364328995;2914.12576227131;2951.631046119235;2955;2961.881524739008;14052.648683782885;14518.92740536301;16284.918575407166;16718.996860188305;16868.409605663866;1975.07171629334;2026.5845501672122;2055.989720051405;2111.5671287386203;2121.586290673319;144654;150520;150908;151648.2417587916;152710;21817.781822181892;22343;22499.775002250095;22722;22738.886305568365;34221;34286;34566;34567.827160864035;34592.308153836784;9775.755606109762;9950.601975921027;10153.441560714231;10212.693619191436;10392.584296628202;7966.3626909848235;8060.677572897136;8229.876551851727;8249.79375515605;8263.173682631688;10367.94816025915;10647.787044259072;10910.290831095954;10959.342439453658;11154.665360039211;4036.1524079942956;4443.955560444419;4538.364628951949;4566.657500687462;4605.40129783126;880.9779755506036;923.6397804856111;929.3076657889916;951.1629765806047;971.9902800972042;18613.813861861207;23367.065317387114;23597.42228961329;23691.1708090216;23847.761522384902;867.496851825952;940.8897500948809;961.6922584772946;973.3964941736169;976.829054915387;9527.428354298625;11828.230148886423;12247.69380765488;12335.074869384833;12673.809892851614;656632;656789;668888;671891;686133;131380;134730;135662.28675426435;138590.3070484641;148407.2579637095;1149.9712507187387;1316.5523721934396;1327.0909427042507;1334.833145856768;1338.5515852189626;20574.588508230052;21695.674564881854;21790.89104554467;21876.343709688736;21962.341129766133;60375.698121509115;61141.69429153004;62136;62618.06072908819;63005;61179.38820611737;86089.56955215184;86343.56828215819;86636.13363866533;87238.56380718056;10671.199660025373;11890.643280701594;11905.52377904874;12188;12188.329641869783;13533.729325413633;13590.864091359355;13608.591742247749;13924.164550127025;13936.651583710489;11193.496292667012;11374.829377559508;11462.885371146516;11687.415629218674;11809.586664466702;11463.484143213409;11469.254498457574;11631.6510504685;11722.824157637813;11816.40917954116;9830.950845245728;11337;11672;12060.638180854588;12120.090993175723;11742.412879356169;11763.705907352043;12034.879651203375;12041.759164816829;12105.152639315163;11371;11527.020203282815;11733.296002239893;11745.530178792753;11854.229475084092 15:48:28 INFO - PID 1916 | |3;mootools.html;1545.8686011689006;1568.7960565126532;1583.0501698980606;1614.8453855493324;1648.3818568036986;9439.575219115139;9717.951410242938;10711.678649640504;11164.720881977944;11192.552297908083;7701.92298077019;9483.905160948389;9506.762330941712;9514.381565198257;9547.997460266659;2031.9535439248762;2270.71616047994;2356.8821558922073;2376.4534157143867;2384.1893756122913;2300.0799680127916;2328.1734984080663;2339.333290012347;2344.3084290134366;2346.296111166652;2315.143396943125;2318.6290193569034;2331.184085570054;2340.8829558522093;2343.414146463384;2307.1348244408177;2314.4908120213527;2318.6406107053267;2327.487952650414;2328.9417764555938;2301.4476525633895;2309.3187509684517;2326.8836558172193;2351.5532048910823;2359.079958816063;10948.671539853816;11054.889451105466;11069.059129973963;11103.944480277627;11105.333679979147;5751.683657398841;5924.2298501195;5981.0729336952845;5981.910271345933;6009.278886533601;3378.8310584470923;3493.283876805249;3644.9817750911343;3690.9815450922843;3717.9961410419305;1069.4652673663168;1141.7088642396136;1185.419144619139;1189.9405029748477;1222.7493363860387;15654.843451565452;15664.686706265811;15812.209389530593;15822.446214382557;15870.523884283375;4697.365855609517;4994.525520075587;5023.447420783711;5052.014857102903;5091.9236211456855;12744.490220391266;12804.359782011048;12809.487620495076;12867.549635762703;12879.613611591667;5109.948900511022;5919.496842768327;5994.490468310242;5996.5202783777195;6006.819795406145;4809.591184749265;4810.725157833177;5149.948500514947;5214.661047031931;5284.101702710548;3389.18659521713;3983.940240896389;4144.3990621359735;4151.335786274181;4165.875023749292;1159.3275899978162;1163.7148898519918;1167.9357635329968;1178.5462596900254;1178.7347846734417;796.9838455968686;827.3670641958786;844.1716814247359;883.9204471597587;888.0453512474116;5414.675119492843;6459.483241340681;6595.241547222035;6621.702023408862;6733.7643182489355;970.4322971061866;973.5278389980854;977.6138425321958;980.5342462330336;995;4064.5122585289955;4125.958740412618;4183.53981062089;4211.642010429086;4247.447831781848;10780.838287425695;12956.546520871725;13420.463181472827;13510.98667599934;13542.119762215425;13159.342032898508;13394.93302533481;13565.457381704819;13896;13903;9342.2526197904;9519.57161927701;9800.509974501247;9881.555330010167;10009.149222316039;6015.218021657157;6172.475339596184;6306.495480361468;6594.769183078569;6866.313368663294;9381.296402769956;12006.519739210335;12236.755264894475;12316.630501084981;12318.322492263012;11629.53481860716;11963.342016188844;12068.879311206776;12117.212381195193;12173.147879648339;9041.954790226007;9369.203617692572;9374.5781439834;9382;9388.24894008464;10047.196224302184;10405.531751071068;10428.322159059637;10474.947625261824;10476.109530689977;8944.195022448012;9070.909290907006;9121.771955700895;9136.132067453582;9295.76760580991;8470.32237421017;8967.237784788365;8977.326700497359;9051.411658242194;9056.818863622822;7702.345300649507;7856.7250146244605;7889.960550197212;7959.801004974922;7963.124056353912;5821.592488525763;5856.94143058581;5967.582269241111;6041.154238406714;6065.8180254592435;5907.586468947133;6018.796240751954;6099.268087829489;6114.113453549122;6243.531735119794 15:48:28 INFO - PID 1916 | |4;prototype.html;317.934823361211;348.5294851949868;377.3660250778691;389.0216106492173;397.4435789894148;5942.554308426869;6107.633541987473;6295.803797278514;6328.430441260286;6333.240011198663;5377.381601115872;6079.361667024954;6165.876682466348;6189.721462534186;6208.286047104584;4986.501349865002;5148.536631703137;5189.896202075956;5193.298904647881;5202.739863006854;4499.885054024619;5162.535371816536;5209.583233341324;5236.502532259429;5307.495787900162;5073.771680274378;5166.236063705918;5181.222816577525;5184.637075404723;5196.76614552346;4009.69927255457;4085.039181193029;5080.77136528857;5115.283860259585;5116.9744151279;4614.284785858164;4676.368690226844;4680.485146633868;4704.741239231841;4755.857324280277;5962.165296858443;5989.772096720162;6088.117223002684;6116.348585881831;6122.204113465221;5017.824376146854;5927.585069045169;5969.761209551612;6016.639001659914;6034.125051867499;6728;6729.629870357128;6729.663516824139;6732.2257940336995;6751.594904305757;4330.523642399334;4780.020095880336;5118.192662560578;5215.087359712035;5217.660852044605;6711.630860302681;6919.99999999995;7094.787156385265;7146.857062858714;7194.4963852530345;4520.389747384127;5162.277281180638;5304.628675992643;5394.38983457208;5405.702686352289;5465.251119641676;5476.726163691799;5477.397486276506;5483.479069488392;5502.312210973629;5119.6160287978555;5577;5909.379515150933;5930.644161350333;5935.495482883917;5288.545649946295;6656.70044847983;6682.899756503656;6684.930411134195;6787.796366109024;1787.347618119377;1844.880082794614;1846.8799528030636;1878.6336664350595;1883.303177824214;1350.1628990026247;1370.4518192722792;1379.2138481065897;1386.2791348498927;1390.318743815523;5794.1308803679785;6216.23377596974;6226.439620434092;6246.281677607042;6254.249490061222;5804.216430781875;6284.560080794392;6309.432151106423;6890.483213758988;6901.996052861736;5492.423295553989;5831.329397119385;5869.20765696634;6242.406971337807;6242.812715618538;3190.680931906837;3467.982660086734;3621.348157331653;3626.220362621996;3648.3615367310613;5603.971980140073;5959.0763431668165;6072.605280656743;7156.964215178891;7157;7078.221395646475;7119.433724580687;7136.750213742598;7143.785426517796;7178.964105179441;6738;6766.830829229309;7031.8593628127155;7105.644717764195;7123.287671232835;5992.370801065826;6851.3491218334175;6862.176538815374;6866.34769696878;6904.482163837632;5148.90661923764;5992.98119319708;6221.440070393686;6224.968875155595;6582.736690532325;6221.564490485623;7191.928080719126;7206.603636800026;7243.5653860768525;7263.745768898063;4517.022251439224;4731.077439899186;5336.706481143575;5338.946610533845;5346.224797404432;5793.362730099601;6774.119364482585;6803.217629972616;6804.489663275175;6807.625580593115;5263.34208223972;6617.470602351897;6637.203535575762;6691.631960242234;6704.731810727516;6314.810555683337;6639.435647969976;6667.766628167991;6690;6733.326667333227;5703.344115426779;5769.336526299529;5805.82582522525;6586.847301722084;6605.372489613479;6052.606580572248;6093.421124993119;6430.839229019312;6697.497687673542;6749.122614060141;5881;6494.188226471691;6526.748271846205;6553.180852393451;6556.68866226747 15:48:28 INFO - PID 1916 | |5;yui.html;599.6222379900664;705.2700455029046;749.1983577572;797.9880301795472;817.5626040068564;15448.768268475967;15885.761713574291;15898.84101158988;15918.920405397972;15933.44232951847;13854.461712150494;13871.514496992608;14430;14520.782188267158;14576.635584110403;927.0590350793949;956.956936937836;959.9424034557914;960.6829746183743;961.2262128986164;957.248559880494;957.7749228931195;958;958.5351104714208;960.183843732825;973.7127547373542;1014.4876837197205;1015.147276287918;1020.3520764314677;1021.0504231065144;863.7063398444527;1000.5547531348553;1013.1034034879185;1013.3109485549786;1013.5742987945044;740.6889106575252;742.1465314887868;748.7828529726373;751.9887201691979;753.2354660020084;16004.679906401923;16285.185740712917;16686;16702.4154154604;16722;12299.772023206673;14533.418663253457;14877;14952.925235373754;15014.174220417872;11798.351090690094;11817.822732659017;11851.822222666668;11887.821682674767;12076.094292927977;3073.431415188197;3690.852365905361;3733.4773131761576;3744.3634582121103;3834.5206849143856;106999.4650026745;107634;109619;110516;112278.43860780726;11259.605913793142;11410.600628977945;11428.885711142948;11730.354830484235;11823.349715765715;24788.628170577456;25046.248612541287;25051.373715657253;25067;25069.4986100277;7784.065912090586;7960.721374751972;7962.800929976797;8124.22819832115;8226.300764434971;4237.618614324726;4307.203167414038;4336.804843782037;4356.237658409766;4501.549845015537;3370.9325813484083;3405.4721518164724;3414;3470.687638112582;3485.546878905777;623.5261201486812;626.9467095296951;638.4668801550757;641.0480436551717;646.7186773753432;582.621296157501;632.1655414852443;650.3334082565408;658.7439355499181;668.4451904918906;8623.78440538979;10019.949900250598;10236.948815255875;10572.995565421274;10588.523516441779;629.7656593077619;643.832603523078;669.220358282605;680.5508364479518;695.978515014165;4658.58072773452;4917.385326834145;4921.458639549646;4950.6782059166035;4966.180580204298;79518.6024069876;83940.16059839446;92677;94129;99050;70640.94038589425;73454.63272683602;75812;80786;85848.57075714707;71095.64452177707;71321;71342.2164445893;71560.56878862393;71761.92357114647;8767.60545775429;10361.326513776581;10372.948135259276;10742.677719668422;10805.45972701346;44899.551004489535;47375.52624473711;47920.041599167125;48316.51683483261;48330.5166948326;61375.69312153589;62119;62275.06587401102;62362.68818656059;62782;13003.219806811621;13060.608181754562;13344.466221351426;14111.647208819862;14112.50606228777;14317.856821431653;14432.278386080445;14452.927735361256;14880.470320045402;14996.550103496913;13544.32278386057;13576.253306067865;13708.931455343058;13837.377318020915;14038.649033773829;10668.253222274367;12482;12515.311657858905;12580.496780128693;12888.097833151589;9761.414315141114;12911.483540658268;13100.934495327463;13321.067525273138;13822.723545528832;10786.474559313674;10997.285176463503;11276;11577.421128943688;11747.647570572897;9296.235024814961;9531.666391676257;10804.189685773441;11174.441277936234;11224.326540407601 15:48:28 INFO - PID 1916 | __end_tp_report 15:48:28 INFO - PID 1916 | __start_cc_report 15:48:28 INFO - PID 1916 | _x_x_mozilla_cycle_collect,429 15:48:28 INFO - PID 1916 | __end_cc_report 15:48:28 INFO - PID 1916 | __startTimestamp1489618108792__endTimestamp 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | ------- Summary: start ------- 15:48:28 INFO - PID 1916 | Number of tests: 6 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | [#0] dojo.html Cycles:165 Average:5889.99 Median:6169.32 stddev:678.76 (11.0%) stddev-sans-first:645.47 15:48:28 INFO - PID 1916 | Values: 3133.2 3404.1 3455.5 3477.3 3480.5 5791.8 5933.0 5958.8 5960.6 6006.3 5824.8 5968.4 6050.8 6085.4 6088.3 5321.5 5380.5 5412.4 5495.3 5533.9 5343.6 5362.1 5377.4 5443.2 5484.6 4837.5 5448.5 5459.1 5477.2 5493.0 4340.5 5311.4 5380.4 5401.3 5446.1 5296.8 5342.8 5343.1 5353.8 5359.1 5050.6 5562.0 6005.5 6056.3 6073.7 6209.8 6250.9 6264.1 6287.8 6287.9 6407.0 6437.3 6438.9 6453.9 6456.8 6134.4 6138.9 6154.7 6182.9 6192.5 5728.0 6289.7 6451.6 6497.3 6637.9 6145.7 6228.3 6233.8 6236.8 6243.6 6099.9 6180.7 6226.9 6273.8 6359.0 5176.0 5425.0 6310.9 6316.4 6322.6 5323.4 6226.2 6295.2 6300.2 6313.3 4862.9 5096.2 5103.6 5142.3 5166.6 3921.3 4338.4 4620.8 4624.0 4636.9 6163.5 6169.3 6169.7 6183.6 6199.3 6196.3 6236.8 6318.6 6333.3 6414.8 6109.5 6111.8 6133.8 6148.6 6153.6 5591.9 5653.0 5654.8 5677.3 5688.6 6337.1 6397.4 6469.4 6613.0 6658.3 6334.1 6355.3 6374.8 6381.0 6385.9 6626.9 6637.0 6645.3 6648.4 6648.7 6216.4 6267.9 6270.3 6284.8 6330.1 6221.2 6271.4 6294.3 6314.5 6314.9 6060.0 6265.5 6272.9 6281.8 6294.2 6147.7 6207.6 6243.8 6254.8 6295.7 6149.4 6155.6 6171.3 6295.7 6298.5 6267.8 6267.9 6291.4 6297.1 6336.7 6081.3 6127.0 6131.4 6272.4 6309.4 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | [#1] ext.html Cycles:180 Average:52376.66 Median:181477.84 stddev:100149.30 (55.2%) stddev-sans-first:100355.12 15:48:28 INFO - PID 1916 | Values: 711.9 774.0 802.3 936.6 939.7 37964.4 38696.4 38699.0 38759.0 38798.8 37282.6 37633.4 37702.8 37741.9 37797.8 7699.3 7842.7 10820.9 11056.2 11059.6 11057.5 11234.9 11263.0 11406.5 11438.1 11341.0 11382.9 11386.9 11450.2 11453.1 8730.7 10235.9 11357.1 11358.1 11418.5 9330.8 9551.3 10993.7 11058.4 11071.3 38488.4 38645.0 38684.4 38717.8 38736.8 3043.5 3571.7 3715.8 3735.7 3781.8 28249.0 28297.0 28316.9 28433.9 29160.4 2707.9 3084.4 3147.6 3160.1 3250.4 330061.0 330214.0 332550.0 332777.7 333551.0 49518.0 49537.8 49562.5 49751.5 49824.8 52251.5 52286.0 52461.7 52572.7 52673.7 13830.3 14033.6 14188.3 14199.6 14206.3 9555.6 11335.5 11347.2 11364.9 11365.2 13780.4 13905.1 14007.5 14027.7 14142.6 5316.7 6243.2 6254.9 6264.2 6270.7 1091.9 1130.9 1135.1 1142.2 1159.0 22608.0 24389.4 25885.8 26067.9 26699.0 1219.7 1237.4 1243.4 1249.6 1266.5 10918.5 12751.8 13018.8 13722.9 13864.6 443789.2 448568.0 449346.0 449461.0 450155.7 55902.2 55963.4 56220.7 56294.0 56327.7 1160.1 1246.7 1404.3 1407.6 1416.2 23601.5 28852.0 29096.4 29613.3 29776.0 43808.0 44081.0 44301.3 44329.1 44362.1 344484.3 346086.0 347401.0 348002.0 348047.0 31695.5 32395.8 32532.8 32569.3 33076.5 41490.6 41643.0 41910.6 42468.5 43310.8 35374.3 35577.8 35752.8 36917.6 36976.4 30572.1 32894.7 33361.5 36687.8 36725.6 35441.6 36377.3 36486.8 36938.8 37139.4 29611.4 30627.4 31265.5 32065.2 32077.2 24423.6 24472.1 24622.3 24790.6 24817.9 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | [#2] jquery.html Cycles:180 Average:40421.79 Median:12491.84 stddev:111608.40 (893.5%) stddev-sans-first:111881.03 15:48:28 INFO - PID 1916 | Values: 400.2 402.8 403.9 408.5 430.9 20319.6 20684.3 21359.8 21577.5 21733.5 19919.4 21656.8 21705.9 21913.0 22037.3 6412.3 6738.1 6761.6 6763.7 6803.6 6355.5 6520.2 6570.0 6586.8 6592.3 6512.0 6527.8 6561.5 6591.7 6597.0 6426.5 6562.1 6604.6 6604.9 6606.8 6127.2 6343.7 6418.8 6421.1 6436.7 26390.2 26412.5 26465.0 26857.3 26988.5 2261.7 2914.1 2951.6 2955.0 2961.9 14052.6 14518.9 16284.9 16719.0 16868.4 1975.1 2026.6 2056.0 2111.6 2121.6 144654.0 150520.0 150908.0 151648.2 152710.0 21817.8 22343.0 22499.8 22722.0 22738.9 34221.0 34286.0 34566.0 34567.8 34592.3 9775.8 9950.6 10153.4 10212.7 10392.6 7966.4 8060.7 8229.9 8249.8 8263.2 10367.9 10647.8 10910.3 10959.3 11154.7 4036.2 4444.0 4538.4 4566.7 4605.4 881.0 923.6 929.3 951.2 972.0 18613.8 23367.1 23597.4 23691.2 23847.8 867.5 940.9 961.7 973.4 976.8 9527.4 11828.2 12247.7 12335.1 12673.8 656632.0 656789.0 668888.0 671891.0 686133.0 131380.0 134730.0 135662.3 138590.3 148407.3 1150.0 1316.6 1327.1 1334.8 1338.6 20574.6 21695.7 21790.9 21876.3 21962.3 60375.7 61141.7 62136.0 62618.1 63005.0 61179.4 86089.6 86343.6 86636.1 87238.6 10671.2 11890.6 11905.5 12188.0 12188.3 13533.7 13590.9 13608.6 13924.2 13936.7 11193.5 11374.8 11462.9 11687.4 11809.6 11463.5 11469.3 11631.7 11722.8 11816.4 9831.0 11337.0 11672.0 12060.6 12120.1 11742.4 11763.7 12034.9 12041.8 12105.2 11371.0 11527.0 11733.3 11745.5 11854.2 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | [#3] mootools.html Cycles:180 Average:6672.13 Median:4095.24 stddev:4175.67 (102.0%) stddev-sans-first:4169.61 15:48:28 INFO - PID 1916 | Values: 1545.9 1568.8 1583.1 1614.8 1648.4 9439.6 9718.0 10711.7 11164.7 11192.6 7701.9 9483.9 9506.8 9514.4 9548.0 2032.0 2270.7 2356.9 2376.5 2384.2 2300.1 2328.2 2339.3 2344.3 2346.3 2315.1 2318.6 2331.2 2340.9 2343.4 2307.1 2314.5 2318.6 2327.5 2328.9 2301.4 2309.3 2326.9 2351.6 2359.1 10948.7 11054.9 11069.1 11103.9 11105.3 5751.7 5924.2 5981.1 5981.9 6009.3 3378.8 3493.3 3645.0 3691.0 3718.0 1069.5 1141.7 1185.4 1189.9 1222.7 15654.8 15664.7 15812.2 15822.4 15870.5 4697.4 4994.5 5023.4 5052.0 5091.9 12744.5 12804.4 12809.5 12867.5 12879.6 5109.9 5919.5 5994.5 5996.5 6006.8 4809.6 4810.7 5149.9 5214.7 5284.1 3389.2 3983.9 4144.4 4151.3 4165.9 1159.3 1163.7 1167.9 1178.5 1178.7 797.0 827.4 844.2 883.9 888.0 5414.7 6459.5 6595.2 6621.7 6733.8 970.4 973.5 977.6 980.5 995.0 4064.5 4126.0 4183.5 4211.6 4247.4 10780.8 12956.5 13420.5 13511.0 13542.1 13159.3 13394.9 13565.5 13896.0 13903.0 9342.3 9519.6 9800.5 9881.6 10009.1 6015.2 6172.5 6306.5 6594.8 6866.3 9381.3 12006.5 12236.8 12316.6 12318.3 11629.5 11963.3 12068.9 12117.2 12173.1 9042.0 9369.2 9374.6 9382.0 9388.2 10047.2 10405.5 10428.3 10474.9 10476.1 8944.2 9070.9 9121.8 9136.1 9295.8 8470.3 8967.2 8977.3 9051.4 9056.8 7702.3 7856.7 7890.0 7959.8 7963.1 5821.6 5856.9 5967.6 6041.2 6065.8 5907.6 6018.8 6099.3 6114.1 6243.5 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | [#4] prototype.html Cycles:180 Average:5545.51 Median:5979.77 stddev:1573.72 (26.3%) stddev-sans-first:1528.43 15:48:28 INFO - PID 1916 | Values: 317.9 348.5 377.4 389.0 397.4 5942.6 6107.6 6295.8 6328.4 6333.2 5377.4 6079.4 6165.9 6189.7 6208.3 4986.5 5148.5 5189.9 5193.3 5202.7 4499.9 5162.5 5209.6 5236.5 5307.5 5073.8 5166.2 5181.2 5184.6 5196.8 4009.7 4085.0 5080.8 5115.3 5117.0 4614.3 4676.4 4680.5 4704.7 4755.9 5962.2 5989.8 6088.1 6116.3 6122.2 5017.8 5927.6 5969.8 6016.6 6034.1 6728.0 6729.6 6729.7 6732.2 6751.6 4330.5 4780.0 5118.2 5215.1 5217.7 6711.6 6920.0 7094.8 7146.9 7194.5 4520.4 5162.3 5304.6 5394.4 5405.7 5465.3 5476.7 5477.4 5483.5 5502.3 5119.6 5577.0 5909.4 5930.6 5935.5 5288.5 6656.7 6682.9 6684.9 6787.8 1787.3 1844.9 1846.9 1878.6 1883.3 1350.2 1370.5 1379.2 1386.3 1390.3 5794.1 6216.2 6226.4 6246.3 6254.2 5804.2 6284.6 6309.4 6890.5 6902.0 5492.4 5831.3 5869.2 6242.4 6242.8 3190.7 3468.0 3621.3 3626.2 3648.4 5604.0 5959.1 6072.6 7157.0 7157.0 7078.2 7119.4 7136.8 7143.8 7179.0 6738.0 6766.8 7031.9 7105.6 7123.3 5992.4 6851.3 6862.2 6866.3 6904.5 5148.9 5993.0 6221.4 6225.0 6582.7 6221.6 7191.9 7206.6 7243.6 7263.7 4517.0 4731.1 5336.7 5338.9 5346.2 5793.4 6774.1 6803.2 6804.5 6807.6 5263.3 6617.5 6637.2 6691.6 6704.7 6314.8 6639.4 6667.8 6690.0 6733.3 5703.3 5769.3 5805.8 6586.8 6605.4 6052.6 6093.4 6430.8 6697.5 6749.1 5881.0 6494.2 6526.7 6553.2 6556.7 15:48:28 INFO - PID 1916 | 15:48:28 INFO - PID 1916 | [#5] yui.html Cycles:180 Average:19640.45 Median:3409.74 stddev:27329.44 (801.5%) stddev-sans-first:27368.71 15:48:28 INFO - PID 1916 | Values: 599.6 705.3 749.2 798.0 817.6 15448.8 15885.8 15898.8 15918.9 15933.4 13854.5 13871.5 14430.0 14520.8 14576.6 927.1 957.0 959.9 960.7 961.2 957.2 957.8 958.0 958.5 960.2 973.7 1014.5 1015.1 1020.4 1021.1 863.7 1000.6 1013.1 1013.3 1013.6 740.7 742.1 748.8 752.0 753.2 16004.7 16285.2 16686.0 16702.4 16722.0 12299.8 14533.4 14877.0 14952.9 15014.2 11798.4 11817.8 11851.8 11887.8 12076.1 3073.4 3690.9 3733.5 3744.4 3834.5 106999.5 107634.0 109619.0 110516.0 112278.4 11259.6 11410.6 11428.9 11730.4 11823.3 24788.6 25046.2 25051.4 25067.0 25069.5 7784.1 7960.7 7962.8 8124.2 8226.3 4237.6 4307.2 4336.8 4356.2 4501.5 3370.9 3405.5 3414.0 3470.7 3485.5 623.5 626.9 638.5 641.0 646.7 582.6 632.2 650.3 658.7 668.4 8623.8 10019.9 10236.9 10573.0 10588.5 629.8 643.8 669.2 680.6 696.0 4658.6 4917.4 4921.5 4950.7 4966.2 79518.6 83940.2 92677.0 94129.0 99050.0 70640.9 73454.6 75812.0 80786.0 85848.6 71095.6 71321.0 71342.2 71560.6 71761.9 8767.6 10361.3 10372.9 10742.7 10805.5 44899.6 47375.5 47920.0 48316.5 48330.5 61375.7 62119.0 62275.1 62362.7 62782.0 13003.2 13060.6 13344.5 14111.6 14112.5 14317.9 14432.3 14452.9 14880.5 14996.6 13544.3 13576.3 13708.9 13837.4 14038.6 10668.3 12482.0 12515.3 12580.5 12888.1 9761.4 12911.5 13100.9 13321.1 13822.7 10786.5 10997.3 11276.0 11577.4 11747.6 9296.2 9531.7 10804.2 11174.4 11224.3 15:48:28 INFO - PID 1916 | -------- Summary: end -------- 15:48:28 INFO - PID 1916 | 15:48:29 INFO - TEST-INFO | 1916: exit 0 15:48:29 INFO - TEST-OK | dromaeo_css | took 1116596ms 15:48:29 INFO - TEST-START | kraken 15:48:29 INFO - operating with platform_type : mac_ 15:48:29 INFO - Initialising browser for kraken test... 15:48:29 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpgUfHEY/profile http://localhost:56579/getInfo.html) 15:48:32 INFO - PID 1925 | 2017-03-15 15:48:32.404 plugin-container[1926:21422] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 15:48:32 INFO - PID 1925 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:48:32 INFO - PID 1925 | 2017-03-15 15:48:32.407 plugin-container[1926:21422] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 15:48:32 INFO - PID 1925 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:48:32 INFO - PID 1925 | 2017-03-15 15:48:32.408 plugin-container[1926:21422] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:48:32 INFO - PID 1925 | __metrics Screen width/height:1600/1200 15:48:32 INFO - PID 1925 | colorDepth:24 15:48:32 INFO - PID 1925 | Browser inner width/height: 1024/689 15:48:32 INFO - PID 1925 | __metrics 15:48:32 ERROR - PID 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 15:48:33 INFO - TEST-INFO | 1925: exit 0 15:48:33 INFO - Browser initialized. 15:48:33 INFO - Running cycle 1/1 for kraken test... 15:48:33 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpgUfHEY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:35 INFO - PID 1927 | 2017-03-15 15:48:35.717 plugin-container[1928:21552] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 15:48:35 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:48:35 INFO - PID 1927 | 2017-03-15 15:48:35.718 plugin-container[1928:21552] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 15:48:35 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:48:35 INFO - PID 1927 | 2017-03-15 15:48:35.718 plugin-container[1928:21552] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:48:45 INFO - PID 1927 | RSS: Main: 227848192 15:48:45 INFO - PID 1927 | 15:48:48 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:49 INFO - PID 1927 | RSS: Main: 242077696 15:48:49 INFO - PID 1927 | 15:48:52 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-dft) 15:48:52 INFO - PID 1927 | RSS: Main: 250638336 15:48:52 INFO - PID 1927 | 15:48:55 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-fft) 15:48:56 INFO - PID 1927 | RSS: Main: 253435904 15:48:56 INFO - PID 1927 | 15:48:58 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-oscillator) 15:48:59 INFO - PID 1927 | RSS: Main: 254574592 15:48:59 INFO - PID 1927 | 15:49:01 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:49:01 INFO - PID 1927 | RSS: Main: 256307200 15:49:01 INFO - PID 1927 | 15:49:04 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56579/tests/kraken/driver.html?testName=imaging-darkroom) 15:49:05 INFO - PID 1927 | RSS: Main: 261345280 15:49:05 INFO - PID 1927 | 15:49:08 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56579/tests/kraken/driver.html?testName=imaging-desaturate) 15:49:09 INFO - PID 1927 | RSS: Main: 262332416 15:49:09 INFO - PID 1927 | 15:49:12 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56579/tests/kraken/driver.html?testName=json-parse-financial) 15:49:13 INFO - PID 1927 | RSS: Main: 262397952 15:49:13 INFO - PID 1927 | 15:49:15 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:49:15 INFO - PID 1927 | RSS: Main: 262144000 15:49:15 INFO - PID 1927 | 15:49:17 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:49:18 INFO - PID 1927 | RSS: Main: 262066176 15:49:18 INFO - PID 1927 | 15:49:20 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:49:21 INFO - PID 1927 | RSS: Main: 262144000 15:49:21 INFO - PID 1927 | 15:49:24 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:49:24 INFO - PID 1927 | RSS: Main: 262664192 15:49:24 INFO - PID 1927 | 15:49:27 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:49:28 INFO - PID 1927 | RSS: Main: 262238208 15:49:28 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56579/tests/kraken/driver.html?testName=ai-astar) 15:49:30 INFO - PID 1927 | RSS: Main: 263892992 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | __start_tp_report 15:49:30 INFO - PID 1927 | _x_x_mozilla_page_load 15:49:30 INFO - PID 1927 | _x_x_mozilla_page_load_details 15:49:30 INFO - PID 1927 | |i|pagename|runs| 15:49:30 INFO - PID 1927 | |0;ai-astar;108;125;121;119;120;119;120;124;163;120 15:49:30 INFO - PID 1927 | |1;audio-beat-detection;151;113;127;191;151;99;147;145;172;120 15:49:30 INFO - PID 1927 | |2;audio-dft;203;204;215;208;223;202;202;202;204;193 15:49:30 INFO - PID 1927 | |3;audio-fft;77;59;62;88;59;57;59;64;84;59 15:49:30 INFO - PID 1927 | |4;audio-oscillator;85;71;88;72;72;70;85;72;73;83 15:49:30 INFO - PID 1927 | |5;imaging-gaussian-blur;128;93;92;92;85;135;85;136;137;104 15:49:30 INFO - PID 1927 | |6;imaging-darkroom;138;136;99;124;99;118;105;92;91;133 15:49:30 INFO - PID 1927 | |7;imaging-desaturate;91;132;91;144;93;142;147;73;78;125 15:49:30 INFO - PID 1927 | |8;json-parse-financial;67;67;64;68;68;69;68;81;104;104 15:49:30 INFO - PID 1927 | |9;json-stringify-tinderbox;57;63;59;66;61;57;57;58;59;60 15:49:30 INFO - PID 1927 | |10;stanford-crypto-aes;79;84;83;74;104;107;109;82;73;102 15:49:30 INFO - PID 1927 | |11;stanford-crypto-ccm;146;148;159;131;127;155;141;153;214;160 15:49:30 INFO - PID 1927 | |12;stanford-crypto-pbkdf2;188;193;188;188;193;187;191;191;188;196 15:49:30 INFO - PID 1927 | |13;stanford-crypto-sha256-iterative;75;92;89;77;68;67;68;66;67;69 15:49:30 INFO - PID 1927 | __end_tp_report 15:49:30 INFO - PID 1927 | __start_cc_report 15:49:30 INFO - PID 1927 | _x_x_mozilla_cycle_collect,994 15:49:30 INFO - PID 1927 | __end_cc_report 15:49:30 INFO - PID 1927 | __startTimestamp1489618170675__endTimestamp 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | ------- Summary: start ------- 15:49:30 INFO - PID 1927 | Number of tests: 14 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#0] ai-astar Cycles:10 Average:123.90 Median:120.50 stddev:14.47 (12.0%) stddev-sans-first:14.16 15:49:30 INFO - PID 1927 | Values: 108.0 125.0 121.0 119.0 120.0 119.0 120.0 124.0 163.0 120.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:151.00 stddev:27.68 (18.3%) stddev-sans-first:29.15 15:49:30 INFO - PID 1927 | Values: 151.0 113.0 127.0 191.0 151.0 99.0 147.0 145.0 172.0 120.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#2] audio-dft Cycles:10 Average:205.60 Median:204.00 stddev:8.21 (4.0%) stddev-sans-first:8.65 15:49:30 INFO - PID 1927 | Values: 203.0 204.0 215.0 208.0 223.0 202.0 202.0 202.0 204.0 193.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#3] audio-fft Cycles:10 Average:66.80 Median:63.00 stddev:11.64 (18.5%) stddev-sans-first:11.75 15:49:30 INFO - PID 1927 | Values: 77.0 59.0 62.0 88.0 59.0 57.0 59.0 64.0 84.0 59.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.00 stddev:7.16 (9.2%) stddev-sans-first:7.00 15:49:30 INFO - PID 1927 | Values: 85.0 71.0 88.0 72.0 72.0 70.0 85.0 72.0 73.0 83.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#5] imaging-gaussian-blur Cycles:10 Average:108.70 Median:85.00 stddev:22.51 (26.5%) stddev-sans-first:22.77 15:49:30 INFO - PID 1927 | Values: 128.0 93.0 92.0 92.0 85.0 135.0 85.0 136.0 137.0 104.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#6] imaging-darkroom Cycles:10 Average:113.50 Median:114.50 stddev:18.49 (16.2%) stddev-sans-first:17.36 15:49:30 INFO - PID 1927 | Values: 138.0 136.0 99.0 124.0 99.0 118.0 105.0 92.0 91.0 133.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#7] imaging-desaturate Cycles:10 Average:111.60 Median:75.50 stddev:29.13 (38.6%) stddev-sans-first:29.93 15:49:30 INFO - PID 1927 | Values: 91.0 132.0 91.0 144.0 93.0 142.0 147.0 73.0 78.0 125.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#8] json-parse-financial Cycles:10 Average:76.00 Median:68.00 stddev:15.42 (22.7%) stddev-sans-first:16.01 15:49:30 INFO - PID 1927 | Values: 67.0 67.0 64.0 68.0 68.0 69.0 68.0 81.0 104.0 104.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.50 stddev:2.95 (5.0%) stddev-sans-first:2.96 15:49:30 INFO - PID 1927 | Values: 57.0 63.0 59.0 66.0 61.0 57.0 57.0 58.0 59.0 60.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:76.50 stddev:14.16 (18.5%) stddev-sans-first:14.48 15:49:30 INFO - PID 1927 | Values: 79.0 84.0 83.0 74.0 104.0 107.0 109.0 82.0 73.0 102.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:154.00 stddev:24.01 (15.6%) stddev-sans-first:25.31 15:49:30 INFO - PID 1927 | Values: 146.0 148.0 159.0 131.0 127.0 155.0 141.0 153.0 214.0 160.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.30 Median:191.00 stddev:2.98 (1.6%) stddev-sans-first:3.05 15:49:30 INFO - PID 1927 | Values: 188.0 193.0 188.0 188.0 193.0 187.0 191.0 191.0 188.0 196.0 15:49:30 INFO - PID 1927 | 15:49:30 INFO - PID 1927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:72.00 stddev:9.53 (13.2%) stddev-sans-first:10.10 15:49:30 INFO - PID 1927 | Values: 75.0 92.0 89.0 77.0 68.0 67.0 68.0 66.0 67.0 69.0 15:49:30 INFO - PID 1927 | -------- Summary: end -------- 15:49:30 INFO - PID 1927 | 15:49:31 INFO - TEST-INFO | 1927: exit 0 15:49:31 INFO - TEST-OK | kraken | took 62125ms 15:49:31 INFO - SUITE-END | took 1178s 15:49:31 INFO - Completed test suite (00:19:38) 15:49:31 INFO - javascript benchmark 15:49:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7934.026903518745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.2166958260436, 3404.0979140527766, 3455.533502977097, 3477.3045390921816, 3480.477928310753, 5791.7972870949525, 5932.970335148324, 5958.821235362941, 5960.612560183585, 6006.339302676702, 5824.825255242339, 5968.40315968403, 6050.788222412217, 6085.4218849209365, 6088.299845517767, 5321.467853214686, 5380.515753582186, 5412.395489836216, 5495.258140151089, 5533.861653458655, 5343.625946183769, 5362.1420572708375, 5377.381601115863, 5443.2107344435035, 5484.561235101182, 4837.516248375152, 5448.45515448456, 5459.12653975366, 5477.20580515825, 5492.972535137339, 4340.500842403132, 5311.389190243094, 5380.381256155514, 5401.297831281948, 5446.128619420873, 5296.841094767125, 5342.786288548454, 5343.145096784496, 5353.785848566053, 5359.08895487768, 5050.621203409759, 5561.972190139023, 6005.519558435359, 6056.303525094627, 6073.665948372838, 6209.782657606962, 6250.87498250037, 6264.091706702548, 6287.842803929892, 6287.937120628781, 6407.0, 6437.259715132773, 6438.871222575523, 6453.870922581522, 6456.774012909573, 6134.355892631299, 6138.938610613836, 6154.692265386713, 6182.907256391158, 6192.535559832985, 5727.968965586151, 6289.7484100636375, 6451.580647257913, 6497.252815926135, 6637.933620663828, 6145.661988590581, 6228.283747369111, 6233.750649974041, 6236.812895613139, 6243.594166379171, 6099.854599951442, 6180.721867515883, 6226.9213665049465, 6273.843153921097, 6359.046143078483, 5176.0, 5424.969255841377, 6310.936890631035, 6316.431521163117, 6322.620642761449, 5323.361196656426, 6226.221722284715, 6295.150154729053, 6300.180976473029, 6313.337099604567, 4862.881537246453, 5096.23556466533, 5103.617228707862, 5142.254373115952, 5166.586673066221, 3921.254961557295, 4338.414314067623, 4620.8151673933335, 4623.976880115645, 4636.907261854744, 6163.506919446433, 6169.321374648785, 6169.660668663267, 6183.5671502994355, 6199.318075011745, 6196.287426945959, 6236.750529978841, 6318.557700960889, 6333.271673757485, 6414.839629009219, 6109.4653969264045, 6111.774065234738, 6133.82435864808, 6148.569600127948, 6153.569250152446, 5591.944080559224, 5653.0, 5654.830355089354, 5677.290338707661, 5688.601797874109, 6337.081123237197, 6397.360263973565, 6469.353064693493, 6613.041109039163, 6658.334166583303, 6334.144890439732, 6355.269144048493, 6374.840628984312, 6380.968095159495, 6385.904211436925, 6626.933730662825, 6636.966815166086, 6645.3022432643875, 6648.434883034996, 6648.700808463534, 6216.409441103088, 6267.874642507216, 6270.310265870842, 6284.780032698834, 6330.113784070142, 6221.160143380585, 6271.372862713874, 6294.339094395205, 6314.526410519137, 6314.905276420949, 6060.0, 6265.49876009909, 6272.937270627418, 6281.842953926006, 6294.181756371642, 6147.723352449061, 6207.565470417027, 6243.750249989949, 6254.8123556293385, 6295.685215739103, 6149.354317796567, 6155.599886007395, 6171.290301615371, 6295.653739044214, 6298.464630506458, 6267.811965641038, 6267.9373206267355, 6291.433770960635, 6297.118403423616, 6336.7148478319505, 6081.331053584014, 6127.019676851683, 6131.386861313833, 6272.372762723874, 6309.3690630936535], "value": 5846.174551344037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8789805733028, 773.9922600773992, 802.2939812964593, 936.5551363102527, 939.6617217801595, 37964.43053354202, 38696.419553706684, 38699.0, 38759.0, 38798.80600597, 37282.62717372825, 37633.43549846748, 37702.8114859426, 37741.867743967654, 37797.811010944904, 7699.268569485904, 7842.686292548291, 10820.891791082067, 11056.170787190993, 11059.557617695324, 11057.50241239146, 11234.943825280861, 11263.0, 11406.486708098155, 11438.142139339541, 11341.0, 11382.886171138265, 11386.886131138666, 11450.198486105975, 11453.14101442391, 8730.650773969033, 10235.948820255926, 11357.091432685365, 11358.091352691807, 11418.486168122412, 9330.766730831716, 9551.331406801526, 10993.725156871062, 11058.447077646166, 11071.280366776135, 38488.422673659916, 38645.0, 38684.41973370402, 38717.80641096805, 38736.80631596824, 3043.5130379139455, 3571.714262858965, 3715.758475699071, 3735.719821013408, 3781.7920014399197, 28249.0, 28297.0, 28316.85841570779, 28433.857830710713, 29160.416791664262, 2707.891684332624, 3084.4447999360104, 3147.6222853257527, 3160.115167753033, 3250.366178595175, 330061.0, 330214.0, 332550.0, 332777.6722232771, 333551.0, 49518.009639807, 49537.75231123821, 49562.50437495579, 49751.50248497541, 49824.75087624539, 52251.47748522542, 52285.95428091417, 52461.7376913113, 52572.73713631484, 52673.7366313166, 13830.308484575731, 14033.649158770908, 14188.290585470686, 14199.645008874653, 14206.289685515683, 9555.61777528891, 11335.489902954387, 11347.20569560123, 11364.943175284236, 11365.204435689588, 13780.379882905294, 13905.096168749, 14007.509737159151, 14027.71944561103, 14142.646433839236, 5316.707581083, 6243.188385509855, 6254.906176407358, 6264.248290205204, 6270.655113968775, 1091.8908109189017, 1130.9377984210782, 1135.1429670598645, 1142.1833389126648, 1159.0032571988083, 22608.0, 24389.39026524351, 25885.835137418486, 26067.869660651955, 26699.0, 1219.664592237142, 1237.3751255616037, 1243.403743142637, 1249.6251124662565, 1266.4997326056157, 10918.50866711, 12751.808722869164, 13018.763217494323, 13722.862771372158, 13864.584062478141, 443789.15370500815, 448568.0, 449346.0, 449461.0, 450155.73987690697, 55902.16146757802, 55963.44036559582, 56220.71889640608, 56294.0, 56327.71836140793, 1160.1414952934936, 1246.7070238493948, 1404.2838152542276, 1407.5917983784589, 1416.157386355117, 23601.52796944086, 28852.0, 29096.418071638873, 29613.25966850846, 29776.0, 43808.0, 44081.0, 44301.33547996847, 44329.11341773082, 44362.11275774531, 344484.27757862053, 346086.0, 347401.0, 348002.0, 348047.0, 31695.513493515235, 32395.838020809744, 32532.83733581317, 32569.34861302808, 33076.503852441754, 41490.58509414867, 41642.958926027095, 41910.580894190665, 42468.513602023784, 43310.78344608257, 35374.29251415009, 35577.82211088928, 35752.82123589365, 36917.63082369142, 36976.44535332026, 30572.08283751491, 32894.67105328916, 33361.49957750587, 36687.816560917025, 36725.63274367222, 35441.64558354383, 36377.337398880845, 36486.817565913065, 36938.8153059233, 37139.442908356934, 29611.407771844013, 30627.387452251274, 31265.531017034307, 32065.198370040936, 32077.198070048435, 24423.633645494978, 24472.14347497829, 24622.261332160066, 24790.628140577544, 24817.875910620332], "value": 18775.51109980788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.16365795487445, 402.8207447685781, 403.886911664734, 408.5261097127332, 430.9269917904419, 20319.59360812785, 20684.27605033826, 21359.786402135975, 21577.46056348588, 21733.456663583398, 19919.40241792745, 21656.783432165674, 21705.891470542625, 21913.0, 22037.33887983359, 6412.262589802174, 6738.090357801683, 6761.594304341731, 6763.729450821961, 6803.625800580966, 6355.523335749815, 6520.152380190569, 6569.967150164242, 6586.769463068794, 6592.307807680172, 6511.958086706128, 6527.804165875032, 6561.540692151551, 6591.670416479157, 6597.043428702859, 6426.518011149159, 6562.081308616797, 6604.603723776589, 6604.900926486131, 6606.8017959461295, 6127.172831667757, 6343.714532846033, 6418.839529011765, 6421.101045853584, 6436.710348034349, 26390.208293751217, 26412.47175056488, 26465.0, 26857.328566785985, 26988.46023079547, 2261.683364328995, 2914.12576227131, 2951.631046119235, 2955.0, 2961.881524739008, 14052.648683782885, 14518.92740536301, 16284.918575407166, 16718.996860188305, 16868.409605663866, 1975.07171629334, 2026.5845501672122, 2055.989720051405, 2111.5671287386203, 2121.586290673319, 144654.0, 150520.0, 150908.0, 151648.2417587916, 152710.0, 21817.781822181892, 22343.0, 22499.775002250095, 22722.0, 22738.886305568365, 34221.0, 34286.0, 34566.0, 34567.827160864035, 34592.308153836784, 9775.755606109762, 9950.601975921027, 10153.441560714231, 10212.693619191436, 10392.584296628202, 7966.3626909848235, 8060.677572897136, 8229.876551851727, 8249.79375515605, 8263.173682631688, 10367.94816025915, 10647.787044259072, 10910.290831095954, 10959.342439453658, 11154.665360039211, 4036.1524079942956, 4443.955560444419, 4538.364628951949, 4566.657500687462, 4605.40129783126, 880.9779755506036, 923.6397804856111, 929.3076657889916, 951.1629765806047, 971.9902800972042, 18613.813861861207, 23367.065317387114, 23597.42228961329, 23691.1708090216, 23847.761522384902, 867.496851825952, 940.8897500948809, 961.6922584772946, 973.3964941736169, 976.829054915387, 9527.428354298625, 11828.230148886423, 12247.69380765488, 12335.074869384833, 12673.809892851614, 656632.0, 656789.0, 668888.0, 671891.0, 686133.0, 131380.0, 134730.0, 135662.28675426435, 138590.3070484641, 148407.2579637095, 1149.9712507187387, 1316.5523721934396, 1327.0909427042507, 1334.833145856768, 1338.5515852189626, 20574.588508230052, 21695.674564881854, 21790.89104554467, 21876.343709688736, 21962.341129766133, 60375.698121509115, 61141.69429153004, 62136.0, 62618.06072908819, 63005.0, 61179.38820611737, 86089.56955215184, 86343.56828215819, 86636.13363866533, 87238.56380718056, 10671.199660025373, 11890.643280701594, 11905.52377904874, 12188.0, 12188.329641869783, 13533.729325413633, 13590.864091359355, 13608.591742247749, 13924.164550127025, 13936.651583710489, 11193.496292667012, 11374.829377559508, 11462.885371146516, 11687.415629218674, 11809.586664466702, 11463.484143213409, 11469.254498457574, 11631.6510504685, 11722.824157637813, 11816.40917954116, 9830.950845245728, 11337.0, 11672.0, 12060.638180854588, 12120.090993175723, 11742.412879356169, 11763.705907352043, 12034.879651203375, 12041.759164816829, 12105.152639315163, 11371.0, 11527.020203282815, 11733.296002239893, 11745.530178792753, 11854.229475084092], "value": 11663.228546088603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.8686011689006, 1568.7960565126532, 1583.0501698980606, 1614.8453855493324, 1648.3818568036986, 9439.575219115139, 9717.951410242938, 10711.678649640504, 11164.720881977944, 11192.552297908083, 7701.92298077019, 9483.905160948389, 9506.762330941712, 9514.381565198257, 9547.997460266659, 2031.9535439248762, 2270.71616047994, 2356.8821558922073, 2376.4534157143867, 2384.1893756122913, 2300.0799680127916, 2328.1734984080663, 2339.333290012347, 2344.3084290134366, 2346.296111166652, 2315.143396943125, 2318.6290193569034, 2331.184085570054, 2340.8829558522093, 2343.414146463384, 2307.1348244408177, 2314.4908120213527, 2318.6406107053267, 2327.487952650414, 2328.9417764555938, 2301.4476525633895, 2309.3187509684517, 2326.8836558172193, 2351.5532048910823, 2359.079958816063, 10948.671539853816, 11054.889451105466, 11069.059129973963, 11103.944480277627, 11105.333679979147, 5751.683657398841, 5924.2298501195, 5981.0729336952845, 5981.910271345933, 6009.278886533601, 3378.8310584470923, 3493.283876805249, 3644.9817750911343, 3690.9815450922843, 3717.9961410419305, 1069.4652673663168, 1141.7088642396136, 1185.419144619139, 1189.9405029748477, 1222.7493363860387, 15654.843451565452, 15664.686706265811, 15812.209389530593, 15822.446214382557, 15870.523884283375, 4697.365855609517, 4994.525520075587, 5023.447420783711, 5052.014857102903, 5091.9236211456855, 12744.490220391266, 12804.359782011048, 12809.487620495076, 12867.549635762703, 12879.613611591667, 5109.948900511022, 5919.496842768327, 5994.490468310242, 5996.5202783777195, 6006.819795406145, 4809.591184749265, 4810.725157833177, 5149.948500514947, 5214.661047031931, 5284.101702710548, 3389.18659521713, 3983.940240896389, 4144.3990621359735, 4151.335786274181, 4165.875023749292, 1159.3275899978162, 1163.7148898519918, 1167.9357635329968, 1178.5462596900254, 1178.7347846734417, 796.9838455968686, 827.3670641958786, 844.1716814247359, 883.9204471597587, 888.0453512474116, 5414.675119492843, 6459.483241340681, 6595.241547222035, 6621.702023408862, 6733.7643182489355, 970.4322971061866, 973.5278389980854, 977.6138425321958, 980.5342462330336, 995.0, 4064.5122585289955, 4125.958740412618, 4183.53981062089, 4211.642010429086, 4247.447831781848, 10780.838287425695, 12956.546520871725, 13420.463181472827, 13510.98667599934, 13542.119762215425, 13159.342032898508, 13394.93302533481, 13565.457381704819, 13896.0, 13903.0, 9342.2526197904, 9519.57161927701, 9800.509974501247, 9881.555330010167, 10009.149222316039, 6015.218021657157, 6172.475339596184, 6306.495480361468, 6594.769183078569, 6866.313368663294, 9381.296402769956, 12006.519739210335, 12236.755264894475, 12316.630501084981, 12318.322492263012, 11629.53481860716, 11963.342016188844, 12068.879311206776, 12117.212381195193, 12173.147879648339, 9041.954790226007, 9369.203617692572, 9374.5781439834, 9382.0, 9388.24894008464, 10047.196224302184, 10405.531751071068, 10428.322159059637, 10474.947625261824, 10476.109530689977, 8944.195022448012, 9070.909290907006, 9121.771955700895, 9136.132067453582, 9295.76760580991, 8470.32237421017, 8967.237784788365, 8977.326700497359, 9051.411658242194, 9056.818863622822, 7702.345300649507, 7856.7250146244605, 7889.960550197212, 7959.801004974922, 7963.124056353912, 5821.592488525763, 5856.94143058581, 5967.582269241111, 6041.154238406714, 6065.8180254592435, 5907.586468947133, 6018.796240751954, 6099.268087829489, 6114.113453549122, 6243.531735119794], "value": 5093.840283791261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.934823361211, 348.5294851949868, 377.3660250778691, 389.0216106492173, 397.4435789894148, 5942.554308426869, 6107.633541987473, 6295.803797278514, 6328.430441260286, 6333.240011198663, 5377.381601115872, 6079.361667024954, 6165.876682466348, 6189.721462534186, 6208.286047104584, 4986.501349865002, 5148.536631703137, 5189.896202075956, 5193.298904647881, 5202.739863006854, 4499.885054024619, 5162.535371816536, 5209.583233341324, 5236.502532259429, 5307.495787900162, 5073.771680274378, 5166.236063705918, 5181.222816577525, 5184.637075404723, 5196.76614552346, 4009.69927255457, 4085.039181193029, 5080.77136528857, 5115.283860259585, 5116.9744151279, 4614.284785858164, 4676.368690226844, 4680.485146633868, 4704.741239231841, 4755.857324280277, 5962.165296858443, 5989.772096720162, 6088.117223002684, 6116.348585881831, 6122.204113465221, 5017.824376146854, 5927.585069045169, 5969.761209551612, 6016.639001659914, 6034.125051867499, 6728.0, 6729.629870357128, 6729.663516824139, 6732.2257940336995, 6751.594904305757, 4330.523642399334, 4780.020095880336, 5118.192662560578, 5215.087359712035, 5217.660852044605, 6711.630860302681, 6919.99999999995, 7094.787156385265, 7146.857062858714, 7194.4963852530345, 4520.389747384127, 5162.277281180638, 5304.628675992643, 5394.38983457208, 5405.702686352289, 5465.251119641676, 5476.726163691799, 5477.397486276506, 5483.479069488392, 5502.312210973629, 5119.6160287978555, 5577.0, 5909.379515150933, 5930.644161350333, 5935.495482883917, 5288.545649946295, 6656.70044847983, 6682.899756503656, 6684.930411134195, 6787.796366109024, 1787.347618119377, 1844.880082794614, 1846.8799528030636, 1878.6336664350595, 1883.303177824214, 1350.1628990026247, 1370.4518192722792, 1379.2138481065897, 1386.2791348498927, 1390.318743815523, 5794.1308803679785, 6216.23377596974, 6226.439620434092, 6246.281677607042, 6254.249490061222, 5804.216430781875, 6284.560080794392, 6309.432151106423, 6890.483213758988, 6901.996052861736, 5492.423295553989, 5831.329397119385, 5869.20765696634, 6242.406971337807, 6242.812715618538, 3190.680931906837, 3467.982660086734, 3621.348157331653, 3626.220362621996, 3648.3615367310613, 5603.971980140073, 5959.0763431668165, 6072.605280656743, 7156.964215178891, 7157.0, 7078.221395646475, 7119.433724580687, 7136.750213742598, 7143.785426517796, 7178.964105179441, 6738.0, 6766.830829229309, 7031.8593628127155, 7105.644717764195, 7123.287671232835, 5992.370801065826, 6851.3491218334175, 6862.176538815374, 6866.34769696878, 6904.482163837632, 5148.90661923764, 5992.98119319708, 6221.440070393686, 6224.968875155595, 6582.736690532325, 6221.564490485623, 7191.928080719126, 7206.603636800026, 7243.5653860768525, 7263.745768898063, 4517.022251439224, 4731.077439899186, 5336.706481143575, 5338.946610533845, 5346.224797404432, 5793.362730099601, 6774.119364482585, 6803.217629972616, 6804.489663275175, 6807.625580593115, 5263.34208223972, 6617.470602351897, 6637.203535575762, 6691.631960242234, 6704.731810727516, 6314.810555683337, 6639.435647969976, 6667.766628167991, 6690.0, 6733.326667333227, 5703.344115426779, 5769.336526299529, 5805.82582522525, 6586.847301722084, 6605.372489613479, 6052.606580572248, 6093.421124993119, 6430.839229019312, 6697.497687673542, 6749.122614060141, 5881.0, 6494.188226471691, 6526.748271846205, 6553.180852393451, 6556.68866226747], "value": 5061.778596322723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.6222379900664, 705.2700455029046, 749.1983577572, 797.9880301795472, 817.5626040068564, 15448.768268475967, 15885.761713574291, 15898.84101158988, 15918.920405397972, 15933.44232951847, 13854.461712150494, 13871.514496992608, 14430.0, 14520.782188267158, 14576.635584110403, 927.0590350793949, 956.956936937836, 959.9424034557914, 960.6829746183743, 961.2262128986164, 957.248559880494, 957.7749228931195, 958.0, 958.5351104714208, 960.183843732825, 973.7127547373542, 1014.4876837197205, 1015.147276287918, 1020.3520764314677, 1021.0504231065144, 863.7063398444527, 1000.5547531348553, 1013.1034034879185, 1013.3109485549786, 1013.5742987945044, 740.6889106575252, 742.1465314887868, 748.7828529726373, 751.9887201691979, 753.2354660020084, 16004.679906401923, 16285.185740712917, 16686.0, 16702.4154154604, 16722.0, 12299.772023206673, 14533.418663253457, 14877.0, 14952.925235373754, 15014.174220417872, 11798.351090690094, 11817.822732659017, 11851.822222666668, 11887.821682674767, 12076.094292927977, 3073.431415188197, 3690.852365905361, 3733.4773131761576, 3744.3634582121103, 3834.5206849143856, 106999.4650026745, 107634.0, 109619.0, 110516.0, 112278.43860780726, 11259.605913793142, 11410.600628977945, 11428.885711142948, 11730.354830484235, 11823.349715765715, 24788.628170577456, 25046.248612541287, 25051.373715657253, 25067.0, 25069.4986100277, 7784.065912090586, 7960.721374751972, 7962.800929976797, 8124.22819832115, 8226.300764434971, 4237.618614324726, 4307.203167414038, 4336.804843782037, 4356.237658409766, 4501.549845015537, 3370.9325813484083, 3405.4721518164724, 3414.0, 3470.687638112582, 3485.546878905777, 623.5261201486812, 626.9467095296951, 638.4668801550757, 641.0480436551717, 646.7186773753432, 582.621296157501, 632.1655414852443, 650.3334082565408, 658.7439355499181, 668.4451904918906, 8623.78440538979, 10019.949900250598, 10236.948815255875, 10572.995565421274, 10588.523516441779, 629.7656593077619, 643.832603523078, 669.220358282605, 680.5508364479518, 695.978515014165, 4658.58072773452, 4917.385326834145, 4921.458639549646, 4950.6782059166035, 4966.180580204298, 79518.6024069876, 83940.16059839446, 92677.0, 94129.0, 99050.0, 70640.94038589425, 73454.63272683602, 75812.0, 80786.0, 85848.57075714707, 71095.64452177707, 71321.0, 71342.2164445893, 71560.56878862393, 71761.92357114647, 8767.60545775429, 10361.326513776581, 10372.948135259276, 10742.677719668422, 10805.45972701346, 44899.551004489535, 47375.52624473711, 47920.041599167125, 48316.51683483261, 48330.5166948326, 61375.69312153589, 62119.0, 62275.06587401102, 62362.68818656059, 62782.0, 13003.219806811621, 13060.608181754562, 13344.466221351426, 14111.647208819862, 14112.50606228777, 14317.856821431653, 14432.278386080445, 14452.927735361256, 14880.470320045402, 14996.550103496913, 13544.32278386057, 13576.253306067865, 13708.931455343058, 13837.377318020915, 14038.649033773829, 10668.253222274367, 12482.0, 12515.311657858905, 12580.496780128693, 12888.097833151589, 9761.414315141114, 12911.483540658268, 13100.934495327463, 13321.067525273138, 13822.723545528832, 10786.474559313674, 10997.285176463503, 11276.0, 11577.421128943688, 11747.647570572897, 9296.235024814961, 9531.666391676257, 10804.189685773441, 11174.441277936234, 11224.326540407601], "value": 7556.078515257628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 125.0, 121.0, 119.0, 120.0, 119.0, 120.0, 124.0, 163.0, 120.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 127.0, 191.0, 151.0, 99.0, 147.0, 145.0, 172.0, 120.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 204.0, 215.0, 208.0, 223.0, 202.0, 202.0, 202.0, 204.0, 193.0], "value": 205.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 62.0, 88.0, 59.0, 57.0, 59.0, 64.0, 84.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 88.0, 72.0, 72.0, 70.0, 85.0, 72.0, 73.0, 83.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 93.0, 92.0, 92.0, 85.0, 135.0, 85.0, 136.0, 137.0, 104.0], "value": 108.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 99.0, 124.0, 99.0, 118.0, 105.0, 92.0, 91.0, 133.0], "value": 113.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 132.0, 91.0, 144.0, 93.0, 142.0, 147.0, 73.0, 78.0, 125.0], "value": 111.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 68.0, 68.0, 69.0, 68.0, 81.0, 104.0, 104.0], "value": 76.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 59.0, 66.0, 61.0, 57.0, 57.0, 58.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 83.0, 74.0, 104.0, 107.0, 109.0, 82.0, 73.0, 102.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 159.0, 131.0, 127.0, 155.0, 141.0, 153.0, 214.0, 160.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 193.0, 188.0, 188.0, 193.0, 187.0, 191.0, 191.0, 188.0, 196.0], "value": 190.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 92.0, 89.0, 77.0, 68.0, 67.0, 68.0, 66.0, 67.0, 69.0], "value": 73.8, "unit": "score"}]}]} 15:49:31 INFO - Return code: 0 15:49:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:49:31 ERROR - # TBPL SUCCESS # 15:49:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:49:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:49:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:49:32 INFO - 2017-03-15 15:49:32.001 screenresolution[1932:21946] starting screenresolution argv=screenresolution get 15:49:32 INFO - 2017-03-15 15:49:32.004 screenresolution[1932:21946] Display 0: 1600x1200x32@60 15:49:32 INFO - 2017-03-15 15:49:32.010 screenresolution[1933:21949] starting screenresolution argv=screenresolution list 15:49:32 INFO - Available Modes on Display 0 15:49:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:49:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:49:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:49:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:49:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:49:32 INFO - Intel Iris: 15:49:32 INFO - Chipset Model: Intel Iris 15:49:32 INFO - Type: GPU 15:49:32 INFO - Bus: Built-In 15:49:32 INFO - VRAM (Dynamic, Max): 1536 MB 15:49:32 INFO - Vendor: Intel (0x8086) 15:49:32 INFO - Device ID: 0x0a2e 15:49:32 INFO - Revision ID: 0x0009 15:49:32 INFO - Displays: 15:49:32 INFO - Display: 15:49:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:49:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:49:32 INFO - Display Serial Number: 1600x1200 60 15:49:32 INFO - Main Display: Yes 15:49:32 INFO - Mirror: Off 15:49:32 INFO - Online: Yes 15:49:32 INFO - Rotation: Supported 15:49:32 INFO - Return code: 0 15:49:32 INFO - Running post-action listener: _resource_record_post_action 15:49:32 INFO - [mozharness: 2017-03-15 22:49:32.245028Z] Finished run-tests step (success) 15:49:32 INFO - Running post-run listener: _resource_record_post_run 15:49:32 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 2301952; Write bytes: 516112384; Read time: 13; Write time: 1634 15:49:32 INFO - TinderboxPrint: CPU usage
54.3% 15:49:32 INFO - TinderboxPrint: I/O read bytes / time
2,301,952 / 13 15:49:32 INFO - TinderboxPrint: I/O write bytes / time
516,112,384 / 1,634 15:49:32 INFO - TinderboxPrint: CPU idle
2,194.3 (45.7%) 15:49:32 INFO - TinderboxPrint: CPU system
967.2 (20.1%) 15:49:32 INFO - TinderboxPrint: CPU user
1,640.2 (34.2%) 15:49:32 INFO - TinderboxPrint: Swap in / out
212,070,400 / 0 15:49:32 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 209844736; Write bytes: 202903552; Read time: 16859; Write time: 382 15:49:32 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 221184; Write bytes: 302057472; Read time: 5; Write time: 1200 15:49:32 INFO - Running post-run listener: _upload_blobber_files 15:49:32 INFO - Blob upload gear active. 15:49:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:49:32 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 15:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:49:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:49:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:49:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:34 INFO - (blobuploader) - INFO - Done attempting. 15:49:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:49:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:49:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:35 INFO - (blobuploader) - INFO - Done attempting. 15:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:49:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:36 INFO - (blobuploader) - INFO - Done attempting. 15:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:49:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:38 INFO - (blobuploader) - INFO - Done attempting. 15:49:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:49:38 INFO - Return code: 0 15:49:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:49:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:49:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62b2da03e0e7e220e30157c37d14f5984346b8c1fcf3560ee126a18d129d1a15003762555db70a3932d0a37560ec5d78db60499a0821d18deb53fc3869f08da9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8023aedbdcb3a6d3587e5a48c0f1e464e8ce8abe675bb32f8364241109e04c794f0971092f5ce1db8f6798635d049484da02708ea2858fa2b459b58d30687a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de742b7ed8dc573856e70cc7009c8c53d5ee6eb4d1534488e050a502384cfc912939444da4caa6b88867e0e259a3d34b94a80456dcb5572ea8e51d22ff7dd495", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57aa21e455913a147c635c21d3ff0251cda6238a7821b9e9d346e421d6c27e4d310ff8a317f7ae226748aa9608ff1e8d39f6939a782db8b1fc0f81bc595124a2"} 15:49:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:49:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:49:38 INFO - Contents: 15:49:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62b2da03e0e7e220e30157c37d14f5984346b8c1fcf3560ee126a18d129d1a15003762555db70a3932d0a37560ec5d78db60499a0821d18deb53fc3869f08da9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8023aedbdcb3a6d3587e5a48c0f1e464e8ce8abe675bb32f8364241109e04c794f0971092f5ce1db8f6798635d049484da02708ea2858fa2b459b58d30687a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de742b7ed8dc573856e70cc7009c8c53d5ee6eb4d1534488e050a502384cfc912939444da4caa6b88867e0e259a3d34b94a80456dcb5572ea8e51d22ff7dd495", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57aa21e455913a147c635c21d3ff0251cda6238a7821b9e9d346e421d6c27e4d310ff8a317f7ae226748aa9608ff1e8d39f6939a782db8b1fc0f81bc595124a2"} 15:49:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:49:38 INFO - Copying logs to upload dir... 15:49:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:49:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.198306 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-15 15:49:38.821810) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:38.825539) ========= 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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/Firefox/sha512/62b2da03e0e7e220e30157c37d14f5984346b8c1fcf3560ee126a18d129d1a15003762555db70a3932d0a37560ec5d78db60499a0821d18deb53fc3869f08da9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8023aedbdcb3a6d3587e5a48c0f1e464e8ce8abe675bb32f8364241109e04c794f0971092f5ce1db8f6798635d049484da02708ea2858fa2b459b58d30687a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de742b7ed8dc573856e70cc7009c8c53d5ee6eb4d1534488e050a502384cfc912939444da4caa6b88867e0e259a3d34b94a80456dcb5572ea8e51d22ff7dd495", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57aa21e455913a147c635c21d3ff0251cda6238a7821b9e9d346e421d6c27e4d310ff8a317f7ae226748aa9608ff1e8d39f6939a782db8b1fc0f81bc595124a2"} build_url:https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/LuNcGUrXS1WaItoskYW5Rg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62b2da03e0e7e220e30157c37d14f5984346b8c1fcf3560ee126a18d129d1a15003762555db70a3932d0a37560ec5d78db60499a0821d18deb53fc3869f08da9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e8023aedbdcb3a6d3587e5a48c0f1e464e8ce8abe675bb32f8364241109e04c794f0971092f5ce1db8f6798635d049484da02708ea2858fa2b459b58d30687a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de742b7ed8dc573856e70cc7009c8c53d5ee6eb4d1534488e050a502384cfc912939444da4caa6b88867e0e259a3d34b94a80456dcb5572ea8e51d22ff7dd495", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57aa21e455913a147c635c21d3ff0251cda6238a7821b9e9d346e421d6c27e4d310ff8a317f7ae226748aa9608ff1e8d39f6939a782db8b1fc0f81bc595124a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:38.860351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:38.860693) ========= 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.Q7yP1mmedi/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.fYBz4B3wWq/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005279 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:49:38.909116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 15:49:38.909434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 15:49:38.909765) ========= ========= Total master_lag: 0.19 =========