builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0201 starttime: 1481204683.57 results: success (0) buildid: 20161208030206 builduid: 423524bcf0d147199a87b3bece1de370 revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:43.573165) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:43.580211) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:43.580636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:43.607496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:43.607889) ========= 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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-08 05:44:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-12-08 05:44:44 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.580705 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.256134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.256431) ========= 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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.039854 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.355490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.355851) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2526f6786f074888d71c8e166a02aea3e19e75b --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 c2526f6786f074888d71c8e166a02aea3e19e75b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-08 05:44:44,458 truncating revision to first 12 chars 2016-12-08 05:44:44,458 Setting DEBUG logging. 2016-12-08 05:44:44,458 attempt 1/10 2016-12-08 05:44:44,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2526f6786f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 05:44:44,922 unpacking tar archive at: mozilla-central-c2526f6786f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740221 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.196858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.197174) ========= script_repo_revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.197599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.198011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.357705) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-12-08 05:44:45.358003) ========= /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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:44:45 INFO - MultiFileLogger online at 20161208 05:44:45 in /builds/slave/test 05:44:45 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 05:44:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:45 INFO - {'append_to_log': False, 05:44:45 INFO - 'base_work_dir': '/builds/slave/test', 05:44:45 INFO - 'blob_upload_branch': 'Firefox', 05:44:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:45 INFO - 'branch': 'Firefox', 05:44:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:45 INFO - 'config_files': ('talos/mac_config.py',), 05:44:45 INFO - 'default_actions': ('clobber', 05:44:45 INFO - 'read-buildbot-config', 05:44:45 INFO - 'download-and-extract', 05:44:45 INFO - 'populate-webroot', 05:44:45 INFO - 'create-virtualenv', 05:44:45 INFO - 'install', 05:44:45 INFO - 'run-tests'), 05:44:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:45 INFO - 'download_minidump_stackwalk': True, 05:44:45 INFO - 'download_symbols': 'ondemand', 05:44:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:45 INFO - 'installer_path': 'installer.exe', 05:44:45 INFO - 'log_level': 'info', 05:44:45 INFO - 'log_name': 'talos', 05:44:45 INFO - 'log_to_console': True, 05:44:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:44:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:44:45 INFO - 'opt_config_files': (), 05:44:45 INFO - 'pip_index': False, 05:44:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:45 INFO - 'cmd': ('bash', 05:44:45 INFO - '-c', 05:44:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:45 INFO - 'enabled': True, 05:44:45 INFO - 'halt_on_failure': False, 05:44:45 INFO - 'name': 'check_screen_resolution'},), 05:44:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:45 INFO - 'cmd': ('bash', 05:44:45 INFO - '-c', 05:44:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:45 INFO - 'enabled': True, 05:44:45 INFO - 'halt_on_failure': False, 05:44:45 INFO - 'name': 'check_screen_resolution'},), 05:44:45 INFO - 'run_cmd_checks_enabled': True, 05:44:45 INFO - 'sps_profile': False, 05:44:45 INFO - 'sps_profile_interval': 0, 05:44:45 INFO - 'suite': 'dromaeojs-e10s', 05:44:45 INFO - 'system_bits': '32', 05:44:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:45 INFO - 'title': 't-yosemite-r7-0201', 05:44:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:45 INFO - 'use_talos_json': True, 05:44:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:45 INFO - 'work_dir': 'build'} 05:44:45 INFO - [mozharness: 2016-12-08 13:44:45.567595Z] Running clobber step. 05:44:45 INFO - Running pre-action listener: _resource_record_pre_action 05:44:45 INFO - Running main action method: clobber 05:44:45 INFO - rmtree: /builds/slave/test/build 05:44:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:46 INFO - Running post-action listener: _resource_record_post_action 05:44:46 INFO - [mozharness: 2016-12-08 13:44:46.929405Z] Finished clobber step (success) 05:44:46 INFO - [mozharness: 2016-12-08 13:44:46.929533Z] Running read-buildbot-config step. 05:44:46 INFO - Running pre-action listener: _resource_record_pre_action 05:44:46 INFO - Running main action method: read_buildbot_config 05:44:46 INFO - Using buildbot properties: 05:44:46 INFO - { 05:44:46 INFO - "project": "", 05:44:46 INFO - "product": "firefox", 05:44:46 INFO - "script_repo_revision": "production", 05:44:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:44:46 INFO - "repository": "", 05:44:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:44:46 INFO - "buildid": "20161208030206", 05:44:46 INFO - "stage_platform": "macosx64", 05:44:46 INFO - "basedir": "/builds/slave/test", 05:44:46 INFO - "nightly_build": "True", 05:44:46 INFO - "buildnumber": 13, 05:44:46 INFO - "slavename": "t-yosemite-r7-0201", 05:44:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:44:46 INFO - "platform": "yosemite_r7", 05:44:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:44:46 INFO - "branch": "mozilla-central", 05:44:46 INFO - "repo_path": "mozilla-central", 05:44:46 INFO - "revision": "c2526f6786f074888d71c8e166a02aea3e19e75b", 05:44:46 INFO - "pgo_build": "False", 05:44:46 INFO - "builduid": "423524bcf0d147199a87b3bece1de370", 05:44:46 INFO - "slavebuilddir": "test" 05:44:46 INFO - } 05:44:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:44:46 INFO - Running post-action listener: _resource_record_post_action 05:44:46 INFO - [mozharness: 2016-12-08 13:44:46.933151Z] Finished read-buildbot-config step (success) 05:44:46 INFO - [mozharness: 2016-12-08 13:44:46.933283Z] Running download-and-extract step. 05:44:46 INFO - Running pre-action listener: _resource_record_pre_action 05:44:46 INFO - Running main action method: download_and_extract 05:44:46 INFO - mkdir: /builds/slave/test/build/tests 05:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:44:46 INFO - trying https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:44:46 INFO - Downloading https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 05:44:51 INFO - Downloaded 1199 bytes. 05:44:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:44:51 INFO - Using the following test package requirements: 05:44:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:44:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:44:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:44:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'jsshell-mac.zip'], 05:44:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:44:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:44:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:44:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:44:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:44:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:51 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:44:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:44:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:44:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:44:51 INFO - Fetch https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:44:52 INFO - Expected file size: 16284432 05:44:52 INFO - Obtained file size: 16284432 05:44:58 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:44:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:44:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:44:58 INFO - Fetch https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:44:59 INFO - Expected file size: 16284432 05:44:59 INFO - Obtained file size: 16284432 05:45:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:45:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:45:06 INFO - Fetch https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:45:07 INFO - Expected file size: 14409734 05:45:07 INFO - Obtained file size: 14409734 05:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:07 INFO - trying https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:45:07 INFO - Downloading https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 05:45:10 INFO - Downloaded 107739399 bytes. 05:45:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:45:10 INFO - mkdir: /builds/slave/test/properties 05:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:10 INFO - Contents: 05:45:10 INFO - build_url:https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:45:17 INFO - Running post-action listener: _resource_record_post_action 05:45:17 INFO - Running post-action listener: set_extra_try_arguments 05:45:17 INFO - [mozharness: 2016-12-08 13:45:17.855161Z] Finished download-and-extract step (success) 05:45:17 INFO - [mozharness: 2016-12-08 13:45:17.855312Z] Running populate-webroot step. 05:45:17 INFO - Running pre-action listener: _resource_record_pre_action 05:45:17 INFO - Running main action method: populate_webroot 05:45:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:17 INFO - '--tppagecycles', 05:45:17 INFO - '7'], 05:45:17 INFO - 'tests': ['tsvgm']}}, 05:45:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['damp', 'tps']}, 05:45:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'tests': ['damp', 'tps']}, 05:45:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['dromaeo_dom']}, 05:45:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['basic_compositor_video']}, 05:45:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['a11yr', 05:45:17 INFO - 'ts_paint', 05:45:17 INFO - 'tpaint', 05:45:17 INFO - 'sessionrestore', 05:45:17 INFO - 'sessionrestore_no_auto_restore', 05:45:17 INFO - 'tabpaint']}, 05:45:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:17 INFO - 'ts_paint', 05:45:17 INFO - 'tpaint', 05:45:17 INFO - 'sessionrestore', 05:45:17 INFO - 'sessionrestore_no_auto_restore', 05:45:17 INFO - 'tabpaint']}, 05:45:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:17 INFO - 'ts_paint', 05:45:17 INFO - 'tpaint', 05:45:17 INFO - 'sessionrestore', 05:45:17 INFO - 'sessionrestore_no_auto_restore', 05:45:17 INFO - 'tabpaint']}, 05:45:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:17 INFO - 'ts_paint', 05:45:17 INFO - 'tpaint', 05:45:17 INFO - 'sessionrestore', 05:45:17 INFO - 'sessionrestore_no_auto_restore', 05:45:17 INFO - 'tabpaint']}, 05:45:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['a11yr', 05:45:17 INFO - 'ts_paint', 05:45:17 INFO - 'tpaint', 05:45:17 INFO - 'sessionrestore', 05:45:17 INFO - 'sessionrestore_no_auto_restore', 05:45:17 INFO - 'tabpaint']}, 05:45:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['a11yr', 05:45:17 INFO - 'ts_paint', 05:45:17 INFO - 'tpaint', 05:45:17 INFO - 'sessionrestore', 05:45:17 INFO - 'sessionrestore_no_auto_restore', 05:45:17 INFO - 'tabpaint']}, 05:45:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['tsvgx', 05:45:17 INFO - 'tsvgr_opacity', 05:45:17 INFO - 'tart', 05:45:17 INFO - 'tscrollx', 05:45:17 INFO - 'cart', 05:45:17 INFO - 'tsvg_static']}, 05:45:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:17 INFO - 'tsvgr_opacity', 05:45:17 INFO - 'tart', 05:45:17 INFO - 'tscrollx', 05:45:17 INFO - 'cart', 05:45:17 INFO - 'tsvg_static']}, 05:45:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'talos_options': ['--disable-e10s'], 05:45:17 INFO - 'tests': ['tp5o']}, 05:45:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:45:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'talos_options': ['--disable-e10s', 05:45:17 INFO - '--xperf_path', 05:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:17 INFO - 'tests': ['tp5n']}, 05:45:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:45:17 INFO - 'talos_options': ['--xperf_path', 05:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:17 INFO - 'tests': ['tp5n']}}, 05:45:17 INFO - 'talos.zip': {'path': '', 05:45:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:17 INFO - Running post-action listener: _resource_record_post_action 05:45:17 INFO - [mozharness: 2016-12-08 13:45:17.874005Z] Finished populate-webroot step (success) 05:45:17 INFO - [mozharness: 2016-12-08 13:45:17.874105Z] Running create-virtualenv step. 05:45:17 INFO - Running pre-action listener: _resource_record_pre_action 05:45:17 INFO - Running main action method: create_virtualenv 05:45:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:17 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 05:45:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:18 INFO - Using real prefix '/tools/python27' 05:45:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:21 INFO - Installing pip.................done. 05:45:21 INFO - Return code: 0 05:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:45:21 INFO - Reading from file tmpfile_stdout 05:45:21 INFO - Output received: 05:45:21 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) 05:45:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:21 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 05:45:21 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 05:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:21 INFO - 'HOME': '/Users/cltbld', 05:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:21 INFO - 'LOGNAME': 'cltbld', 05:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:21 INFO - 'MOZ_NO_REMOTE': '1', 05:45:21 INFO - 'NO_EM_RESTART': '1', 05:45:21 INFO - 'PAGER': '/bin/cat', 05:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:21 INFO - 'PWD': '/builds/slave/test', 05:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:21 INFO - 'SHELL': '/bin/bash', 05:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:21 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:21 INFO - 'USER': 'cltbld', 05:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:21 INFO - 'XPC_FLAGS': '0x0', 05:45:21 INFO - 'XPC_SERVICE_NAME': '0', 05:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:22 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 05:45:22 INFO - Cleaning up... 05:45:22 INFO - Return code: 0 05:45:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:45:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:22 INFO - 'HOME': '/Users/cltbld', 05:45:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:22 INFO - 'LOGNAME': 'cltbld', 05:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:22 INFO - 'MOZ_NO_REMOTE': '1', 05:45:22 INFO - 'NO_EM_RESTART': '1', 05:45:22 INFO - 'PAGER': '/bin/cat', 05:45:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:22 INFO - 'PWD': '/builds/slave/test', 05:45:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:22 INFO - 'SHELL': '/bin/bash', 05:45:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:22 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:22 INFO - 'USER': 'cltbld', 05:45:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:22 INFO - 'XPC_FLAGS': '0x0', 05:45:22 INFO - 'XPC_SERVICE_NAME': '0', 05:45:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:22 INFO - Downloading/unpacking psutil>=3.1.1 05:45:22 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 05:45:22 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 05:45:22 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 05:45:22 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 05:45:22 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 05:45:22 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 05:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:26 INFO - Installing collected packages: psutil 05:45:26 INFO - Running setup.py install for psutil 05:45:26 INFO - building 'psutil._psutil_osx' extension 05:45:26 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 05:45:27 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 05:45:27 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 05:45:27 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 05:45:27 INFO - building 'psutil._psutil_posix' extension 05:45:27 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 05:45:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:45:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:45:27 INFO - ^ 05:45:27 INFO - 1 warning generated. 05:45:27 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 05:45:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:27 INFO - Successfully installed psutil 05:45:27 INFO - Cleaning up... 05:45:27 INFO - Return code: 0 05:45:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45:27 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')]} 05:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:27 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')]} 05:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:27 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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:27 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 05:45:27 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 05:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:27 INFO - 'HOME': '/Users/cltbld', 05:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:27 INFO - 'LOGNAME': 'cltbld', 05:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:27 INFO - 'MOZ_NO_REMOTE': '1', 05:45:27 INFO - 'NO_EM_RESTART': '1', 05:45:27 INFO - 'PAGER': '/bin/cat', 05:45:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:27 INFO - 'PWD': '/builds/slave/test', 05:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:27 INFO - 'SHELL': '/bin/bash', 05:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:27 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:27 INFO - 'USER': 'cltbld', 05:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:27 INFO - 'XPC_FLAGS': '0x0', 05:45:27 INFO - 'XPC_SERVICE_NAME': '0', 05:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:28 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 05:45:28 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 05:45:28 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 05:45:28 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 05:45:28 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 05:45:28 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 05:45:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:30 INFO - Installing collected packages: mozsystemmonitor 05:45:30 INFO - Running setup.py install for mozsystemmonitor 05:45:30 INFO - Successfully installed mozsystemmonitor 05:45:30 INFO - Cleaning up... 05:45:30 INFO - Return code: 0 05:45:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45: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==2.5.1'] in /builds/slave/test/build 05:45: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==2.5.1 05:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:30 INFO - 'HOME': '/Users/cltbld', 05:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:30 INFO - 'LOGNAME': 'cltbld', 05:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:30 INFO - 'MOZ_NO_REMOTE': '1', 05:45:30 INFO - 'NO_EM_RESTART': '1', 05:45:30 INFO - 'PAGER': '/bin/cat', 05:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:30 INFO - 'PWD': '/builds/slave/test', 05:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:30 INFO - 'SHELL': '/bin/bash', 05:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:30 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:30 INFO - 'USER': 'cltbld', 05:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:30 INFO - 'XPC_FLAGS': '0x0', 05:45:30 INFO - 'XPC_SERVICE_NAME': '0', 05:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:33 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 05:45:33 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 05:45:33 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 05:45:33 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 05:45:33 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 05:45:33 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 05:45:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:34 INFO - warning: no files found matching '*.txt' 05:45:34 INFO - no previously-included directories found matching 'build' 05:45:34 INFO - no previously-included directories found matching 'dist' 05:45:34 INFO - no previously-included directories found matching '.git*' 05:45:34 INFO - Installing collected packages: jsonschema, functools32 05:45:34 INFO - Running setup.py install for functools32 05:45:34 INFO - warning: no files found matching '*.txt' 05:45:34 INFO - no previously-included directories found matching 'build' 05:45:34 INFO - no previously-included directories found matching 'dist' 05:45:34 INFO - no previously-included directories found matching '.git*' 05:45:34 INFO - Successfully installed jsonschema functools32 05:45:34 INFO - Cleaning up... 05:45:34 INFO - Return code: 0 05:45:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:34 INFO - 'HOME': '/Users/cltbld', 05:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:34 INFO - 'LOGNAME': 'cltbld', 05:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:34 INFO - 'MOZ_NO_REMOTE': '1', 05:45:34 INFO - 'NO_EM_RESTART': '1', 05:45:34 INFO - 'PAGER': '/bin/cat', 05:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:34 INFO - 'PWD': '/builds/slave/test', 05:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:34 INFO - 'SHELL': '/bin/bash', 05:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:34 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:34 INFO - 'USER': 'cltbld', 05:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:34 INFO - 'XPC_FLAGS': '0x0', 05:45:34 INFO - 'XPC_SERVICE_NAME': '0', 05:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:45:34 INFO - Cleaning up... 05:45:34 INFO - Return code: 0 05:45:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:34 INFO - 'HOME': '/Users/cltbld', 05:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:34 INFO - 'LOGNAME': 'cltbld', 05:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:34 INFO - 'MOZ_NO_REMOTE': '1', 05:45:34 INFO - 'NO_EM_RESTART': '1', 05:45:34 INFO - 'PAGER': '/bin/cat', 05:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:34 INFO - 'PWD': '/builds/slave/test', 05:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:34 INFO - 'SHELL': '/bin/bash', 05:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:34 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:34 INFO - 'USER': 'cltbld', 05:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:34 INFO - 'XPC_FLAGS': '0x0', 05:45:34 INFO - 'XPC_SERVICE_NAME': '0', 05:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:35 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 05:45:35 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 05:45:35 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 05:45:35 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 05:45:35 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 05:45:35 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 05:45:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:37 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 05:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:38 INFO - Downloading docopt-0.6.1.tar.gz 05:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:38 INFO - Running setup.py install for blobuploader 05:45:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:39 INFO - Running setup.py install for requests 05:45:39 INFO - Running setup.py install for docopt 05:45:39 INFO - Successfully installed blobuploader requests docopt 05:45:39 INFO - Cleaning up... 05:45:39 INFO - Return code: 0 05:45:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:39 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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:39 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 05:45:39 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 05:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:39 INFO - 'HOME': '/Users/cltbld', 05:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:39 INFO - 'LOGNAME': 'cltbld', 05:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:39 INFO - 'MOZ_NO_REMOTE': '1', 05:45:39 INFO - 'NO_EM_RESTART': '1', 05:45:39 INFO - 'PAGER': '/bin/cat', 05:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:39 INFO - 'PWD': '/builds/slave/test', 05:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:39 INFO - 'SHELL': '/bin/bash', 05:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:39 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:39 INFO - 'USER': 'cltbld', 05:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:39 INFO - 'XPC_FLAGS': '0x0', 05:45:39 INFO - 'XPC_SERVICE_NAME': '0', 05:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-SKJpEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-NpWHc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-CoSBH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-5bUFUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Cyp6I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-ahOVSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-W2kjf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-uyz2FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-LOUlq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-bwqBRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-KaGyne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-95RLzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-vQoJX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-9iYs6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-rYxt6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-11G4Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-vKr2i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:41 INFO - Running setup.py install for manifestparser 05:45:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:42 INFO - Running setup.py install for mozcrash 05:45:42 INFO - Running setup.py install for mozdebug 05:45:42 INFO - Running setup.py install for mozdevice 05:45:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:42 INFO - Running setup.py install for mozfile 05:45:42 INFO - Running setup.py install for mozhttpd 05:45:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:42 INFO - Running setup.py install for mozinfo 05:45:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:42 INFO - Running setup.py install for mozInstall 05:45:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Running setup.py install for mozleak 05:45:43 INFO - Running setup.py install for mozlog 05:45:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Running setup.py install for moznetwork 05:45:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Running setup.py install for mozprocess 05:45:43 INFO - Running setup.py install for mozprofile 05:45:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:43 INFO - Running setup.py install for mozrunner 05:45:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Running setup.py install for mozscreenshot 05:45:44 INFO - Running setup.py install for moztest 05:45:44 INFO - Running setup.py install for mozversion 05:45:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:44 INFO - Cleaning up... 05:45:44 INFO - Return code: 0 05:45:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:44 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')]} 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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')]} 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:44 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 05:45:44 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 05:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:44 INFO - 'HOME': '/Users/cltbld', 05:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:44 INFO - 'LOGNAME': 'cltbld', 05:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:44 INFO - 'MOZ_NO_REMOTE': '1', 05:45:44 INFO - 'NO_EM_RESTART': '1', 05:45:44 INFO - 'PAGER': '/bin/cat', 05:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:44 INFO - 'PWD': '/builds/slave/test', 05:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:44 INFO - 'SHELL': '/bin/bash', 05:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:44 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:44 INFO - 'USER': 'cltbld', 05:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:44 INFO - 'XPC_FLAGS': '0x0', 05:45:44 INFO - 'XPC_SERVICE_NAME': '0', 05:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:44 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-rzk5fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:44 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)) 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:44 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Brn2AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:44 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)) 05:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:44 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Lzbzy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-DjXmzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-rWLME8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-BOPGiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-7TDYSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-RaYIQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-0EZ0Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-HAeNw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-TlrOTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:45 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)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-NiokBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:45 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-q5bc_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:46 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)) 05:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:46 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-a3Se8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:46 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)) 05:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:46 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-3tM187-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:46 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)) 05:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:46 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-qnjzNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:46 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-V7SAuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:46 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)) 05:45:46 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)) 05:45:46 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)) 05:45:46 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)) 05:45:46 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)) 05:45:46 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)) 05:45:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:49 INFO - Downloading blessings-1.6.tar.gz 05:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:49 INFO - Installing collected packages: blessings 05:45:49 INFO - Running setup.py install for blessings 05:45:49 INFO - Successfully installed blessings 05:45:49 INFO - Cleaning up... 05:45:49 INFO - Return code: 0 05:45:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:49 INFO - Reading from file tmpfile_stdout 05:45:49 INFO - Current package versions: 05:45:49 INFO - blessings == 1.6 05:45:49 INFO - blobuploader == 1.2.4 05:45:49 INFO - docopt == 0.6.1 05:45:49 INFO - functools32 == 3.2.3-2 05:45:49 INFO - jsonschema == 2.5.1 05:45:49 INFO - manifestparser == 1.1 05:45:49 INFO - mozInstall == 1.12 05:45:49 INFO - mozcrash == 1.0 05:45:49 INFO - mozdebug == 0.1 05:45:49 INFO - mozdevice == 0.49 05:45:49 INFO - mozfile == 1.2 05:45:49 INFO - mozhttpd == 0.7 05:45:49 INFO - mozinfo == 0.9 05:45:49 INFO - mozleak == 0.1 05:45:49 INFO - mozlog == 3.4 05:45:49 INFO - moznetwork == 0.27 05:45:49 INFO - mozprocess == 0.23 05:45:49 INFO - mozprofile == 0.28 05:45:49 INFO - mozrunner == 6.13 05:45:49 INFO - mozscreenshot == 0.1 05:45:49 INFO - mozsystemmonitor == 0.3 05:45:49 INFO - moztest == 0.7 05:45:49 INFO - mozversion == 1.4 05:45:49 INFO - psutil == 3.1.1 05:45:49 INFO - requests == 1.2.3 05:45:49 INFO - wsgiref == 0.1.2 05:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:49 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')]} 05:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:49 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')]} 05:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:49 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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:49 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 05:45:49 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 05:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:49 INFO - 'HOME': '/Users/cltbld', 05:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:49 INFO - 'LOGNAME': 'cltbld', 05:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:49 INFO - 'MOZ_NO_REMOTE': '1', 05:45:49 INFO - 'NO_EM_RESTART': '1', 05:45:49 INFO - 'PAGER': '/bin/cat', 05:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:49 INFO - 'PWD': '/builds/slave/test', 05:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:49 INFO - 'SHELL': '/bin/bash', 05:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:49 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:49 INFO - 'USER': 'cltbld', 05:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:49 INFO - 'XPC_FLAGS': '0x0', 05:45:49 INFO - 'XPC_SERVICE_NAME': '0', 05:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 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)) 05:45:50 INFO - Cleaning up... 05:45:50 INFO - Return code: 0 05:45:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:50 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')]} 05:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:50 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')]} 05:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:50 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 0x10e8e93f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9279c8c700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, '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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 05:45:50 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 05:45:50 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 05:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:50 INFO - 'HOME': '/Users/cltbld', 05:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:50 INFO - 'LOGNAME': 'cltbld', 05:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:50 INFO - 'MOZ_NO_REMOTE': '1', 05:45:50 INFO - 'NO_EM_RESTART': '1', 05:45:50 INFO - 'PAGER': '/bin/cat', 05:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:50 INFO - 'PWD': '/builds/slave/test', 05:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:50 INFO - 'SHELL': '/bin/bash', 05:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:45:50 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:50 INFO - 'USER': 'cltbld', 05:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:50 INFO - 'XPC_FLAGS': '0x0', 05:45:50 INFO - 'XPC_SERVICE_NAME': '0', 05:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:45:50 INFO - Cleaning up... 05:45:50 INFO - Return code: 0 05:45:50 INFO - Running post-action listener: _resource_record_post_action 05:45:50 INFO - Running post-action listener: _start_resource_monitoring 05:45:50 INFO - Starting resource monitoring. 05:45:50 INFO - [mozharness: 2016-12-08 13:45:50.320139Z] Finished create-virtualenv step (success) 05:45:50 INFO - [mozharness: 2016-12-08 13:45:50.321173Z] Running install step. 05:45:50 INFO - Running pre-action listener: _resource_record_pre_action 05:45:50 INFO - Running main action method: install 05:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:50 INFO - Reading from file tmpfile_stdout 05:45:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:45:50 INFO - Reading from file tmpfile_stdout 05:45:50 INFO - Output received: 05:45:50 INFO - Usage: mozinstall [options] installer 05:45:50 INFO - Options: 05:45:50 INFO - -h, --help show this help message and exit 05:45:50 INFO - -d DEST, --destination=DEST 05:45:50 INFO - Directory to install application into. [default: 05:45:50 INFO - "/builds/slave/test"] 05:45:50 INFO - --app=APP Application being installed. [default: firefox] 05:45:50 INFO - mkdir: /builds/slave/test/build/application 05:45:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:46:23 INFO - Reading from file tmpfile_stdout 05:46:23 INFO - Output received: 05:46:23 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:46:23 INFO - Running post-action listener: _resource_record_post_action 05:46:23 INFO - [mozharness: 2016-12-08 13:46:23.477985Z] Finished install step (success) 05:46:23 INFO - [mozharness: 2016-12-08 13:46:23.478135Z] Running run-tests step. 05:46:23 INFO - Running pre-action listener: _resource_record_pre_action 05:46:23 INFO - Running main action method: run_tests 05:46:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:23 INFO - 2016-12-08 05:46:23.492 screenresolution[1635:8425] starting screenresolution argv=screenresolution get 05:46:23 INFO - 2016-12-08 05:46:23.495 screenresolution[1635:8425] Display 0: 1600x1200x32@60 05:46:23 INFO - 2016-12-08 05:46:23.501 screenresolution[1636:8427] starting screenresolution argv=screenresolution list 05:46:23 INFO - Available Modes on Display 0 05:46:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:23 INFO - Intel Iris: 05:46:23 INFO - Chipset Model: Intel Iris 05:46:23 INFO - Type: GPU 05:46:23 INFO - Bus: Built-In 05:46:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:23 INFO - Vendor: Intel (0x8086) 05:46:23 INFO - Device ID: 0x0a2e 05:46:23 INFO - Revision ID: 0x0009 05:46:23 INFO - Displays: 05:46:23 INFO - Display: 05:46:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:23 INFO - Display Serial Number: 1600x1200 60 05:46:23 INFO - Main Display: Yes 05:46:23 INFO - Mirror: Off 05:46:23 INFO - Online: Yes 05:46:23 INFO - Rotation: Supported 05:46:23 INFO - Return code: 0 05:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:23 INFO - Python 2.7.3 05:46:23 INFO - Return code: 0 05:46:23 INFO - grabbing minidump binary from tooltool 05:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:23 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 0x10e6fed30>, '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 0x10e565db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:23 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 05:46:23 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 05:46:23 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 05:46:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:23 INFO - Return code: 0 05:46:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:23 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--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 05:46:23 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0201 --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 05:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vqb7p7FhJV/Render', 05:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:23 INFO - 'HOME': '/Users/cltbld', 05:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:23 INFO - 'LOGNAME': 'cltbld', 05:46:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:23 INFO - 'MOZ_NO_REMOTE': '1', 05:46:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:23 INFO - 'NO_EM_RESTART': '1', 05:46:23 INFO - 'PAGER': '/bin/cat', 05:46:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:23 INFO - 'PWD': '/builds/slave/test', 05:46:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:23 INFO - 'SHELL': '/bin/bash', 05:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRZzEUb2yu/Listeners', 05:46:23 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 05:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:23 INFO - 'USER': 'cltbld', 05:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:23 INFO - 'XPC_FLAGS': '0x0', 05:46:23 INFO - 'XPC_SERVICE_NAME': '0', 05:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:23 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--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 05:46:24 INFO - mozversion application_buildid: 20161208030206 05:46:24 INFO - mozversion application_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 05:46:24 INFO - mozversion application_display_name: Nightly 05:46:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:24 INFO - mozversion application_name: Firefox 05:46:24 INFO - mozversion application_remotingname: firefox 05:46:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:24 INFO - mozversion application_vendor: Mozilla 05:46:24 INFO - mozversion application_version: 53.0a1 05:46:24 INFO - mozversion platform_buildid: 20161208030206 05:46:24 INFO - mozversion platform_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 05:46:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:24 INFO - mozversion platform_version: 53.0a1 05:46:24 INFO - using testdate: 1481204784 05:46:24 INFO - actual date: 1481204784 05:46:24 INFO - starting webserver on 'localhost:49247' 05:46:24 INFO - SUITE-START | Running 2 tests 05:46:24 INFO - TEST-START | dromaeo_css 05:46:24 INFO - operating with platform_type : mac_ 05:46:24 INFO - Initialising browser for dromaeo_css test... 05:46:24 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpN6ZGNf/profile http://localhost:49247/getInfo.html) 05:46:27 INFO - PROCESS | 1646 | 2016-12-08 05:46:27.551 plugin-container[1649:8603] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 05:46:27 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:27 INFO - PROCESS | 1646 | 2016-12-08 05:46:27.552 plugin-container[1649:8603] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 05:46:27 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:27 INFO - PROCESS | 1646 | 2016-12-08 05:46:27.552 plugin-container[1649:8603] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:27 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 05:46:27 INFO - PROCESS | 1646 | colorDepth:24 05:46:27 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 05:46:27 INFO - PROCESS | 1646 | __metrics 05:46:27 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 05:46:28 INFO - TEST-INFO | 1646: exit 0 05:46:28 INFO - Browser initialized. 05:46:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:28 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpN6ZGNf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:31 INFO - PROCESS | 1651 | 2016-12-08 05:46:31.411 plugin-container[1652:8730] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 05:46:31 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:31 INFO - PROCESS | 1651 | 2016-12-08 05:46:31.412 plugin-container[1652:8730] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x480b, name = 'com.apple.CFPasteboardClient' 05:46:31 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:31 INFO - PROCESS | 1651 | 2016-12-08 05:46:31.412 plugin-container[1652:8730] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:40 INFO - PROCESS | 1651 | RSS: Main: 241610752 05:46:40 INFO - PROCESS | 1651 | 05:47:30 INFO - PROCESS | 1651 | 1481204850555 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 05:49:45 INFO - PROCESS | 1651 | RSS: Main: 252682240 05:49:45 INFO - PROCESS | 1651 | 05:52:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 05:52:48 INFO - PROCESS | 1651 | RSS: Main: 263507968 05:52:48 INFO - PROCESS | 1651 | 05:55:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 05:55:51 INFO - PROCESS | 1651 | RSS: Main: 268881920 05:55:51 INFO - PROCESS | 1651 | 05:58:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 05:58:53 INFO - PROCESS | 1651 | RSS: Main: 268607488 05:58:53 INFO - PROCESS | 1651 | 06:01:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 06:01:57 INFO - PROCESS | 1651 | RSS: Main: 273125376 06:01:57 INFO - PROCESS | 1651 | 06:04:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 06:05:00 INFO - PROCESS | 1651 | RSS: Main: 275914752 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | __start_tp_report 06:05:00 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 06:05:00 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 06:05:00 INFO - PROCESS | 1651 | |i|pagename|runs| 06:05:00 INFO - PROCESS | 1651 | |0;dojo.html;2601.193629974708;3327.9500807487875;3366.2594229269566;3408.778429402087;3427.520147179394;5604.747786349614;5697.373288938219;5713.342965558962;5737;5806.825795226139;4172.937405938906;5657.773689052433;5764.077747560391;5785.797497087603;5926.644401335912;5161.096808058574;5213.9478605214035;5243.6853788772605;5318;5404.08130617794;4536.206163921317;5359.249705041298;5366.543843773284;5371.892562148755;5383.138697808351;4436.822527098912;5026.145555255597;5319.734013299339;5334.706591137486;5377.8117765878205;5151.7681704323395;5296.841094767163;5330.946690533084;5337.893242135155;5380.0046991306735;3702.2040261343673;5125.513076257749;5129.384473863123;5158.69047857126;5248.422673505911;5441.483059109379;5697.829065128053;5701.77192912283;5710.628809127435;5716.628419152742;6253.906191407133;6261.248650161964;6261.373862613747;6264.185655864709;6282.842928926768;6132.263729246501;6203;6208.906866397007;6228.87542249157;6231.906521402183;5822.970885145632;5842.59101862874;5857.092150716646;5865.530757539386;5873.794417195378;6305.117283580303;6312.621242725451;6315.96842015787;6340.239171299474;6359.872802543923;5964;6022.608530445507;6041.879162416815;6100.572959892765;6190.783322583688;6132.661461321697;6143.082036032849;6152.569320147636;6156.29202641693;6194.628322300587;6209.379062093754;6223.595466294676;6234;6249;6251.74993000284;6100.542459315569;6114.692773002168;6152.723127459275;6160.815175544741;6263.248410190715;4123.567025462284;4370.497392799869;4889.413270407574;4936.185529387682;4973.52751488608;4415.911681766411;4429.512753597101;4442.244818380883;4460.620847227957;4470.642348612103;5675.687837168995;5678.630888992202;5747.885042299131;5878.971180043475;5899.380565040695;5102.36220472441;6134.038624681888;6164.599301045508;6190.535709821781;6202;5823.5923485355615;5846.093855452412;5850.151727999416;5852.122181672698;5859.677717725566;5336.67979921206;5382.892342153135;5386.29978102852;5410.91883621746;5432.456754324536;6152;6227.377262273827;6242.563020588696;6259.749610015549;6279.466245369012;6191.535634827316;6192.783252586318;6198.907016394848;6219.564630475823;6285.465735412541;6395.616263024233;6399.168108145911;6409.583377080475;6412.23053233615;6413.935860641521;5091.821786237464;5851.356350801323;5980.910286345621;6092.238470191226;6118.405988989777;5113.846584602468;5303.946960530346;6076.574639775174;6185.938140618537;6222.09779581949;6086.381249409276;6115.021596544531;6150.446459818638;6151.046587778901;6168;5467.507924286833;5608.214849921096;6092.086187071975;6104.481119104926;6130.785422510191;5706.372299047184;5760.740766665426;5854.0340843760305;5946.167536544974;5980.671063091571;6056.212692349966;6072.453479186895;6075.635461872302;6079.908801368071;6105.511559075352;5932.614380065282;5954.821355359346;5955.076963070731;6007.579469437097;6028.57799953999 06:05:00 INFO - PROCESS | 1651 | |1;ext.html;479.2523663085586;489.29052873333654;494.65374238033377;504.5837184322932;510.16842546648957;28915;30413.695863041365;37565.36519522069;38288.04279892997;38462.61537384625;38785.03037424066;39256.60743392565;39368;39406;39450.605493945055;9107.726768196948;9285.95357023214;9287.628494860197;9287.860682089775;9315.906840931606;8432.325413966899;8500.914990850075;9181.678641247558;9183.678571250008;11086.334819910791;11205.383703896283;11251.887481125206;11255.380954047525;11264.324140551553;11288.604898828542;11037.503312350964;11100.944495277552;11105.333679979227;11131.666050018512;11233.494492747765;11032.834507482394;11048.834267485994;11057.944710276397;11080.944595277053;11097.667069987914;37556;37949;37970.430443543366;37978.81010594929;38078.61921380806;3322.2358857462677;3419.6580341965855;3484.6863782259466;3603.72972027099;3754.624537546251;28745.28136796576;28972.42055158885;29477;29490.852545737347;29524.70475295241;3060.6021217241614;3114;3188.9362212755614;3249.723773479257;3290.93418131636;478637;482657;485512;485955;486378;53862.7306863471;54238.72880635651;54662.18006729902;54699;54784.17823732647;56340.15489767657;56354.71822640861;56643.71678141583;56715.71642141763;56827.71586142043;14626.341814618369;14969.251537423086;14980.1011939284;14981.625459363604;14988.175650339117;10686.51910664022;11732.354720490455;11733;11764.647060588197;11780.469878855472;12813.743725125445;14464.566063018126;14702.705945881022;14788.264171128376;14955.700885982436;5075.061113693979;5587.916181257285;5988.37122102173;5990.490808281258;6056.091586262008;736.6537727268176;825.8389614025208;832.7252006837729;868.4962721621445;1031.0823367203195;21731.67402488964;26180.476390472082;27114.45771084607;27380.7678654461;28845.134645960654;1015.4516561056946;1042.2443728296923;1044.4934206909795;1062.645127462476;1168.1239070696977;12371.628851134481;12551;14683.706325873423;14789.926050369679;15240.542783716506;591648;626548;630627;635306;807425;42587.148257034685;53226.20160697593;53803.19295210575;53978.46021539735;54002.649933751185;1297.3383574376946;1318;1323.5698398020681;1342.154442701092;1346.5489061164424;24188.51622967566;28678;28884.566731499464;29222;29561;46322.7683861592;46591.767041164574;46600.30099548577;46647;46683.06633867235;546882;550558;552160;552808;553280;21690.34928952134;23805.047798087882;23856.64215036741;24141.63787543153;24215.394615134763;36640.267194655426;41582.58417415787;42107.789461052496;43434.348484773385;43549.346759798;25336.733163342127;34365.82817085998;34999.65000349964;35272.64727352796;36230;30023;35098.947031589094;35869.28261434809;35887.46168807522;36121.81939090288;31898.52152217672;32086.358272833946;35075.12312192216;35656.465153023244;35967.82016089903;30384;32444;32533.674663254013;32661.34677306488;32723.34553308968;21529.031193596013;23992.920318585355;24224.273271801874;24839;24956 06:05:00 INFO - PROCESS | 1651 | |2;jquery.html;362.7660159197318;365.10367048894966;366.31681913231813;373.33732624591346;386.246818703528;13216.471341146354;18131.72802407963;19742.210311587518;19939.900300498477;20012;18515.592972913535;18754.624907501842;19200.23199072039;19306.32427865025;19384.903075484603;4548.5224051474615;5633.915491267634;5716.371199168088;5725.828225153231;5744.052231381817;5538.335399752035;5636.7181640918;5818.709064546777;5870.559708021894;5876.177335173079;5835.941640583582;5838.854028649296;5870.677112758796;5871.794487192949;5873.089671100986;5509.641873278244;5529.225908372831;5577.52591029763;5580.693061881595;5589.35722391924;4894.241392584155;4900.411950565955;4907.11671899058;4912.606991440676;4917.40991081069;12435.253884766942;13318.734720201566;22337.441563960867;23260;23482.530349393088;2156.805887470135;2203.405080628221;2216.822654187677;2234.273860995183;2279.566882292376;7560.546367217985;7608.619569021526;9670.56482458291;9957.800843983152;10150;1638.189096397291;1723.5863392785766;1797.4248240563024;1828.7896891857474;1863.2267608942273;115072.27391589133;119379.65893240129;122037;123076.38461807724;124458.37770811089;11056.11551075928;11203.831942520868;11235.887641123483;11325.943370283096;11490.597829075943;14085.718285634435;14109.71780564383;14116.647083822987;14127.646808829655;14143.85856141446;6566.376194261537;6767.932320676829;6950.200726916368;7881.290683838482;8198.180181981874;6736.686346162549;7758.14660387357;7855.489393189425;8007.359411247086;8028.11690714021;4379.605835474759;4389.912201755947;4470.530594287618;4483.955160448419;4493.370928070073;1860.228005377753;1955.1299671645982;1971.8957383865081;1979.4061781465502;1979.9307024254083;792.7819849541422;794.4319811334923;829.6266679994027;874.9300055995633;951.2390087929629;18745.90627046856;19624.41126766199;19801;19843.30548430827;20061;890.3856339125982;901.4726385064679;910.6038873090226;953.7281874665687;963.9325247232626;9788.510574471391;10002.899971000343;10169.796604068026;10224.13094886943;10234.846477302846;527222;540359;540511;550956;551095;101862;116951;122076;128296;130232;959.5586030426082;1001.1440218613127;1033.3489901362093;1033.4884232305058;1034.177828626244;17303.04833234134;17592.329297434204;17658;17689.557761056076;17915.104244787446;49053.754731226116;51956.74021629868;53468;55046.17430738462;56825;72861;77818.05454863673;79755.60122199352;80685.59657201676;83333;7534.35957943581;7689.884651730116;7954.403419743659;7992;8137.75586732399;11198.328100313682;12098.153129280865;12354.629361119181;12501.999840012595;12520.248785072925;10087.394756314645;10300.227482938959;10592.788144236918;10747.408892510673;10938.398388088732;9119.863202052107;9475.905240947503;9874.851877221703;10736.409497477714;10829.24195306321;10530.420826854597;10541.73645658834;10973.286736362112;11081.224314297922;11109.611163609236;7788.221177882393;7820.687172513036;7899.763007109796;7906.802329941567;8085.716999904975;10509.632162874263;10614.787704246026;10850.348979061282;10881.945590271998;10900.509477073392 06:05:00 INFO - PROCESS | 1651 | |3;mootools.html;1264.715439026219;1342.3556692787463;1463.560931720484;1764.7705798246227;1776.9822301776978;7420.146683131442;7676.731314403997;7915.920840791598;8364.038135614406;8372.748817535468;7896.684132634702;8201.671933122683;8203.958980205105;8288.254057134856;8305.335573154149;1743.9476815695486;1849.9630007399844;2253.07623874212;2272.420532764151;2292.1862738727764;1884.5006073390562;1898.686716691744;2163.8377121715857;2280.692106565609;2324.837261391703;1662.1772222749755;2245.69683092782;2255.075419078178;2256.4020534558354;2291.51878105598;2242.7084479017703;2252.6733623624564;2277.0322612889454;2277.669737887997;2290.358699564125;2263.4680850000236;2275.533515629292;2282.44080200352;2284.2804516577226;2311.2603966730653;8222.8355432891;8273.875891861628;8293.585320733939;8332.250097491255;8349.874751878726;4247.617714405718;4567.1550763108935;4962.106820772259;5087.949120508784;5164.870878228036;2927.487689654302;3183.2996740717003;3431.78171749028;3438.638942911008;3442.2599141184514;978.9853152202722;1002;1045.5869931377063;1048.0829274384914;1059.5655781129776;10765.407902565355;10800.5679772809;10804.513796879159;10971.012608865161;10985.725356866062;4399.450068741407;4629.421322334708;4688.9531104689195;4691.882702932386;4695.366125573072;9315.254779617615;9363.578638961262;9374.578143983537;9402.623895044258;9480.668176613786;5088.847334579968;5123.718195499208;5148.433672296044;5156.303898973665;5166.328377311001;4219.810108545123;4491.438570178728;4492.281235002384;4630.58324750774;4640.257558790578;3217.6943190396873;3680.392735198662;3733.9253214936093;3746.8501259949844;3805.238952209569;1247.8689737577606;1253.8746125387388;1258.2890666773244;1263.109507797001;1264.1846009323936;850.2093053460218;852.2713080316364;876.2464280718577;910.1217325281135;918.7657147427363;5622.6345287557;5699.943000569941;5709.65742055478;5750.741216645261;5969.31352894414;854.3549620036832;862.3316929379781;910.6129894794685;938.3900464697864;940.5626383731598;3753.962460375416;3777.527809023872;3797.4303854421505;3844.7308688392104;3868.5357757069332;9451.763705907408;10020.899791002143;10081.429235544889;10089.798204035878;10140.239482038876;9997.150242229493;10029.598816047423;10068.848967265498;10082.69751907444;10089;7652.579108149105;7685.923970644114;7718.575478348745;7789.298963093235;7846.568438735811;5311.442298558596;5474.753636086306;5541.3904470507405;5566.304211973504;5645.915311270416;7727.49771264866;9247.029061948668;9335.206507446943;9335.48654823964;9372.109649583279;8478.321734261368;8727.389082764399;8854.911450885666;9412.67055653049;9424.64383904024;6881.380675739208;7011.859762804817;7108.253633368422;7109.040279562193;7109.680064397011;7831.295183433518;7908.130105688485;7917.564533950688;7933.444658873824;7956.880646790187;7056.082709247765;7067.0459487968465;7088.432925366062;7262.164851042197;7269.781906542812;7003.089598352181;7016.5790052597;7023;7036.155661320674;7039.788806335818;5350.9732451337495;5514.283143191359;6521.543491955517;6543;6604.801855944329;4066.755994640331;4620.660008597603;4766.666333356632;4814.20565606671;4908;4118.011677197511;4621.075784843112;4812.278158276286;4844.709317440965;4891.364122664031 06:05:00 INFO - PROCESS | 1651 | |4;prototype.html;287.95248783950643;300.5221697500974;301.4664044640984;305.2993380192458;307.82300177397985;4381.846635367763;5443.401225865152;5450.591205659572;5458.563314934806;5463.9180412293845;5033.647644664875;5382.2324372939;5402.621816472849;5405.27028851105;5431.158170483582;3310.96689033109;3843.6540711336042;3914.354131568302;3971.523417189941;3988.9800550997347;3601.49695961307;4048.137856585959;4058.817353219112;4084.65280451162;4105;4049.2104039712267;4051.513818341803;4056.655184309337;4063.963689259235;4072.6945479089186;3915.902102447433;4005.599440055971;4077.4495443115097;4081.7346872453195;4100.323446631302;3052.8015678980796;3484.703800176988;3530.9823450882836;3542.9902477793703;3547.9645203547893;5194.22086687;5217.3999990000875;5220.504052115043;5224.555912747383;5238.899831035487;4392.682195341385;4408.14041261954;4544.409226800528;4626.653001024936;4683.227267500858;5569.192467092249;5575;5604.187392828017;5647.548196144339;5657.953278643423;3869.8645547405704;3870.1292209252974;3884.320243957296;3906.980465097656;3909.882703518899;5073.239014147907;5840.853978650525;5874.85440339134;5889.617174883661;5899.528037756969;3196.5205219216837;3780.3573392523335;3828.464015037897;3828.5214348206473;3843.423486477051;3868.149007218464;3887.611238876146;3894.571597124314;3912.980435097806;3934.3114954883354;4523.5024147343765;4597.218472859622;4598.333241680005;4607;4628.745419001987;4671.672982891165;4952.777125029383;5356.250124982505;5413.377461591888;5665.487397813382;1183.041736193686;1267.7781388257204;1268.3024336614824;1275.183882315319;1279.2452453052558;743.6690672650727;813.3452570680658;856.8200677857595;862.6032025268447;872.1975782280317;4192.161567686475;5058.898822023539;5252.579793616502;5311.920321195185;5356.866078348073;5099.36257967754;5218.739063046908;5222.529972302435;5767.134929760569;5849.122631605208;4696.671233013724;4940.357753492023;5216.426193118754;5299.920501192485;5369.5167434931045;2514.371407148213;2612.843229406242;2866.942661146765;2889.898853540158;2912.199145235077;5279.340082489689;5426.375966763794;5506.339239291311;5742.30111847431;5784.363719990798;4742.620590352763;5558.944410555842;5717.285339332583;5929.703514824241;6115.541334399849;5118.692878427306;5345.412004679482;5423.105187644073;5661.179129026268;6108.1143234230785;5193.428722840409;5953.261499710182;5981.790637327673;5988.790392336422;6010.226983040101;4883.60931125502;5221.686698798084;5259.7370131494035;5864.44287792659;5926.585139040399;5201.699575106223;5897.7935772247765;6155.692215389123;6191.9690401547705;6321.26165304545;3779.3340459753995;3875.9224815502967;3923.2349691809823;3923.5291764988383;3943.2310699413338;5635.718214089197;5657.519110875622;5785.595008349375;5824.912626310524;5873.911891321548;5326;5379.2469054333205;5510.614257002132;5697.006047883374;5724.971375143097;4473.664475164311;5369.731513424391;5442;5581.544120586928;5678.637127089386;5464.617476776588;5539.864327812869;5654.886902261849;5676.091825307931;5686.914696279477;5447.373552041566;5520.944790552043;5561.304836895388;5642.548596112383;5837.5329973601165;5412.945870541244;5481.314835645544;5505.201745746925;5525.060739674184;5545.611807173459 06:05:00 INFO - PROCESS | 1651 | |5;yui.html;627.1376856821872;688.1432616392592;710.9999999999999;757.0877093102812;769.7606852966725;12945.352732363379;14452.132872027672;15310.311036003379;15461;15494;13921.791173132411;14027.719445611081;14058.507952221675;14064.929675351634;14090.436382544685;636.3477435628472;657.0046379734706;777.2887807656016;798.6046906781137;811.525257724232;624.8656538844148;815.1196707555855;815.2581151152452;819.3608984991686;820.4420993724265;867.1025488619281;868.8522951098329;869.1265278395203;871.4030888841132;875.7722992022057;849.7663142635763;854.598338780772;860.3375400941271;862.107718511344;864.6843901975797;623.6601052426438;634.4765568406084;641.4323323858372;641.5990006246096;641.8940874755659;14617.196054217015;14993.775093373608;15132.848671513255;15167.924160379238;15178.241087945558;14275.286235688278;14575.489857854924;14688.192149431778;14706.264686765619;14857.47998820047;11595.94202028993;11861.406929653484;11915.463804128749;11962.581309654208;12165.391730413532;3708.647678470541;3709.3694072007825;3735.364987952055;3750.081230098616;3850.4416859555486;123805;127590;128547;129369.35315323363;129727;10973;10973.451327433597;11055.613053543248;11136.276142050741;11190;22370.44073898133;22443.775562244497;22725.772742272366;22780.658290125662;22995.080196792274;7740.4194685398825;7748.070231572135;7761.9521364616185;7831.216878312123;7881.605919704107;4203.747775133502;4231.724937879028;4246.766427846436;4275.337322714984;4344.087741574242;3356.3622911646708;3459.6021457532706;3459.7059249964036;3460.0138960396166;3469.809160496197;592.5674257791836;597.229573849729;603.7554790309931;604.446931058077;604.5465900574569;448.8406615651462;592.7362323765883;592.8517870532366;632.81031660478;677.3091446724412;8836.248918841971;9103.81792364149;9235.55794226154;9292.442453452815;9336.673216437392;578.5892016668129;602.1078735275884;624.4941597306197;649.4382359259207;661.1372159332021;4536.77316134192;4599.655025873073;4614.469336026333;4619.376384188159;4667.32323813052;96955;100373;106345.4682726597;106579;119876.4006179981;93808.12383752287;95849.5207523958;95912;95948;97412.51293743486;78247.60876195696;82910.58544707358;82946.17053829505;85153;85314;9601;9809.359443740552;9831.9016809831;9918.156956658764;9951;41564.960875978344;47692.7615361921;50228.73970671256;51967;53252.73373633107;70170.29829701637;71642.64178679073;75257.6237118811;76378.23621763711;77301.2269877294;12521.499140034297;12595.370231488572;12666.43001064936;12703.872961270268;12815.16701414405;11704.94147529257;12241;12373.876261237272;12783.16909400886;13516.783489485993;11651.30092194471;13197.670058248621;13325.333733313102;13742.106763060368;14032.22822744759;13315.667108321983;13658.453661853811;13717.519886803913;13982.510612128526;14547.854521455074;13298.75477204101;13501.122427042212;13568.728625427633;13666.180029197882;13724.93137534306;10123.190144788547;10968.287061340987;11056.502457389275;11351.602693905674;11497.195196336175;10258.640947566799;11077.667669969915;11111.55465958775;11123.332600044023;11281.830772538255 06:05:00 INFO - PROCESS | 1651 | __end_tp_report 06:05:00 INFO - PROCESS | 1651 | __start_cc_report 06:05:00 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,361 06:05:00 INFO - PROCESS | 1651 | __end_cc_report 06:05:00 INFO - PROCESS | 1651 | __startTimestamp1481205900171__endTimestamp 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | ------- Summary: start ------- 06:05:00 INFO - PROCESS | 1651 | Number of tests: 6 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5682.05 Median:5878.97 stddev:697.07 (11.9%) stddev-sans-first:655.97 06:05:00 INFO - PROCESS | 1651 | Values: 2601.2 3328.0 3366.3 3408.8 3427.5 5604.7 5697.4 5713.3 5737.0 5806.8 4172.9 5657.8 5764.1 5785.8 5926.6 5161.1 5213.9 5243.7 5318.0 5404.1 4536.2 5359.2 5366.5 5371.9 5383.1 4436.8 5026.1 5319.7 5334.7 5377.8 5151.8 5296.8 5330.9 5337.9 5380.0 3702.2 5125.5 5129.4 5158.7 5248.4 5441.5 5697.8 5701.8 5710.6 5716.6 6253.9 6261.2 6261.4 6264.2 6282.8 6132.3 6203.0 6208.9 6228.9 6231.9 5823.0 5842.6 5857.1 5865.5 5873.8 6305.1 6312.6 6316.0 6340.2 6359.9 5964.0 6022.6 6041.9 6100.6 6190.8 6132.7 6143.1 6152.6 6156.3 6194.6 6209.4 6223.6 6234.0 6249.0 6251.7 6100.5 6114.7 6152.7 6160.8 6263.2 4123.6 4370.5 4889.4 4936.2 4973.5 4415.9 4429.5 4442.2 4460.6 4470.6 5675.7 5678.6 5747.9 5879.0 5899.4 5102.4 6134.0 6164.6 6190.5 6202.0 5823.6 5846.1 5850.2 5852.1 5859.7 5336.7 5382.9 5386.3 5410.9 5432.5 6152.0 6227.4 6242.6 6259.7 6279.5 6191.5 6192.8 6198.9 6219.6 6285.5 6395.6 6399.2 6409.6 6412.2 6413.9 5091.8 5851.4 5980.9 6092.2 6118.4 5113.8 5303.9 6076.6 6185.9 6222.1 6086.4 6115.0 6150.4 6151.0 6168.0 5467.5 5608.2 6092.1 6104.5 6130.8 5706.4 5760.7 5854.0 5946.2 5980.7 6056.2 6072.5 6075.6 6079.9 6105.5 5932.6 5954.8 5955.1 6007.6 6028.6 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:67883.23 Median:18925.26 stddev:152944.06 (808.1%) stddev-sans-first:153289.38 06:05:00 INFO - PROCESS | 1651 | Values: 479.3 489.3 494.7 504.6 510.2 28915.0 30413.7 37565.4 38288.0 38462.6 38785.0 39256.6 39368.0 39406.0 39450.6 9107.7 9286.0 9287.6 9287.9 9315.9 8432.3 8500.9 9181.7 9183.7 11086.3 11205.4 11251.9 11255.4 11264.3 11288.6 11037.5 11100.9 11105.3 11131.7 11233.5 11032.8 11048.8 11057.9 11080.9 11097.7 37556.0 37949.0 37970.4 37978.8 38078.6 3322.2 3419.7 3484.7 3603.7 3754.6 28745.3 28972.4 29477.0 29490.9 29524.7 3060.6 3114.0 3188.9 3249.7 3290.9 478637.0 482657.0 485512.0 485955.0 486378.0 53862.7 54238.7 54662.2 54699.0 54784.2 56340.2 56354.7 56643.7 56715.7 56827.7 14626.3 14969.3 14980.1 14981.6 14988.2 10686.5 11732.4 11733.0 11764.6 11780.5 12813.7 14464.6 14702.7 14788.3 14955.7 5075.1 5587.9 5988.4 5990.5 6056.1 736.7 825.8 832.7 868.5 1031.1 21731.7 26180.5 27114.5 27380.8 28845.1 1015.5 1042.2 1044.5 1062.6 1168.1 12371.6 12551.0 14683.7 14789.9 15240.5 591648.0 626548.0 630627.0 635306.0 807425.0 42587.1 53226.2 53803.2 53978.5 54002.6 1297.3 1318.0 1323.6 1342.2 1346.5 24188.5 28678.0 28884.6 29222.0 29561.0 46322.8 46591.8 46600.3 46647.0 46683.1 546882.0 550558.0 552160.0 552808.0 553280.0 21690.3 23805.0 23856.6 24141.6 24215.4 36640.3 41582.6 42107.8 43434.3 43549.3 25336.7 34365.8 34999.7 35272.6 36230.0 30023.0 35098.9 35869.3 35887.5 36121.8 31898.5 32086.4 35075.1 35656.5 35967.8 30384.0 32444.0 32533.7 32661.3 32723.3 21529.0 23992.9 24224.3 24839.0 24956.0 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:32745.85 Median:11922.65 stddev:91042.66 (763.6%) stddev-sans-first:91265.59 06:05:00 INFO - PROCESS | 1651 | Values: 362.8 365.1 366.3 373.3 386.2 13216.5 18131.7 19742.2 19939.9 20012.0 18515.6 18754.6 19200.2 19306.3 19384.9 4548.5 5633.9 5716.4 5725.8 5744.1 5538.3 5636.7 5818.7 5870.6 5876.2 5835.9 5838.9 5870.7 5871.8 5873.1 5509.6 5529.2 5577.5 5580.7 5589.4 4894.2 4900.4 4907.1 4912.6 4917.4 12435.3 13318.7 22337.4 23260.0 23482.5 2156.8 2203.4 2216.8 2234.3 2279.6 7560.5 7608.6 9670.6 9957.8 10150.0 1638.2 1723.6 1797.4 1828.8 1863.2 115072.3 119379.7 122037.0 123076.4 124458.4 11056.1 11203.8 11235.9 11325.9 11490.6 14085.7 14109.7 14116.6 14127.6 14143.9 6566.4 6767.9 6950.2 7881.3 8198.2 6736.7 7758.1 7855.5 8007.4 8028.1 4379.6 4389.9 4470.5 4484.0 4493.4 1860.2 1955.1 1971.9 1979.4 1979.9 792.8 794.4 829.6 874.9 951.2 18745.9 19624.4 19801.0 19843.3 20061.0 890.4 901.5 910.6 953.7 963.9 9788.5 10002.9 10169.8 10224.1 10234.8 527222.0 540359.0 540511.0 550956.0 551095.0 101862.0 116951.0 122076.0 128296.0 130232.0 959.6 1001.1 1033.3 1033.5 1034.2 17303.0 17592.3 17658.0 17689.6 17915.1 49053.8 51956.7 53468.0 55046.2 56825.0 72861.0 77818.1 79755.6 80685.6 83333.0 7534.4 7689.9 7954.4 7992.0 8137.8 11198.3 12098.2 12354.6 12502.0 12520.2 10087.4 10300.2 10592.8 10747.4 10938.4 9119.9 9475.9 9874.9 10736.4 10829.2 10530.4 10541.7 10973.3 11081.2 11109.6 7788.2 7820.7 7899.8 7906.8 8085.7 10509.6 10614.8 10850.3 10881.9 10900.5 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5346.02 Median:5088.40 stddev:2971.42 (58.4%) stddev-sans-first:2963.92 06:05:00 INFO - PROCESS | 1651 | Values: 1264.7 1342.4 1463.6 1764.8 1777.0 7420.1 7676.7 7915.9 8364.0 8372.7 7896.7 8201.7 8204.0 8288.3 8305.3 1743.9 1850.0 2253.1 2272.4 2292.2 1884.5 1898.7 2163.8 2280.7 2324.8 1662.2 2245.7 2255.1 2256.4 2291.5 2242.7 2252.7 2277.0 2277.7 2290.4 2263.5 2275.5 2282.4 2284.3 2311.3 8222.8 8273.9 8293.6 8332.3 8349.9 4247.6 4567.2 4962.1 5087.9 5164.9 2927.5 3183.3 3431.8 3438.6 3442.3 979.0 1002.0 1045.6 1048.1 1059.6 10765.4 10800.6 10804.5 10971.0 10985.7 4399.5 4629.4 4689.0 4691.9 4695.4 9315.3 9363.6 9374.6 9402.6 9480.7 5088.8 5123.7 5148.4 5156.3 5166.3 4219.8 4491.4 4492.3 4630.6 4640.3 3217.7 3680.4 3733.9 3746.9 3805.2 1247.9 1253.9 1258.3 1263.1 1264.2 850.2 852.3 876.2 910.1 918.8 5622.6 5699.9 5709.7 5750.7 5969.3 854.4 862.3 910.6 938.4 940.6 3754.0 3777.5 3797.4 3844.7 3868.5 9451.8 10020.9 10081.4 10089.8 10140.2 9997.2 10029.6 10068.8 10082.7 10089.0 7652.6 7685.9 7718.6 7789.3 7846.6 5311.4 5474.8 5541.4 5566.3 5645.9 7727.5 9247.0 9335.2 9335.5 9372.1 8478.3 8727.4 8854.9 9412.7 9424.6 6881.4 7011.9 7108.3 7109.0 7109.7 7831.3 7908.1 7917.6 7933.4 7956.9 7056.1 7067.0 7088.4 7262.2 7269.8 7003.1 7016.6 7023.0 7036.2 7039.8 5351.0 5514.3 6521.5 6543.0 6604.8 4066.8 4620.7 4766.7 4814.2 4908.0 4118.0 4621.1 4812.3 4844.7 4891.4 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4556.79 Median:5221.10 stddev:1418.55 (27.2%) stddev-sans-first:1385.87 06:05:00 INFO - PROCESS | 1651 | Values: 288.0 300.5 301.5 305.3 307.8 4381.8 5443.4 5450.6 5458.6 5463.9 5033.6 5382.2 5402.6 5405.3 5431.2 3311.0 3843.7 3914.4 3971.5 3989.0 3601.5 4048.1 4058.8 4084.7 4105.0 4049.2 4051.5 4056.7 4064.0 4072.7 3915.9 4005.6 4077.4 4081.7 4100.3 3052.8 3484.7 3531.0 3543.0 3548.0 5194.2 5217.4 5220.5 5224.6 5238.9 4392.7 4408.1 4544.4 4626.7 4683.2 5569.2 5575.0 5604.2 5647.5 5658.0 3869.9 3870.1 3884.3 3907.0 3909.9 5073.2 5840.9 5874.9 5889.6 5899.5 3196.5 3780.4 3828.5 3828.5 3843.4 3868.1 3887.6 3894.6 3913.0 3934.3 4523.5 4597.2 4598.3 4607.0 4628.7 4671.7 4952.8 5356.3 5413.4 5665.5 1183.0 1267.8 1268.3 1275.2 1279.2 743.7 813.3 856.8 862.6 872.2 4192.2 5058.9 5252.6 5311.9 5356.9 5099.4 5218.7 5222.5 5767.1 5849.1 4696.7 4940.4 5216.4 5299.9 5369.5 2514.4 2612.8 2866.9 2889.9 2912.2 5279.3 5426.4 5506.3 5742.3 5784.4 4742.6 5558.9 5717.3 5929.7 6115.5 5118.7 5345.4 5423.1 5661.2 6108.1 5193.4 5953.3 5981.8 5988.8 6010.2 4883.6 5221.7 5259.7 5864.4 5926.6 5201.7 5897.8 6155.7 6192.0 6321.3 3779.3 3875.9 3923.2 3923.5 3943.2 5635.7 5657.5 5785.6 5824.9 5873.9 5326.0 5379.2 5510.6 5697.0 5725.0 4473.7 5369.7 5442.0 5581.5 5678.6 5464.6 5539.9 5654.9 5676.1 5686.9 5447.4 5520.9 5561.3 5642.5 5837.5 5412.9 5481.3 5505.2 5525.1 5545.6 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:21573.26 Median:4217.74 stddev:32543.85 (771.6%) stddev-sans-first:32597.14 06:05:00 INFO - PROCESS | 1651 | Values: 627.1 688.1 711.0 757.1 769.8 12945.4 14452.1 15310.3 15461.0 15494.0 13921.8 14027.7 14058.5 14064.9 14090.4 636.3 657.0 777.3 798.6 811.5 624.9 815.1 815.3 819.4 820.4 867.1 868.9 869.1 871.4 875.8 849.8 854.6 860.3 862.1 864.7 623.7 634.5 641.4 641.6 641.9 14617.2 14993.8 15132.8 15167.9 15178.2 14275.3 14575.5 14688.2 14706.3 14857.5 11595.9 11861.4 11915.5 11962.6 12165.4 3708.6 3709.4 3735.4 3750.1 3850.4 123805.0 127590.0 128547.0 129369.4 129727.0 10973.0 10973.5 11055.6 11136.3 11190.0 22370.4 22443.8 22725.8 22780.7 22995.1 7740.4 7748.1 7762.0 7831.2 7881.6 4203.7 4231.7 4246.8 4275.3 4344.1 3356.4 3459.6 3459.7 3460.0 3469.8 592.6 597.2 603.8 604.4 604.5 448.8 592.7 592.9 632.8 677.3 8836.2 9103.8 9235.6 9292.4 9336.7 578.6 602.1 624.5 649.4 661.1 4536.8 4599.7 4614.5 4619.4 4667.3 96955.0 100373.0 106345.5 106579.0 119876.4 93808.1 95849.5 95912.0 95948.0 97412.5 78247.6 82910.6 82946.2 85153.0 85314.0 9601.0 9809.4 9831.9 9918.2 9951.0 41565.0 47692.8 50228.7 51967.0 53252.7 70170.3 71642.6 75257.6 76378.2 77301.2 12521.5 12595.4 12666.4 12703.9 12815.2 11704.9 12241.0 12373.9 12783.2 13516.8 11651.3 13197.7 13325.3 13742.1 14032.2 13315.7 13658.5 13717.5 13982.5 14547.9 13298.8 13501.1 13568.7 13666.2 13724.9 10123.2 10968.3 11056.5 11351.6 11497.2 10258.6 11077.7 11111.6 11123.3 11281.8 06:05:00 INFO - PROCESS | 1651 | -------- Summary: end -------- 06:05:00 INFO - PROCESS | 1651 | 06:05:00 INFO - TEST-INFO | 1651: exit 0 06:05:00 INFO - TEST-OK | dromaeo_css | took 1116756ms 06:05:00 INFO - TEST-START | kraken 06:05:00 INFO - operating with platform_type : mac_ 06:05:00 INFO - Initialising browser for kraken test... 06:05:00 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmp0xvuyL/profile http://localhost:49247/getInfo.html) 06:05:03 INFO - PROCESS | 1658 | 2016-12-08 06:05:03.979 plugin-container[1660:10829] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 06:05:03 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:03 INFO - PROCESS | 1658 | 2016-12-08 06:05:03.980 plugin-container[1660:10829] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 06:05:03 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:03 INFO - PROCESS | 1658 | 2016-12-08 06:05:03.980 plugin-container[1660:10829] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:05:04 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 06:05:04 INFO - PROCESS | 1658 | colorDepth:24 06:05:04 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 06:05:04 INFO - PROCESS | 1658 | __metrics 06:05:04 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 06:05:05 INFO - TEST-INFO | 1658: exit 0 06:05:05 INFO - Browser initialized. 06:05:05 INFO - Running cycle 1/1 for kraken test... 06:05:05 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmp0xvuyL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:07 INFO - PROCESS | 1661 | 2016-12-08 06:05:07.626 plugin-container[1662:10956] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 06:05:07 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:07 INFO - PROCESS | 1661 | 2016-12-08 06:05:07.626 plugin-container[1662:10956] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 06:05:07 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:05:07 INFO - PROCESS | 1661 | 2016-12-08 06:05:07.626 plugin-container[1662:10956] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:05:17 INFO - PROCESS | 1661 | RSS: Main: 242114560 06:05:17 INFO - PROCESS | 1661 | 06:05:20 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:21 INFO - PROCESS | 1661 | RSS: Main: 254197760 06:05:21 INFO - PROCESS | 1661 | 06:05:23 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 06:05:24 INFO - PROCESS | 1661 | RSS: Main: 261738496 06:05:24 INFO - PROCESS | 1661 | 06:05:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 06:05:28 INFO - PROCESS | 1661 | RSS: Main: 264388608 06:05:28 INFO - PROCESS | 1661 | 06:05:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 06:05:30 INFO - PROCESS | 1661 | RSS: Main: 265588736 06:05:30 INFO - PROCESS | 1661 | 06:05:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:33 INFO - PROCESS | 1661 | RSS: Main: 267243520 06:05:33 INFO - PROCESS | 1661 | 06:05:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:37 INFO - PROCESS | 1661 | RSS: Main: 273285120 06:05:37 INFO - PROCESS | 1661 | 06:05:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:40 INFO - PROCESS | 1661 | RSS: Main: 272195584 06:05:40 INFO - PROCESS | 1661 | 06:05:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 06:05:44 INFO - PROCESS | 1661 | RSS: Main: 272437248 06:05:44 INFO - PROCESS | 1661 | 06:05:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:46 INFO - PROCESS | 1661 | RSS: Main: 271384576 06:05:46 INFO - PROCESS | 1661 | 06:05:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:49 INFO - PROCESS | 1661 | RSS: Main: 271405056 06:05:49 INFO - PROCESS | 1661 | 06:05:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:52 INFO - PROCESS | 1661 | RSS: Main: 271441920 06:05:52 INFO - PROCESS | 1661 | 06:05:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:55 INFO - PROCESS | 1661 | RSS: Main: 271712256 06:05:55 INFO - PROCESS | 1661 | 06:05:58 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:59 INFO - PROCESS | 1661 | RSS: Main: 271790080 06:05:59 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 06:06:01 INFO - PROCESS | 1661 | RSS: Main: 272613376 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | __start_tp_report 06:06:01 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 06:06:01 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 06:06:01 INFO - PROCESS | 1661 | |i|pagename|runs| 06:06:01 INFO - PROCESS | 1661 | |0;ai-astar;106;117;119;118;116;119;118;119;116;125 06:06:01 INFO - PROCESS | 1661 | |1;audio-beat-detection;152;115;116;152;118;119;116;118;161;153 06:06:01 INFO - PROCESS | 1661 | |2;audio-dft;200;207;211;198;195;191;194;193;198;192 06:06:01 INFO - PROCESS | 1661 | |3;audio-fft;81;59;59;85;60;59;65;51;89;83 06:06:01 INFO - PROCESS | 1661 | |4;audio-oscillator;87;69;83;74;69;67;81;70;73;80 06:06:01 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;113;134;99;88;89;85;90;87;90;89 06:06:01 INFO - PROCESS | 1661 | |6;imaging-darkroom;153;95;96;122;117;94;96;100;97;147 06:06:01 INFO - PROCESS | 1661 | |7;imaging-desaturate;94;95;99;92;95;101;131;92;97;130 06:06:01 INFO - PROCESS | 1661 | |8;json-parse-financial;56;59;63;92;93;87;87;58;57;58 06:06:01 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;69;73;68;70;79;70;69;71;71;72 06:06:01 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;102;86;92;87;89;92;88;88;95;96 06:06:01 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;168;162;161;147;146;148;146;150;199;160 06:06:01 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;176;174;175;175;177;176;178;177;230;197 06:06:01 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;66;69;69;66;71;68;69;69;67;69 06:06:01 INFO - PROCESS | 1661 | __end_tp_report 06:06:01 INFO - PROCESS | 1661 | __start_cc_report 06:06:01 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,920 06:06:01 INFO - PROCESS | 1661 | __end_cc_report 06:06:01 INFO - PROCESS | 1661 | __startTimestamp1481205961419__endTimestamp 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | ------- Summary: start ------- 06:06:01 INFO - PROCESS | 1661 | Number of tests: 14 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:117.30 Median:118.50 stddev:4.72 (4.0%) stddev-sans-first:2.70 06:06:01 INFO - PROCESS | 1661 | Values: 106.0 117.0 119.0 118.0 116.0 119.0 118.0 119.0 116.0 125.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:135.50 stddev:19.56 (14.4%) stddev-sans-first:19.36 06:06:01 INFO - PROCESS | 1661 | Values: 152.0 115.0 116.0 152.0 118.0 119.0 116.0 118.0 161.0 153.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:197.90 Median:198.00 stddev:6.57 (3.3%) stddev-sans-first:6.93 06:06:01 INFO - PROCESS | 1661 | Values: 200.0 207.0 211.0 198.0 195.0 191.0 194.0 193.0 198.0 192.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:69.10 Median:73.00 stddev:13.81 (18.9%) stddev-sans-first:13.96 06:06:01 INFO - PROCESS | 1661 | Values: 81.0 59.0 59.0 85.0 60.0 59.0 65.0 51.0 89.0 83.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:77.00 stddev:6.95 (9.0%) stddev-sans-first:5.94 06:06:01 INFO - PROCESS | 1661 | Values: 87.0 69.0 83.0 74.0 69.0 67.0 81.0 70.0 73.0 80.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:89.00 stddev:15.55 (17.5%) stddev-sans-first:15.29 06:06:01 INFO - PROCESS | 1661 | Values: 113.0 134.0 99.0 88.0 89.0 85.0 90.0 87.0 90.0 89.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:111.70 Median:94.50 stddev:22.42 (23.7%) stddev-sans-first:18.13 06:06:01 INFO - PROCESS | 1661 | Values: 153.0 95.0 96.0 122.0 117.0 94.0 96.0 100.0 97.0 147.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:94.50 stddev:14.98 (15.8%) stddev-sans-first:15.56 06:06:01 INFO - PROCESS | 1661 | Values: 94.0 95.0 99.0 92.0 95.0 101.0 131.0 92.0 97.0 130.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:75.00 stddev:16.34 (21.8%) stddev-sans-first:16.41 06:06:01 INFO - PROCESS | 1661 | Values: 56.0 59.0 63.0 92.0 93.0 87.0 87.0 58.0 57.0 58.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:3.12 (4.4%) stddev-sans-first:3.21 06:06:01 INFO - PROCESS | 1661 | Values: 69.0 73.0 68.0 70.0 79.0 70.0 69.0 71.0 71.0 72.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:90.50 stddev:4.99 (5.5%) stddev-sans-first:3.57 06:06:01 INFO - PROCESS | 1661 | Values: 102.0 86.0 92.0 87.0 89.0 92.0 88.0 88.0 95.0 96.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:160.50 stddev:16.26 (10.1%) stddev-sans-first:16.89 06:06:01 INFO - PROCESS | 1661 | Values: 168.0 162.0 161.0 147.0 146.0 148.0 146.0 150.0 199.0 160.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:177.00 stddev:17.66 (10.0%) stddev-sans-first:18.52 06:06:01 INFO - PROCESS | 1661 | Values: 176.0 174.0 175.0 175.0 177.0 176.0 178.0 177.0 230.0 197.0 06:06:01 INFO - PROCESS | 1661 | 06:06:01 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.42 06:06:01 INFO - PROCESS | 1661 | Values: 66.0 69.0 69.0 66.0 71.0 68.0 69.0 69.0 67.0 69.0 06:06:01 INFO - PROCESS | 1661 | -------- Summary: end -------- 06:06:01 INFO - PROCESS | 1661 | 06:06:02 INFO - TEST-INFO | 1661: exit 0 06:06:02 INFO - TEST-OK | kraken | took 61581ms 06:06:02 INFO - SUITE-END | took 1178s 06:06:02 INFO - Completed test suite (00:19:38) 06:06:02 INFO - javascript benchmark 06:06:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7071.323015384718, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.193629974708, 3327.9500807487875, 3366.2594229269566, 3408.778429402087, 3427.520147179394, 5604.747786349614, 5697.373288938219, 5713.342965558962, 5737.0, 5806.825795226139, 4172.937405938906, 5657.773689052433, 5764.077747560391, 5785.797497087603, 5926.644401335912, 5161.096808058574, 5213.9478605214035, 5243.6853788772605, 5318.0, 5404.08130617794, 4536.206163921317, 5359.249705041298, 5366.543843773284, 5371.892562148755, 5383.138697808351, 4436.822527098912, 5026.145555255597, 5319.734013299339, 5334.706591137486, 5377.8117765878205, 5151.7681704323395, 5296.841094767163, 5330.946690533084, 5337.893242135155, 5380.0046991306735, 3702.2040261343673, 5125.513076257749, 5129.384473863123, 5158.69047857126, 5248.422673505911, 5441.483059109379, 5697.829065128053, 5701.77192912283, 5710.628809127435, 5716.628419152742, 6253.906191407133, 6261.248650161964, 6261.373862613747, 6264.185655864709, 6282.842928926768, 6132.263729246501, 6203.0, 6208.906866397007, 6228.87542249157, 6231.906521402183, 5822.970885145632, 5842.59101862874, 5857.092150716646, 5865.530757539386, 5873.794417195378, 6305.117283580303, 6312.621242725451, 6315.96842015787, 6340.239171299474, 6359.872802543923, 5964.0, 6022.608530445507, 6041.879162416815, 6100.572959892765, 6190.783322583688, 6132.661461321697, 6143.082036032849, 6152.569320147636, 6156.29202641693, 6194.628322300587, 6209.379062093754, 6223.595466294676, 6234.0, 6249.0, 6251.74993000284, 6100.542459315569, 6114.692773002168, 6152.723127459275, 6160.815175544741, 6263.248410190715, 4123.567025462284, 4370.497392799869, 4889.413270407574, 4936.185529387682, 4973.52751488608, 4415.911681766411, 4429.512753597101, 4442.244818380883, 4460.620847227957, 4470.642348612103, 5675.687837168995, 5678.630888992202, 5747.885042299131, 5878.971180043475, 5899.380565040695, 5102.36220472441, 6134.038624681888, 6164.599301045508, 6190.535709821781, 6202.0, 5823.5923485355615, 5846.093855452412, 5850.151727999416, 5852.122181672698, 5859.677717725566, 5336.67979921206, 5382.892342153135, 5386.29978102852, 5410.91883621746, 5432.456754324536, 6152.0, 6227.377262273827, 6242.563020588696, 6259.749610015549, 6279.466245369012, 6191.535634827316, 6192.783252586318, 6198.907016394848, 6219.564630475823, 6285.465735412541, 6395.616263024233, 6399.168108145911, 6409.583377080475, 6412.23053233615, 6413.935860641521, 5091.821786237464, 5851.356350801323, 5980.910286345621, 6092.238470191226, 6118.405988989777, 5113.846584602468, 5303.946960530346, 6076.574639775174, 6185.938140618537, 6222.09779581949, 6086.381249409276, 6115.021596544531, 6150.446459818638, 6151.046587778901, 6168.0, 5467.507924286833, 5608.214849921096, 6092.086187071975, 6104.481119104926, 6130.785422510191, 5706.372299047184, 5760.740766665426, 5854.0340843760305, 5946.167536544974, 5980.671063091571, 6056.212692349966, 6072.453479186895, 6075.635461872302, 6079.908801368071, 6105.511559075352, 5932.614380065282, 5954.821355359346, 5955.076963070731, 6007.579469437097, 6028.57799953999], "value": 5637.049186503866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.2523663085586, 489.29052873333654, 494.65374238033377, 504.5837184322932, 510.16842546648957, 28915.0, 30413.695863041365, 37565.36519522069, 38288.04279892997, 38462.61537384625, 38785.03037424066, 39256.60743392565, 39368.0, 39406.0, 39450.605493945055, 9107.726768196948, 9285.95357023214, 9287.628494860197, 9287.860682089775, 9315.906840931606, 8432.325413966899, 8500.914990850075, 9181.678641247558, 9183.678571250008, 11086.334819910791, 11205.383703896283, 11251.887481125206, 11255.380954047525, 11264.324140551553, 11288.604898828542, 11037.503312350964, 11100.944495277552, 11105.333679979227, 11131.666050018512, 11233.494492747765, 11032.834507482394, 11048.834267485994, 11057.944710276397, 11080.944595277053, 11097.667069987914, 37556.0, 37949.0, 37970.430443543366, 37978.81010594929, 38078.61921380806, 3322.2358857462677, 3419.6580341965855, 3484.6863782259466, 3603.72972027099, 3754.624537546251, 28745.28136796576, 28972.42055158885, 29477.0, 29490.852545737347, 29524.70475295241, 3060.6021217241614, 3114.0, 3188.9362212755614, 3249.723773479257, 3290.93418131636, 478637.0, 482657.0, 485512.0, 485955.0, 486378.0, 53862.7306863471, 54238.72880635651, 54662.18006729902, 54699.0, 54784.17823732647, 56340.15489767657, 56354.71822640861, 56643.71678141583, 56715.71642141763, 56827.71586142043, 14626.341814618369, 14969.251537423086, 14980.1011939284, 14981.625459363604, 14988.175650339117, 10686.51910664022, 11732.354720490455, 11733.0, 11764.647060588197, 11780.469878855472, 12813.743725125445, 14464.566063018126, 14702.705945881022, 14788.264171128376, 14955.700885982436, 5075.061113693979, 5587.916181257285, 5988.37122102173, 5990.490808281258, 6056.091586262008, 736.6537727268176, 825.8389614025208, 832.7252006837729, 868.4962721621445, 1031.0823367203195, 21731.67402488964, 26180.476390472082, 27114.45771084607, 27380.7678654461, 28845.134645960654, 1015.4516561056946, 1042.2443728296923, 1044.4934206909795, 1062.645127462476, 1168.1239070696977, 12371.628851134481, 12551.0, 14683.706325873423, 14789.926050369679, 15240.542783716506, 591648.0, 626548.0, 630627.0, 635306.0, 807425.0, 42587.148257034685, 53226.20160697593, 53803.19295210575, 53978.46021539735, 54002.649933751185, 1297.3383574376946, 1318.0, 1323.5698398020681, 1342.154442701092, 1346.5489061164424, 24188.51622967566, 28678.0, 28884.566731499464, 29222.0, 29561.0, 46322.7683861592, 46591.767041164574, 46600.30099548577, 46647.0, 46683.06633867235, 546882.0, 550558.0, 552160.0, 552808.0, 553280.0, 21690.34928952134, 23805.047798087882, 23856.64215036741, 24141.63787543153, 24215.394615134763, 36640.267194655426, 41582.58417415787, 42107.789461052496, 43434.348484773385, 43549.346759798, 25336.733163342127, 34365.82817085998, 34999.65000349964, 35272.64727352796, 36230.0, 30023.0, 35098.947031589094, 35869.28261434809, 35887.46168807522, 36121.81939090288, 31898.52152217672, 32086.358272833946, 35075.12312192216, 35656.465153023244, 35967.82016089903, 30384.0, 32444.0, 32533.674663254013, 32661.34677306488, 32723.34553308968, 21529.031193596013, 23992.920318585355, 24224.273271801874, 24839.0, 24956.0], "value": 18752.563679385858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7660159197318, 365.10367048894966, 366.31681913231813, 373.33732624591346, 386.246818703528, 13216.471341146354, 18131.72802407963, 19742.210311587518, 19939.900300498477, 20012.0, 18515.592972913535, 18754.624907501842, 19200.23199072039, 19306.32427865025, 19384.903075484603, 4548.5224051474615, 5633.915491267634, 5716.371199168088, 5725.828225153231, 5744.052231381817, 5538.335399752035, 5636.7181640918, 5818.709064546777, 5870.559708021894, 5876.177335173079, 5835.941640583582, 5838.854028649296, 5870.677112758796, 5871.794487192949, 5873.089671100986, 5509.641873278244, 5529.225908372831, 5577.52591029763, 5580.693061881595, 5589.35722391924, 4894.241392584155, 4900.411950565955, 4907.11671899058, 4912.606991440676, 4917.40991081069, 12435.253884766942, 13318.734720201566, 22337.441563960867, 23260.0, 23482.530349393088, 2156.805887470135, 2203.405080628221, 2216.822654187677, 2234.273860995183, 2279.566882292376, 7560.546367217985, 7608.619569021526, 9670.56482458291, 9957.800843983152, 10150.0, 1638.189096397291, 1723.5863392785766, 1797.4248240563024, 1828.7896891857474, 1863.2267608942273, 115072.27391589133, 119379.65893240129, 122037.0, 123076.38461807724, 124458.37770811089, 11056.11551075928, 11203.831942520868, 11235.887641123483, 11325.943370283096, 11490.597829075943, 14085.718285634435, 14109.71780564383, 14116.647083822987, 14127.646808829655, 14143.85856141446, 6566.376194261537, 6767.932320676829, 6950.200726916368, 7881.290683838482, 8198.180181981874, 6736.686346162549, 7758.14660387357, 7855.489393189425, 8007.359411247086, 8028.11690714021, 4379.605835474759, 4389.912201755947, 4470.530594287618, 4483.955160448419, 4493.370928070073, 1860.228005377753, 1955.1299671645982, 1971.8957383865081, 1979.4061781465502, 1979.9307024254083, 792.7819849541422, 794.4319811334923, 829.6266679994027, 874.9300055995633, 951.2390087929629, 18745.90627046856, 19624.41126766199, 19801.0, 19843.30548430827, 20061.0, 890.3856339125982, 901.4726385064679, 910.6038873090226, 953.7281874665687, 963.9325247232626, 9788.510574471391, 10002.899971000343, 10169.796604068026, 10224.13094886943, 10234.846477302846, 527222.0, 540359.0, 540511.0, 550956.0, 551095.0, 101862.0, 116951.0, 122076.0, 128296.0, 130232.0, 959.5586030426082, 1001.1440218613127, 1033.3489901362093, 1033.4884232305058, 1034.177828626244, 17303.04833234134, 17592.329297434204, 17658.0, 17689.557761056076, 17915.104244787446, 49053.754731226116, 51956.74021629868, 53468.0, 55046.17430738462, 56825.0, 72861.0, 77818.05454863673, 79755.60122199352, 80685.59657201676, 83333.0, 7534.35957943581, 7689.884651730116, 7954.403419743659, 7992.0, 8137.75586732399, 11198.328100313682, 12098.153129280865, 12354.629361119181, 12501.999840012595, 12520.248785072925, 10087.394756314645, 10300.227482938959, 10592.788144236918, 10747.408892510673, 10938.398388088732, 9119.863202052107, 9475.905240947503, 9874.851877221703, 10736.409497477714, 10829.24195306321, 10530.420826854597, 10541.73645658834, 10973.286736362112, 11081.224314297922, 11109.611163609236, 7788.221177882393, 7820.687172513036, 7899.763007109796, 7906.802329941567, 8085.716999904975, 10509.632162874263, 10614.787704246026, 10850.348979061282, 10881.945590271998, 10900.509477073392], "value": 9057.244927065094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.715439026219, 1342.3556692787463, 1463.560931720484, 1764.7705798246227, 1776.9822301776978, 7420.146683131442, 7676.731314403997, 7915.920840791598, 8364.038135614406, 8372.748817535468, 7896.684132634702, 8201.671933122683, 8203.958980205105, 8288.254057134856, 8305.335573154149, 1743.9476815695486, 1849.9630007399844, 2253.07623874212, 2272.420532764151, 2292.1862738727764, 1884.5006073390562, 1898.686716691744, 2163.8377121715857, 2280.692106565609, 2324.837261391703, 1662.1772222749755, 2245.69683092782, 2255.075419078178, 2256.4020534558354, 2291.51878105598, 2242.7084479017703, 2252.6733623624564, 2277.0322612889454, 2277.669737887997, 2290.358699564125, 2263.4680850000236, 2275.533515629292, 2282.44080200352, 2284.2804516577226, 2311.2603966730653, 8222.8355432891, 8273.875891861628, 8293.585320733939, 8332.250097491255, 8349.874751878726, 4247.617714405718, 4567.1550763108935, 4962.106820772259, 5087.949120508784, 5164.870878228036, 2927.487689654302, 3183.2996740717003, 3431.78171749028, 3438.638942911008, 3442.2599141184514, 978.9853152202722, 1002.0, 1045.5869931377063, 1048.0829274384914, 1059.5655781129776, 10765.407902565355, 10800.5679772809, 10804.513796879159, 10971.012608865161, 10985.725356866062, 4399.450068741407, 4629.421322334708, 4688.9531104689195, 4691.882702932386, 4695.366125573072, 9315.254779617615, 9363.578638961262, 9374.578143983537, 9402.623895044258, 9480.668176613786, 5088.847334579968, 5123.718195499208, 5148.433672296044, 5156.303898973665, 5166.328377311001, 4219.810108545123, 4491.438570178728, 4492.281235002384, 4630.58324750774, 4640.257558790578, 3217.6943190396873, 3680.392735198662, 3733.9253214936093, 3746.8501259949844, 3805.238952209569, 1247.8689737577606, 1253.8746125387388, 1258.2890666773244, 1263.109507797001, 1264.1846009323936, 850.2093053460218, 852.2713080316364, 876.2464280718577, 910.1217325281135, 918.7657147427363, 5622.6345287557, 5699.943000569941, 5709.65742055478, 5750.741216645261, 5969.31352894414, 854.3549620036832, 862.3316929379781, 910.6129894794685, 938.3900464697864, 940.5626383731598, 3753.962460375416, 3777.527809023872, 3797.4303854421505, 3844.7308688392104, 3868.5357757069332, 9451.763705907408, 10020.899791002143, 10081.429235544889, 10089.798204035878, 10140.239482038876, 9997.150242229493, 10029.598816047423, 10068.848967265498, 10082.69751907444, 10089.0, 7652.579108149105, 7685.923970644114, 7718.575478348745, 7789.298963093235, 7846.568438735811, 5311.442298558596, 5474.753636086306, 5541.3904470507405, 5566.304211973504, 5645.915311270416, 7727.49771264866, 9247.029061948668, 9335.206507446943, 9335.48654823964, 9372.109649583279, 8478.321734261368, 8727.389082764399, 8854.911450885666, 9412.67055653049, 9424.64383904024, 6881.380675739208, 7011.859762804817, 7108.253633368422, 7109.040279562193, 7109.680064397011, 7831.295183433518, 7908.130105688485, 7917.564533950688, 7933.444658873824, 7956.880646790187, 7056.082709247765, 7067.0459487968465, 7088.432925366062, 7262.164851042197, 7269.781906542812, 7003.089598352181, 7016.5790052597, 7023.0, 7036.155661320674, 7039.788806335818, 5350.9732451337495, 5514.283143191359, 6521.543491955517, 6543.0, 6604.801855944329, 4066.755994640331, 4620.660008597603, 4766.666333356632, 4814.20565606671, 4908.0, 4118.011677197511, 4621.075784843112, 4812.278158276286, 4844.709317440965, 4891.364122664031], "value": 4313.958801144493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.95248783950643, 300.5221697500974, 301.4664044640984, 305.2993380192458, 307.82300177397985, 4381.846635367763, 5443.401225865152, 5450.591205659572, 5458.563314934806, 5463.9180412293845, 5033.647644664875, 5382.2324372939, 5402.621816472849, 5405.27028851105, 5431.158170483582, 3310.96689033109, 3843.6540711336042, 3914.354131568302, 3971.523417189941, 3988.9800550997347, 3601.49695961307, 4048.137856585959, 4058.817353219112, 4084.65280451162, 4105.0, 4049.2104039712267, 4051.513818341803, 4056.655184309337, 4063.963689259235, 4072.6945479089186, 3915.902102447433, 4005.599440055971, 4077.4495443115097, 4081.7346872453195, 4100.323446631302, 3052.8015678980796, 3484.703800176988, 3530.9823450882836, 3542.9902477793703, 3547.9645203547893, 5194.22086687, 5217.3999990000875, 5220.504052115043, 5224.555912747383, 5238.899831035487, 4392.682195341385, 4408.14041261954, 4544.409226800528, 4626.653001024936, 4683.227267500858, 5569.192467092249, 5575.0, 5604.187392828017, 5647.548196144339, 5657.953278643423, 3869.8645547405704, 3870.1292209252974, 3884.320243957296, 3906.980465097656, 3909.882703518899, 5073.239014147907, 5840.853978650525, 5874.85440339134, 5889.617174883661, 5899.528037756969, 3196.5205219216837, 3780.3573392523335, 3828.464015037897, 3828.5214348206473, 3843.423486477051, 3868.149007218464, 3887.611238876146, 3894.571597124314, 3912.980435097806, 3934.3114954883354, 4523.5024147343765, 4597.218472859622, 4598.333241680005, 4607.0, 4628.745419001987, 4671.672982891165, 4952.777125029383, 5356.250124982505, 5413.377461591888, 5665.487397813382, 1183.041736193686, 1267.7781388257204, 1268.3024336614824, 1275.183882315319, 1279.2452453052558, 743.6690672650727, 813.3452570680658, 856.8200677857595, 862.6032025268447, 872.1975782280317, 4192.161567686475, 5058.898822023539, 5252.579793616502, 5311.920321195185, 5356.866078348073, 5099.36257967754, 5218.739063046908, 5222.529972302435, 5767.134929760569, 5849.122631605208, 4696.671233013724, 4940.357753492023, 5216.426193118754, 5299.920501192485, 5369.5167434931045, 2514.371407148213, 2612.843229406242, 2866.942661146765, 2889.898853540158, 2912.199145235077, 5279.340082489689, 5426.375966763794, 5506.339239291311, 5742.30111847431, 5784.363719990798, 4742.620590352763, 5558.944410555842, 5717.285339332583, 5929.703514824241, 6115.541334399849, 5118.692878427306, 5345.412004679482, 5423.105187644073, 5661.179129026268, 6108.1143234230785, 5193.428722840409, 5953.261499710182, 5981.790637327673, 5988.790392336422, 6010.226983040101, 4883.60931125502, 5221.686698798084, 5259.7370131494035, 5864.44287792659, 5926.585139040399, 5201.699575106223, 5897.7935772247765, 6155.692215389123, 6191.9690401547705, 6321.26165304545, 3779.3340459753995, 3875.9224815502967, 3923.2349691809823, 3923.5291764988383, 3943.2310699413338, 5635.718214089197, 5657.519110875622, 5785.595008349375, 5824.912626310524, 5873.911891321548, 5326.0, 5379.2469054333205, 5510.614257002132, 5697.006047883374, 5724.971375143097, 4473.664475164311, 5369.731513424391, 5442.0, 5581.544120586928, 5678.637127089386, 5464.617476776588, 5539.864327812869, 5654.886902261849, 5676.091825307931, 5686.914696279477, 5447.373552041566, 5520.944790552043, 5561.304836895388, 5642.548596112383, 5837.5329973601165, 5412.945870541244, 5481.314835645544, 5505.201745746925, 5525.060739674184, 5545.611807173459], "value": 4092.4865607358543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.1376856821872, 688.1432616392592, 710.9999999999999, 757.0877093102812, 769.7606852966725, 12945.352732363379, 14452.132872027672, 15310.311036003379, 15461.0, 15494.0, 13921.791173132411, 14027.719445611081, 14058.507952221675, 14064.929675351634, 14090.436382544685, 636.3477435628472, 657.0046379734706, 777.2887807656016, 798.6046906781137, 811.525257724232, 624.8656538844148, 815.1196707555855, 815.2581151152452, 819.3608984991686, 820.4420993724265, 867.1025488619281, 868.8522951098329, 869.1265278395203, 871.4030888841132, 875.7722992022057, 849.7663142635763, 854.598338780772, 860.3375400941271, 862.107718511344, 864.6843901975797, 623.6601052426438, 634.4765568406084, 641.4323323858372, 641.5990006246096, 641.8940874755659, 14617.196054217015, 14993.775093373608, 15132.848671513255, 15167.924160379238, 15178.241087945558, 14275.286235688278, 14575.489857854924, 14688.192149431778, 14706.264686765619, 14857.47998820047, 11595.94202028993, 11861.406929653484, 11915.463804128749, 11962.581309654208, 12165.391730413532, 3708.647678470541, 3709.3694072007825, 3735.364987952055, 3750.081230098616, 3850.4416859555486, 123805.0, 127590.0, 128547.0, 129369.35315323363, 129727.0, 10973.0, 10973.451327433597, 11055.613053543248, 11136.276142050741, 11190.0, 22370.44073898133, 22443.775562244497, 22725.772742272366, 22780.658290125662, 22995.080196792274, 7740.4194685398825, 7748.070231572135, 7761.9521364616185, 7831.216878312123, 7881.605919704107, 4203.747775133502, 4231.724937879028, 4246.766427846436, 4275.337322714984, 4344.087741574242, 3356.3622911646708, 3459.6021457532706, 3459.7059249964036, 3460.0138960396166, 3469.809160496197, 592.5674257791836, 597.229573849729, 603.7554790309931, 604.446931058077, 604.5465900574569, 448.8406615651462, 592.7362323765883, 592.8517870532366, 632.81031660478, 677.3091446724412, 8836.248918841971, 9103.81792364149, 9235.55794226154, 9292.442453452815, 9336.673216437392, 578.5892016668129, 602.1078735275884, 624.4941597306197, 649.4382359259207, 661.1372159332021, 4536.77316134192, 4599.655025873073, 4614.469336026333, 4619.376384188159, 4667.32323813052, 96955.0, 100373.0, 106345.4682726597, 106579.0, 119876.4006179981, 93808.12383752287, 95849.5207523958, 95912.0, 95948.0, 97412.51293743486, 78247.60876195696, 82910.58544707358, 82946.17053829505, 85153.0, 85314.0, 9601.0, 9809.359443740552, 9831.9016809831, 9918.156956658764, 9951.0, 41564.960875978344, 47692.7615361921, 50228.73970671256, 51967.0, 53252.73373633107, 70170.29829701637, 71642.64178679073, 75257.6237118811, 76378.23621763711, 77301.2269877294, 12521.499140034297, 12595.370231488572, 12666.43001064936, 12703.872961270268, 12815.16701414405, 11704.94147529257, 12241.0, 12373.876261237272, 12783.16909400886, 13516.783489485993, 11651.30092194471, 13197.670058248621, 13325.333733313102, 13742.106763060368, 14032.22822744759, 13315.667108321983, 13658.453661853811, 13717.519886803913, 13982.510612128526, 14547.854521455074, 13298.75477204101, 13501.122427042212, 13568.728625427633, 13666.180029197882, 13724.93137534306, 10123.190144788547, 10968.287061340987, 11056.502457389275, 11351.602693905674, 11497.195196336175, 10258.640947566799, 11077.667669969915, 11111.55465958775, 11123.332600044023, 11281.830772538255], "value": 7395.832405067465, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 119.0, 118.0, 116.0, 119.0, 118.0, 119.0, 116.0, 125.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 116.0, 152.0, 118.0, 119.0, 116.0, 118.0, 161.0, 153.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 207.0, 211.0, 198.0, 195.0, 191.0, 194.0, 193.0, 198.0, 192.0], "value": 197.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 85.0, 60.0, 59.0, 65.0, 51.0, 89.0, 83.0], "value": 69.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 83.0, 74.0, 69.0, 67.0, 81.0, 70.0, 73.0, 80.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 134.0, 99.0, 88.0, 89.0, 85.0, 90.0, 87.0, 90.0, 89.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 95.0, 96.0, 122.0, 117.0, 94.0, 96.0, 100.0, 97.0, 147.0], "value": 111.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 99.0, 92.0, 95.0, 101.0, 131.0, 92.0, 97.0, 130.0], "value": 102.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 63.0, 92.0, 93.0, 87.0, 87.0, 58.0, 57.0, 58.0], "value": 71.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 68.0, 70.0, 79.0, 70.0, 69.0, 71.0, 71.0, 72.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 86.0, 92.0, 87.0, 89.0, 92.0, 88.0, 88.0, 95.0, 96.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 162.0, 161.0, 147.0, 146.0, 148.0, 146.0, 150.0, 199.0, 160.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 175.0, 175.0, 177.0, 176.0, 178.0, 177.0, 230.0, 197.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 69.0, 66.0, 71.0, 68.0, 69.0, 69.0, 67.0, 69.0], "value": 68.3, "unit": "score"}]}]} 06:06:02 INFO - Return code: 0 06:06:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:02 ERROR - # TBPL SUCCESS # 06:06:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:02 INFO - 2016-12-08 06:06:02.760 screenresolution[1666:11342] starting screenresolution argv=screenresolution get 06:06:02 INFO - 2016-12-08 06:06:02.763 screenresolution[1666:11342] Display 0: 1600x1200x32@60 06:06:02 INFO - 2016-12-08 06:06:02.769 screenresolution[1667:11345] starting screenresolution argv=screenresolution list 06:06:02 INFO - Available Modes on Display 0 06:06:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:03 INFO - Intel Iris: 06:06:03 INFO - Chipset Model: Intel Iris 06:06:03 INFO - Type: GPU 06:06:03 INFO - Bus: Built-In 06:06:03 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:03 INFO - Vendor: Intel (0x8086) 06:06:03 INFO - Device ID: 0x0a2e 06:06:03 INFO - Revision ID: 0x0009 06:06:03 INFO - Displays: 06:06:03 INFO - Display: 06:06:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:03 INFO - Display Serial Number: 1600x1200 60 06:06:03 INFO - Main Display: Yes 06:06:03 INFO - Mirror: Off 06:06:03 INFO - Online: Yes 06:06:03 INFO - Rotation: Supported 06:06:03 INFO - Return code: 0 06:06:03 INFO - Running post-action listener: _resource_record_post_action 06:06:03 INFO - [mozharness: 2016-12-08 14:06:03.011196Z] Finished run-tests step (success) 06:06:03 INFO - Running post-run listener: _resource_record_post_run 06:06:03 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 33517568; Write bytes: 698957824; Read time: 198; Write time: 1968 06:06:03 INFO - TinderboxPrint: CPU usage
54.4% 06:06:03 INFO - TinderboxPrint: I/O read bytes / time
33,517,568 / 198 06:06:03 INFO - TinderboxPrint: I/O write bytes / time
698,957,824 / 1,968 06:06:03 INFO - TinderboxPrint: CPU idle
2,209.3 (45.6%) 06:06:03 INFO - TinderboxPrint: CPU system
980.9 (20.2%) 06:06:03 INFO - TinderboxPrint: CPU user
1,659.5 (34.2%) 06:06:03 INFO - TinderboxPrint: Swap in / out
413,511,680 / 0 06:06:03 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384760320; Write bytes: 387741184; Read time: 29030; Write time: 808 06:06:03 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30400512; Write bytes: 309766656; Read time: 175; Write time: 1153 06:06:03 INFO - Running post-run listener: _upload_blobber_files 06:06:03 INFO - Blob upload gear active. 06:06:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:03 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 06:06:03 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'] 06:06:03 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 06:06:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:06:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:05 INFO - (blobuploader) - INFO - Done attempting. 06:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:06 INFO - (blobuploader) - INFO - Done attempting. 06:06:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:09 INFO - (blobuploader) - INFO - Done attempting. 06:06:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:09 INFO - Return code: 0 06:06:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e184b8cd96b2ec758bf2400bf93ec3783884578383eafc6c03a364ff88af4121b37270f7e8c82f0c5149ff72df1aabb578310edcde218956d5a13aedb1f796f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbca6a177200903703eba28af0727fd225d995fd75bd8d02c01a5a250181d7a7523537fa067f0bb5d386e7f9740ade7039d27906ac2fcad636972cbc2cb6749b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e19c5521315ed9d50f3d2ae711c4d738c8998670834e87b90d2ab0934b834fa061c39c8210fb2604e8021801917bc0680c86d75cc73fb6144838e55df471c9"} 06:06:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:09 INFO - Contents: 06:06:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e184b8cd96b2ec758bf2400bf93ec3783884578383eafc6c03a364ff88af4121b37270f7e8c82f0c5149ff72df1aabb578310edcde218956d5a13aedb1f796f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbca6a177200903703eba28af0727fd225d995fd75bd8d02c01a5a250181d7a7523537fa067f0bb5d386e7f9740ade7039d27906ac2fcad636972cbc2cb6749b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e19c5521315ed9d50f3d2ae711c4d738c8998670834e87b90d2ab0934b834fa061c39c8210fb2604e8021801917bc0680c86d75cc73fb6144838e55df471c9"} 06:06:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:09 INFO - Copying logs to upload dir... 06:06:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.755411 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-12-08 06:06:09.182948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:09.187926) ========= 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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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/e184b8cd96b2ec758bf2400bf93ec3783884578383eafc6c03a364ff88af4121b37270f7e8c82f0c5149ff72df1aabb578310edcde218956d5a13aedb1f796f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbca6a177200903703eba28af0727fd225d995fd75bd8d02c01a5a250181d7a7523537fa067f0bb5d386e7f9740ade7039d27906ac2fcad636972cbc2cb6749b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e19c5521315ed9d50f3d2ae711c4d738c8998670834e87b90d2ab0934b834fa061c39c8210fb2604e8021801917bc0680c86d75cc73fb6144838e55df471c9"} build_url:https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e184b8cd96b2ec758bf2400bf93ec3783884578383eafc6c03a364ff88af4121b37270f7e8c82f0c5149ff72df1aabb578310edcde218956d5a13aedb1f796f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbca6a177200903703eba28af0727fd225d995fd75bd8d02c01a5a250181d7a7523537fa067f0bb5d386e7f9740ade7039d27906ac2fcad636972cbc2cb6749b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e19c5521315ed9d50f3d2ae711c4d738c8998670834e87b90d2ab0934b834fa061c39c8210fb2604e8021801917bc0680c86d75cc73fb6144838e55df471c9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:09.227615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:09.228022) ========= 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.Vqb7p7FhJV/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.yRZzEUb2yu/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:09.284541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 06:06:09.284927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 06:06:09.285335) ========= ========= Total master_lag: 0.38 =========