builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0097 starttime: 1490139462.16 results: success (0) buildid: 20170321153523 builduid: 4aa961419e624bd49319b754f710959c revision: 18bb0299dd9b3516597e5c68cd49d8b894745a93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.158764) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.159119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.159400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.186610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.186897) ========= 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.DIOR0NfHiq/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.mqfaeSApyp/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-21 16:37:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 223M=0s 2017-03-21 16:37:42 (223 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.468575 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.681424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.681962) ========= 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.DIOR0NfHiq/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.mqfaeSApyp/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.027943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:42.736192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 16:37:42.736539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 18bb0299dd9b3516597e5c68cd49d8b894745a93 --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 18bb0299dd9b3516597e5c68cd49d8b894745a93 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DIOR0NfHiq/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.mqfaeSApyp/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-21 16:37:42,846 truncating revision to first 12 chars 2017-03-21 16:37:42,846 Setting DEBUG logging. 2017-03-21 16:37:42,847 attempt 1/10 2017-03-21 16:37:42,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/18bb0299dd9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 16:37:43,995 unpacking tar archive at: mozilla-central-18bb0299dd9b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 16:37:44.190950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:44.194509) ========= script_repo_revision: 18bb0299dd9b3516597e5c68cd49d8b894745a93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:44.194953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:44.195245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 16:37:44.216302) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-21 16:37:44.216598) ========= /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.DIOR0NfHiq/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.mqfaeSApyp/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:37:44 INFO - MultiFileLogger online at 20170321 16:37:44 in /builds/slave/test 16:37:44 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 16:37:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:37:44 INFO - {'append_to_log': False, 16:37:44 INFO - 'base_work_dir': '/builds/slave/test', 16:37:44 INFO - 'blob_upload_branch': 'Firefox', 16:37:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:37:44 INFO - 'branch': 'Firefox', 16:37:44 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:44 INFO - 'config_files': ('talos/mac_config.py',), 16:37:44 INFO - 'default_actions': ('clobber', 16:37:44 INFO - 'read-buildbot-config', 16:37:44 INFO - 'download-and-extract', 16:37:44 INFO - 'populate-webroot', 16:37:44 INFO - 'create-virtualenv', 16:37:44 INFO - 'install', 16:37:44 INFO - 'run-tests'), 16:37:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:44 INFO - 'download_minidump_stackwalk': True, 16:37:44 INFO - 'download_symbols': 'ondemand', 16:37:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:44 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:44 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:44 INFO - 'gecko_profile': False, 16:37:44 INFO - 'gecko_profile_interval': 0, 16:37:44 INFO - 'installer_path': 'installer.exe', 16:37:44 INFO - 'log_level': 'info', 16:37:44 INFO - 'log_name': 'talos', 16:37:44 INFO - 'log_to_console': True, 16:37:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:37:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:37:44 INFO - 'opt_config_files': (), 16:37:44 INFO - 'pip_index': False, 16:37:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:37:44 INFO - 'cmd': ('bash', 16:37:44 INFO - '-c', 16:37:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:37:44 INFO - 'enabled': True, 16:37:44 INFO - 'halt_on_failure': False, 16:37:44 INFO - 'name': 'check_screen_resolution'},), 16:37:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:37:44 INFO - 'cmd': ('bash', 16:37:44 INFO - '-c', 16:37:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:37:44 INFO - 'enabled': True, 16:37:44 INFO - 'halt_on_failure': False, 16:37:44 INFO - 'name': 'check_screen_resolution'},), 16:37:44 INFO - 'run_cmd_checks_enabled': True, 16:37:44 INFO - 'suite': 'dromaeojs-e10s', 16:37:44 INFO - 'system_bits': '32', 16:37:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:44 INFO - 'title': 't-yosemite-r7-0097', 16:37:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:44 INFO - 'use_talos_json': True, 16:37:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:37:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:44 INFO - 'work_dir': 'build'} 16:37:44 INFO - [mozharness: 2017-03-21 23:37:44.448318Z] Running clobber step. 16:37:44 INFO - Running pre-action listener: _resource_record_pre_action 16:37:44 INFO - Running main action method: clobber 16:37:44 INFO - rmtree: /builds/slave/test/build 16:37:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:37:47 INFO - Running post-action listener: _resource_record_post_action 16:37:47 INFO - [mozharness: 2017-03-21 23:37:47.153491Z] Finished clobber step (success) 16:37:47 INFO - [mozharness: 2017-03-21 23:37:47.153761Z] Running read-buildbot-config step. 16:37:47 INFO - Running pre-action listener: _resource_record_pre_action 16:37:47 INFO - Running main action method: read_buildbot_config 16:37:47 INFO - Using buildbot properties: 16:37:47 INFO - { 16:37:47 INFO - "project": "", 16:37:47 INFO - "product": "firefox", 16:37:47 INFO - "script_repo_revision": "production", 16:37:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:37:47 INFO - "repository": "", 16:37:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:37:47 INFO - "buildid": "20170321153523", 16:37:47 INFO - "pgo_build": "False", 16:37:47 INFO - "basedir": "/builds/slave/test", 16:37:47 INFO - "buildnumber": 15, 16:37:47 INFO - "slavename": "t-yosemite-r7-0097", 16:37:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:37:47 INFO - "platform": "yosemite_r7", 16:37:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:37:47 INFO - "branch": "mozilla-central", 16:37:47 INFO - "repo_path": "mozilla-central", 16:37:47 INFO - "revision": "18bb0299dd9b3516597e5c68cd49d8b894745a93", 16:37:47 INFO - "stage_platform": "macosx64", 16:37:47 INFO - "builduid": "4aa961419e624bd49319b754f710959c", 16:37:47 INFO - "slavebuilddir": "test" 16:37:47 INFO - } 16:37:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:37:47 INFO - Running post-action listener: _resource_record_post_action 16:37:47 INFO - [mozharness: 2017-03-21 23:37:47.159590Z] Finished read-buildbot-config step (success) 16:37:47 INFO - [mozharness: 2017-03-21 23:37:47.159780Z] Running download-and-extract step. 16:37:47 INFO - Running pre-action listener: _resource_record_pre_action 16:37:47 INFO - Running main action method: download_and_extract 16:37:47 INFO - mkdir: /builds/slave/test/build/tests 16:37:47 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')]} 16:37:47 INFO - trying https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:37:47 INFO - Downloaded 1325 bytes. 16:37:47 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:37:47 INFO - Using the following test package requirements: 16:37:47 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:37:47 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:37:47 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:37:47 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:37:47 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'jsshell-mac.zip'], 16:37:47 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:37:47 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:37:47 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:37:47 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:37:47 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:37:47 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:37:47 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:37:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:37:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:37:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:37:47 INFO - Fetch https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:37:49 INFO - Expected file size: 52474135 16:37:49 INFO - Obtained file size: 52474135 16:38:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:38:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:38:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:38:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:38:07 INFO - Expected file size: 52474135 16:38:07 INFO - Obtained file size: 52474135 16:38:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:38:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:38:23 INFO - Fetch https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:38:23 INFO - Expected file size: 14404171 16:38:23 INFO - Obtained file size: 14404171 16:38:24 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')]} 16:38:24 INFO - trying https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:38:24 INFO - Downloading https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:38:26 INFO - Downloaded 75233586 bytes. 16:38:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:38:26 INFO - mkdir: /builds/slave/test/properties 16:38:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:26 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:26 INFO - Contents: 16:38:26 INFO - build_url:https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:38:27 INFO - Running post-action listener: _resource_record_post_action 16:38:27 INFO - Running post-action listener: set_extra_try_arguments 16:38:27 INFO - [mozharness: 2017-03-21 23:38:27.051492Z] Finished download-and-extract step (success) 16:38:27 INFO - [mozharness: 2017-03-21 23:38:27.051587Z] Running populate-webroot step. 16:38:27 INFO - Running pre-action listener: _resource_record_pre_action 16:38:27 INFO - Running main action method: populate_webroot 16:38:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:27 INFO - '--tppagecycles', 16:38:27 INFO - '7'], 16:38:27 INFO - 'tests': ['tsvgm']}}, 16:38:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:38:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:38:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:38:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['damp', 'tps']}, 16:38:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'tests': ['damp', 'tps']}, 16:38:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['dromaeo_dom']}, 16:38:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['basic_compositor_video']}, 16:38:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:38:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['a11yr', 16:38:27 INFO - 'ts_paint', 16:38:27 INFO - 'tpaint', 16:38:27 INFO - 'sessionrestore', 16:38:27 INFO - 'sessionrestore_no_auto_restore', 16:38:27 INFO - 'tabpaint']}, 16:38:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:38:27 INFO - 'ts_paint', 16:38:27 INFO - 'tpaint', 16:38:27 INFO - 'sessionrestore', 16:38:27 INFO - 'sessionrestore_no_auto_restore', 16:38:27 INFO - 'tabpaint']}, 16:38:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:38:27 INFO - 'ts_paint', 16:38:27 INFO - 'tpaint', 16:38:27 INFO - 'sessionrestore', 16:38:27 INFO - 'sessionrestore_no_auto_restore', 16:38:27 INFO - 'tabpaint']}, 16:38:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:38:27 INFO - 'ts_paint', 16:38:27 INFO - 'tpaint', 16:38:27 INFO - 'sessionrestore', 16:38:27 INFO - 'sessionrestore_no_auto_restore', 16:38:27 INFO - 'tabpaint']}, 16:38:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['a11yr', 16:38:27 INFO - 'ts_paint', 16:38:27 INFO - 'tpaint', 16:38:27 INFO - 'sessionrestore', 16:38:27 INFO - 'sessionrestore_no_auto_restore', 16:38:27 INFO - 'tabpaint']}, 16:38:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['a11yr', 16:38:27 INFO - 'ts_paint', 16:38:27 INFO - 'tpaint', 16:38:27 INFO - 'sessionrestore', 16:38:27 INFO - 'sessionrestore_no_auto_restore', 16:38:27 INFO - 'tabpaint']}, 16:38:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['tsvgx', 16:38:27 INFO - 'tsvgr_opacity', 16:38:27 INFO - 'tart', 16:38:27 INFO - 'tscrollx', 16:38:27 INFO - 'cart', 16:38:27 INFO - 'tsvg_static']}, 16:38:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:38:27 INFO - 'tsvgr_opacity', 16:38:27 INFO - 'tart', 16:38:27 INFO - 'tscrollx', 16:38:27 INFO - 'cart', 16:38:27 INFO - 'tsvg_static']}, 16:38:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'talos_options': ['--disable-e10s'], 16:38:27 INFO - 'tests': ['tp5o']}, 16:38:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:38:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'talos_options': ['--disable-e10s', 16:38:27 INFO - '--xperf_path', 16:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:27 INFO - 'tests': ['tp5n']}, 16:38:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:38:27 INFO - 'talos_options': ['--xperf_path', 16:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:27 INFO - 'tests': ['tp5n']}}, 16:38:27 INFO - 'talos.zip': {'path': '', 16:38:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:27 INFO - Running post-action listener: _resource_record_post_action 16:38:27 INFO - [mozharness: 2017-03-21 23:38:27.069968Z] Finished populate-webroot step (success) 16:38:27 INFO - [mozharness: 2017-03-21 23:38:27.070102Z] Running create-virtualenv step. 16:38:27 INFO - Running pre-action listener: _resource_record_pre_action 16:38:27 INFO - Running main action method: create_virtualenv 16:38:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:27 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 16:38:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:27 INFO - Using real prefix '/tools/python27' 16:38:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:27 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:30 INFO - Installing pip.................done. 16:38:30 INFO - Return code: 0 16:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:38:31 INFO - Reading from file tmpfile_stdout 16:38:31 INFO - Output received: 16:38:31 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) 16:38:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:31 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:31 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 16:38:31 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 16:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:31 INFO - 'HOME': '/Users/cltbld', 16:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:31 INFO - 'LOGNAME': 'cltbld', 16:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:31 INFO - 'MOZ_NO_REMOTE': '1', 16:38:31 INFO - 'NO_EM_RESTART': '1', 16:38:31 INFO - 'PAGER': '/bin/cat', 16:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:31 INFO - 'PWD': '/builds/slave/test', 16:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:31 INFO - 'SHELL': '/bin/bash', 16:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:31 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:31 INFO - 'USER': 'cltbld', 16:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:31 INFO - 'XPC_FLAGS': '0x0', 16:38:31 INFO - 'XPC_SERVICE_NAME': '0', 16:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:31 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 16:38:31 INFO - Cleaning up... 16:38:31 INFO - Return code: 0 16:38:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:31 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:31 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 16:38:31 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 16:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:31 INFO - 'HOME': '/Users/cltbld', 16:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:31 INFO - 'LOGNAME': 'cltbld', 16:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:31 INFO - 'MOZ_NO_REMOTE': '1', 16:38:31 INFO - 'NO_EM_RESTART': '1', 16:38:31 INFO - 'PAGER': '/bin/cat', 16:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:31 INFO - 'PWD': '/builds/slave/test', 16:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:31 INFO - 'SHELL': '/bin/bash', 16:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:31 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:31 INFO - 'USER': 'cltbld', 16:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:31 INFO - 'XPC_FLAGS': '0x0', 16:38:31 INFO - 'XPC_SERVICE_NAME': '0', 16:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:31 INFO - Downloading/unpacking psutil>=3.1.1 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38: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 16:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:35 INFO - Installing collected packages: psutil 16:38:35 INFO - Running setup.py install for psutil 16:38:35 INFO - building 'psutil._psutil_osx' extension 16:38:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:38:36 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 16:38:36 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 16:38:36 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 16:38:36 INFO - building 'psutil._psutil_posix' extension 16:38:36 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 16:38:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:38:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:38:36 INFO - ^ 16:38:36 INFO - 1 warning generated. 16:38:36 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 16:38:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:36 INFO - Successfully installed psutil 16:38:36 INFO - Cleaning up... 16:38:36 INFO - Return code: 0 16:38:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:36 INFO - 'HOME': '/Users/cltbld', 16:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:36 INFO - 'LOGNAME': 'cltbld', 16:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:36 INFO - 'MOZ_NO_REMOTE': '1', 16:38:36 INFO - 'NO_EM_RESTART': '1', 16:38:36 INFO - 'PAGER': '/bin/cat', 16:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:36 INFO - 'PWD': '/builds/slave/test', 16:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:36 INFO - 'SHELL': '/bin/bash', 16:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:36 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:36 INFO - 'USER': 'cltbld', 16:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:36 INFO - 'XPC_FLAGS': '0x0', 16:38:36 INFO - 'XPC_SERVICE_NAME': '0', 16:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:38:39 INFO - Installing collected packages: mozsystemmonitor 16:38:39 INFO - Running setup.py install for mozsystemmonitor 16:38:39 INFO - Successfully installed mozsystemmonitor 16:38:39 INFO - Cleaning up... 16:38:40 INFO - Return code: 0 16:38:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:38:40 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')]} 16:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 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')]} 16:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:40 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:40 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 16:38:40 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 16:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:40 INFO - 'HOME': '/Users/cltbld', 16:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:40 INFO - 'LOGNAME': 'cltbld', 16:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:40 INFO - 'MOZ_NO_REMOTE': '1', 16:38:40 INFO - 'NO_EM_RESTART': '1', 16:38:40 INFO - 'PAGER': '/bin/cat', 16:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:40 INFO - 'PWD': '/builds/slave/test', 16:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:40 INFO - 'SHELL': '/bin/bash', 16:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:40 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:40 INFO - 'USER': 'cltbld', 16:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:40 INFO - 'XPC_FLAGS': '0x0', 16:38:40 INFO - 'XPC_SERVICE_NAME': '0', 16:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:38:40 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 16:38:40 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 16:38:40 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 16:38:40 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 16:38:40 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 16:38:40 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 16:38:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:43 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:43 INFO - warning: no files found matching '*.txt' 16:38:43 INFO - no previously-included directories found matching 'build' 16:38:43 INFO - no previously-included directories found matching 'dist' 16:38:43 INFO - no previously-included directories found matching '.git*' 16:38:43 INFO - Installing collected packages: jsonschema, functools32 16:38:43 INFO - Running setup.py install for functools32 16:38:43 INFO - warning: no files found matching '*.txt' 16:38:43 INFO - no previously-included directories found matching 'build' 16:38:43 INFO - no previously-included directories found matching 'dist' 16:38:43 INFO - no previously-included directories found matching '.git*' 16:38:43 INFO - Successfully installed jsonschema functools32 16:38:43 INFO - Cleaning up... 16:38:43 INFO - Return code: 0 16:38:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:43 INFO - 'HOME': '/Users/cltbld', 16:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:43 INFO - 'LOGNAME': 'cltbld', 16:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:43 INFO - 'MOZ_NO_REMOTE': '1', 16:38:43 INFO - 'NO_EM_RESTART': '1', 16:38:43 INFO - 'PAGER': '/bin/cat', 16:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:43 INFO - 'PWD': '/builds/slave/test', 16:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:43 INFO - 'SHELL': '/bin/bash', 16:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:43 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:43 INFO - 'USER': 'cltbld', 16:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:43 INFO - 'XPC_FLAGS': '0x0', 16:38:43 INFO - 'XPC_SERVICE_NAME': '0', 16:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:38:43 INFO - Cleaning up... 16:38:43 INFO - Return code: 0 16:38:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:38:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:43 INFO - 'HOME': '/Users/cltbld', 16:38:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:43 INFO - 'LOGNAME': 'cltbld', 16:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:43 INFO - 'MOZ_NO_REMOTE': '1', 16:38:43 INFO - 'NO_EM_RESTART': '1', 16:38:43 INFO - 'PAGER': '/bin/cat', 16:38:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:43 INFO - 'PWD': '/builds/slave/test', 16:38:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:43 INFO - 'SHELL': '/bin/bash', 16:38:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:43 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:43 INFO - 'USER': 'cltbld', 16:38:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:43 INFO - 'XPC_FLAGS': '0x0', 16:38:43 INFO - 'XPC_SERVICE_NAME': '0', 16:38:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:44 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:44 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 16:38:44 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 16:38:44 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 16:38:44 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 16:38:44 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 16:38:44 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 16:38:47 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:38:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:47 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 16:38:48 INFO - Downloading docopt-0.6.1.tar.gz 16:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:48 INFO - Running setup.py install for blobuploader 16:38:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:38:48 INFO - Running setup.py install for requests 16:38:49 INFO - Running setup.py install for docopt 16:38:49 INFO - Successfully installed blobuploader requests docopt 16:38:49 INFO - Cleaning up... 16:38:49 INFO - Return code: 0 16:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:49 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:49 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 16:38:49 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 16:38:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:49 INFO - 'HOME': '/Users/cltbld', 16:38:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:49 INFO - 'LOGNAME': 'cltbld', 16:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:49 INFO - 'MOZ_NO_REMOTE': '1', 16:38:49 INFO - 'NO_EM_RESTART': '1', 16:38:49 INFO - 'PAGER': '/bin/cat', 16:38:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:49 INFO - 'PWD': '/builds/slave/test', 16:38:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:49 INFO - 'SHELL': '/bin/bash', 16:38:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:49 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:49 INFO - 'USER': 'cltbld', 16:38:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:49 INFO - 'XPC_FLAGS': '0x0', 16:38:49 INFO - 'XPC_SERVICE_NAME': '0', 16:38:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:49 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Dw0g43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:49 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-bz1uD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:49 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-3JMyq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:49 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ULA60M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-47cI2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-x4QcMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-S_lb3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QaD1fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-QKC6yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-7k_LjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1Vh9rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-HKGKhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ZwkruT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:50 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-bi02i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-hll3ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-mgjQxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:51 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-7eTsy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:51 INFO - Running setup.py install for manifestparser 16:38:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozcrash 16:38:51 INFO - Running setup.py install for mozdebug 16:38:51 INFO - Running setup.py install for mozdevice 16:38:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:38:51 INFO - Running setup.py install for mozfile 16:38:52 INFO - Running setup.py install for mozhttpd 16:38:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozinfo 16:38:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozInstall 16:38:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for mozleak 16:38:52 INFO - Running setup.py install for mozlog 16:38:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:38:52 INFO - Running setup.py install for moznetwork 16:38:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Running setup.py install for mozprocess 16:38:53 INFO - Running setup.py install for mozprofile 16:38:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Running setup.py install for mozrunner 16:38:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Running setup.py install for mozscreenshot 16:38:53 INFO - Running setup.py install for moztest 16:38:53 INFO - Running setup.py install for mozversion 16:38:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:38:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:53 INFO - Cleaning up... 16:38:53 INFO - Return code: 0 16:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:53 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')]} 16:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:53 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')]} 16:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:53 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:53 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 16:38:53 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 16:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:53 INFO - 'HOME': '/Users/cltbld', 16:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:53 INFO - 'LOGNAME': 'cltbld', 16:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:53 INFO - 'MOZ_NO_REMOTE': '1', 16:38:53 INFO - 'NO_EM_RESTART': '1', 16:38:53 INFO - 'PAGER': '/bin/cat', 16:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:53 INFO - 'PWD': '/builds/slave/test', 16:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:53 INFO - 'SHELL': '/bin/bash', 16:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:53 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:53 INFO - 'USER': 'cltbld', 16:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:53 INFO - 'XPC_FLAGS': '0x0', 16:38:53 INFO - 'XPC_SERVICE_NAME': '0', 16:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-t9UNeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-_KxROG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-xm40ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-q7BQK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-CFxryw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-3m0LAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-dFJxPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:54 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)) 16:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:54 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-bnqW9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-jUdToK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-qk9AZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-6O9cwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-66PwQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-5IfXm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-_a0ofO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Jn1j5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:55 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)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-mdTpA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:55 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-AmfeMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 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)) 16:38:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:58 INFO - Downloading blessings-1.6.tar.gz 16:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:58 INFO - Installing collected packages: blessings 16:38:58 INFO - Running setup.py install for blessings 16:38:58 INFO - Successfully installed blessings 16:38:58 INFO - Cleaning up... 16:38:59 INFO - Return code: 0 16:38:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:59 INFO - Reading from file tmpfile_stdout 16:38:59 INFO - Current package versions: 16:38:59 INFO - blessings == 1.6 16:38:59 INFO - blobuploader == 1.2.4 16:38:59 INFO - docopt == 0.6.1 16:38:59 INFO - functools32 == 3.2.3-2 16:38:59 INFO - jsonschema == 2.5.1 16:38:59 INFO - manifestparser == 1.1 16:38:59 INFO - mozInstall == 1.12 16:38:59 INFO - mozcrash == 1.0 16:38:59 INFO - mozdebug == 0.1 16:38:59 INFO - mozdevice == 0.49 16:38:59 INFO - mozfile == 1.2 16:38:59 INFO - mozhttpd == 0.7 16:38:59 INFO - mozinfo == 0.9 16:38:59 INFO - mozleak == 0.1 16:38:59 INFO - mozlog == 3.4 16:38:59 INFO - moznetwork == 0.27 16:38:59 INFO - mozprocess == 0.25 16:38:59 INFO - mozprofile == 0.28 16:38:59 INFO - mozrunner == 6.13 16:38:59 INFO - mozscreenshot == 0.1 16:38:59 INFO - mozsystemmonitor == 0.3 16:38:59 INFO - moztest == 0.8 16:38:59 INFO - mozversion == 1.4 16:38:59 INFO - psutil == 3.1.1 16:38:59 INFO - requests == 1.2.3 16:38:59 INFO - wsgiref == 0.1.2 16:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:59 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:59 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 16:38:59 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 16:38:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:59 INFO - 'HOME': '/Users/cltbld', 16:38:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:59 INFO - 'LOGNAME': 'cltbld', 16:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:59 INFO - 'MOZ_NO_REMOTE': '1', 16:38:59 INFO - 'NO_EM_RESTART': '1', 16:38:59 INFO - 'PAGER': '/bin/cat', 16:38:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:59 INFO - 'PWD': '/builds/slave/test', 16:38:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:59 INFO - 'SHELL': '/bin/bash', 16:38:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:59 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:59 INFO - 'USER': 'cltbld', 16:38:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:59 INFO - 'XPC_FLAGS': '0x0', 16:38:59 INFO - 'XPC_SERVICE_NAME': '0', 16:38:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 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)) 16:38:59 INFO - Cleaning up... 16:38:59 INFO - Return code: 0 16:38:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:59 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 0x10463fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104642768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff69156cea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, '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.DIOR0NfHiq/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.mqfaeSApyp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 16:38:59 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 16:38:59 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 16:38:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:38:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:59 INFO - 'HOME': '/Users/cltbld', 16:38:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:59 INFO - 'LOGNAME': 'cltbld', 16:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:59 INFO - 'MOZ_NO_REMOTE': '1', 16:38:59 INFO - 'NO_EM_RESTART': '1', 16:38:59 INFO - 'PAGER': '/bin/cat', 16:38:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:59 INFO - 'PWD': '/builds/slave/test', 16:38:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:59 INFO - 'SHELL': '/bin/bash', 16:38:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:38:59 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:38:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:59 INFO - 'USER': 'cltbld', 16:38:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:59 INFO - 'XPC_FLAGS': '0x0', 16:38:59 INFO - 'XPC_SERVICE_NAME': '0', 16:38:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:38:59 INFO - Cleaning up... 16:38:59 INFO - Return code: 0 16:38:59 INFO - Running post-action listener: _resource_record_post_action 16:38:59 INFO - Running post-action listener: _start_resource_monitoring 16:38:59 INFO - Starting resource monitoring. 16:38:59 INFO - [mozharness: 2017-03-21 23:38:59.923280Z] Finished create-virtualenv step (success) 16:38:59 INFO - [mozharness: 2017-03-21 23:38:59.924266Z] Running install step. 16:38:59 INFO - Running pre-action listener: _resource_record_pre_action 16:38:59 INFO - Running main action method: install 16:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:00 INFO - Reading from file tmpfile_stdout 16:39:00 INFO - Detecting whether we're running mozinstall >=1.0... 16:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:39:00 INFO - Reading from file tmpfile_stdout 16:39:00 INFO - Output received: 16:39:00 INFO - Usage: mozinstall [options] installer 16:39:00 INFO - Options: 16:39:00 INFO - -h, --help show this help message and exit 16:39:00 INFO - -d DEST, --destination=DEST 16:39:00 INFO - Directory to install application into. [default: 16:39:00 INFO - "/builds/slave/test"] 16:39:00 INFO - --app=APP Application being installed. [default: firefox] 16:39:00 INFO - mkdir: /builds/slave/test/build/application 16:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:39:20 INFO - Reading from file tmpfile_stdout 16:39:20 INFO - Output received: 16:39:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:39:20 INFO - Running post-action listener: _resource_record_post_action 16:39:20 INFO - [mozharness: 2017-03-21 23:39:20.459891Z] Finished install step (success) 16:39:20 INFO - [mozharness: 2017-03-21 23:39:20.460031Z] Running run-tests step. 16:39:20 INFO - Running pre-action listener: _resource_record_pre_action 16:39:20 INFO - Running main action method: run_tests 16:39:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:20 INFO - 2017-03-21 16:39:20.472 screenresolution[1629:7568] starting screenresolution argv=screenresolution get 16:39:20 INFO - 2017-03-21 16:39:20.475 screenresolution[1629:7568] Display 0: 1600x1200x32@60 16:39:20 INFO - 2017-03-21 16:39:20.480 screenresolution[1630:7571] starting screenresolution argv=screenresolution list 16:39:20 INFO - Available Modes on Display 0 16:39:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:20 INFO - Intel Iris: 16:39:20 INFO - Chipset Model: Intel Iris 16:39:20 INFO - Type: GPU 16:39:20 INFO - Bus: Built-In 16:39:20 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:20 INFO - Vendor: Intel (0x8086) 16:39:20 INFO - Device ID: 0x0a2e 16:39:20 INFO - Revision ID: 0x0009 16:39:20 INFO - Displays: 16:39:20 INFO - Display: 16:39:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:20 INFO - Display Serial Number: 1600x1200 60 16:39:20 INFO - Main Display: Yes 16:39:20 INFO - Mirror: Off 16:39:20 INFO - Online: Yes 16:39:20 INFO - Rotation: Supported 16:39:20 INFO - Return code: 0 16:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:39:20 INFO - Python 2.7.3 16:39:20 INFO - Return code: 0 16:39:20 INFO - grabbing minidump binary from tooltool 16:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:39:20 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 0x10441dd30>, '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 0x104344db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104412be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:39:20 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 16:39:20 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 16:39:20 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 16:39:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:20 INFO - Return code: 0 16:39:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:39:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:39:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:39:20 INFO - ENV: RUST_BACKTRACE is now 1 16:39:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:39:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 16:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --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 16:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DIOR0NfHiq/Render', 16:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:20 INFO - 'HOME': '/Users/cltbld', 16:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:20 INFO - 'LOGNAME': 'cltbld', 16:39:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:39:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:20 INFO - 'MOZ_NO_REMOTE': '1', 16:39:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:39:20 INFO - 'NO_EM_RESTART': '1', 16:39:20 INFO - 'PAGER': '/bin/cat', 16:39:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:20 INFO - 'PWD': '/builds/slave/test', 16:39:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:20 INFO - 'RUST_BACKTRACE': '1', 16:39:20 INFO - 'SHELL': '/bin/bash', 16:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqfaeSApyp/Listeners', 16:39:20 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 16:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:20 INFO - 'USER': 'cltbld', 16:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:20 INFO - 'XPC_FLAGS': '0x0', 16:39:20 INFO - 'XPC_SERVICE_NAME': '0', 16:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--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 16:39:21 INFO - mozversion application_buildid: 20170321153523 16:39:21 INFO - mozversion application_changeset: 18bb0299dd9b3516597e5c68cd49d8b894745a93 16:39:21 INFO - mozversion application_display_name: Nightly 16:39:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:21 INFO - mozversion application_name: Firefox 16:39:21 INFO - mozversion application_remotingname: firefox 16:39:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:39:21 INFO - mozversion application_vendor: Mozilla 16:39:21 INFO - mozversion application_version: 55.0a1 16:39:21 INFO - mozversion platform_buildid: 20170321153523 16:39:21 INFO - mozversion platform_changeset: 18bb0299dd9b3516597e5c68cd49d8b894745a93 16:39:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:39:21 INFO - mozversion platform_version: 55.0a1 16:39:21 INFO - using testdate: 1490139561 16:39:21 INFO - actual date: 1490139561 16:39:21 INFO - starting webserver on 'localhost:49254' 16:39:21 INFO - SUITE-START | Running 2 tests 16:39:21 INFO - TEST-START | dromaeo_css 16:39:21 INFO - operating with platform_type : mac_ 16:39:21 INFO - Initialising browser for dromaeo_css test... 16:39:21 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpOWBySZ/profile http://localhost:49254/getInfo.html) 16:39:24 INFO - PID 1640 | 2017-03-21 16:39:24.311 plugin-container[1642:7760] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 16:39:24 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:39:24 INFO - PID 1640 | 2017-03-21 16:39:24.314 plugin-container[1642:7760] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 16:39:24 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:39:24 INFO - PID 1640 | 2017-03-21 16:39:24.314 plugin-container[1642:7760] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:39:24 INFO - PID 1640 | __metrics Screen width/height:1600/1200 16:39:24 INFO - PID 1640 | colorDepth:24 16:39:24 INFO - PID 1640 | Browser inner width/height: 1024/689 16:39:24 INFO - PID 1640 | __metrics 16:39:24 ERROR - PID 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:39:25 INFO - TEST-INFO | 1640: exit 0 16:39:25 INFO - Browser initialized. 16:39:25 INFO - Running cycle 1/1 for dromaeo_css test... 16:39:25 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpOWBySZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:27 INFO - PID 1643 | 2017-03-21 16:39:27.950 plugin-container[1644:7892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 16:39:27 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:39:27 INFO - PID 1643 | 2017-03-21 16:39:27.951 plugin-container[1644:7892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4427, name = 'com.apple.CFPasteboardClient' 16:39:27 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:39:27 INFO - PID 1643 | 2017-03-21 16:39:27.951 plugin-container[1644:7892] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:39:37 INFO - PID 1643 | RSS: Main: 227676160 16:39:37 INFO - PID 1643 | 16:42:41 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49254/tests/dromaeo/cssquery-ext.html) 16:42:43 INFO - PID 1643 | RSS: Main: 250851328 16:42:43 INFO - PID 1643 | 16:44:25 INFO - PID 1643 | ************************* 16:44:25 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 16:44:25 INFO - PID 1643 | 16:44:25 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:44:25 INFO - PID 1643 | Full stack: 16:44:25 INFO - PID 1643 | ************************* 16:45:45 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-ext.html (next: http://localhost:49254/tests/dromaeo/cssquery-jquery.html) 16:45:45 INFO - PID 1643 | RSS: Main: 258727936 16:45:45 INFO - PID 1643 | 16:48:47 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49254/tests/dromaeo/cssquery-mootools.html) 16:48:48 INFO - PID 1643 | RSS: Main: 270651392 16:48:48 INFO - PID 1643 | 16:51:50 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49254/tests/dromaeo/cssquery-prototype.html) 16:51:51 INFO - PID 1643 | RSS: Main: 262963200 16:51:51 INFO - PID 1643 | 16:54:53 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49254/tests/dromaeo/cssquery-yui.html) 16:54:54 INFO - PID 1643 | RSS: Main: 273203200 16:54:54 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49254/tests/dromaeo/cssquery-yui.html (next: http://localhost:49254/tests/dromaeo/cssquery-dojo.html) 16:57:57 INFO - PID 1643 | RSS: Main: 266903552 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | __start_tp_report 16:57:57 INFO - PID 1643 | _x_x_mozilla_page_load 16:57:57 INFO - PID 1643 | _x_x_mozilla_page_load_details 16:57:57 INFO - PID 1643 | |i|pagename|runs| 16:57:57 INFO - PID 1643 | |0;dojo.html;2837.9574306385407;3553.5380400547942;3568.768030078045;3584;3626.2203626220366;4373.365861950016;4909.5581397674205;4964.7765850536725;6129.387061293868;6199.907001394971;6109.981658125348;6142.7443454968825;6190.504759619231;6202.937970620293;6204.503639708823;5433.864153396157;5500.559955203574;5501.559875209973;5559.082751346023;5583.35791383991;4880.487548807378;5583.8604034899045;5640.689762063085;5641.887162256752;5860.945029894618;5496.697681627509;5535.308086489189;5554.638948468337;5592.965301419251;5593.3847276799515;5559.332880054379;5576.996140694673;5580.218769372291;5588.022096133161;5592.636478628876;5521.723913804293;5541.030319694038;5566.610337276392;5595.38450770415;5634.859128521779;4926.876828079291;5692.946804841117;6123.6938153092615;6181.505479561624;6204.906926396107;6653.334666533308;6654.534182607219;6657.500687448461;6676.432503237231;6680.298568650271;6751.054852320679;6765.2219994700745;6768.458523318122;6781.830454238634;6784.253732089466;6142.069075791408;6183.9381606183815;6244.219472565929;6257.124002639634;6291.748330066837;6049.879002419927;6643.302453242437;6883.518153729191;6902.033715279765;6956.304369563003;6337.841553961096;6415.166028416276;6421.229452465734;6519.348065193442;6579.572327798678;6602.40578347951;6736.696848641823;6740.29226931175;6752.864942701119;6759.2226893906845;6411.487081033506;6504.0243963405865;6575.539712220098;6658.6337751424135;6676.46588272937;5521.779128834802;6582.868342633121;6644.103046088813;6663.733450661919;6712.295209003082;5337.81317653888;5346.8395948121615;5352.0366334060245;5356.544693701079;5377.784888604412;4713.316569097462;4734.147853386355;4738.715677059387;4795.304680821261;4804.903901921942;6223.875522489525;6252.155958945484;6275.96862015687;6281.057841323838;6283.08895210192;6757.986302054731;6778.593284402951;6780;6786.287439818847;6789.388954994074;5638.182463542763;6298.0552917062805;6317.5893566918;6342.5243106767175;6354.872902541923;5787.7395517200985;5796.710164491758;5801.854953626109;5804.6807425592;5826.708664566755;6783.796486105425;6909.550879192836;6951.826204344932;6975;6977.965110174619;6704.128463299739;6749.122614060141;6752.966235168793;6759.087523184307;6762.256151823394;6651.700673469609;6931.306869313028;6978.371946524837;6984.126984126984;7019.6841142147705;5826.563007774349;6569.408753212234;6594.967025164843;6647.634380109141;6658.900116498353;5538.446155384429;6473.643949582818;6505.447037001908;6693.09643198162;6719.798406047827;6410.0705397718;6506.869862602816;6507.121538592419;6512.088307637029;6512.739490420519;6508.73965041412;6522.608643481406;6537;6539.934600653933;6542.411182993554;4959.330490383896;5958;6098.6742875288965;6315.747370105144;6400.455961243347;6529.151210342625;6533.542652014504;6555.704993275219;6556.082148499118;6557.836054098686;5893.557983151367;6356.872862542816;6367.076773867856;6371.362863713592;6374.171357723466 16:57:57 INFO - PID 1643 | |1;ext.html;736.2453485177693;741.8279118991993;805.6012273924408;806.5080301016383;826.9379796515259;31113.533297000507;38028.80985595071;38841.417378739345;38846.83459496216;38961.805190974075;38079.80960095196;38229.61770382295;38234.23531529368;38279.80860095696;38296.234075318476;2684.7986401019953;2739.671239451269;2835.4896118698625;2917.081119447378;2919.357741296911;2894.016034548253;2928.853557322136;2929.340898297887;2930.326025014248;2943.6467623885164;2903.6951120132294;2923.9912230280624;2935.060780550225;2935.163478408654;2941.529355303152;2897.1018984114994;2904.4191161767626;2931.3697555025665;2947.8673459694364;2948.6609039960463;2895.1459319500796;2906.912792616225;2918.7373136417614;2918.751906087985;2922.225610213295;39121.63074292386;39361.60638393608;39477;39574.802125989474;39599.80200098981;3044.939101217963;3056.3581647853757;3073.185605814461;3085.861136248852;3120.1419609607315;29119.70880291191;29193.97821076252;29598.852005739835;30195.245118871986;30342;2807.5928990296293;2814.6200262964444;2833.8016338856287;2844.9431011379866;2857.2142660768454;235388;239497;271037;350231;351949;49171.75414122907;49494;49636.751816240685;49675.50324496781;49770.25344619834;51137.48862511402;51210;51573.74213128985;51581.22628160581;51806;14475.78286325706;14566.053206541541;14694.338754755849;14698.926505367404;14701.191434471206;12004.819927701092;12005.579804706793;12008.63974080779;12015.279083255033;12040.578579749666;13863.514776982756;13873.156003019356;13877.722445551033;13887.930560347133;13991.650208744863;4987.35922776368;5872.007035216094;5897.0269905465975;5911.497522710618;5947.167396564484;853;963.3352986439335;1013.8202863842797;1050.9579616815242;1053.9894601054045;24335.391615209406;24358.025678972997;24565.385865353153;24678.753212468004;24776.628350574756;964.6816550538306;1032.256775121911;1091.3670071358592;1108.318384193715;1145.3471521232818;8830.381873268938;11948.16604436631;12203.328816915155;12523.74952500963;12544.560940367044;384440;435638;437237.6276237197;438894;440204;45306.546934530896;55676;56309.71845140748;56365.7181714097;56452;1327.9601611951657;1439.7912302716047;1527.6868242010362;1535.3781718404064;1538.907665540071;24045.63931540993;26016.34959125961;28356.291092722022;28400.289992750346;28983.710162898944;49531;49989;50106;50308;50317;309584;364785.17607411795;372215;377314;378285;29371.55942660819;31449.21376965594;32012.8795492166;32048.718051277687;32734.50898236481;40067.79966100151;40105.99735006648;40150.996225094605;41037;41530.792346039285;32447.67552324541;33820.27976922586;34772.65227347694;35676.64323356837;36349.45475817918;34555;34617;34718.13204669904;35672.64327356693;35690.28619427649;34835.65164348324;35279;35455.82272088623;35598.28803423969;35713.28573428569;30007.549886752153;31384.686153138176;31713.365732684757;31741;31784.205394865312;22628.773712262668;23735.28794136179;24272;24476.14333498319;25044 16:57:57 INFO - PID 1643 | |2;jquery.html;373.3578245417881;411.4157895787979;414.3908454571778;422.5689796407663;437.5165442186384;19970.20119195232;21005.894970525143;21702;21846.45383865404;21877.67183492249;18534.814651853478;21543.784562154375;22020.779792202073;22733.20433784818;22843.200487982926;4220.978895105528;4407.272799987998;4436.268015777409;4447.533009034053;4454.37638730578;4329.220740266751;4331.783410829462;4394.934075988863;4399.604035636792;4403.889902752425;3706.8331925063435;4321.243782338094;4352.673549483786;4352.804123814421;4356.281213599752;4312.870613881589;4338.457692788402;4346.739195648272;4350.8912277193;4355.150745604608;3299.290652509722;3906.0234941264684;3992.0818211811447;4027.536833264183;4027.9597204027878;25047.872845721806;25754.227373178834;27147;27536;27806;1631.3230009546023;1981.3659628918751;1996.0219492448741;1996.2613832881782;2016.667249903764;15684.902056856025;16284.674306513922;16579.50261492157;16937.068461234627;17653.25594338879;1693.2295805408633;1700.4473546097568;1717.7423386492;1738.0440757583406;1745.834145756164;128147.35926320402;145639;149856;157590.42409575873;176599.11700441543;11577.247478914012;12153.84538468844;12906.29015404143;12930.806037909439;13276.867231327757;16427.83572164287;16524.25640846165;16546.751798723028;16551.172441377883;16561.91719041397;7551.924480755122;8784.297256219486;9143.54282285883;9159.771005724777;9208.309376796633;8735;8788.648454061893;8798.472091674392;8965.596548155349;8994.685186018458;8056.556889371141;8241.587920603946;8276.131006244377;8294.958525207456;8302.294304984143;2170.121100954116;2186.726659167604;2187;2189.179057853305;2407.001094545779;945.2863088368238;948.1419315519466;964.0744884910564;984.6602921991902;987.0770829274651;19270;20347.491312717302;21772.45568860791;21872.562548748934;21901.452463688536;895.2658819767728;963.4315753705207;978.4276198424002;993.2600212841479;1008.4201584089178;8233.876491852627;9772.706818795305;11099.889001110047;11179.66461006171;11222.04612607921;673475;675008;694152;697345;725005.3749731323;112892.09755317213;130253.34873325573;134777;139725;150292.24853875878;1080.9459527023616;1206.1617176062728;1229.5450683247077;1257.616426989777;1260.911736178477;16794.58013549622;21267;22580.870956451785;22633.773662263167;22731.65902511497;55663.60840979008;56633.433665662815;57046.42953570577;62129.75740485256;62643;60677.69661151666;70208.64895675489;83506.74739879028;86649;87601.56199218963;6261.186045814015;6695.397414232742;8462.19609137131;8580.528070956158;8601.483910965111;11248.381339026431;12540.87459125397;13434.529791457253;13732.970027248197;13806.792898106738;11435.885641143816;11565.768684626428;11602.593909213474;11722.062235021007;11866.644000679993;9284.535773211448;9565.569549370433;10238.129758970274;11350.978411942964;11785.057195424173;9941.801163976535;11466.2546934449;11709.648710538697;11764.058875290128;11767.823482647596;8380.287675547646;8571.699990500303;8612.181842725182;8819.338549608678;8950.462972221687;11580.42097895085;11606.013488853541;11767.823482647938;11848.822267665819;11981.981531569914 16:57:57 INFO - PID 1643 | |3;mootools.html;1385.2242744063326;1402.2077526197697;1413.3993052952505;1414.3918115210456;1444.8482909294523;8929.821403571932;10312.845307320396;10431.530581123849;10741.301815381994;10777.892221077807;10477;10644.840327395075;10657.520411581478;10676.733081672943;10697.572097116126;2379.8215133864987;2419.1532963462737;2422.200673777658;2423.8060955123547;2429.307647320505;2130.4673831542113;2266.784655457729;2356.846804957681;2412.746661600533;2424.9878750606313;1955.7848636650028;1965.3317871923543;2406.4104294447884;2436.062116085311;2437.098273638756;2020.6261841559358;2281.3840263129027;2392.0431827269144;2400.327908185702;2411.5056413435204;1866.6466811561645;2039.2047101630376;2325.186184835311;2385.5348207099623;2446.9143579974616;8746.431481953652;10443.268971172021;10520.526576304084;10813.75641801195;10835;6118.388161183891;6372.681365931731;6374.713137908805;6389.904151437732;6425.646589437579;3934.4098385242155;4001.9399709004388;4044.2720310344125;4048.291548978917;4078;1139.800534906388;1160.1878684920505;1174.4127936031985;1210.703377672467;1212.4968138222628;14663.633409164857;14765;14852.851471485363;14864;14896.478623248135;5248.6588371755715;5403.2165336026055;5445.319335083114;5651.463111004448;5660.094384898396;10963.50664220112;11201;11280.32318060919;11324.886751132548;11353.921377469127;6197.1324014637985;6253.624782513064;6256.217972753406;6258.74965001404;6262.3111457739615;5703.458171473703;5728.656280623176;5832.88334233313;5839.2992840858515;5860.8534786629825;3997.2882966247303;4130.855420060284;4149.751014939114;4176.519700234451;4183.769892655872;1248.9812652810215;1250.2373552133192;1264.3109505319624;1264.7091169031175;1268.0616343905444;631.712570780303;762.6720510180564;788.4993029426356;791.1969351108629;826.1201820061615;5788.942110578924;6316.463100636405;6346.619202847844;6409.55133140685;6681.832954176088;554.5674373988215;562.1455387810505;572.4990633195954;574.3108270075926;588.9705514724246;3612.3317186320614;3760.793156376371;3767.7550959187565;3807.4098514730263;3835.6164383561977;12892.162009469355;13516.729665406638;13803.51687690926;13864.930675346559;13898.444062237599;10798.946005269923;13621.455141794217;13645.38595763193;13648.24934628605;13665.248411337472;10032.297739158335;10107.595696172219;10122.39265644049;10216.591336346462;10259.487025648688;6163.84590385244;6311.337309582428;6367.395097465734;6380.904286435614;6488.545801794018;11866.762664746484;12085.939570302093;12371.69070773238;12372.505099796268;12399.628011159679;11971.10216733731;12537.435815388511;12784.872151278369;12829.679258018625;12904.225746455242;7779.494332868346;9958.900410996088;10078.949605251926;10085.69742907714;10101.040401161878;9601.55976603515;9816.312858099864;9843.655472058443;9933.255005874733;9950.402975821475;7896.881546776688;8458.450200736932;8738.737837864874;8765.780855478664;9085.818283634158;7092.645367731489;8775.956120219358;8793.164649358301;8809;8862.20240178387;7560.243975602396;7686.615669216629;7762.8447431049935;7774.844503109793;7781.105172904962;5699.572532060195;5764.855878602901;5808.099744539603;5875.089361149029;5924.555658325729;5817.680027598353;5869.900400085421;6014.127951447103;6028.517718582415;6099.207103076749 16:57:57 INFO - PID 1643 | |4;prototype.html;320.32571437124835;336.7911894625333;378.31713756669217;396.5281315234869;401.93569028955375;5666.781641946981;5974.864775692616;6290.528210384222;6385.201849768779;6424.004279336698;5995.940040599593;6158.692065396724;6174.857651334495;6197.783077592285;6216.658083805401;4641.767911604423;4644.258403098838;4649.976750116245;4653.418322709661;4655.394798676184;3968.9206215875665;4216.810243539048;4618.1687296286655;4624.520153550865;4658.184817656914;4523.5024147343765;4526.434195725535;4546.408966834323;4548.840790572331;4584.129015487063;3743.8128093595346;4580.610648094899;4583.610393116589;4599.2871104978785;4639.930401043987;3443.0359499340225;3804.752691075071;3922.7057970652313;3933.213357328546;3947.17109407022;4930.260460930889;5678.3186017678145;5991.730372133221;6021.608595441282;6024.8493787655225;4468.620167285784;4484.910301793979;4713.505081966413;5370.194470829368;5405.945940540623;5397.379301380313;5604.1593760935775;5823.272090988627;6035.387090006292;6638;3381.4589665653625;3713.721470889694;4359.520452750195;4389.253826849444;4395.406620106277;6002.429769171922;6019.428154325332;6542.771003014919;6761.661916904184;6972.79081627552;3723.4600982857332;3887.989122828085;4325.502567204811;4451.243288640939;4503.639708823286;3799.886003419902;4079.265732168179;4358.978205109018;4526.954730452653;4570.885727856764;4969.062065794343;5216.817411390583;5340.172273297645;5397.622166448389;5434.402215756264;5148.716820574829;5151.5621172200035;6362.331955144736;6633.635150066696;6675.332466753286;1540.353051718281;1553.9145347006024;1554.2694933381292;1554.3704799555971;1572.4182052640597;1001.762822913701;1006.8540061691014;1011.5397494140149;1030.304544432505;1063.9095676867398;4901.485344038896;5503.587230957694;5537.916931246034;6055.909161362583;6291.683527419324;5627.774889004394;6820.795376138723;6821.727130914807;6835.282295358916;6840.418564421981;5267.604929630293;5886.882262354815;6214;6303.212098487689;6341.397567231105;3278.868845246211;3278.999905028989;3486.33759585683;3616.150204701893;3639.253952939641;6347.365263473615;6708.53040287185;7152;7190.784276471714;7201.3518783309755;6702.932970670328;6810.693518791666;7023.8244043898285;7071.100848652028;7121.643917804089;6847.109875716224;7157.821054473576;7180.533265337736;7200.387967022862;7203.372896934832;6404.615723056631;6409.9038514423255;6852.8286792828585;6883.896741548981;6903.965480172567;5066.442691304027;5242.925200333846;5805.82582522525;6656.866862662817;6776.390124888587;7280.344768970818;7302.890456643261;7318.890216646648;7322.633868306457;7324.487285889936;3794.6774524165753;3952.6837852972267;4501.707389019703;4515;4525.072360166224;5285.814996475105;5310.9734451327495;6851.691673874788;6860.245373009065;6958.130233720785;6665.233498147775;6701.631410272482;6729.327067293231;6739.865202696017;6770.796876093725;6443.67781610927;6656.7670131545165;6683.532152749455;6713.295104014008;6724.260331363644;6537.248216455168;6575.934240657532;6589.505787065893;6591.769288074895;6598;6529.379708927644;6649.966750166218;6696.363845434676;6713.026611141455;6749.907528666129;6513.934860651333;6518.706658200297;6524.086627872007;6547.345265473605;6558.475321974326 16:57:57 INFO - PID 1643 | |5;yui.html;617.5646169450538;725.8475720098779;733.6368497593692;733.9596322202281;742.8365759532904;13080.149790263638;15102;16200.837991620081;16238.512844614666;16327.346906123741;15017.474388396407;15148.015379000384;15296.617584560392;15307.770383444229;15308.46420375287;897.6947837735185;922.7600823785831;942.4722155592856;970.3401686852937;974.1768205866032;993.7118235711634;993.8459538771502;995.2833959549113;997.7705127820606;1000.8498725191207;1029.1201023125232;1029.53156313877;1030.0523518363125;1030.618671091697;1030.9329893556933;1009.6112996496329;1018.5416562546884;1018.6485662446444;1021.7905329407454;1024.713080337503;748.6668432547518;768.6041688530412;768.7271018788362;769.5613500304828;769.6882762481204;16215.756763648555;16472.83527164725;16614.335426582922;16753.162341882857;17082.97502149875;14701.485448009269;14703;14814.703705925822;14893.77659335111;14982.925085374613;11520.654380368602;11680.766384672259;11696.649100526998;11739.445210302414;12073.396330183456;3042.361104168105;3055.847207639609;3062.693730626942;3093.721565059133;3165.446046941776;102322.48838755833;104474.81336342682;106316.46841765742;106889;107985;11423.371714555778;11442.485088171052;11480.885191148149;11736.647900562997;11893.226940248856;21054.684179737316;24635.753642463704;24846.751532484806;24904.75095249024;24973.62539561908;7650.081990161217;7810.648520816577;7832.725854595062;7887.526748395115;7892.881606775903;4095.9795201023803;4179.519355274121;4192.4759405074365;4198.6011328923705;4207.663386929038;3435.3129374125274;4092.7748973806724;4145.481814773153;4182.038131229834;4189.581041895847;783.5768684910199;788.1291173253587;789.0707220845094;789.8420315936836;810.5622963599708;562.5134258866051;566.6684989281316;568.2243737298558;587.4683411512588;598.3448124303881;8155.184481551797;9474.38416502925;9652.90347096534;10019.476518870397;10115.739815296152;538.9326334208224;558.3634656491603;580.9331926828385;586.1325238646826;601.2004034633926;4487.981103237517;4581.289900065429;4630.282306242538;4686.203345431285;4715.528447155257;96819.51590242004;98995.01004990003;99698;100892;101188.97622047664;84672.15327846765;85974;87922.56038719765;89190.10809891818;89195;77372;78735.99999999885;78825.60587197027;79736.80394794083;79804.20195798084;9360.11078947499;9386.48374339418;9428.057194280516;9435.914869789787;9491.905080949378;28674.713252867205;29352.09211401252;32051.519227212077;33222.667773321955;36848;45581.77209113933;45976;46658;47095;47117.52882471131;9758;11505.367204803817;11557.87624148126;11732.296062236293;12017;12242.283398879596;12453.315067671003;12528.373581320715;12559.120861539604;13002.739945200854;11698.883011169779;11728.70678233017;11749.530018799152;12026.75946481048;12173.208741432132;11328.716782080184;11445.25605835618;11662;12007.099467539794;12056.994535790367;8619.655213791379;11523.481443335239;11837.822432663344;11904.761904761683;12314.322712250912;9862.112409883144;10008.542424061627;10053.597856085675;10075.748106297107;10730.785384292114;8600.440971336842;8702.651893924172;9049.321300902327;9955.50222488887;9997.500124993867 16:57:57 INFO - PID 1643 | __end_tp_report 16:57:57 INFO - PID 1643 | __start_cc_report 16:57:57 INFO - PID 1643 | _x_x_mozilla_cycle_collect,422 16:57:57 INFO - PID 1643 | __end_cc_report 16:57:57 INFO - PID 1643 | __startTimestamp1490140677668__endTimestamp 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | ------- Summary: start ------- 16:57:57 INFO - PID 1643 | Number of tests: 6 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6101.62 Median:6337.84 stddev:756.80 (11.9%) stddev-sans-first:714.51 16:57:57 INFO - PID 1643 | Values: 2838.0 3553.5 3568.8 3584.0 3626.2 4373.4 4909.6 4964.8 6129.4 6199.9 6110.0 6142.7 6190.5 6202.9 6204.5 5433.9 5500.6 5501.6 5559.1 5583.4 4880.5 5583.9 5640.7 5641.9 5860.9 5496.7 5535.3 5554.6 5593.0 5593.4 5559.3 5577.0 5580.2 5588.0 5592.6 5521.7 5541.0 5566.6 5595.4 5634.9 4926.9 5692.9 6123.7 6181.5 6204.9 6653.3 6654.5 6657.5 6676.4 6680.3 6751.1 6765.2 6768.5 6781.8 6784.3 6142.1 6183.9 6244.2 6257.1 6291.7 6049.9 6643.3 6883.5 6902.0 6956.3 6337.8 6415.2 6421.2 6519.3 6579.6 6602.4 6736.7 6740.3 6752.9 6759.2 6411.5 6504.0 6575.5 6658.6 6676.5 5521.8 6582.9 6644.1 6663.7 6712.3 5337.8 5346.8 5352.0 5356.5 5377.8 4713.3 4734.1 4738.7 4795.3 4804.9 6223.9 6252.2 6276.0 6281.1 6283.1 6758.0 6778.6 6780.0 6786.3 6789.4 5638.2 6298.1 6317.6 6342.5 6354.9 5787.7 5796.7 5801.9 5804.7 5826.7 6783.8 6909.6 6951.8 6975.0 6978.0 6704.1 6749.1 6753.0 6759.1 6762.3 6651.7 6931.3 6978.4 6984.1 7019.7 5826.6 6569.4 6595.0 6647.6 6658.9 5538.4 6473.6 6505.4 6693.1 6719.8 6410.1 6506.9 6507.1 6512.1 6512.7 6508.7 6522.6 6537.0 6539.9 6542.4 4959.3 5958.0 6098.7 6315.7 6400.5 6529.2 6533.5 6555.7 6556.1 6557.8 5893.6 6356.9 6367.1 6371.4 6374.2 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:49825.86 Median:170348.77 stddev:96970.60 (56.9%) stddev-sans-first:97172.59 16:57:57 INFO - PID 1643 | Values: 736.2 741.8 805.6 806.5 826.9 31113.5 38028.8 38841.4 38846.8 38961.8 38079.8 38229.6 38234.2 38279.8 38296.2 2684.8 2739.7 2835.5 2917.1 2919.4 2894.0 2928.9 2929.3 2930.3 2943.6 2903.7 2924.0 2935.1 2935.2 2941.5 2897.1 2904.4 2931.4 2947.9 2948.7 2895.1 2906.9 2918.7 2918.8 2922.2 39121.6 39361.6 39477.0 39574.8 39599.8 3044.9 3056.4 3073.2 3085.9 3120.1 29119.7 29194.0 29598.9 30195.2 30342.0 2807.6 2814.6 2833.8 2844.9 2857.2 235388.0 239497.0 271037.0 350231.0 351949.0 49171.8 49494.0 49636.8 49675.5 49770.3 51137.5 51210.0 51573.7 51581.2 51806.0 14475.8 14566.1 14694.3 14698.9 14701.2 12004.8 12005.6 12008.6 12015.3 12040.6 13863.5 13873.2 13877.7 13887.9 13991.7 4987.4 5872.0 5897.0 5911.5 5947.2 853.0 963.3 1013.8 1051.0 1054.0 24335.4 24358.0 24565.4 24678.8 24776.6 964.7 1032.3 1091.4 1108.3 1145.3 8830.4 11948.2 12203.3 12523.7 12544.6 384440.0 435638.0 437237.6 438894.0 440204.0 45306.5 55676.0 56309.7 56365.7 56452.0 1328.0 1439.8 1527.7 1535.4 1538.9 24045.6 26016.3 28356.3 28400.3 28983.7 49531.0 49989.0 50106.0 50308.0 50317.0 309584.0 364785.2 372215.0 377314.0 378285.0 29371.6 31449.2 32012.9 32048.7 32734.5 40067.8 40106.0 40151.0 41037.0 41530.8 32447.7 33820.3 34772.7 35676.6 36349.5 34555.0 34617.0 34718.1 35672.6 35690.3 34835.7 35279.0 35455.8 35598.3 35713.3 30007.5 31384.7 31713.4 31741.0 31784.2 22628.8 23735.3 24272.0 24476.1 25044.0 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:39261.15 Median:13727.44 stddev:115844.72 (843.9%) stddev-sans-first:116132.90 16:57:57 INFO - PID 1643 | Values: 373.4 411.4 414.4 422.6 437.5 19970.2 21005.9 21702.0 21846.5 21877.7 18534.8 21543.8 22020.8 22733.2 22843.2 4221.0 4407.3 4436.3 4447.5 4454.4 4329.2 4331.8 4394.9 4399.6 4403.9 3706.8 4321.2 4352.7 4352.8 4356.3 4312.9 4338.5 4346.7 4350.9 4355.2 3299.3 3906.0 3992.1 4027.5 4028.0 25047.9 25754.2 27147.0 27536.0 27806.0 1631.3 1981.4 1996.0 1996.3 2016.7 15684.9 16284.7 16579.5 16937.1 17653.3 1693.2 1700.4 1717.7 1738.0 1745.8 128147.4 145639.0 149856.0 157590.4 176599.1 11577.2 12153.8 12906.3 12930.8 13276.9 16427.8 16524.3 16546.8 16551.2 16561.9 7551.9 8784.3 9143.5 9159.8 9208.3 8735.0 8788.6 8798.5 8965.6 8994.7 8056.6 8241.6 8276.1 8295.0 8302.3 2170.1 2186.7 2187.0 2189.2 2407.0 945.3 948.1 964.1 984.7 987.1 19270.0 20347.5 21772.5 21872.6 21901.5 895.3 963.4 978.4 993.3 1008.4 8233.9 9772.7 11099.9 11179.7 11222.0 673475.0 675008.0 694152.0 697345.0 725005.4 112892.1 130253.3 134777.0 139725.0 150292.2 1080.9 1206.2 1229.5 1257.6 1260.9 16794.6 21267.0 22580.9 22633.8 22731.7 55663.6 56633.4 57046.4 62129.8 62643.0 60677.7 70208.6 83506.7 86649.0 87601.6 6261.2 6695.4 8462.2 8580.5 8601.5 11248.4 12540.9 13434.5 13733.0 13806.8 11435.9 11565.8 11602.6 11722.1 11866.6 9284.5 9565.6 10238.1 11351.0 11785.1 9941.8 11466.3 11709.6 11764.1 11767.8 8380.3 8571.7 8612.2 8819.3 8950.5 11580.4 11606.0 11767.8 11848.8 11982.0 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:6663.30 Median:3029.62 stddev:4118.62 (135.9%) stddev-sans-first:4111.07 16:57:57 INFO - PID 1643 | Values: 1385.2 1402.2 1413.4 1414.4 1444.8 8929.8 10312.8 10431.5 10741.3 10777.9 10477.0 10644.8 10657.5 10676.7 10697.6 2379.8 2419.2 2422.2 2423.8 2429.3 2130.5 2266.8 2356.8 2412.7 2425.0 1955.8 1965.3 2406.4 2436.1 2437.1 2020.6 2281.4 2392.0 2400.3 2411.5 1866.6 2039.2 2325.2 2385.5 2446.9 8746.4 10443.3 10520.5 10813.8 10835.0 6118.4 6372.7 6374.7 6389.9 6425.6 3934.4 4001.9 4044.3 4048.3 4078.0 1139.8 1160.2 1174.4 1210.7 1212.5 14663.6 14765.0 14852.9 14864.0 14896.5 5248.7 5403.2 5445.3 5651.5 5660.1 10963.5 11201.0 11280.3 11324.9 11353.9 6197.1 6253.6 6256.2 6258.7 6262.3 5703.5 5728.7 5832.9 5839.3 5860.9 3997.3 4130.9 4149.8 4176.5 4183.8 1249.0 1250.2 1264.3 1264.7 1268.1 631.7 762.7 788.5 791.2 826.1 5788.9 6316.5 6346.6 6409.6 6681.8 554.6 562.1 572.5 574.3 589.0 3612.3 3760.8 3767.8 3807.4 3835.6 12892.2 13516.7 13803.5 13864.9 13898.4 10798.9 13621.5 13645.4 13648.2 13665.2 10032.3 10107.6 10122.4 10216.6 10259.5 6163.8 6311.3 6367.4 6380.9 6488.5 11866.8 12085.9 12371.7 12372.5 12399.6 11971.1 12537.4 12784.9 12829.7 12904.2 7779.5 9958.9 10078.9 10085.7 10101.0 9601.6 9816.3 9843.7 9933.3 9950.4 7896.9 8458.5 8738.7 8765.8 9085.8 7092.6 8776.0 8793.2 8809.0 8862.2 7560.2 7686.6 7762.8 7774.8 7781.1 5699.6 5764.9 5808.1 5875.1 5924.6 5817.7 5869.9 6014.1 6028.5 6099.2 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5280.29 Median:5742.07 stddev:1710.45 (29.8%) stddev-sans-first:1674.24 16:57:57 INFO - PID 1643 | Values: 320.3 336.8 378.3 396.5 401.9 5666.8 5974.9 6290.5 6385.2 6424.0 5995.9 6158.7 6174.9 6197.8 6216.7 4641.8 4644.3 4650.0 4653.4 4655.4 3968.9 4216.8 4618.2 4624.5 4658.2 4523.5 4526.4 4546.4 4548.8 4584.1 3743.8 4580.6 4583.6 4599.3 4639.9 3443.0 3804.8 3922.7 3933.2 3947.2 4930.3 5678.3 5991.7 6021.6 6024.8 4468.6 4484.9 4713.5 5370.2 5405.9 5397.4 5604.2 5823.3 6035.4 6638.0 3381.5 3713.7 4359.5 4389.3 4395.4 6002.4 6019.4 6542.8 6761.7 6972.8 3723.5 3888.0 4325.5 4451.2 4503.6 3799.9 4079.3 4359.0 4527.0 4570.9 4969.1 5216.8 5340.2 5397.6 5434.4 5148.7 5151.6 6362.3 6633.6 6675.3 1540.4 1553.9 1554.3 1554.4 1572.4 1001.8 1006.9 1011.5 1030.3 1063.9 4901.5 5503.6 5537.9 6055.9 6291.7 5627.8 6820.8 6821.7 6835.3 6840.4 5267.6 5886.9 6214.0 6303.2 6341.4 3278.9 3279.0 3486.3 3616.2 3639.3 6347.4 6708.5 7152.0 7190.8 7201.4 6702.9 6810.7 7023.8 7071.1 7121.6 6847.1 7157.8 7180.5 7200.4 7203.4 6404.6 6409.9 6852.8 6883.9 6904.0 5066.4 5242.9 5805.8 6656.9 6776.4 7280.3 7302.9 7318.9 7322.6 7324.5 3794.7 3952.7 4501.7 4515.0 4525.1 5285.8 5311.0 6851.7 6860.2 6958.1 6665.2 6701.6 6729.3 6739.9 6770.8 6443.7 6656.8 6683.5 6713.3 6724.3 6537.2 6575.9 6589.5 6591.8 6598.0 6529.4 6650.0 6696.4 6713.0 6749.9 6513.9 6518.7 6524.1 6547.3 6558.5 16:57:57 INFO - PID 1643 | 16:57:57 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:19097.10 Median:18328.99 stddev:27969.97 (152.6%) stddev-sans-first:28014.02 16:57:57 INFO - PID 1643 | Values: 617.6 725.8 733.6 734.0 742.8 13080.1 15102.0 16200.8 16238.5 16327.3 15017.5 15148.0 15296.6 15307.8 15308.5 897.7 922.8 942.5 970.3 974.2 993.7 993.8 995.3 997.8 1000.8 1029.1 1029.5 1030.1 1030.6 1030.9 1009.6 1018.5 1018.6 1021.8 1024.7 748.7 768.6 768.7 769.6 769.7 16215.8 16472.8 16614.3 16753.2 17083.0 14701.5 14703.0 14814.7 14893.8 14982.9 11520.7 11680.8 11696.6 11739.4 12073.4 3042.4 3055.8 3062.7 3093.7 3165.4 102322.5 104474.8 106316.5 106889.0 107985.0 11423.4 11442.5 11480.9 11736.6 11893.2 21054.7 24635.8 24846.8 24904.8 24973.6 7650.1 7810.6 7832.7 7887.5 7892.9 4096.0 4179.5 4192.5 4198.6 4207.7 3435.3 4092.8 4145.5 4182.0 4189.6 783.6 788.1 789.1 789.8 810.6 562.5 566.7 568.2 587.5 598.3 8155.2 9474.4 9652.9 10019.5 10115.7 538.9 558.4 580.9 586.1 601.2 4488.0 4581.3 4630.3 4686.2 4715.5 96819.5 98995.0 99698.0 100892.0 101189.0 84672.2 85974.0 87922.6 89190.1 89195.0 77372.0 78736.0 78825.6 79736.8 79804.2 9360.1 9386.5 9428.1 9435.9 9491.9 28674.7 29352.1 32051.5 33222.7 36848.0 45581.8 45976.0 46658.0 47095.0 47117.5 9758.0 11505.4 11557.9 11732.3 12017.0 12242.3 12453.3 12528.4 12559.1 13002.7 11698.9 11728.7 11749.5 12026.8 12173.2 11328.7 11445.3 11662.0 12007.1 12057.0 8619.7 11523.5 11837.8 11904.8 12314.3 9862.1 10008.5 10053.6 10075.7 10730.8 8600.4 8702.7 9049.3 9955.5 9997.5 16:57:57 INFO - PID 1643 | -------- Summary: end -------- 16:57:57 INFO - PID 1643 | 16:57:58 INFO - TEST-INFO | 1643: exit 0 16:57:58 INFO - TEST-OK | dromaeo_css | took 1117307ms 16:57:58 INFO - TEST-START | kraken 16:57:58 INFO - operating with platform_type : mac_ 16:57:58 INFO - Initialising browser for kraken test... 16:57:58 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpX1QC1S/profile http://localhost:49254/getInfo.html) 16:58:01 INFO - PID 1651 | 2017-03-21 16:58:01.253 plugin-container[1652:10229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 16:58:01 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:58:01 INFO - PID 1651 | 2017-03-21 16:58:01.257 plugin-container[1652:10229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.CFPasteboardClient' 16:58:01 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:58:01 INFO - PID 1651 | 2017-03-21 16:58:01.257 plugin-container[1652:10229] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:58:01 INFO - PID 1651 | __metrics Screen width/height:1600/1200 16:58:01 INFO - PID 1651 | colorDepth:24 16:58:01 INFO - PID 1651 | Browser inner width/height: 1024/689 16:58:01 INFO - PID 1651 | __metrics 16:58:01 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 16:58:02 INFO - TEST-INFO | 1651: exit 0 16:58:02 INFO - Browser initialized. 16:58:02 INFO - Running cycle 1/1 for kraken test... 16:58:02 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpX1QC1S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:04 INFO - PID 1653 | 2017-03-21 16:58:04.667 plugin-container[1654:10360] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 16:58:04 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:58:04 INFO - PID 1653 | 2017-03-21 16:58:04.667 plugin-container[1654:10360] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 16:58:04 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:58:04 INFO - PID 1653 | 2017-03-21 16:58:04.667 plugin-container[1654:10360] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:58:14 INFO - PID 1653 | RSS: Main: 227856384 16:58:14 INFO - PID 1653 | 16:58:17 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:18 INFO - PID 1653 | RSS: Main: 242204672 16:58:18 INFO - PID 1653 | 16:58:20 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-dft) 16:58:21 INFO - PID 1653 | RSS: Main: 250535936 16:58:21 INFO - PID 1653 | 16:58:24 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-fft) 16:58:25 INFO - PID 1653 | RSS: Main: 253132800 16:58:25 INFO - PID 1653 | 16:58:27 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49254/tests/kraken/driver.html?testName=audio-oscillator) 16:58:28 INFO - PID 1653 | RSS: Main: 254279680 16:58:28 INFO - PID 1653 | 16:58:30 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49254/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:30 INFO - PID 1653 | RSS: Main: 256024576 16:58:30 INFO - PID 1653 | 16:58:33 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49254/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:34 INFO - PID 1653 | RSS: Main: 261165056 16:58:34 INFO - PID 1653 | 16:58:37 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49254/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:38 INFO - PID 1653 | RSS: Main: 261922816 16:58:38 INFO - PID 1653 | 16:58:41 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49254/tests/kraken/driver.html?testName=json-parse-financial) 16:58:41 INFO - PID 1653 | RSS: Main: 261869568 16:58:41 INFO - PID 1653 | 16:58:43 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49254/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:44 INFO - PID 1653 | RSS: Main: 261386240 16:58:44 INFO - PID 1653 | 16:58:46 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:46 INFO - PID 1653 | RSS: Main: 261369856 16:58:46 INFO - PID 1653 | 16:58:49 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:49 INFO - PID 1653 | RSS: Main: 261427200 16:58:49 INFO - PID 1653 | 16:58:52 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:53 INFO - PID 1653 | RSS: Main: 261873664 16:58:53 INFO - PID 1653 | 16:58:56 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:57 INFO - PID 1653 | RSS: Main: 259588096 16:58:57 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49254/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49254/tests/kraken/driver.html?testName=ai-astar) 16:58:59 INFO - PID 1653 | RSS: Main: 261337088 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | __start_tp_report 16:58:59 INFO - PID 1653 | _x_x_mozilla_page_load 16:58:59 INFO - PID 1653 | _x_x_mozilla_page_load_details 16:58:59 INFO - PID 1653 | |i|pagename|runs| 16:58:59 INFO - PID 1653 | |0;ai-astar;102;115;114;114;118;138;114;114;115;137 16:58:59 INFO - PID 1653 | |1;audio-beat-detection;146;137;146;196;122;127;100;125;178;149 16:58:59 INFO - PID 1653 | |2;audio-dft;198;206;208;219;219;198;200;195;201;193 16:58:59 INFO - PID 1653 | |3;audio-fft;78;58;60;84;62;60;57;59;74;60 16:58:59 INFO - PID 1653 | |4;audio-oscillator;92;72;84;70;71;70;84;97;105;121 16:58:59 INFO - PID 1653 | |5;imaging-gaussian-blur;92;89;89;95;90;94;96;89;82;134 16:58:59 INFO - PID 1653 | |6;imaging-darkroom;97;98;97;97;97;106;110;98;96;154 16:58:59 INFO - PID 1653 | |7;imaging-desaturate;142;104;88;93;93;90;136;126;122;102 16:58:59 INFO - PID 1653 | |8;json-parse-financial;68;67;67;66;70;67;66;80;104;106 16:58:59 INFO - PID 1653 | |9;json-stringify-tinderbox;58;57;69;61;67;73;79;56;57;58 16:58:59 INFO - PID 1653 | |10;stanford-crypto-aes;81;85;85;73;98;77;85;100;76;110 16:58:59 INFO - PID 1653 | |11;stanford-crypto-ccm;151;145;153;135;131;136;152;141;212;145 16:58:59 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;233;238;194;252;240;200;214;177;237;228 16:58:59 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;69;68;74;68;57;84;81;98;97;101 16:58:59 INFO - PID 1653 | __end_tp_report 16:58:59 INFO - PID 1653 | __start_cc_report 16:58:59 INFO - PID 1653 | _x_x_mozilla_cycle_collect,996 16:58:59 INFO - PID 1653 | __end_cc_report 16:58:59 INFO - PID 1653 | __startTimestamp1490140739695__endTimestamp 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | ------- Summary: start ------- 16:58:59 INFO - PID 1653 | Number of tests: 14 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:118.10 Median:115.00 stddev:11.05 (9.6%) stddev-sans-first:10.07 16:58:59 INFO - PID 1653 | Values: 102.0 115.0 114.0 114.0 118.0 138.0 114.0 114.0 115.0 137.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:146.00 stddev:27.87 (19.1%) stddev-sans-first:29.54 16:58:59 INFO - PID 1653 | Values: 146.0 137.0 146.0 196.0 122.0 127.0 100.0 125.0 178.0 149.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:203.70 Median:203.50 stddev:9.24 (4.5%) stddev-sans-first:9.57 16:58:59 INFO - PID 1653 | Values: 198.0 206.0 208.0 219.0 219.0 198.0 200.0 195.0 201.0 193.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:65.20 Median:61.00 stddev:9.68 (15.9%) stddev-sans-first:9.09 16:58:59 INFO - PID 1653 | Values: 78.0 58.0 60.0 84.0 62.0 60.0 57.0 59.0 74.0 60.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:78.00 stddev:17.26 (22.1%) stddev-sans-first:18.19 16:58:59 INFO - PID 1653 | Values: 92.0 72.0 84.0 70.0 71.0 70.0 84.0 97.0 105.0 121.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:91.00 stddev:14.28 (15.7%) stddev-sans-first:15.10 16:58:59 INFO - PID 1653 | Values: 92.0 89.0 89.0 95.0 90.0 94.0 96.0 89.0 82.0 134.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:97.00 stddev:17.83 (18.4%) stddev-sans-first:18.68 16:58:59 INFO - PID 1653 | Values: 97.0 98.0 97.0 97.0 97.0 106.0 110.0 98.0 96.0 154.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:109.60 Median:115.00 stddev:20.17 (17.5%) stddev-sans-first:17.66 16:58:59 INFO - PID 1653 | Values: 142.0 104.0 88.0 93.0 93.0 90.0 136.0 126.0 122.0 102.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:76.10 Median:67.00 stddev:15.79 (23.6%) stddev-sans-first:16.47 16:58:59 INFO - PID 1653 | Values: 68.0 67.0 67.0 66.0 70.0 67.0 66.0 80.0 104.0 106.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:8.03 (12.5%) stddev-sans-first:8.27 16:58:59 INFO - PID 1653 | Values: 58.0 57.0 69.0 61.0 67.0 73.0 79.0 56.0 57.0 58.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:83.00 stddev:11.94 (14.4%) stddev-sans-first:12.47 16:58:59 INFO - PID 1653 | Values: 81.0 85.0 85.0 73.0 98.0 77.0 85.0 100.0 76.0 110.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:148.00 stddev:23.02 (15.6%) stddev-sans-first:24.42 16:58:59 INFO - PID 1653 | Values: 151.0 145.0 153.0 135.0 131.0 136.0 152.0 141.0 212.0 145.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:221.30 Median:235.00 stddev:24.07 (10.2%) stddev-sans-first:25.15 16:58:59 INFO - PID 1653 | Values: 233.0 238.0 194.0 252.0 240.0 200.0 214.0 177.0 237.0 228.0 16:58:59 INFO - PID 1653 | 16:58:59 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:77.50 stddev:15.07 (19.4%) stddev-sans-first:15.48 16:58:59 INFO - PID 1653 | Values: 69.0 68.0 74.0 68.0 57.0 84.0 81.0 98.0 97.0 101.0 16:58:59 INFO - PID 1653 | -------- Summary: end -------- 16:58:59 INFO - PID 1653 | 16:59:00 INFO - TEST-INFO | 1653: exit 0 16:59:00 INFO - TEST-OK | kraken | took 62248ms 16:59:00 INFO - SUITE-END | took 1179s 16:59:00 INFO - Completed test suite (00:19:39) 16:59:00 INFO - javascript benchmark 16:59:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7352.530454347771, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2837.9574306385407, 3553.5380400547942, 3568.768030078045, 3584.0, 3626.2203626220366, 4373.365861950016, 4909.5581397674205, 4964.7765850536725, 6129.387061293868, 6199.907001394971, 6109.981658125348, 6142.7443454968825, 6190.504759619231, 6202.937970620293, 6204.503639708823, 5433.864153396157, 5500.559955203574, 5501.559875209973, 5559.082751346023, 5583.35791383991, 4880.487548807378, 5583.8604034899045, 5640.689762063085, 5641.887162256752, 5860.945029894618, 5496.697681627509, 5535.308086489189, 5554.638948468337, 5592.965301419251, 5593.3847276799515, 5559.332880054379, 5576.996140694673, 5580.218769372291, 5588.022096133161, 5592.636478628876, 5521.723913804293, 5541.030319694038, 5566.610337276392, 5595.38450770415, 5634.859128521779, 4926.876828079291, 5692.946804841117, 6123.6938153092615, 6181.505479561624, 6204.906926396107, 6653.334666533308, 6654.534182607219, 6657.500687448461, 6676.432503237231, 6680.298568650271, 6751.054852320679, 6765.2219994700745, 6768.458523318122, 6781.830454238634, 6784.253732089466, 6142.069075791408, 6183.9381606183815, 6244.219472565929, 6257.124002639634, 6291.748330066837, 6049.879002419927, 6643.302453242437, 6883.518153729191, 6902.033715279765, 6956.304369563003, 6337.841553961096, 6415.166028416276, 6421.229452465734, 6519.348065193442, 6579.572327798678, 6602.40578347951, 6736.696848641823, 6740.29226931175, 6752.864942701119, 6759.2226893906845, 6411.487081033506, 6504.0243963405865, 6575.539712220098, 6658.6337751424135, 6676.46588272937, 5521.779128834802, 6582.868342633121, 6644.103046088813, 6663.733450661919, 6712.295209003082, 5337.81317653888, 5346.8395948121615, 5352.0366334060245, 5356.544693701079, 5377.784888604412, 4713.316569097462, 4734.147853386355, 4738.715677059387, 4795.304680821261, 4804.903901921942, 6223.875522489525, 6252.155958945484, 6275.96862015687, 6281.057841323838, 6283.08895210192, 6757.986302054731, 6778.593284402951, 6780.0, 6786.287439818847, 6789.388954994074, 5638.182463542763, 6298.0552917062805, 6317.5893566918, 6342.5243106767175, 6354.872902541923, 5787.7395517200985, 5796.710164491758, 5801.854953626109, 5804.6807425592, 5826.708664566755, 6783.796486105425, 6909.550879192836, 6951.826204344932, 6975.0, 6977.965110174619, 6704.128463299739, 6749.122614060141, 6752.966235168793, 6759.087523184307, 6762.256151823394, 6651.700673469609, 6931.306869313028, 6978.371946524837, 6984.126984126984, 7019.6841142147705, 5826.563007774349, 6569.408753212234, 6594.967025164843, 6647.634380109141, 6658.900116498353, 5538.446155384429, 6473.643949582818, 6505.447037001908, 6693.09643198162, 6719.798406047827, 6410.0705397718, 6506.869862602816, 6507.121538592419, 6512.088307637029, 6512.739490420519, 6508.73965041412, 6522.608643481406, 6537.0, 6539.934600653933, 6542.411182993554, 4959.330490383896, 5958.0, 6098.6742875288965, 6315.747370105144, 6400.455961243347, 6529.151210342625, 6533.542652014504, 6555.704993275219, 6556.082148499118, 6557.836054098686, 5893.557983151367, 6356.872862542816, 6367.076773867856, 6371.362863713592, 6374.171357723466], "value": 6051.8442782004795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.2453485177693, 741.8279118991993, 805.6012273924408, 806.5080301016383, 826.9379796515259, 31113.533297000507, 38028.80985595071, 38841.417378739345, 38846.83459496216, 38961.805190974075, 38079.80960095196, 38229.61770382295, 38234.23531529368, 38279.80860095696, 38296.234075318476, 2684.7986401019953, 2739.671239451269, 2835.4896118698625, 2917.081119447378, 2919.357741296911, 2894.016034548253, 2928.853557322136, 2929.340898297887, 2930.326025014248, 2943.6467623885164, 2903.6951120132294, 2923.9912230280624, 2935.060780550225, 2935.163478408654, 2941.529355303152, 2897.1018984114994, 2904.4191161767626, 2931.3697555025665, 2947.8673459694364, 2948.6609039960463, 2895.1459319500796, 2906.912792616225, 2918.7373136417614, 2918.751906087985, 2922.225610213295, 39121.63074292386, 39361.60638393608, 39477.0, 39574.802125989474, 39599.80200098981, 3044.939101217963, 3056.3581647853757, 3073.185605814461, 3085.861136248852, 3120.1419609607315, 29119.70880291191, 29193.97821076252, 29598.852005739835, 30195.245118871986, 30342.0, 2807.5928990296293, 2814.6200262964444, 2833.8016338856287, 2844.9431011379866, 2857.2142660768454, 235388.0, 239497.0, 271037.0, 350231.0, 351949.0, 49171.75414122907, 49494.0, 49636.751816240685, 49675.50324496781, 49770.25344619834, 51137.48862511402, 51210.0, 51573.74213128985, 51581.22628160581, 51806.0, 14475.78286325706, 14566.053206541541, 14694.338754755849, 14698.926505367404, 14701.191434471206, 12004.819927701092, 12005.579804706793, 12008.63974080779, 12015.279083255033, 12040.578579749666, 13863.514776982756, 13873.156003019356, 13877.722445551033, 13887.930560347133, 13991.650208744863, 4987.35922776368, 5872.007035216094, 5897.0269905465975, 5911.497522710618, 5947.167396564484, 853.0, 963.3352986439335, 1013.8202863842797, 1050.9579616815242, 1053.9894601054045, 24335.391615209406, 24358.025678972997, 24565.385865353153, 24678.753212468004, 24776.628350574756, 964.6816550538306, 1032.256775121911, 1091.3670071358592, 1108.318384193715, 1145.3471521232818, 8830.381873268938, 11948.16604436631, 12203.328816915155, 12523.74952500963, 12544.560940367044, 384440.0, 435638.0, 437237.6276237197, 438894.0, 440204.0, 45306.546934530896, 55676.0, 56309.71845140748, 56365.7181714097, 56452.0, 1327.9601611951657, 1439.7912302716047, 1527.6868242010362, 1535.3781718404064, 1538.907665540071, 24045.63931540993, 26016.34959125961, 28356.291092722022, 28400.289992750346, 28983.710162898944, 49531.0, 49989.0, 50106.0, 50308.0, 50317.0, 309584.0, 364785.17607411795, 372215.0, 377314.0, 378285.0, 29371.55942660819, 31449.21376965594, 32012.8795492166, 32048.718051277687, 32734.50898236481, 40067.79966100151, 40105.99735006648, 40150.996225094605, 41037.0, 41530.792346039285, 32447.67552324541, 33820.27976922586, 34772.65227347694, 35676.64323356837, 36349.45475817918, 34555.0, 34617.0, 34718.13204669904, 35672.64327356693, 35690.28619427649, 34835.65164348324, 35279.0, 35455.82272088623, 35598.28803423969, 35713.28573428569, 30007.549886752153, 31384.686153138176, 31713.365732684757, 31741.0, 31784.205394865312, 22628.773712262668, 23735.28794136179, 24272.0, 24476.14333498319, 25044.0], "value": 15350.283310884994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3578245417881, 411.4157895787979, 414.3908454571778, 422.5689796407663, 437.5165442186384, 19970.20119195232, 21005.894970525143, 21702.0, 21846.45383865404, 21877.67183492249, 18534.814651853478, 21543.784562154375, 22020.779792202073, 22733.20433784818, 22843.200487982926, 4220.978895105528, 4407.272799987998, 4436.268015777409, 4447.533009034053, 4454.37638730578, 4329.220740266751, 4331.783410829462, 4394.934075988863, 4399.604035636792, 4403.889902752425, 3706.8331925063435, 4321.243782338094, 4352.673549483786, 4352.804123814421, 4356.281213599752, 4312.870613881589, 4338.457692788402, 4346.739195648272, 4350.8912277193, 4355.150745604608, 3299.290652509722, 3906.0234941264684, 3992.0818211811447, 4027.536833264183, 4027.9597204027878, 25047.872845721806, 25754.227373178834, 27147.0, 27536.0, 27806.0, 1631.3230009546023, 1981.3659628918751, 1996.0219492448741, 1996.2613832881782, 2016.667249903764, 15684.902056856025, 16284.674306513922, 16579.50261492157, 16937.068461234627, 17653.25594338879, 1693.2295805408633, 1700.4473546097568, 1717.7423386492, 1738.0440757583406, 1745.834145756164, 128147.35926320402, 145639.0, 149856.0, 157590.42409575873, 176599.11700441543, 11577.247478914012, 12153.84538468844, 12906.29015404143, 12930.806037909439, 13276.867231327757, 16427.83572164287, 16524.25640846165, 16546.751798723028, 16551.172441377883, 16561.91719041397, 7551.924480755122, 8784.297256219486, 9143.54282285883, 9159.771005724777, 9208.309376796633, 8735.0, 8788.648454061893, 8798.472091674392, 8965.596548155349, 8994.685186018458, 8056.556889371141, 8241.587920603946, 8276.131006244377, 8294.958525207456, 8302.294304984143, 2170.121100954116, 2186.726659167604, 2187.0, 2189.179057853305, 2407.001094545779, 945.2863088368238, 948.1419315519466, 964.0744884910564, 984.6602921991902, 987.0770829274651, 19270.0, 20347.491312717302, 21772.45568860791, 21872.562548748934, 21901.452463688536, 895.2658819767728, 963.4315753705207, 978.4276198424002, 993.2600212841479, 1008.4201584089178, 8233.876491852627, 9772.706818795305, 11099.889001110047, 11179.66461006171, 11222.04612607921, 673475.0, 675008.0, 694152.0, 697345.0, 725005.3749731323, 112892.09755317213, 130253.34873325573, 134777.0, 139725.0, 150292.24853875878, 1080.9459527023616, 1206.1617176062728, 1229.5450683247077, 1257.616426989777, 1260.911736178477, 16794.58013549622, 21267.0, 22580.870956451785, 22633.773662263167, 22731.65902511497, 55663.60840979008, 56633.433665662815, 57046.42953570577, 62129.75740485256, 62643.0, 60677.69661151666, 70208.64895675489, 83506.74739879028, 86649.0, 87601.56199218963, 6261.186045814015, 6695.397414232742, 8462.19609137131, 8580.528070956158, 8601.483910965111, 11248.381339026431, 12540.87459125397, 13434.529791457253, 13732.970027248197, 13806.792898106738, 11435.885641143816, 11565.768684626428, 11602.593909213474, 11722.062235021007, 11866.644000679993, 9284.535773211448, 9565.569549370433, 10238.129758970274, 11350.978411942964, 11785.057195424173, 9941.801163976535, 11466.2546934449, 11709.648710538697, 11764.058875290128, 11767.823482647596, 8380.287675547646, 8571.699990500303, 8612.181842725182, 8819.338549608678, 8950.462972221687, 11580.42097895085, 11606.013488853541, 11767.823482647938, 11848.822267665819, 11981.981531569914], "value": 9820.300718673136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.2242744063326, 1402.2077526197697, 1413.3993052952505, 1414.3918115210456, 1444.8482909294523, 8929.821403571932, 10312.845307320396, 10431.530581123849, 10741.301815381994, 10777.892221077807, 10477.0, 10644.840327395075, 10657.520411581478, 10676.733081672943, 10697.572097116126, 2379.8215133864987, 2419.1532963462737, 2422.200673777658, 2423.8060955123547, 2429.307647320505, 2130.4673831542113, 2266.784655457729, 2356.846804957681, 2412.746661600533, 2424.9878750606313, 1955.7848636650028, 1965.3317871923543, 2406.4104294447884, 2436.062116085311, 2437.098273638756, 2020.6261841559358, 2281.3840263129027, 2392.0431827269144, 2400.327908185702, 2411.5056413435204, 1866.6466811561645, 2039.2047101630376, 2325.186184835311, 2385.5348207099623, 2446.9143579974616, 8746.431481953652, 10443.268971172021, 10520.526576304084, 10813.75641801195, 10835.0, 6118.388161183891, 6372.681365931731, 6374.713137908805, 6389.904151437732, 6425.646589437579, 3934.4098385242155, 4001.9399709004388, 4044.2720310344125, 4048.291548978917, 4078.0, 1139.800534906388, 1160.1878684920505, 1174.4127936031985, 1210.703377672467, 1212.4968138222628, 14663.633409164857, 14765.0, 14852.851471485363, 14864.0, 14896.478623248135, 5248.6588371755715, 5403.2165336026055, 5445.319335083114, 5651.463111004448, 5660.094384898396, 10963.50664220112, 11201.0, 11280.32318060919, 11324.886751132548, 11353.921377469127, 6197.1324014637985, 6253.624782513064, 6256.217972753406, 6258.74965001404, 6262.3111457739615, 5703.458171473703, 5728.656280623176, 5832.88334233313, 5839.2992840858515, 5860.8534786629825, 3997.2882966247303, 4130.855420060284, 4149.751014939114, 4176.519700234451, 4183.769892655872, 1248.9812652810215, 1250.2373552133192, 1264.3109505319624, 1264.7091169031175, 1268.0616343905444, 631.712570780303, 762.6720510180564, 788.4993029426356, 791.1969351108629, 826.1201820061615, 5788.942110578924, 6316.463100636405, 6346.619202847844, 6409.55133140685, 6681.832954176088, 554.5674373988215, 562.1455387810505, 572.4990633195954, 574.3108270075926, 588.9705514724246, 3612.3317186320614, 3760.793156376371, 3767.7550959187565, 3807.4098514730263, 3835.6164383561977, 12892.162009469355, 13516.729665406638, 13803.51687690926, 13864.930675346559, 13898.444062237599, 10798.946005269923, 13621.455141794217, 13645.38595763193, 13648.24934628605, 13665.248411337472, 10032.297739158335, 10107.595696172219, 10122.39265644049, 10216.591336346462, 10259.487025648688, 6163.84590385244, 6311.337309582428, 6367.395097465734, 6380.904286435614, 6488.545801794018, 11866.762664746484, 12085.939570302093, 12371.69070773238, 12372.505099796268, 12399.628011159679, 11971.10216733731, 12537.435815388511, 12784.872151278369, 12829.679258018625, 12904.225746455242, 7779.494332868346, 9958.900410996088, 10078.949605251926, 10085.69742907714, 10101.040401161878, 9601.55976603515, 9816.312858099864, 9843.655472058443, 9933.255005874733, 9950.402975821475, 7896.881546776688, 8458.450200736932, 8738.737837864874, 8765.780855478664, 9085.818283634158, 7092.645367731489, 8775.956120219358, 8793.164649358301, 8809.0, 8862.20240178387, 7560.243975602396, 7686.615669216629, 7762.8447431049935, 7774.844503109793, 7781.105172904962, 5699.572532060195, 5764.855878602901, 5808.099744539603, 5875.089361149029, 5924.555658325729, 5817.680027598353, 5869.900400085421, 6014.127951447103, 6028.517718582415, 6099.207103076749], "value": 5024.343350256285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.32571437124835, 336.7911894625333, 378.31713756669217, 396.5281315234869, 401.93569028955375, 5666.781641946981, 5974.864775692616, 6290.528210384222, 6385.201849768779, 6424.004279336698, 5995.940040599593, 6158.692065396724, 6174.857651334495, 6197.783077592285, 6216.658083805401, 4641.767911604423, 4644.258403098838, 4649.976750116245, 4653.418322709661, 4655.394798676184, 3968.9206215875665, 4216.810243539048, 4618.1687296286655, 4624.520153550865, 4658.184817656914, 4523.5024147343765, 4526.434195725535, 4546.408966834323, 4548.840790572331, 4584.129015487063, 3743.8128093595346, 4580.610648094899, 4583.610393116589, 4599.2871104978785, 4639.930401043987, 3443.0359499340225, 3804.752691075071, 3922.7057970652313, 3933.213357328546, 3947.17109407022, 4930.260460930889, 5678.3186017678145, 5991.730372133221, 6021.608595441282, 6024.8493787655225, 4468.620167285784, 4484.910301793979, 4713.505081966413, 5370.194470829368, 5405.945940540623, 5397.379301380313, 5604.1593760935775, 5823.272090988627, 6035.387090006292, 6638.0, 3381.4589665653625, 3713.721470889694, 4359.520452750195, 4389.253826849444, 4395.406620106277, 6002.429769171922, 6019.428154325332, 6542.771003014919, 6761.661916904184, 6972.79081627552, 3723.4600982857332, 3887.989122828085, 4325.502567204811, 4451.243288640939, 4503.639708823286, 3799.886003419902, 4079.265732168179, 4358.978205109018, 4526.954730452653, 4570.885727856764, 4969.062065794343, 5216.817411390583, 5340.172273297645, 5397.622166448389, 5434.402215756264, 5148.716820574829, 5151.5621172200035, 6362.331955144736, 6633.635150066696, 6675.332466753286, 1540.353051718281, 1553.9145347006024, 1554.2694933381292, 1554.3704799555971, 1572.4182052640597, 1001.762822913701, 1006.8540061691014, 1011.5397494140149, 1030.304544432505, 1063.9095676867398, 4901.485344038896, 5503.587230957694, 5537.916931246034, 6055.909161362583, 6291.683527419324, 5627.774889004394, 6820.795376138723, 6821.727130914807, 6835.282295358916, 6840.418564421981, 5267.604929630293, 5886.882262354815, 6214.0, 6303.212098487689, 6341.397567231105, 3278.868845246211, 3278.999905028989, 3486.33759585683, 3616.150204701893, 3639.253952939641, 6347.365263473615, 6708.53040287185, 7152.0, 7190.784276471714, 7201.3518783309755, 6702.932970670328, 6810.693518791666, 7023.8244043898285, 7071.100848652028, 7121.643917804089, 6847.109875716224, 7157.821054473576, 7180.533265337736, 7200.387967022862, 7203.372896934832, 6404.615723056631, 6409.9038514423255, 6852.8286792828585, 6883.896741548981, 6903.965480172567, 5066.442691304027, 5242.925200333846, 5805.82582522525, 6656.866862662817, 6776.390124888587, 7280.344768970818, 7302.890456643261, 7318.890216646648, 7322.633868306457, 7324.487285889936, 3794.6774524165753, 3952.6837852972267, 4501.707389019703, 4515.0, 4525.072360166224, 5285.814996475105, 5310.9734451327495, 6851.691673874788, 6860.245373009065, 6958.130233720785, 6665.233498147775, 6701.631410272482, 6729.327067293231, 6739.865202696017, 6770.796876093725, 6443.67781610927, 6656.7670131545165, 6683.532152749455, 6713.295104014008, 6724.260331363644, 6537.248216455168, 6575.934240657532, 6589.505787065893, 6591.769288074895, 6598.0, 6529.379708927644, 6649.966750166218, 6696.363845434676, 6713.026611141455, 6749.907528666129, 6513.934860651333, 6518.706658200297, 6524.086627872007, 6547.345265473605, 6558.475321974326], "value": 4745.161756330092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.5646169450538, 725.8475720098779, 733.6368497593692, 733.9596322202281, 742.8365759532904, 13080.149790263638, 15102.0, 16200.837991620081, 16238.512844614666, 16327.346906123741, 15017.474388396407, 15148.015379000384, 15296.617584560392, 15307.770383444229, 15308.46420375287, 897.6947837735185, 922.7600823785831, 942.4722155592856, 970.3401686852937, 974.1768205866032, 993.7118235711634, 993.8459538771502, 995.2833959549113, 997.7705127820606, 1000.8498725191207, 1029.1201023125232, 1029.53156313877, 1030.0523518363125, 1030.618671091697, 1030.9329893556933, 1009.6112996496329, 1018.5416562546884, 1018.6485662446444, 1021.7905329407454, 1024.713080337503, 748.6668432547518, 768.6041688530412, 768.7271018788362, 769.5613500304828, 769.6882762481204, 16215.756763648555, 16472.83527164725, 16614.335426582922, 16753.162341882857, 17082.97502149875, 14701.485448009269, 14703.0, 14814.703705925822, 14893.77659335111, 14982.925085374613, 11520.654380368602, 11680.766384672259, 11696.649100526998, 11739.445210302414, 12073.396330183456, 3042.361104168105, 3055.847207639609, 3062.693730626942, 3093.721565059133, 3165.446046941776, 102322.48838755833, 104474.81336342682, 106316.46841765742, 106889.0, 107985.0, 11423.371714555778, 11442.485088171052, 11480.885191148149, 11736.647900562997, 11893.226940248856, 21054.684179737316, 24635.753642463704, 24846.751532484806, 24904.75095249024, 24973.62539561908, 7650.081990161217, 7810.648520816577, 7832.725854595062, 7887.526748395115, 7892.881606775903, 4095.9795201023803, 4179.519355274121, 4192.4759405074365, 4198.6011328923705, 4207.663386929038, 3435.3129374125274, 4092.7748973806724, 4145.481814773153, 4182.038131229834, 4189.581041895847, 783.5768684910199, 788.1291173253587, 789.0707220845094, 789.8420315936836, 810.5622963599708, 562.5134258866051, 566.6684989281316, 568.2243737298558, 587.4683411512588, 598.3448124303881, 8155.184481551797, 9474.38416502925, 9652.90347096534, 10019.476518870397, 10115.739815296152, 538.9326334208224, 558.3634656491603, 580.9331926828385, 586.1325238646826, 601.2004034633926, 4487.981103237517, 4581.289900065429, 4630.282306242538, 4686.203345431285, 4715.528447155257, 96819.51590242004, 98995.01004990003, 99698.0, 100892.0, 101188.97622047664, 84672.15327846765, 85974.0, 87922.56038719765, 89190.10809891818, 89195.0, 77372.0, 78735.99999999885, 78825.60587197027, 79736.80394794083, 79804.20195798084, 9360.11078947499, 9386.48374339418, 9428.057194280516, 9435.914869789787, 9491.905080949378, 28674.713252867205, 29352.09211401252, 32051.519227212077, 33222.667773321955, 36848.0, 45581.77209113933, 45976.0, 46658.0, 47095.0, 47117.52882471131, 9758.0, 11505.367204803817, 11557.87624148126, 11732.296062236293, 12017.0, 12242.283398879596, 12453.315067671003, 12528.373581320715, 12559.120861539604, 13002.739945200854, 11698.883011169779, 11728.70678233017, 11749.530018799152, 12026.75946481048, 12173.208741432132, 11328.716782080184, 11445.25605835618, 11662.0, 12007.099467539794, 12056.994535790367, 8619.655213791379, 11523.481443335239, 11837.822432663344, 11904.761904761683, 12314.322712250912, 9862.112409883144, 10008.542424061627, 10053.597856085675, 10075.748106297107, 10730.785384292114, 8600.440971336842, 8702.651893924172, 9049.321300902327, 9955.50222488887, 9997.500124993867], "value": 7263.302158318405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 114.0, 114.0, 118.0, 138.0, 114.0, 114.0, 115.0, 137.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 137.0, 146.0, 196.0, 122.0, 127.0, 100.0, 125.0, 178.0, 149.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 206.0, 208.0, 219.0, 219.0, 198.0, 200.0, 195.0, 201.0, 193.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 84.0, 62.0, 60.0, 57.0, 59.0, 74.0, 60.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 72.0, 84.0, 70.0, 71.0, 70.0, 84.0, 97.0, 105.0, 121.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 89.0, 95.0, 90.0, 94.0, 96.0, 89.0, 82.0, 134.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 97.0, 97.0, 106.0, 110.0, 98.0, 96.0, 154.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 104.0, 88.0, 93.0, 93.0, 90.0, 136.0, 126.0, 122.0, 102.0], "value": 109.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 70.0, 67.0, 66.0, 80.0, 104.0, 106.0], "value": 76.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 69.0, 61.0, 67.0, 73.0, 79.0, 56.0, 57.0, 58.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 85.0, 73.0, 98.0, 77.0, 85.0, 100.0, 76.0, 110.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 145.0, 153.0, 135.0, 131.0, 136.0, 152.0, 141.0, 212.0, 145.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [233.0, 238.0, 194.0, 252.0, 240.0, 200.0, 214.0, 177.0, 237.0, 228.0], "value": 221.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 68.0, 57.0, 84.0, 81.0, 98.0, 97.0, 101.0], "value": 79.7, "unit": "score"}]}]} 16:59:00 INFO - Return code: 0 16:59:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:59:01 ERROR - # TBPL SUCCESS # 16:59:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:59:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:59:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:59:01 INFO - 2017-03-21 16:59:01.016 screenresolution[1658:10752] starting screenresolution argv=screenresolution get 16:59:01 INFO - 2017-03-21 16:59:01.018 screenresolution[1658:10752] Display 0: 1600x1200x32@60 16:59:01 INFO - 2017-03-21 16:59:01.025 screenresolution[1659:10755] starting screenresolution argv=screenresolution list 16:59:01 INFO - Available Modes on Display 0 16:59:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:59:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:59:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:59:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:59:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:59:01 INFO - Intel Iris: 16:59:01 INFO - Chipset Model: Intel Iris 16:59:01 INFO - Type: GPU 16:59:01 INFO - Bus: Built-In 16:59:01 INFO - VRAM (Dynamic, Max): 1536 MB 16:59:01 INFO - Vendor: Intel (0x8086) 16:59:01 INFO - Device ID: 0x0a2e 16:59:01 INFO - Revision ID: 0x0009 16:59:01 INFO - Displays: 16:59:01 INFO - Display: 16:59:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:59:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:59:01 INFO - Display Serial Number: 1600x1200 60 16:59:01 INFO - Main Display: Yes 16:59:01 INFO - Mirror: Off 16:59:01 INFO - Online: Yes 16:59:01 INFO - Rotation: Supported 16:59:01 INFO - Return code: 0 16:59:01 INFO - Running post-action listener: _resource_record_post_action 16:59:01 INFO - [mozharness: 2017-03-21 23:59:01.265853Z] Finished run-tests step (success) 16:59:01 INFO - Running post-run listener: _resource_record_post_run 16:59:01 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 34628096; Write bytes: 513643520; Read time: 318; Write time: 1884 16:59:01 INFO - TinderboxPrint: CPU usage
54.1% 16:59:01 INFO - TinderboxPrint: I/O read bytes / time
34,628,096 / 318 16:59:01 INFO - TinderboxPrint: I/O write bytes / time
513,643,520 / 1,884 16:59:01 INFO - TinderboxPrint: CPU idle
2,204.8 (45.9%) 16:59:01 INFO - TinderboxPrint: CPU system
966.2 (20.1%) 16:59:01 INFO - TinderboxPrint: CPU user
1,630.5 (34.0%) 16:59:01 INFO - TinderboxPrint: Swap in / out
241,160,192 / 0 16:59:01 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 206084608; Write bytes: 203790336; Read time: 15737; Write time: 468 16:59:01 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 32731648; Write bytes: 299047936; Read time: 300; Write time: 1381 16:59:01 INFO - Running post-run listener: _upload_blobber_files 16:59:01 INFO - Blob upload gear active. 16:59:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:59:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:59:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:03 INFO - (blobuploader) - INFO - Done attempting. 16:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:04 INFO - (blobuploader) - INFO - Done attempting. 16:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:05 INFO - (blobuploader) - INFO - Done attempting. 16:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:59:07 INFO - (blobuploader) - INFO - Done attempting. 16:59:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:59:07 INFO - Return code: 0 16:59:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:59:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:59:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39a779f85a8f23c2573d4b43c1acac5a6b840365b776798c8d3e00296cb52aa33668e98c2a551b32b493a8ef8366956cc4b1c3d7c0442008ed610decdde846c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d89c0b8521af4cda72ac171a6e8adc8c12159b9beb2a43be2f0b76f739c7b8389e24fdb8aa249a62852b2dabb3294684e2b2baad25855a31bb499b691bfc2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de6847beb8fedfa0ab1fa490afb9419c9cdc49edde3d5822feb61e282d35a4c2dd8febd636f696c7b38ba5538260656328b1124055f568ae314f4914d2cfeb9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/498e24edaa0260be1b86558b232ba2afe4d9125f30dfe2a8fb00b93b36b036a9d57cf6d77aeb2b0b41034468e1c073bdd1e28bc723733f3b36b4b177b1267ad8"} 16:59:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:59:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:59:07 INFO - Contents: 16:59:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39a779f85a8f23c2573d4b43c1acac5a6b840365b776798c8d3e00296cb52aa33668e98c2a551b32b493a8ef8366956cc4b1c3d7c0442008ed610decdde846c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d89c0b8521af4cda72ac171a6e8adc8c12159b9beb2a43be2f0b76f739c7b8389e24fdb8aa249a62852b2dabb3294684e2b2baad25855a31bb499b691bfc2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de6847beb8fedfa0ab1fa490afb9419c9cdc49edde3d5822feb61e282d35a4c2dd8febd636f696c7b38ba5538260656328b1124055f568ae314f4914d2cfeb9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/498e24edaa0260be1b86558b232ba2afe4d9125f30dfe2a8fb00b93b36b036a9d57cf6d77aeb2b0b41034468e1c073bdd1e28bc723733f3b36b4b177b1267ad8"} 16:59:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:59:07 INFO - Copying logs to upload dir... 16:59:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:59:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.782917 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-21 16:59:08.044065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:08.047501) ========= 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.DIOR0NfHiq/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.mqfaeSApyp/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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/d39a779f85a8f23c2573d4b43c1acac5a6b840365b776798c8d3e00296cb52aa33668e98c2a551b32b493a8ef8366956cc4b1c3d7c0442008ed610decdde846c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d89c0b8521af4cda72ac171a6e8adc8c12159b9beb2a43be2f0b76f739c7b8389e24fdb8aa249a62852b2dabb3294684e2b2baad25855a31bb499b691bfc2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de6847beb8fedfa0ab1fa490afb9419c9cdc49edde3d5822feb61e282d35a4c2dd8febd636f696c7b38ba5538260656328b1124055f568ae314f4914d2cfeb9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/498e24edaa0260be1b86558b232ba2afe4d9125f30dfe2a8fb00b93b36b036a9d57cf6d77aeb2b0b41034468e1c073bdd1e28bc723733f3b36b4b177b1267ad8"} build_url:https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/YRC9RbOcSXW-nyAOhGrzfg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d39a779f85a8f23c2573d4b43c1acac5a6b840365b776798c8d3e00296cb52aa33668e98c2a551b32b493a8ef8366956cc4b1c3d7c0442008ed610decdde846c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/37d89c0b8521af4cda72ac171a6e8adc8c12159b9beb2a43be2f0b76f739c7b8389e24fdb8aa249a62852b2dabb3294684e2b2baad25855a31bb499b691bfc2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de6847beb8fedfa0ab1fa490afb9419c9cdc49edde3d5822feb61e282d35a4c2dd8febd636f696c7b38ba5538260656328b1124055f568ae314f4914d2cfeb9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/498e24edaa0260be1b86558b232ba2afe4d9125f30dfe2a8fb00b93b36b036a9d57cf6d77aeb2b0b41034468e1c073bdd1e28bc723733f3b36b4b177b1267ad8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:08.082547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:08.082827) ========= 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.DIOR0NfHiq/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.mqfaeSApyp/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.005166 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 16:59:08.131856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 16:59:08.132121) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 16:59:08.132412) ========= ========= Total master_lag: 0.19 =========