builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0190 starttime: 1489077510.41 results: success (0) buildid: 20170309072024 builduid: 253b8d1dbfcb4f3a887508c390a440b9 revision: 34585620e529614c79ecc007705646de748e592d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.410123) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.410555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.411368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.438759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.439037) ========= 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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-09 08:38:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.9M=0.001s 2017-03-09 08:38:30 (17.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117887 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.580957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.581284) ========= 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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.021293 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:30.629592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 08:38:30.629949) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34585620e529614c79ecc007705646de748e592d --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 34585620e529614c79ecc007705646de748e592d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jJnCbX8JQY/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.JTIuD7R4CU/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-09 08:38:30,715 truncating revision to first 12 chars 2017-03-09 08:38:30,715 Setting DEBUG logging. 2017-03-09 08:38:30,715 attempt 1/10 2017-03-09 08:38:30,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34585620e529?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 08:38:31,514 unpacking tar archive at: mozilla-central-34585620e529/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 08:38:31.707282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:31.707609) ========= script_repo_revision: 34585620e529614c79ecc007705646de748e592d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:31.708026) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:31.708297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 08:38:31.728056) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-09 08:38:31.728443) ========= /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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:38:31 INFO - MultiFileLogger online at 20170309 08:38:31 in /builds/slave/test 08:38:31 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 08:38:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:31 INFO - {'append_to_log': False, 08:38:31 INFO - 'base_work_dir': '/builds/slave/test', 08:38:31 INFO - 'blob_upload_branch': 'Firefox', 08:38:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:31 INFO - 'branch': 'Firefox', 08:38:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:31 INFO - 'config_files': ('talos/mac_config.py',), 08:38:31 INFO - 'default_actions': ('clobber', 08:38:31 INFO - 'read-buildbot-config', 08:38:31 INFO - 'download-and-extract', 08:38:31 INFO - 'populate-webroot', 08:38:31 INFO - 'create-virtualenv', 08:38:31 INFO - 'install', 08:38:31 INFO - 'run-tests'), 08:38:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:31 INFO - 'download_minidump_stackwalk': True, 08:38:31 INFO - 'download_symbols': 'ondemand', 08:38:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:31 INFO - 'gecko_profile': False, 08:38:31 INFO - 'gecko_profile_interval': 0, 08:38:31 INFO - 'installer_path': 'installer.exe', 08:38:31 INFO - 'log_level': 'info', 08:38:31 INFO - 'log_name': 'talos', 08:38:31 INFO - 'log_to_console': True, 08:38:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:38:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:38:31 INFO - 'opt_config_files': (), 08:38:31 INFO - 'pip_index': False, 08:38:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:31 INFO - 'cmd': ('bash', 08:38:31 INFO - '-c', 08:38:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:31 INFO - 'enabled': True, 08:38:31 INFO - 'halt_on_failure': False, 08:38:31 INFO - 'name': 'check_screen_resolution'},), 08:38:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:31 INFO - 'cmd': ('bash', 08:38:31 INFO - '-c', 08:38:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:31 INFO - 'enabled': True, 08:38:31 INFO - 'halt_on_failure': False, 08:38:31 INFO - 'name': 'check_screen_resolution'},), 08:38:31 INFO - 'run_cmd_checks_enabled': True, 08:38:31 INFO - 'suite': 'dromaeojs-e10s', 08:38:31 INFO - 'system_bits': '32', 08:38:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:31 INFO - 'title': 't-yosemite-r7-0190', 08:38:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:31 INFO - 'use_talos_json': True, 08:38:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:31 INFO - 'work_dir': 'build'} 08:38:31 INFO - [mozharness: 2017-03-09 16:38:31.937861Z] Running clobber step. 08:38:31 INFO - Running pre-action listener: _resource_record_pre_action 08:38:31 INFO - Running main action method: clobber 08:38:31 INFO - rmtree: /builds/slave/test/build 08:38:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:33 INFO - Running post-action listener: _resource_record_post_action 08:38:33 INFO - [mozharness: 2017-03-09 16:38:33.781027Z] Finished clobber step (success) 08:38:33 INFO - [mozharness: 2017-03-09 16:38:33.781198Z] Running read-buildbot-config step. 08:38:33 INFO - Running pre-action listener: _resource_record_pre_action 08:38:33 INFO - Running main action method: read_buildbot_config 08:38:33 INFO - Using buildbot properties: 08:38:33 INFO - { 08:38:33 INFO - "project": "", 08:38:33 INFO - "product": "firefox", 08:38:33 INFO - "script_repo_revision": "production", 08:38:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:38:33 INFO - "repository": "", 08:38:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:38:33 INFO - "buildid": "20170309072024", 08:38:33 INFO - "pgo_build": "False", 08:38:33 INFO - "basedir": "/builds/slave/test", 08:38:33 INFO - "buildnumber": 108, 08:38:33 INFO - "slavename": "t-yosemite-r7-0190", 08:38:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:38:33 INFO - "platform": "yosemite_r7", 08:38:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:38:33 INFO - "branch": "mozilla-central", 08:38:33 INFO - "repo_path": "mozilla-central", 08:38:33 INFO - "revision": "34585620e529614c79ecc007705646de748e592d", 08:38:33 INFO - "stage_platform": "macosx64", 08:38:33 INFO - "builduid": "253b8d1dbfcb4f3a887508c390a440b9", 08:38:33 INFO - "slavebuilddir": "test" 08:38:33 INFO - } 08:38:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:38:33 INFO - Running post-action listener: _resource_record_post_action 08:38:33 INFO - [mozharness: 2017-03-09 16:38:33.784660Z] Finished read-buildbot-config step (success) 08:38:33 INFO - [mozharness: 2017-03-09 16:38:33.784797Z] Running download-and-extract step. 08:38:33 INFO - Running pre-action listener: _resource_record_pre_action 08:38:33 INFO - Running main action method: download_and_extract 08:38:33 INFO - mkdir: /builds/slave/test/build/tests 08:38:33 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')]} 08:38:33 INFO - trying https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/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 08:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/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 08:38:34 INFO - Downloaded 1199 bytes. 08:38:34 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:34 INFO - Using the following test package requirements: 08:38:34 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:38:34 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:38:34 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:38:34 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'jsshell-mac.zip'], 08:38:34 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:38:34 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:38:34 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:38:34 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:38:34 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:38:34 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:34 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:38:34 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:38:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:38:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:38:34 INFO - Fetch https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:38:36 INFO - Expected file size: 51788385 08:38:36 INFO - Obtained file size: 51788385 08:38:52 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 08:38:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:38:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:38:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:38:54 INFO - Expected file size: 51788385 08:38:54 INFO - Obtained file size: 51788385 08:39:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:39:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:39:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:39:11 INFO - Expected file size: 14404424 08:39:11 INFO - Obtained file size: 14404424 08:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:12 INFO - trying https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/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 08:39:14 INFO - Downloaded 74928021 bytes. 08:39:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:14 INFO - mkdir: /builds/slave/test/properties 08:39:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:39:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:39:14 INFO - Contents: 08:39:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:14 INFO - Running post-action listener: _resource_record_post_action 08:39:14 INFO - Running post-action listener: set_extra_try_arguments 08:39:14 INFO - [mozharness: 2017-03-09 16:39:14.994246Z] Finished download-and-extract step (success) 08:39:14 INFO - [mozharness: 2017-03-09 16:39:14.994371Z] Running populate-webroot step. 08:39:14 INFO - Running pre-action listener: _resource_record_pre_action 08:39:14 INFO - Running main action method: populate_webroot 08:39:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:15 INFO - '--tppagecycles', 08:39:15 INFO - '7'], 08:39:15 INFO - 'tests': ['tsvgm']}}, 08:39:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:39:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:39:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:39:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['damp', 'tps']}, 08:39:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'tests': ['damp', 'tps']}, 08:39:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['dromaeo_dom']}, 08:39:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['basic_compositor_video']}, 08:39:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:39:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['a11yr', 08:39:15 INFO - 'ts_paint', 08:39:15 INFO - 'tpaint', 08:39:15 INFO - 'sessionrestore', 08:39:15 INFO - 'sessionrestore_no_auto_restore', 08:39:15 INFO - 'tabpaint']}, 08:39:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:39:15 INFO - 'ts_paint', 08:39:15 INFO - 'tpaint', 08:39:15 INFO - 'sessionrestore', 08:39:15 INFO - 'sessionrestore_no_auto_restore', 08:39:15 INFO - 'tabpaint']}, 08:39:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:39:15 INFO - 'ts_paint', 08:39:15 INFO - 'tpaint', 08:39:15 INFO - 'sessionrestore', 08:39:15 INFO - 'sessionrestore_no_auto_restore', 08:39:15 INFO - 'tabpaint']}, 08:39:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:39:15 INFO - 'ts_paint', 08:39:15 INFO - 'tpaint', 08:39:15 INFO - 'sessionrestore', 08:39:15 INFO - 'sessionrestore_no_auto_restore', 08:39:15 INFO - 'tabpaint']}, 08:39:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['a11yr', 08:39:15 INFO - 'ts_paint', 08:39:15 INFO - 'tpaint', 08:39:15 INFO - 'sessionrestore', 08:39:15 INFO - 'sessionrestore_no_auto_restore', 08:39:15 INFO - 'tabpaint']}, 08:39:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['a11yr', 08:39:15 INFO - 'ts_paint', 08:39:15 INFO - 'tpaint', 08:39:15 INFO - 'sessionrestore', 08:39:15 INFO - 'sessionrestore_no_auto_restore', 08:39:15 INFO - 'tabpaint']}, 08:39:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['tsvgx', 08:39:15 INFO - 'tsvgr_opacity', 08:39:15 INFO - 'tart', 08:39:15 INFO - 'tscrollx', 08:39:15 INFO - 'cart', 08:39:15 INFO - 'tsvg_static']}, 08:39:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:39:15 INFO - 'tsvgr_opacity', 08:39:15 INFO - 'tart', 08:39:15 INFO - 'tscrollx', 08:39:15 INFO - 'cart', 08:39:15 INFO - 'tsvg_static']}, 08:39:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'talos_options': ['--disable-e10s'], 08:39:15 INFO - 'tests': ['tp5o']}, 08:39:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:39:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'talos_options': ['--disable-e10s', 08:39:15 INFO - '--xperf_path', 08:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:15 INFO - 'tests': ['tp5n']}, 08:39:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:39:15 INFO - 'talos_options': ['--xperf_path', 08:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:15 INFO - 'tests': ['tp5n']}}, 08:39:15 INFO - 'talos.zip': {'path': '', 08:39:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:15 INFO - Running post-action listener: _resource_record_post_action 08:39:15 INFO - [mozharness: 2017-03-09 16:39:15.013252Z] Finished populate-webroot step (success) 08:39:15 INFO - [mozharness: 2017-03-09 16:39:15.013382Z] Running create-virtualenv step. 08:39:15 INFO - Running pre-action listener: _resource_record_pre_action 08:39:15 INFO - Running main action method: create_virtualenv 08:39:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:39:15 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 08:39:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:39:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:15 INFO - Using real prefix '/tools/python27' 08:39:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:18 INFO - Installing pip.................done. 08:39:18 INFO - Return code: 0 08:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:39:18 INFO - Reading from file tmpfile_stdout 08:39:18 INFO - Output received: 08:39:18 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) 08:39:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:19 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:19 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 08:39:19 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 08:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:19 INFO - 'HOME': '/Users/cltbld', 08:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:19 INFO - 'LOGNAME': 'cltbld', 08:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:19 INFO - 'MOZ_NO_REMOTE': '1', 08:39:19 INFO - 'NO_EM_RESTART': '1', 08:39:19 INFO - 'PAGER': '/bin/cat', 08:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:19 INFO - 'PWD': '/builds/slave/test', 08:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:19 INFO - 'SHELL': '/bin/bash', 08:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:19 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:19 INFO - 'USER': 'cltbld', 08:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:19 INFO - 'XPC_FLAGS': '0x0', 08:39:19 INFO - 'XPC_SERVICE_NAME': '0', 08:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:19 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 08:39:19 INFO - Cleaning up... 08:39:19 INFO - Return code: 0 08:39:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:19 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:19 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 08:39:19 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 08:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:19 INFO - 'HOME': '/Users/cltbld', 08:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:19 INFO - 'LOGNAME': 'cltbld', 08:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:19 INFO - 'MOZ_NO_REMOTE': '1', 08:39:19 INFO - 'NO_EM_RESTART': '1', 08:39:19 INFO - 'PAGER': '/bin/cat', 08:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:19 INFO - 'PWD': '/builds/slave/test', 08:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:19 INFO - 'SHELL': '/bin/bash', 08:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:19 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:19 INFO - 'USER': 'cltbld', 08:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:19 INFO - 'XPC_FLAGS': '0x0', 08:39:19 INFO - 'XPC_SERVICE_NAME': '0', 08:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:19 INFO - Downloading/unpacking psutil>=3.1.1 08:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:22 INFO - Installing collected packages: psutil 08:39:22 INFO - Running setup.py install for psutil 08:39:23 INFO - building 'psutil._psutil_osx' extension 08:39:23 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 08:39:23 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 08:39:23 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 08:39:23 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 08:39:23 INFO - building 'psutil._psutil_posix' extension 08:39:23 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 08:39:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:39:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:39:23 INFO - ^ 08:39:23 INFO - 1 warning generated. 08:39:23 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 08:39:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:23 INFO - Successfully installed psutil 08:39:23 INFO - Cleaning up... 08:39:23 INFO - Return code: 0 08:39:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:23 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:23 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 08:39:23 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 08:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:23 INFO - 'HOME': '/Users/cltbld', 08:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:23 INFO - 'LOGNAME': 'cltbld', 08:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:23 INFO - 'MOZ_NO_REMOTE': '1', 08:39:23 INFO - 'NO_EM_RESTART': '1', 08:39:23 INFO - 'PAGER': '/bin/cat', 08:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:23 INFO - 'PWD': '/builds/slave/test', 08:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:23 INFO - 'SHELL': '/bin/bash', 08:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:23 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:23 INFO - 'USER': 'cltbld', 08:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:23 INFO - 'XPC_FLAGS': '0x0', 08:39:23 INFO - 'XPC_SERVICE_NAME': '0', 08:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39:24 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 08:39:24 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 08:39:24 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 08:39:24 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 08:39:24 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 08:39:24 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 08:39:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:26 INFO - Installing collected packages: mozsystemmonitor 08:39:26 INFO - Running setup.py install for mozsystemmonitor 08:39:27 INFO - Successfully installed mozsystemmonitor 08:39:27 INFO - Cleaning up... 08:39:27 INFO - Return code: 0 08:39:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:28 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:28 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 08:39:28 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 08:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:28 INFO - 'HOME': '/Users/cltbld', 08:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:28 INFO - 'LOGNAME': 'cltbld', 08:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:28 INFO - 'MOZ_NO_REMOTE': '1', 08:39:28 INFO - 'NO_EM_RESTART': '1', 08:39:28 INFO - 'PAGER': '/bin/cat', 08:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:28 INFO - 'PWD': '/builds/slave/test', 08:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:28 INFO - 'SHELL': '/bin/bash', 08:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:28 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:28 INFO - 'USER': 'cltbld', 08:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:28 INFO - 'XPC_FLAGS': '0x0', 08:39:28 INFO - 'XPC_SERVICE_NAME': '0', 08:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:28 INFO - Downloading/unpacking jsonschema==2.5.1 08:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:30 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 08:39:30 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 08:39:30 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 08:39:30 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 08:39:30 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 08:39:30 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 08:39:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:31 INFO - warning: no files found matching '*.txt' 08:39:31 INFO - no previously-included directories found matching 'build' 08:39:31 INFO - no previously-included directories found matching 'dist' 08:39:31 INFO - no previously-included directories found matching '.git*' 08:39:31 INFO - Installing collected packages: jsonschema, functools32 08:39:31 INFO - Running setup.py install for functools32 08:39:31 INFO - warning: no files found matching '*.txt' 08:39:31 INFO - no previously-included directories found matching 'build' 08:39:31 INFO - no previously-included directories found matching 'dist' 08:39:31 INFO - no previously-included directories found matching '.git*' 08:39:31 INFO - Successfully installed jsonschema functools32 08:39:31 INFO - Cleaning up... 08:39:31 INFO - Return code: 0 08:39:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', '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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:39: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 functools32==3.2.3-2 08:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:31 INFO - 'HOME': '/Users/cltbld', 08:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:31 INFO - 'LOGNAME': 'cltbld', 08:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:31 INFO - 'MOZ_NO_REMOTE': '1', 08:39:31 INFO - 'NO_EM_RESTART': '1', 08:39:31 INFO - 'PAGER': '/bin/cat', 08:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:31 INFO - 'PWD': '/builds/slave/test', 08:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:31 INFO - 'SHELL': '/bin/bash', 08:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:31 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:31 INFO - 'USER': 'cltbld', 08:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:31 INFO - 'XPC_FLAGS': '0x0', 08:39:31 INFO - 'XPC_SERVICE_NAME': '0', 08:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:31 INFO - Cleaning up... 08:39:31 INFO - Return code: 0 08:39:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', '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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:39: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 blobuploader==1.2.4 08:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:31 INFO - 'HOME': '/Users/cltbld', 08:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:31 INFO - 'LOGNAME': 'cltbld', 08:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:31 INFO - 'MOZ_NO_REMOTE': '1', 08:39:31 INFO - 'NO_EM_RESTART': '1', 08:39:31 INFO - 'PAGER': '/bin/cat', 08:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:31 INFO - 'PWD': '/builds/slave/test', 08:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:31 INFO - 'SHELL': '/bin/bash', 08:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:31 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:31 INFO - 'USER': 'cltbld', 08:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:31 INFO - 'XPC_FLAGS': '0x0', 08:39:31 INFO - 'XPC_SERVICE_NAME': '0', 08:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:32 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 08:39:32 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 08:39:32 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 08:39:32 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 08:39:32 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 08:39:32 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 08:39:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:34 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 08:39:34 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 08:39:34 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 08:39:34 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 08:39:34 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 08:39:34 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 08:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:36 INFO - Downloading docopt-0.6.1.tar.gz 08:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:36 INFO - Running setup.py install for blobuploader 08:39:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:36 INFO - Running setup.py install for requests 08:39:36 INFO - Running setup.py install for docopt 08:39:36 INFO - Successfully installed blobuploader requests docopt 08:39:36 INFO - Cleaning up... 08:39:37 INFO - Return code: 0 08:39:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:37 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')]} 08:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 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')]} 08:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:37 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 08:39:37 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 08:39:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:37 INFO - 'HOME': '/Users/cltbld', 08:39:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:37 INFO - 'LOGNAME': 'cltbld', 08:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:37 INFO - 'MOZ_NO_REMOTE': '1', 08:39:37 INFO - 'NO_EM_RESTART': '1', 08:39:37 INFO - 'PAGER': '/bin/cat', 08:39:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:37 INFO - 'PWD': '/builds/slave/test', 08:39:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:37 INFO - 'SHELL': '/bin/bash', 08:39:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:37 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:37 INFO - 'USER': 'cltbld', 08:39:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:37 INFO - 'XPC_FLAGS': '0x0', 08:39:37 INFO - 'XPC_SERVICE_NAME': '0', 08:39:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FKFR3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-HVuWgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-aasNqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-K5ANCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-yQPtJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-hj4FO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-jlFfUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-4y9mRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-OF447y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wWa0tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-bEDlhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-jf3mWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-a8ArYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-u1w_uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-inwvjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-WazTT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:39 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-cGuYCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:39 INFO - Running setup.py install for manifestparser 08:39:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:39 INFO - Running setup.py install for mozcrash 08:39:39 INFO - Running setup.py install for mozdebug 08:39:39 INFO - Running setup.py install for mozdevice 08:39:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:39 INFO - Running setup.py install for mozfile 08:39:39 INFO - Running setup.py install for mozhttpd 08:39:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Running setup.py install for mozinfo 08:39:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Running setup.py install for mozInstall 08:39:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Running setup.py install for mozleak 08:39:40 INFO - Running setup.py install for mozlog 08:39:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Running setup.py install for moznetwork 08:39:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:40 INFO - Running setup.py install for mozprocess 08:39:40 INFO - Running setup.py install for mozprofile 08:39:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:41 INFO - Running setup.py install for mozrunner 08:39:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:41 INFO - Running setup.py install for mozscreenshot 08:39:41 INFO - Running setup.py install for moztest 08:39:41 INFO - Running setup.py install for mozversion 08:39:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:41 INFO - Cleaning up... 08:39:41 INFO - Return code: 0 08:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:41 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')]} 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:41 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')]} 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:41 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:41 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 08:39:41 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 08:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:41 INFO - 'HOME': '/Users/cltbld', 08:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:41 INFO - 'LOGNAME': 'cltbld', 08:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:41 INFO - 'MOZ_NO_REMOTE': '1', 08:39:41 INFO - 'NO_EM_RESTART': '1', 08:39:41 INFO - 'PAGER': '/bin/cat', 08:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:41 INFO - 'PWD': '/builds/slave/test', 08:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:41 INFO - 'SHELL': '/bin/bash', 08:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:41 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:41 INFO - 'USER': 'cltbld', 08:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:41 INFO - 'XPC_FLAGS': '0x0', 08:39:41 INFO - 'XPC_SERVICE_NAME': '0', 08:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-aYAKC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-iBSfN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-b29q0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-TmUPsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-mawRZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-BuJVBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-v02bhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-fVNAXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:42 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)) 08:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-H2AQKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-XWQVe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lD4u5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-rs2oyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Qos3fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-z_4nmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-O12XY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-eneYjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:43 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)) 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-QnXbu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:43 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)) 08:39:43 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)) 08:39:43 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)) 08:39:43 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)) 08:39:43 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)) 08:39:43 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)) 08:39:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - Downloading blessings-1.6.tar.gz 08:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:46 INFO - Installing collected packages: blessings 08:39:46 INFO - Running setup.py install for blessings 08:39:46 INFO - Successfully installed blessings 08:39:46 INFO - Cleaning up... 08:39:46 INFO - Return code: 0 08:39:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:47 INFO - Reading from file tmpfile_stdout 08:39:47 INFO - Current package versions: 08:39:47 INFO - blessings == 1.6 08:39:47 INFO - blobuploader == 1.2.4 08:39:47 INFO - docopt == 0.6.1 08:39:47 INFO - functools32 == 3.2.3-2 08:39:47 INFO - jsonschema == 2.5.1 08:39:47 INFO - manifestparser == 1.1 08:39:47 INFO - mozInstall == 1.12 08:39:47 INFO - mozcrash == 1.0 08:39:47 INFO - mozdebug == 0.1 08:39:47 INFO - mozdevice == 0.49 08:39:47 INFO - mozfile == 1.2 08:39:47 INFO - mozhttpd == 0.7 08:39:47 INFO - mozinfo == 0.9 08:39:47 INFO - mozleak == 0.1 08:39:47 INFO - mozlog == 3.4 08:39:47 INFO - moznetwork == 0.27 08:39:47 INFO - mozprocess == 0.25 08:39:47 INFO - mozprofile == 0.28 08:39:47 INFO - mozrunner == 6.13 08:39:47 INFO - mozscreenshot == 0.1 08:39:47 INFO - mozsystemmonitor == 0.3 08:39:47 INFO - moztest == 0.8 08:39:47 INFO - mozversion == 1.4 08:39:47 INFO - psutil == 3.1.1 08:39:47 INFO - requests == 1.2.3 08:39:47 INFO - wsgiref == 0.1.2 08:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:47 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:47 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 08:39:47 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 08:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:47 INFO - 'HOME': '/Users/cltbld', 08:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:47 INFO - 'LOGNAME': 'cltbld', 08:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:47 INFO - 'MOZ_NO_REMOTE': '1', 08:39:47 INFO - 'NO_EM_RESTART': '1', 08:39:47 INFO - 'PAGER': '/bin/cat', 08:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:47 INFO - 'PWD': '/builds/slave/test', 08:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:47 INFO - 'SHELL': '/bin/bash', 08:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:47 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:47 INFO - 'USER': 'cltbld', 08:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:47 INFO - 'XPC_FLAGS': '0x0', 08:39:47 INFO - 'XPC_SERVICE_NAME': '0', 08:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 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)) 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:47 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 0x106788b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f38c7c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, '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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 08:39:47 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 08:39:47 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 08:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:47 INFO - 'HOME': '/Users/cltbld', 08:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:47 INFO - 'LOGNAME': 'cltbld', 08:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:47 INFO - 'MOZ_NO_REMOTE': '1', 08:39:47 INFO - 'NO_EM_RESTART': '1', 08:39:47 INFO - 'PAGER': '/bin/cat', 08:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:47 INFO - 'PWD': '/builds/slave/test', 08:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:47 INFO - 'SHELL': '/bin/bash', 08:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:39:47 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:47 INFO - 'USER': 'cltbld', 08:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:47 INFO - 'XPC_FLAGS': '0x0', 08:39:47 INFO - 'XPC_SERVICE_NAME': '0', 08:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Running post-action listener: _resource_record_post_action 08:39:47 INFO - Running post-action listener: _start_resource_monitoring 08:39:47 INFO - Starting resource monitoring. 08:39:47 INFO - [mozharness: 2017-03-09 16:39:47.764618Z] Finished create-virtualenv step (success) 08:39:47 INFO - [mozharness: 2017-03-09 16:39:47.765677Z] Running install step. 08:39:47 INFO - Running pre-action listener: _resource_record_pre_action 08:39:47 INFO - Running main action method: install 08:39:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:48 INFO - Reading from file tmpfile_stdout 08:39:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:48 INFO - Reading from file tmpfile_stdout 08:39:48 INFO - Output received: 08:39:48 INFO - Usage: mozinstall [options] installer 08:39:48 INFO - Options: 08:39:48 INFO - -h, --help show this help message and exit 08:39:48 INFO - -d DEST, --destination=DEST 08:39:48 INFO - Directory to install application into. [default: 08:39:48 INFO - "/builds/slave/test"] 08:39:48 INFO - --app=APP Application being installed. [default: firefox] 08:39:48 INFO - mkdir: /builds/slave/test/build/application 08:39:48 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'] 08:39:48 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 08:40:08 INFO - Reading from file tmpfile_stdout 08:40:08 INFO - Output received: 08:40:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:40:08 INFO - Running post-action listener: _resource_record_post_action 08:40:08 INFO - [mozharness: 2017-03-09 16:40:08.279688Z] Finished install step (success) 08:40:08 INFO - [mozharness: 2017-03-09 16:40:08.279813Z] Running run-tests step. 08:40:08 INFO - Running pre-action listener: _resource_record_pre_action 08:40:08 INFO - Running main action method: run_tests 08:40:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:08 INFO - 2017-03-09 08:40:08.294 screenresolution[2438:35573] starting screenresolution argv=screenresolution get 08:40:08 INFO - 2017-03-09 08:40:08.297 screenresolution[2438:35573] Display 0: 1600x1200x32@60 08:40:08 INFO - 2017-03-09 08:40:08.303 screenresolution[2439:35576] starting screenresolution argv=screenresolution list 08:40:08 INFO - Available Modes on Display 0 08:40:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:08 INFO - Intel Iris: 08:40:08 INFO - Chipset Model: Intel Iris 08:40:08 INFO - Type: GPU 08:40:08 INFO - Bus: Built-In 08:40:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:08 INFO - Vendor: Intel (0x8086) 08:40:08 INFO - Device ID: 0x0a2e 08:40:08 INFO - Revision ID: 0x0009 08:40:08 INFO - Displays: 08:40:08 INFO - Display: 08:40:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:08 INFO - Display Serial Number: 1600x1200 60 08:40:08 INFO - Main Display: Yes 08:40:08 INFO - Mirror: Off 08:40:08 INFO - Online: Yes 08:40:08 INFO - Rotation: Supported 08:40:08 INFO - Return code: 0 08:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:40:08 INFO - Python 2.7.3 08:40:08 INFO - Return code: 0 08:40:08 INFO - grabbing minidump binary from tooltool 08:40:08 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')]} 08:40:08 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 0x106566d30>, '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 0x10648ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10655bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:40:08 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 08:40:08 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 08:40:08 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 08:40:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:08 INFO - Return code: 0 08:40:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:40:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:40:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:40:08 INFO - ENV: RUST_BACKTRACE is now 1 08:40:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:40:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:40:08 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/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 08:40:08 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/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --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 08:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jJnCbX8JQY/Render', 08:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:08 INFO - 'HOME': '/Users/cltbld', 08:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:08 INFO - 'LOGNAME': 'cltbld', 08:40:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:40:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:08 INFO - 'MOZ_NO_REMOTE': '1', 08:40:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:40:08 INFO - 'NO_EM_RESTART': '1', 08:40:08 INFO - 'PAGER': '/bin/cat', 08:40:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:08 INFO - 'PWD': '/builds/slave/test', 08:40:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:08 INFO - 'RUST_BACKTRACE': '1', 08:40:08 INFO - 'SHELL': '/bin/bash', 08:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JTIuD7R4CU/Listeners', 08:40:08 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:08 INFO - 'USER': 'cltbld', 08:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:08 INFO - 'XPC_FLAGS': '0x0', 08:40:08 INFO - 'XPC_SERVICE_NAME': '0', 08:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:08 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/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 08:40:08 INFO - mozversion application_buildid: 20170309072024 08:40:08 INFO - mozversion application_changeset: 34585620e529614c79ecc007705646de748e592d 08:40:08 INFO - mozversion application_display_name: Nightly 08:40:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:08 INFO - mozversion application_name: Firefox 08:40:08 INFO - mozversion application_remotingname: firefox 08:40:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:40:08 INFO - mozversion application_vendor: Mozilla 08:40:08 INFO - mozversion application_version: 55.0a1 08:40:08 INFO - mozversion platform_buildid: 20170309072024 08:40:08 INFO - mozversion platform_changeset: 34585620e529614c79ecc007705646de748e592d 08:40:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:40:08 INFO - mozversion platform_version: 55.0a1 08:40:08 INFO - using testdate: 1489077608 08:40:08 INFO - actual date: 1489077608 08:40:08 INFO - starting webserver on 'localhost:63437' 08:40:08 INFO - SUITE-START | Running 2 tests 08:40:08 INFO - TEST-START | dromaeo_css 08:40:08 INFO - operating with platform_type : mac_ 08:40:08 INFO - Initialising browser for dromaeo_css test... 08:40:08 INFO - TEST-INFO | started process 2449 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpaKFY2z/profile http://localhost:63437/getInfo.html) 08:40:12 INFO - PROCESS | 2449 | 2017-03-09 08:40:12.190 plugin-container[2451:35738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903b, name = 'com.apple.tsm.portname' 08:40:12 INFO - PROCESS | 2449 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:12 INFO - PROCESS | 2449 | 2017-03-09 08:40:12.193 plugin-container[2451:35738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 08:40:12 INFO - PROCESS | 2449 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:12 INFO - PROCESS | 2449 | 2017-03-09 08:40:12.193 plugin-container[2451:35738] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:12 INFO - PROCESS | 2449 | __metrics Screen width/height:1600/1200 08:40:12 INFO - PROCESS | 2449 | colorDepth:24 08:40:12 INFO - PROCESS | 2449 | Browser inner width/height: 1024/689 08:40:12 INFO - PROCESS | 2449 | __metrics 08:40:12 ERROR - PROCESS | 2449 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:40:13 INFO - TEST-INFO | 2449: exit 0 08:40:13 INFO - Browser initialized. 08:40:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:40:13 INFO - TEST-INFO | started process 2452 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpaKFY2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:15 INFO - PROCESS | 2452 | 2017-03-09 08:40:15.806 plugin-container[2453:35872] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:40:15 INFO - PROCESS | 2452 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:15 INFO - PROCESS | 2452 | 2017-03-09 08:40:15.807 plugin-container[2453:35872] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 08:40:15 INFO - PROCESS | 2452 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:15 INFO - PROCESS | 2452 | 2017-03-09 08:40:15.807 plugin-container[2453:35872] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:25 INFO - PROCESS | 2452 | RSS: Main: 227426304 08:40:25 INFO - PROCESS | 2452 | 08:43:28 INFO - PROCESS | 2452 | Cycle 1(1): loaded http://localhost:63437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:63437/tests/dromaeo/cssquery-ext.html) 08:43:30 INFO - PROCESS | 2452 | RSS: Main: 249724928 08:43:30 INFO - PROCESS | 2452 | 08:45:13 INFO - PROCESS | 2452 | ************************* 08:45:13 INFO - PROCESS | 2452 | A coding exception was thrown and uncaught in a Task. 08:45:13 INFO - PROCESS | 2452 | 08:45:13 ERROR - PROCESS | 2452 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:45:13 INFO - PROCESS | 2452 | Full stack: 08:45:13 INFO - PROCESS | 2452 | ************************* 08:46:32 INFO - PROCESS | 2452 | Cycle 1(1): loaded http://localhost:63437/tests/dromaeo/cssquery-ext.html (next: http://localhost:63437/tests/dromaeo/cssquery-jquery.html) 08:46:33 INFO - PROCESS | 2452 | RSS: Main: 259170304 08:46:33 INFO - PROCESS | 2452 | 08:49:35 INFO - PROCESS | 2452 | Cycle 1(1): loaded http://localhost:63437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:63437/tests/dromaeo/cssquery-mootools.html) 08:49:35 INFO - PROCESS | 2452 | RSS: Main: 273457152 08:49:35 INFO - PROCESS | 2452 | 08:52:37 INFO - PROCESS | 2452 | Cycle 1(1): loaded http://localhost:63437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:63437/tests/dromaeo/cssquery-prototype.html) 08:52:38 INFO - PROCESS | 2452 | RSS: Main: 266199040 08:52:38 INFO - PROCESS | 2452 | 08:55:41 INFO - PROCESS | 2452 | Cycle 1(1): loaded http://localhost:63437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:63437/tests/dromaeo/cssquery-yui.html) 08:55:42 INFO - PROCESS | 2452 | RSS: Main: 275849216 08:55:42 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | Cycle 1(1): loaded http://localhost:63437/tests/dromaeo/cssquery-yui.html (next: http://localhost:63437/tests/dromaeo/cssquery-dojo.html) 08:58:45 INFO - PROCESS | 2452 | RSS: Main: 269877248 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | __start_tp_report 08:58:45 INFO - PROCESS | 2452 | _x_x_mozilla_page_load 08:58:45 INFO - PROCESS | 2452 | _x_x_mozilla_page_load_details 08:58:45 INFO - PROCESS | 2452 | |i|pagename|runs| 08:58:45 INFO - PROCESS | 2452 | |0;dojo.html;2900.738933495985;3441.4149594568903;3460.273342598054;3473.826308684565;3506.526618906447;5926.9407305926925;5988.7604495820115;6004.66974316413;6064.211652485171;6068.0291153415465;5707.543396528278;5754.108113242454;5786.508146807527;5900.852478688024;5927.88144237115;4441.977790111045;5303.575713942894;5389.973050134763;5396.10964190908;5436.864078398052;5474.534664553517;5503.6147469677135;5514.5864060195445;5518.475744804237;5597.944020559803;5500.009998200322;5515.117581187011;5516.034693928566;5518.806841760539;5529.419410961851;891.132833995184;4726.503717109723;5334;5343.198520221959;5476.534494567966;5355.196720491918;5382.085045542228;5390.865228369283;5403.486668766461;5404.891902161935;4874.878128046827;5065.46812584677;5380.923815236929;6005.759769609254;6035.064564992434;6302.023186406114;6313.116163737081;6335.8732825343695;6341.8414539636415;6356.0783686365685;6392.968035159841;6444.967775161141;6466.805995820086;6473.93526064738;6477.935220647827;5610.719464026783;5618.213450116987;6141.618856021587;6148.6618235997;6188;6345.809625711236;6362.077498762654;6603;6629.7679581214425;6653.6340501271925;5241.24002019705;6256.311805701369;6294.213223347082;6344.555881088279;6346.952752795829;5828.970855145697;6038.215032045894;6394.360563943568;6436.452901503331;6439.871202576016;6275.058741188858;6290.622562646256;6300.0234963580715;6335.461485773761;6363.33185015576;6388.648624325614;6397.776077837253;6404;6406.647634380154;6454.548181627335;5139.408967968731;5202.375714914158;5213.6089793265655;5221.947780522222;5270.446603106695;3756.549214094326;3982.721209515364;4557.703749256288;4620.1221767864;4651.093036857848;6178.938210617926;6194.101855230966;6216.875662486725;6236.095766113979;6248.687775567091;6453.451456626145;6529.640869752115;6534.313897040743;6538.1827271591055;6544.836379090466;5988.550858685616;6046.274447066292;6156.230471191101;6231.22109736283;6276.560640755195;4533.342665313577;5606.243157173811;5628.09950407941;5632.690202038845;5682.460166284196;6735.4274886635185;6735.797926062226;6736.4274036705465;6750.346165189462;6769.93230067693;6430.003349480838;6449;6474.352564743488;6508.73965041412;6523.282438931618;6353.555251132377;6432.324605916311;6588.143541339595;6592.274849766426;6735.955926831349;6374;6386.96806515983;6390.616563006234;6398;6398.456131228898;6358.237011558643;6398.552101353047;6413.166288382667;6440.13058237132;6459.838504037437;4748.525147485224;6160.414760597736;6222.222222222223;6306.495480361652;6370.872582548416;6281.424615907456;6347.777827776005;6350.841228969312;6354.364563543609;6355.428011478989;6059.878802424015;6139.785107521216;6186.690665466619;6223.626582405071;6255.937440625536;6195.132681424694;6229.844253893689;6304.5586808922935;6324.494040476843;6325.209348831396;4985.700857948535;6277.497800176066;6300.338464461165;6312.842178945563;6317.431431171217 08:58:45 INFO - PROCESS | 2452 | |1;ext.html;729.3581648149631;758.4614923404383;800.8158123631566;929.2287401456791;938.2962777916558;36925.076873078186;37490;38871.25396785722;38967.02582435441;39096.80451597745;37429.43855842158;37591;37593.68422105227;37660;37664.62335376645;7719.228077192292;7829.843403131934;10976.890231097666;11238.044766194884;11350.262232954832;11115.555377784878;11175.105991520699;11242.213045086848;11246.606368777095;11251.212415130904;11156.609518666848;11165.218434709574;11251.381174035425;11254.662360129209;11279.49242284095;9377;9432;11027.944860275727;11170.664880053571;11195.936386043313;10771.892281077246;10778.461076946121;10810.243282970196;10839;10839.18706097038;24924;37567.436488452695;37763;37781.81109094437;37953.62046379528;3767.7174211934216;3768.321702093622;3800.5629352624524;3813.637704418076;3947.526296844397;22030.339089827332;27064.864675676694;28130.296742581395;28135.0152744655;28164.577531337047;3081.2142903559675;3123.7813353065294;3150.6219253689474;3204.9198770030935;3262.9021129366156;311704;313535;313536.43231783924;313811;314937.42531287426;48732.756336218095;49411;49457.50542494601;49501;49562.25656615154;40142;48485.75757121263;50734;50742;50916.236256456184;11465.770684586429;12981.545645902348;13054.934725326313;14234.43062277518;14359.425622975174;11599.362035087983;11682.072458044497;11743.295402275891;11758.470868810924;11810.52757889692;10080.445575493271;12683.365831708563;12779.36103194855;12819;12876.291803950686;5998.970005150034;6017.983975368213;6056;6062.151298818169;6066.4227300902085;981.1464026297167;1037.3516552154904;1091.82530795074;1110.9166812489095;1114.3425379026414;22135.667964980537;25951.74048259531;26041.95832166692;26206.475870482485;26374.208773736435;1154.6074334726234;1209.8366720492797;1225.7119576899422;1243.4031664800946;1264.563725514696;13248.933755331162;13301.66745831362;13505.189688618715;13672.65818354549;13684.384202710902;395846;398521;398583;399148;399452.0027399844;41389.965250868365;54295.45704542983;54387.728061360234;54492;54618.72690636521;1219.0552321950381;1256.5225214418463;1294.372229468707;1303.7327347893658;1427;24817.62773558362;26001.56991365493;28847.711522885344;29080.56379154272;29279.852328568762;38865;38881.22237555176;39282.60717392789;39375.2124957505;39439;372430;376798;378806;378851;378929;32310.19224519406;32451.67548324581;32460.35079298448;32501.349972999935;32509.34981300408;41163;41822;41860.37209441922;43067.7846610765;43349.13301734011;28541.001064962627;30816;33840.984770456926;34022;34852.47721284132;34189.31621367509;34246;34924.47613285854;35386.29227415489;35661.64338356583;35534.644653553136;35854.924352269474;35867.46198806968;35886.820565897004;39739.40390894081;32246.54890529885;34350.48474272838;34412.13969650779;39827.60172398239;40032.79983600063;29702.811887524258;29803.254918627208;30534.38931221319;31117.8444107778;31120.53319200259 08:58:45 INFO - PROCESS | 2452 | |2;jquery.html;396.56774116213325;397.75339289640425;403.42310495990733;408.6975638027859;436.9781510924453;20485;21129.73221606705;21278.361649150513;21924;22163;21777.782222177775;21920.89039554804;22165.778342216574;22541.661875071888;22778.430539236488;6342.14381058557;6436.292007879129;6470.126532918066;6481.93518064818;6490.643014634194;6206;6397.680115994205;6455.289918109004;6512.283648798629;6526.401031747228;6427.421532062113;6483.092367068614;6511.251206111287;6518.315576864432;6544.312847151052;6203;6469.902951455732;6511.0558968949235;6519.348065193491;6525.314841941576;6059.697015149225;6336.081268216129;6346.9682651586445;6350.682465876687;6374.330695277022;26360.60459093115;26471.73528264731;26579.73420265792;26630.86684566584;27026.864865675743;2801.9299517512227;2903.7096290371005;2909.3890283040587;2912.0972498525525;2913.9708602914125;16319.265633046542;16339.26473308704;16782.412615558518;16880.07159606221;17469.301227950866;1929.1897403090736;2024.5242368043498;2033.9389818305326;2060.443680206336;2086.374087773662;125338;129232;158985;161662;162845;17783.46649600514;21902.561948761253;22545.88727056387;22702.659460108112;22968.27737919663;36174.45738313928;36222.45666314955;36296.27407451836;36451.27097458036;36494.53301936365;9295.860562091573;9544.95227523858;9640.566174522164;9820.607175713034;9821.508924553744;7605.733799316998;7614.466987310946;7617.238276172338;7694.576798276036;7767;10875.293105948089;10949.343039417661;10959.397233152253;11114.944425277821;11130.942560456744;3788.242351529705;3805.4291856221234;4148.481439820022;4181.323952670294;4185.162967406531;873.5850471026212;993.8757655293089;1027.291169093323;1043.7025447747355;1081.588996181446;23132.65301020486;23569.41076473102;23687.289381318587;23719.407014824767;23724.64413033806;889.8432038350119;953.4660590069583;977.2816979520047;980.6616717232544;992.9602815887428;10179.389236645826;11050.668479945614;11312.547498099984;11620.012298954684;11767.88232117685;537126;572660;713434;719341;729795;143334.84997725041;145491;148216;149659.50340496455;151014.24492877466;1213.8118591618313;1244.9315287659085;1309.8821106100497;1316.2694704438936;1338.6653336665834;18583.72124418162;21307;21504.269575340943;21748.13007479683;21865.344039678836;49128;62002.20990055368;62100;62415.6879215601;62856;70887.9366809488;79965;81682.59158704168;89052.5547372259;89347.55326223327;11671.649850504498;11965;12011.4594843234;12313.753724925631;12512.436940337524;13698.972577056562;13734.725305494034;13758.724825503234;14044.929775351058;14133.717325653635;8734.868976965223;9731.805363892541;11526;11754.529818807152;11846.466908989289;10528.210384221062;10576.629817956642;11416.372099534605;11709.707257318294;11774.764504710029;10471.895281047093;11631.709207269885;11719;12064.457099430721;12154.453049612612;11941.940290298493;12019.09856760764;12242.265464072185;12272.140950133406;12405.317707525812;11540.596079137189;11667.474963626826;11886.762264754483;11963.820542692041;12065.81901271464 08:58:45 INFO - PROCESS | 2452 | |3;mootools.html;1339.4709089909484;1539.7613369927665;1558.1196623907492;1598.6562888978867;1612.7822743929569;9363.15731584159;9614.230861531078;10512.053915147635;11112.833307500385;11142.220044596872;10388.480575971209;10738.463076846147;10757.031867131956;10768.138548916088;10991.890081099187;2299.6665483504926;2345.226075395124;2351.6825228594093;2356.552255071531;2357.7288611809604;1671.9884469895721;1932.420273917826;2328;2349.3891588187025;2379.4765151666693;1906.4852489827738;2317;2331.079223706635;2333.871637059961;2341.7072865891764;2277.6697378880135;2283.1324096843177;2287.2223444029028;2291.0606651272897;2294.2314324701247;2265.501589650274;2278.715160604924;2347.448349637834;2351.6354964980455;2352.141468364052;11129.387883666395;11205.327680339205;11215.439228038565;11224.887751122465;11245.83131253032;5749.108888122348;5880.9411905880825;5903.439173278532;5907.054871220627;5933.881322373529;3381.678740519647;3463.428534291839;3668.321360548307;3675.761075530082;3687.631236876318;1127.6729748372961;1153.5039932828881;1158.5018442069907;1197.4312201704208;1213.1083653514659;12300.446479908336;12449.626511204588;13657.8390836779;15147.56098170683;15216.771748423782;4727.385439892861;4795.496472870298;4841.878953026132;4907.2393778964315;4918.606511479073;12639.873601264053;12654.81017784734;12686.492540298284;12708.173968692005;12711.110222284351;5732.05421105513;5821.941780582225;5825.33008703996;5834.154047663065;5924.555658325643;4495.43807024122;5003.649744517848;5189.273501709764;5216.947830521722;5322.281491998608;3910.902227444337;4016.8995775105855;4027.436158937751;4094.897627559335;4104.117614712851;938.9530523473799;1129.6836885672026;1130.1354463835173;1140.3408041299888;1146.9770604587861;770.622395026433;786.3198333441532;807.1766797866261;809.6032943857467;815.0820064170256;6321.304656487782;6385.680715964183;6646.734130634817;6674.132362792806;6697.760914230883;909.5043201455222;986.6398764451068;999.8400255959011;1007.2445665750687;1037.5019990404496;3930.8231129599235;4070.3690927906223;4185.476815398075;4259.765712885759;4350.195213885441;12984.117302991013;13272.27002514871;13445.663858403617;13467.595972120656;13471;12797.488100475877;13038.934805326102;13305.80041299362;13306.933465332804;13406.664833379244;9881.456519891475;9930.751731206634;10037.996200379903;10066.345687530433;10068.59725610982;6377.585456945284;6404.103425520338;6432.9385651367;6484.1246431731115;6569.343065693392;11810.173287869766;11934.462949167482;12036.699082523008;12073.154879158375;12173.57392491294;11947.82078268844;12073.698157546132;12282.75434491323;12360.134790564574;12390.194637348544;7807.726729564438;8036.919630803617;8727.956360218159;8995.505247211466;9140.497272650067;10243.795124097625;10317.9484102579;10394.688159355232;10430.42632655181;10439.582416703246;8980.910190898006;9042.819143617222;9069.274458043208;9144.131307525775;9197.816043679222;8670.479771213748;8851.69019084329;8976.596053177753;8993.775155621162;9068;6434.967825160844;7699.345555627834;7744.651490683045;7811.296983271533;7873.724419645285;5809.883802324014;5825.3883342248455;5891.440313170242;5923.052311630118;6010.038393856962;5230.34620672416;5698.572607054404;5952.970235148797;5996.433904874156;6009.248843894513 08:58:45 INFO - PROCESS | 2452 | |4;prototype.html;367.37912927153127;379.9753016053956;381.8548951398468;389.58509187715083;393.7165241026462;4166.895552947642;4558.37041254051;4917.262410638406;5084.288199652052;5187.533122019017;4363.6509079273665;4423.380726698265;5063.999999999991;5064.620153488494;5116.948830511694;3573.731970102253;4146.475495828537;4172.937405938906;4206.558311377307;4219.2405367033925;4194.811942923385;4266.935995960063;4275;4282.293421585435;4315.82736690532;3609;3650.507181530499;3750.8124593770203;4265.53079161292;4299.5485474025245;3594.9101272468138;3611.9277614447697;3844.7693138411646;3939.2712348215387;3983.0881177034894;3648.5074514940675;3887.3391523441082;3912.2371137628174;3915.9216815663813;3934.288584465738;4450.020995381011;4517.932231016537;4910.508949105061;5041.470645582234;5076.670016448956;4406.725476287996;4874.326794924513;4878.658493905428;4936.432310284327;4952.554270115671;4243.554426785205;5257.789688412459;5454.509094181542;5522.199281104217;5526.917096243559;3827.923441531154;4125.29869922114;4218.865511798424;4326.048269380732;4341.9131617367475;4635.860924172281;5244.580433565306;5560.666360018412;5658.43415658435;5854.97072514639;3450.9309813803584;3888.2806680764147;3903.497153595886;4545.909081818345;4559.788502576248;4045.1707399982934;4122.793860306972;4455.532169122261;4621.6302695784925;4673.564929776611;4478.57453541913;4959.429665588431;4975.577075948585;4991.5258050485145;5021.7740201690285;4714.81140754366;5496.6701997880255;5504.256925315031;5556.916156441334;5626.887462250732;1438.3383643523887;1466.538040517255;1478.2165452310078;1563.2881994216316;1568.9293981770847;1086.7174534621056;1105.6075093341908;1165.8076417391035;1166.5800311887713;1170.7658468306372;4529.230030894756;4777.402824646919;5163.772642098688;5173.71544565045;5202.309249493854;4934.432540257916;5223.093570846614;5275.892062666806;5770.980156945036;5800.50695690871;4312.698111132253;4605.723656580616;4848.0546293472435;4859.878503037452;4962.354893863775;2604.3852811257143;2726.4001919577663;2738.589211618273;2755.7244275572284;2987.9701202988126;4937;5092;5897.262842144732;5912.320083190488;6005.948958932169;5040.420351659533;5407.161889907071;5408.269883565668;5550.093712315334;5855.560832937546;4766.880827979328;5436.782528698887;5488.545535433033;5599.380511078377;5709.914351284817;4953.925691114709;5069.524913093924;5412.83761487156;5691.121929763085;5697.4587414195585;4498.572635599613;4897.779599917941;5471.699056551928;5597.944020559742;5667.603267771216;5343.759530821045;5451.918221226605;5660.499967508531;5880.294364676266;5881.470667639933;3709.8516059358403;4110.862351577103;4377.299632058855;4403.955960440355;4428.247197976288;4680.859574212779;5013.568419316702;5167.483251674803;5435.347758269033;5640.830775076754;5154.974225128851;5161.896762064813;5517.227588137584;5542.418046105262;5543.916841247304;4776.283557466269;4992.450830408579;5107.744612769421;5110.642255042111;5381.730913454233;4160.148611654211;4794.640401969936;4900.754962251802;4961.975190124026;5211.60912931524;5129.820456284012;5296.7351632418995;5404.351477822686;5480.314960629921;5511.5039646432015;4656.231721765871;4659.83504123969;5298.6290959634;5323.760430780701;5372.307723067222 08:58:45 INFO - PROCESS | 2452 | |5;yui.html;697.424624684635;714.4891402647106;773.4122067228905;799.1728560939428;800.4596897094461;15116.697666046672;15604.375824966988;16138;16216.918915405437;16318.347266109356;15027.173505457196;15041.699166016673;15174;15197.316120774563;15198.088114713126;931.9487428191446;969.9563519641598;979.7550612346913;981.2150279776187;982.9606815727362;798.409177208867;923.6628630549868;967.8935317115112;974.5273542331963;980.568549838069;977.9706608801712;982.5971351745785;984.1782111936542;994.3983889746708;995.5569771451707;980.9803803923917;986.9654562090292;989.1839232633107;990.5889056041734;990.7770751580908;737.3216640690578;740.7851723000324;741.4142827166532;742.7548908860064;743.353282644103;16179.91910040454;16436.83563164377;16518.587035324093;16582.419615313527;16696.916515417346;14557.490487832874;14721.630605704748;14861.777073343908;14891.10653360791;15486.993345432624;8867.600957956844;11461.828072578917;11555.306681599046;11943;12129.818052729217;3266.7059964603063;3684.6499582539614;3782.0328674307534;3789.2232092421264;3873.0898238913833;78250.60874695647;83529.58235208785;93021.53489232578;102462;107251.46374268079;9480.24158067353;10289;11390.544378224944;11627.825582616268;11826.11304152192;21163;21764.12943482243;22304;23739.931703073402;24305.878470607535;7987.800304992422;8043;8053.959730201312;8133.389995750343;8258.256756891788;4183.958160418357;4210.642095421924;4239.292457517627;4285.37862010013;4293.592108749664;3468.826558672107;3530.135116896377;3543.309054734302;3572.1962558424148;3572.374834404021;644.9967750161219;646.4279112984948;651.680676468527;655.3741177175881;674.150570281449;590.819799961016;662.4634046422317;664.9468042556584;678.2403707847144;680.7991642465386;9985.650502232533;10044.745951261199;10096.495175241209;10231;10310.639127630497;639.9200099987502;685.3078390825302;688.7795905310353;697.919739229995;700.7127077898037;4436.44544431946;4610.631149508032;4791.353167322437;4791.5687588117235;4806.831760888352;96201.51899240458;99908;100389;101384;101415;63701;84481;85991.57004214938;86212;86715;60002;64299.678501607195;64366.678166608865;64947.02579461312;65312;9290.303227257848;9481.146696797321;9660.855087173839;9691.321607487691;9711.66009189675;40709.59290407058;42248.5775142257;43311;45247.86880327886;47095.529044710485;61052.38947610467;63646.68176659087;65800;67456;69101.65449172923;13175.407106680032;13650.795238071238;13808.723825523231;14034.859651403356;14394.568162955127;14679.41282348694;14690.485832995793;14742.189179595225;14808;15017.924910375377;13487.527936522174;13635.659108522366;13663.863361366259;13690.863091369358;13962.371693273624;13223.471061157446;13268.535601254296;13528.526501572398;13961.969780533831;13969.371378287799;13256;13264.668383290495;13297.867021329663;13411.664708382368;13766.65583360424;9100.954495227481;11030.669079927615;11100.278481898651;11208.439578020903;11583.536658533565;6441.57953909471;10274.897251027693;11326.37704926237;11359.772804544029;11505.022073123879 08:58:45 INFO - PROCESS | 2452 | __end_tp_report 08:58:45 INFO - PROCESS | 2452 | __start_cc_report 08:58:45 INFO - PROCESS | 2452 | _x_x_mozilla_cycle_collect,443 08:58:45 INFO - PROCESS | 2452 | __end_cc_report 08:58:45 INFO - PROCESS | 2452 | __startTimestamp1489078725590__endTimestamp 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | ------- Summary: start ------- 08:58:45 INFO - PROCESS | 2452 | Number of tests: 6 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | [#0] dojo.html Cycles:165 Average:5881.38 Median:6229.84 stddev:829.70 (13.3%) stddev-sans-first:798.62 08:58:45 INFO - PROCESS | 2452 | Values: 2900.7 3441.4 3460.3 3473.8 3506.5 5926.9 5988.8 6004.7 6064.2 6068.0 5707.5 5754.1 5786.5 5900.9 5927.9 4442.0 5303.6 5390.0 5396.1 5436.9 5474.5 5503.6 5514.6 5518.5 5597.9 5500.0 5515.1 5516.0 5518.8 5529.4 891.1 4726.5 5334.0 5343.2 5476.5 5355.2 5382.1 5390.9 5403.5 5404.9 4874.9 5065.5 5380.9 6005.8 6035.1 6302.0 6313.1 6335.9 6341.8 6356.1 6393.0 6445.0 6466.8 6473.9 6477.9 5610.7 5618.2 6141.6 6148.7 6188.0 6345.8 6362.1 6603.0 6629.8 6653.6 5241.2 6256.3 6294.2 6344.6 6347.0 5829.0 6038.2 6394.4 6436.5 6439.9 6275.1 6290.6 6300.0 6335.5 6363.3 6388.6 6397.8 6404.0 6406.6 6454.5 5139.4 5202.4 5213.6 5221.9 5270.4 3756.5 3982.7 4557.7 4620.1 4651.1 6178.9 6194.1 6216.9 6236.1 6248.7 6453.5 6529.6 6534.3 6538.2 6544.8 5988.6 6046.3 6156.2 6231.2 6276.6 4533.3 5606.2 5628.1 5632.7 5682.5 6735.4 6735.8 6736.4 6750.3 6769.9 6430.0 6449.0 6474.4 6508.7 6523.3 6353.6 6432.3 6588.1 6592.3 6736.0 6374.0 6387.0 6390.6 6398.0 6398.5 6358.2 6398.6 6413.2 6440.1 6459.8 4748.5 6160.4 6222.2 6306.5 6370.9 6281.4 6347.8 6350.8 6354.4 6355.4 6059.9 6139.8 6186.7 6223.6 6255.9 6195.1 6229.8 6304.6 6324.5 6325.2 4985.7 6277.5 6300.3 6312.8 6317.4 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | [#1] ext.html Cycles:180 Average:50973.31 Median:32480.85 stddev:96146.87 (296.0%) stddev-sans-first:96342.58 08:58:45 INFO - PROCESS | 2452 | Values: 729.4 758.5 800.8 929.2 938.3 36925.1 37490.0 38871.3 38967.0 39096.8 37429.4 37591.0 37593.7 37660.0 37664.6 7719.2 7829.8 10976.9 11238.0 11350.3 11115.6 11175.1 11242.2 11246.6 11251.2 11156.6 11165.2 11251.4 11254.7 11279.5 9377.0 9432.0 11027.9 11170.7 11195.9 10771.9 10778.5 10810.2 10839.0 10839.2 24924.0 37567.4 37763.0 37781.8 37953.6 3767.7 3768.3 3800.6 3813.6 3947.5 22030.3 27064.9 28130.3 28135.0 28164.6 3081.2 3123.8 3150.6 3204.9 3262.9 311704.0 313535.0 313536.4 313811.0 314937.4 48732.8 49411.0 49457.5 49501.0 49562.3 40142.0 48485.8 50734.0 50742.0 50916.2 11465.8 12981.5 13054.9 14234.4 14359.4 11599.4 11682.1 11743.3 11758.5 11810.5 10080.4 12683.4 12779.4 12819.0 12876.3 5999.0 6018.0 6056.0 6062.2 6066.4 981.1 1037.4 1091.8 1110.9 1114.3 22135.7 25951.7 26042.0 26206.5 26374.2 1154.6 1209.8 1225.7 1243.4 1264.6 13248.9 13301.7 13505.2 13672.7 13684.4 395846.0 398521.0 398583.0 399148.0 399452.0 41390.0 54295.5 54387.7 54492.0 54618.7 1219.1 1256.5 1294.4 1303.7 1427.0 24817.6 26001.6 28847.7 29080.6 29279.9 38865.0 38881.2 39282.6 39375.2 39439.0 372430.0 376798.0 378806.0 378851.0 378929.0 32310.2 32451.7 32460.4 32501.3 32509.3 41163.0 41822.0 41860.4 43067.8 43349.1 28541.0 30816.0 33841.0 34022.0 34852.5 34189.3 34246.0 34924.5 35386.3 35661.6 35534.6 35854.9 35867.5 35886.8 39739.4 32246.5 34350.5 34412.1 39827.6 40032.8 29702.8 29803.3 30534.4 31117.8 31120.5 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | [#2] jquery.html Cycles:180 Average:40240.66 Median:23050.47 stddev:110535.73 (479.5%) stddev-sans-first:110805.33 08:58:45 INFO - PROCESS | 2452 | Values: 396.6 397.8 403.4 408.7 437.0 20485.0 21129.7 21278.4 21924.0 22163.0 21777.8 21920.9 22165.8 22541.7 22778.4 6342.1 6436.3 6470.1 6481.9 6490.6 6206.0 6397.7 6455.3 6512.3 6526.4 6427.4 6483.1 6511.3 6518.3 6544.3 6203.0 6469.9 6511.1 6519.3 6525.3 6059.7 6336.1 6347.0 6350.7 6374.3 26360.6 26471.7 26579.7 26630.9 27026.9 2801.9 2903.7 2909.4 2912.1 2914.0 16319.3 16339.3 16782.4 16880.1 17469.3 1929.2 2024.5 2033.9 2060.4 2086.4 125338.0 129232.0 158985.0 161662.0 162845.0 17783.5 21902.6 22545.9 22702.7 22968.3 36174.5 36222.5 36296.3 36451.3 36494.5 9295.9 9545.0 9640.6 9820.6 9821.5 7605.7 7614.5 7617.2 7694.6 7767.0 10875.3 10949.3 10959.4 11114.9 11130.9 3788.2 3805.4 4148.5 4181.3 4185.2 873.6 993.9 1027.3 1043.7 1081.6 23132.7 23569.4 23687.3 23719.4 23724.6 889.8 953.5 977.3 980.7 993.0 10179.4 11050.7 11312.5 11620.0 11767.9 537126.0 572660.0 713434.0 719341.0 729795.0 143334.8 145491.0 148216.0 149659.5 151014.2 1213.8 1244.9 1309.9 1316.3 1338.7 18583.7 21307.0 21504.3 21748.1 21865.3 49128.0 62002.2 62100.0 62415.7 62856.0 70887.9 79965.0 81682.6 89052.6 89347.6 11671.6 11965.0 12011.5 12313.8 12512.4 13699.0 13734.7 13758.7 14044.9 14133.7 8734.9 9731.8 11526.0 11754.5 11846.5 10528.2 10576.6 11416.4 11709.7 11774.8 10471.9 11631.7 11719.0 12064.5 12154.5 11941.9 12019.1 12242.3 12272.1 12405.3 11540.6 11667.5 11886.8 11963.8 12065.8 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | [#3] mootools.html Cycles:180 Average:6632.70 Median:2368.60 stddev:4124.06 (174.1%) stddev-sans-first:4116.45 08:58:45 INFO - PROCESS | 2452 | Values: 1339.5 1539.8 1558.1 1598.7 1612.8 9363.2 9614.2 10512.1 11112.8 11142.2 10388.5 10738.5 10757.0 10768.1 10991.9 2299.7 2345.2 2351.7 2356.6 2357.7 1672.0 1932.4 2328.0 2349.4 2379.5 1906.5 2317.0 2331.1 2333.9 2341.7 2277.7 2283.1 2287.2 2291.1 2294.2 2265.5 2278.7 2347.4 2351.6 2352.1 11129.4 11205.3 11215.4 11224.9 11245.8 5749.1 5880.9 5903.4 5907.1 5933.9 3381.7 3463.4 3668.3 3675.8 3687.6 1127.7 1153.5 1158.5 1197.4 1213.1 12300.4 12449.6 13657.8 15147.6 15216.8 4727.4 4795.5 4841.9 4907.2 4918.6 12639.9 12654.8 12686.5 12708.2 12711.1 5732.1 5821.9 5825.3 5834.2 5924.6 4495.4 5003.6 5189.3 5216.9 5322.3 3910.9 4016.9 4027.4 4094.9 4104.1 939.0 1129.7 1130.1 1140.3 1147.0 770.6 786.3 807.2 809.6 815.1 6321.3 6385.7 6646.7 6674.1 6697.8 909.5 986.6 999.8 1007.2 1037.5 3930.8 4070.4 4185.5 4259.8 4350.2 12984.1 13272.3 13445.7 13467.6 13471.0 12797.5 13038.9 13305.8 13306.9 13406.7 9881.5 9930.8 10038.0 10066.3 10068.6 6377.6 6404.1 6432.9 6484.1 6569.3 11810.2 11934.5 12036.7 12073.2 12173.6 11947.8 12073.7 12282.8 12360.1 12390.2 7807.7 8036.9 8728.0 8995.5 9140.5 10243.8 10317.9 10394.7 10430.4 10439.6 8980.9 9042.8 9069.3 9144.1 9197.8 8670.5 8851.7 8976.6 8993.8 9068.0 6435.0 7699.3 7744.7 7811.3 7873.7 5809.9 5825.4 5891.4 5923.1 6010.0 5230.3 5698.6 5953.0 5996.4 6009.2 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | [#4] prototype.html Cycles:180 Average:4477.60 Median:4876.49 stddev:1260.42 (25.8%) stddev-sans-first:1225.62 08:58:45 INFO - PROCESS | 2452 | Values: 367.4 380.0 381.9 389.6 393.7 4166.9 4558.4 4917.3 5084.3 5187.5 4363.7 4423.4 5064.0 5064.6 5116.9 3573.7 4146.5 4172.9 4206.6 4219.2 4194.8 4266.9 4275.0 4282.3 4315.8 3609.0 3650.5 3750.8 4265.5 4299.5 3594.9 3611.9 3844.8 3939.3 3983.1 3648.5 3887.3 3912.2 3915.9 3934.3 4450.0 4517.9 4910.5 5041.5 5076.7 4406.7 4874.3 4878.7 4936.4 4952.6 4243.6 5257.8 5454.5 5522.2 5526.9 3827.9 4125.3 4218.9 4326.0 4341.9 4635.9 5244.6 5560.7 5658.4 5855.0 3450.9 3888.3 3903.5 4545.9 4559.8 4045.2 4122.8 4455.5 4621.6 4673.6 4478.6 4959.4 4975.6 4991.5 5021.8 4714.8 5496.7 5504.3 5556.9 5626.9 1438.3 1466.5 1478.2 1563.3 1568.9 1086.7 1105.6 1165.8 1166.6 1170.8 4529.2 4777.4 5163.8 5173.7 5202.3 4934.4 5223.1 5275.9 5771.0 5800.5 4312.7 4605.7 4848.1 4859.9 4962.4 2604.4 2726.4 2738.6 2755.7 2988.0 4937.0 5092.0 5897.3 5912.3 6005.9 5040.4 5407.2 5408.3 5550.1 5855.6 4766.9 5436.8 5488.5 5599.4 5709.9 4953.9 5069.5 5412.8 5691.1 5697.5 4498.6 4897.8 5471.7 5597.9 5667.6 5343.8 5451.9 5660.5 5880.3 5881.5 3709.9 4110.9 4377.3 4404.0 4428.2 4680.9 5013.6 5167.5 5435.3 5640.8 5155.0 5161.9 5517.2 5542.4 5543.9 4776.3 4992.5 5107.7 5110.6 5381.7 4160.1 4794.6 4900.8 4962.0 5211.6 5129.8 5296.7 5404.4 5480.3 5511.5 4656.2 4659.8 5298.6 5323.8 5372.3 08:58:45 INFO - PROCESS | 2452 | 08:58:45 INFO - PROCESS | 2452 | [#5] yui.html Cycles:180 Average:19328.76 Median:4289.49 stddev:26697.03 (622.4%) stddev-sans-first:26735.27 08:58:45 INFO - PROCESS | 2452 | Values: 697.4 714.5 773.4 799.2 800.5 15116.7 15604.4 16138.0 16216.9 16318.3 15027.2 15041.7 15174.0 15197.3 15198.1 931.9 970.0 979.8 981.2 983.0 798.4 923.7 967.9 974.5 980.6 978.0 982.6 984.2 994.4 995.6 981.0 987.0 989.2 990.6 990.8 737.3 740.8 741.4 742.8 743.4 16179.9 16436.8 16518.6 16582.4 16696.9 14557.5 14721.6 14861.8 14891.1 15487.0 8867.6 11461.8 11555.3 11943.0 12129.8 3266.7 3684.6 3782.0 3789.2 3873.1 78250.6 83529.6 93021.5 102462.0 107251.5 9480.2 10289.0 11390.5 11627.8 11826.1 21163.0 21764.1 22304.0 23739.9 24305.9 7987.8 8043.0 8054.0 8133.4 8258.3 4184.0 4210.6 4239.3 4285.4 4293.6 3468.8 3530.1 3543.3 3572.2 3572.4 645.0 646.4 651.7 655.4 674.2 590.8 662.5 664.9 678.2 680.8 9985.7 10044.7 10096.5 10231.0 10310.6 639.9 685.3 688.8 697.9 700.7 4436.4 4610.6 4791.4 4791.6 4806.8 96201.5 99908.0 100389.0 101384.0 101415.0 63701.0 84481.0 85991.6 86212.0 86715.0 60002.0 64299.7 64366.7 64947.0 65312.0 9290.3 9481.1 9660.9 9691.3 9711.7 40709.6 42248.6 43311.0 45247.9 47095.5 61052.4 63646.7 65800.0 67456.0 69101.7 13175.4 13650.8 13808.7 14034.9 14394.6 14679.4 14690.5 14742.2 14808.0 15017.9 13487.5 13635.7 13663.9 13690.9 13962.4 13223.5 13268.5 13528.5 13962.0 13969.4 13256.0 13264.7 13297.9 13411.7 13766.7 9101.0 11030.7 11100.3 11208.4 11583.5 6441.6 10274.9 11326.4 11359.8 11505.0 08:58:45 INFO - PROCESS | 2452 | -------- Summary: end -------- 08:58:45 INFO - PROCESS | 2452 | 08:58:46 INFO - TEST-INFO | 2452: exit 0 08:58:46 INFO - TEST-OK | dromaeo_css | took 1117358ms 08:58:46 INFO - TEST-START | kraken 08:58:46 INFO - operating with platform_type : mac_ 08:58:46 INFO - Initialising browser for kraken test... 08:58:46 INFO - TEST-INFO | started process 2456 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpV1hBx1/profile http://localhost:63437/getInfo.html) 08:58:49 INFO - PROCESS | 2456 | 2017-03-09 08:58:49.045 plugin-container[2457:37883] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 08:58:49 INFO - PROCESS | 2456 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:49 INFO - PROCESS | 2456 | 2017-03-09 08:58:49.048 plugin-container[2457:37883] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 08:58:49 INFO - PROCESS | 2456 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:49 INFO - PROCESS | 2456 | 2017-03-09 08:58:49.048 plugin-container[2457:37883] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:58:49 INFO - PROCESS | 2456 | __metrics Screen width/height:1600/1200 08:58:49 INFO - PROCESS | 2456 | colorDepth:24 08:58:49 INFO - PROCESS | 2456 | Browser inner width/height: 1024/689 08:58:49 INFO - PROCESS | 2456 | __metrics 08:58:49 ERROR - PROCESS | 2456 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:58:50 INFO - TEST-INFO | 2456: exit 0 08:58:50 INFO - Browser initialized. 08:58:50 INFO - Running cycle 1/1 for kraken test... 08:58:50 INFO - TEST-INFO | started process 2458 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpV1hBx1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:52 INFO - PROCESS | 2458 | 2017-03-09 08:58:52.744 plugin-container[2459:38012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4f, name = 'com.apple.tsm.portname' 08:58:52 INFO - PROCESS | 2458 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:52 INFO - PROCESS | 2458 | 2017-03-09 08:58:52.745 plugin-container[2459:38012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 08:58:52 INFO - PROCESS | 2458 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:52 INFO - PROCESS | 2458 | 2017-03-09 08:58:52.745 plugin-container[2459:38012] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:59:02 INFO - PROCESS | 2458 | RSS: Main: 227344384 08:59:02 INFO - PROCESS | 2458 | 08:59:05 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:63437/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:06 INFO - PROCESS | 2458 | RSS: Main: 241467392 08:59:06 INFO - PROCESS | 2458 | 08:59:09 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:63437/tests/kraken/driver.html?testName=audio-dft) 08:59:09 INFO - PROCESS | 2458 | RSS: Main: 250015744 08:59:09 INFO - PROCESS | 2458 | 08:59:13 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:63437/tests/kraken/driver.html?testName=audio-fft) 08:59:13 INFO - PROCESS | 2458 | RSS: Main: 252649472 08:59:13 INFO - PROCESS | 2458 | 08:59:15 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:63437/tests/kraken/driver.html?testName=audio-oscillator) 08:59:16 INFO - PROCESS | 2458 | RSS: Main: 254660608 08:59:16 INFO - PROCESS | 2458 | 08:59:18 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:63437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:19 INFO - PROCESS | 2458 | RSS: Main: 254447616 08:59:19 INFO - PROCESS | 2458 | 08:59:22 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:63437/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:22 INFO - PROCESS | 2458 | RSS: Main: 261541888 08:59:22 INFO - PROCESS | 2458 | 08:59:26 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:63437/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:26 INFO - PROCESS | 2458 | RSS: Main: 261754880 08:59:26 INFO - PROCESS | 2458 | 08:59:29 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:63437/tests/kraken/driver.html?testName=json-parse-financial) 08:59:30 INFO - PROCESS | 2458 | RSS: Main: 261705728 08:59:30 INFO - PROCESS | 2458 | 08:59:32 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:63437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:32 INFO - PROCESS | 2458 | RSS: Main: 261632000 08:59:32 INFO - PROCESS | 2458 | 08:59:34 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:35 INFO - PROCESS | 2458 | RSS: Main: 261529600 08:59:35 INFO - PROCESS | 2458 | 08:59:37 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:38 INFO - PROCESS | 2458 | RSS: Main: 261640192 08:59:38 INFO - PROCESS | 2458 | 08:59:41 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:42 INFO - PROCESS | 2458 | RSS: Main: 262160384 08:59:42 INFO - PROCESS | 2458 | 08:59:45 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:45 INFO - PROCESS | 2458 | RSS: Main: 261689344 08:59:45 INFO - PROCESS | 2458 | 08:59:47 INFO - PROCESS | 2458 | Cycle 1(1): loaded http://localhost:63437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:63437/tests/kraken/driver.html?testName=ai-astar) 08:59:48 INFO - PROCESS | 2458 | RSS: Main: 265191424 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | __start_tp_report 08:59:48 INFO - PROCESS | 2458 | _x_x_mozilla_page_load 08:59:48 INFO - PROCESS | 2458 | _x_x_mozilla_page_load_details 08:59:48 INFO - PROCESS | 2458 | |i|pagename|runs| 08:59:48 INFO - PROCESS | 2458 | |0;ai-astar;108;125;124;134;160;178;151;120;120;119 08:59:48 INFO - PROCESS | 2458 | |1;audio-beat-detection;146;130;149;169;114;111;114;116;134;112 08:59:48 INFO - PROCESS | 2458 | |2;audio-dft;229;221;206;212;199;200;198;202;203;198 08:59:48 INFO - PROCESS | 2458 | |3;audio-fft;84;58;61;88;63;65;73;88;101;90 08:59:48 INFO - PROCESS | 2458 | |4;audio-oscillator;94;58;84;91;58;69;104;60;88;116 08:59:48 INFO - PROCESS | 2458 | |5;imaging-gaussian-blur;90;90;98;90;89;89;109;90;89;90 08:59:48 INFO - PROCESS | 2458 | |6;imaging-darkroom;97;139;154;96;96;96;98;152;96;96 08:59:48 INFO - PROCESS | 2458 | |7;imaging-desaturate;89;91;93;93;89;104;93;91;90;88 08:59:48 INFO - PROCESS | 2458 | |8;json-parse-financial;67;66;68;69;67;66;67;68;68;69 08:59:48 INFO - PROCESS | 2458 | |9;json-stringify-tinderbox;54;63;60;66;61;58;56;59;59;60 08:59:48 INFO - PROCESS | 2458 | |10;stanford-crypto-aes;86;87;96;109;110;110;87;88;89;85 08:59:48 INFO - PROCESS | 2458 | |11;stanford-crypto-ccm;147;160;152;146;145;148;156;155;212;164 08:59:48 INFO - PROCESS | 2458 | |12;stanford-crypto-pbkdf2;181;188;177;171;177;249;241;171;170;232 08:59:48 INFO - PROCESS | 2458 | |13;stanford-crypto-sha256-iterative;70;71;84;89;87;93;80;67;70;66 08:59:48 INFO - PROCESS | 2458 | __end_tp_report 08:59:48 INFO - PROCESS | 2458 | __start_cc_report 08:59:48 INFO - PROCESS | 2458 | _x_x_mozilla_cycle_collect,1004 08:59:48 INFO - PROCESS | 2458 | __end_cc_report 08:59:48 INFO - PROCESS | 2458 | __startTimestamp1489078788044__endTimestamp 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | ------- Summary: start ------- 08:59:48 INFO - PROCESS | 2458 | Number of tests: 14 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#0] ai-astar Cycles:10 Average:133.90 Median:129.50 stddev:22.05 (17.0%) stddev-sans-first:21.30 08:59:48 INFO - PROCESS | 2458 | Values: 108.0 125.0 124.0 134.0 160.0 178.0 151.0 120.0 120.0 119.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#1] audio-beat-detection Cycles:10 Average:129.50 Median:132.00 stddev:19.85 (15.0%) stddev-sans-first:20.13 08:59:48 INFO - PROCESS | 2458 | Values: 146.0 130.0 149.0 169.0 114.0 111.0 114.0 116.0 134.0 112.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#2] audio-dft Cycles:10 Average:206.80 Median:204.50 stddev:10.65 (5.2%) stddev-sans-first:7.70 08:59:48 INFO - PROCESS | 2458 | Values: 229.0 221.0 206.0 212.0 199.0 200.0 198.0 202.0 203.0 198.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#3] audio-fft Cycles:10 Average:77.10 Median:78.50 stddev:14.94 (19.0%) stddev-sans-first:15.64 08:59:48 INFO - PROCESS | 2458 | Values: 84.0 58.0 61.0 88.0 63.0 65.0 73.0 88.0 101.0 90.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:76.50 stddev:20.30 (26.5%) stddev-sans-first:21.08 08:59:48 INFO - PROCESS | 2458 | Values: 94.0 58.0 84.0 91.0 58.0 69.0 104.0 60.0 88.0 116.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:90.00 stddev:6.42 (7.1%) stddev-sans-first:6.75 08:59:48 INFO - PROCESS | 2458 | Values: 90.0 90.0 98.0 90.0 89.0 89.0 109.0 90.0 89.0 90.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:96.00 stddev:25.37 (26.4%) stddev-sans-first:26.32 08:59:48 INFO - PROCESS | 2458 | Values: 97.0 139.0 154.0 96.0 96.0 96.0 98.0 152.0 96.0 96.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:91.00 stddev:4.56 (5.0%) stddev-sans-first:4.69 08:59:48 INFO - PROCESS | 2458 | Values: 89.0 91.0 93.0 93.0 89.0 104.0 93.0 91.0 90.0 88.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 08:59:48 INFO - PROCESS | 2458 | Values: 67.0 66.0 68.0 69.0 67.0 66.0 67.0 68.0 68.0 69.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:3.37 (5.6%) stddev-sans-first:2.91 08:59:48 INFO - PROCESS | 2458 | Values: 54.0 63.0 60.0 66.0 61.0 58.0 56.0 59.0 59.0 60.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#10] stanford-crypto-aes Cycles:10 Average:94.70 Median:87.00 stddev:10.75 (12.4%) stddev-sans-first:10.93 08:59:48 INFO - PROCESS | 2458 | Values: 86.0 87.0 96.0 109.0 110.0 110.0 87.0 88.0 89.0 85.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:155.50 stddev:19.82 (12.7%) stddev-sans-first:20.58 08:59:48 INFO - PROCESS | 2458 | Values: 147.0 160.0 152.0 146.0 145.0 148.0 156.0 155.0 212.0 164.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.70 Median:184.50 stddev:31.74 (17.2%) stddev-sans-first:33.22 08:59:48 INFO - PROCESS | 2458 | Values: 181.0 188.0 177.0 171.0 177.0 249.0 241.0 171.0 170.0 232.0 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - PROCESS | 2458 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:82.00 stddev:10.04 (12.2%) stddev-sans-first:10.26 08:59:48 INFO - PROCESS | 2458 | Values: 70.0 71.0 84.0 89.0 87.0 93.0 80.0 67.0 70.0 66.0 08:59:48 INFO - PROCESS | 2458 | -------- Summary: end -------- 08:59:48 INFO - PROCESS | 2458 | 08:59:48 INFO - TEST-INFO | 2458: exit 0 08:59:48 INFO - TEST-OK | kraken | took 62708ms 08:59:48 INFO - SUITE-END | took 1180s 08:59:49 INFO - Completed test suite (00:19:40) 08:59:49 INFO - javascript benchmark 08:59:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7628.854595307155, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2900.738933495985, 3441.4149594568903, 3460.273342598054, 3473.826308684565, 3506.526618906447, 5926.9407305926925, 5988.7604495820115, 6004.66974316413, 6064.211652485171, 6068.0291153415465, 5707.543396528278, 5754.108113242454, 5786.508146807527, 5900.852478688024, 5927.88144237115, 4441.977790111045, 5303.575713942894, 5389.973050134763, 5396.10964190908, 5436.864078398052, 5474.534664553517, 5503.6147469677135, 5514.5864060195445, 5518.475744804237, 5597.944020559803, 5500.009998200322, 5515.117581187011, 5516.034693928566, 5518.806841760539, 5529.419410961851, 891.132833995184, 4726.503717109723, 5334.0, 5343.198520221959, 5476.534494567966, 5355.196720491918, 5382.085045542228, 5390.865228369283, 5403.486668766461, 5404.891902161935, 4874.878128046827, 5065.46812584677, 5380.923815236929, 6005.759769609254, 6035.064564992434, 6302.023186406114, 6313.116163737081, 6335.8732825343695, 6341.8414539636415, 6356.0783686365685, 6392.968035159841, 6444.967775161141, 6466.805995820086, 6473.93526064738, 6477.935220647827, 5610.719464026783, 5618.213450116987, 6141.618856021587, 6148.6618235997, 6188.0, 6345.809625711236, 6362.077498762654, 6603.0, 6629.7679581214425, 6653.6340501271925, 5241.24002019705, 6256.311805701369, 6294.213223347082, 6344.555881088279, 6346.952752795829, 5828.970855145697, 6038.215032045894, 6394.360563943568, 6436.452901503331, 6439.871202576016, 6275.058741188858, 6290.622562646256, 6300.0234963580715, 6335.461485773761, 6363.33185015576, 6388.648624325614, 6397.776077837253, 6404.0, 6406.647634380154, 6454.548181627335, 5139.408967968731, 5202.375714914158, 5213.6089793265655, 5221.947780522222, 5270.446603106695, 3756.549214094326, 3982.721209515364, 4557.703749256288, 4620.1221767864, 4651.093036857848, 6178.938210617926, 6194.101855230966, 6216.875662486725, 6236.095766113979, 6248.687775567091, 6453.451456626145, 6529.640869752115, 6534.313897040743, 6538.1827271591055, 6544.836379090466, 5988.550858685616, 6046.274447066292, 6156.230471191101, 6231.22109736283, 6276.560640755195, 4533.342665313577, 5606.243157173811, 5628.09950407941, 5632.690202038845, 5682.460166284196, 6735.4274886635185, 6735.797926062226, 6736.4274036705465, 6750.346165189462, 6769.93230067693, 6430.003349480838, 6449.0, 6474.352564743488, 6508.73965041412, 6523.282438931618, 6353.555251132377, 6432.324605916311, 6588.143541339595, 6592.274849766426, 6735.955926831349, 6374.0, 6386.96806515983, 6390.616563006234, 6398.0, 6398.456131228898, 6358.237011558643, 6398.552101353047, 6413.166288382667, 6440.13058237132, 6459.838504037437, 4748.525147485224, 6160.414760597736, 6222.222222222223, 6306.495480361652, 6370.872582548416, 6281.424615907456, 6347.777827776005, 6350.841228969312, 6354.364563543609, 6355.428011478989, 6059.878802424015, 6139.785107521216, 6186.690665466619, 6223.626582405071, 6255.937440625536, 6195.132681424694, 6229.844253893689, 6304.5586808922935, 6324.494040476843, 6325.209348831396, 4985.700857948535, 6277.497800176066, 6300.338464461165, 6312.842178945563, 6317.431431171217], "value": 5826.698363966945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.3581648149631, 758.4614923404383, 800.8158123631566, 929.2287401456791, 938.2962777916558, 36925.076873078186, 37490.0, 38871.25396785722, 38967.02582435441, 39096.80451597745, 37429.43855842158, 37591.0, 37593.68422105227, 37660.0, 37664.62335376645, 7719.228077192292, 7829.843403131934, 10976.890231097666, 11238.044766194884, 11350.262232954832, 11115.555377784878, 11175.105991520699, 11242.213045086848, 11246.606368777095, 11251.212415130904, 11156.609518666848, 11165.218434709574, 11251.381174035425, 11254.662360129209, 11279.49242284095, 9377.0, 9432.0, 11027.944860275727, 11170.664880053571, 11195.936386043313, 10771.892281077246, 10778.461076946121, 10810.243282970196, 10839.0, 10839.18706097038, 24924.0, 37567.436488452695, 37763.0, 37781.81109094437, 37953.62046379528, 3767.7174211934216, 3768.321702093622, 3800.5629352624524, 3813.637704418076, 3947.526296844397, 22030.339089827332, 27064.864675676694, 28130.296742581395, 28135.0152744655, 28164.577531337047, 3081.2142903559675, 3123.7813353065294, 3150.6219253689474, 3204.9198770030935, 3262.9021129366156, 311704.0, 313535.0, 313536.43231783924, 313811.0, 314937.42531287426, 48732.756336218095, 49411.0, 49457.50542494601, 49501.0, 49562.25656615154, 40142.0, 48485.75757121263, 50734.0, 50742.0, 50916.236256456184, 11465.770684586429, 12981.545645902348, 13054.934725326313, 14234.43062277518, 14359.425622975174, 11599.362035087983, 11682.072458044497, 11743.295402275891, 11758.470868810924, 11810.52757889692, 10080.445575493271, 12683.365831708563, 12779.36103194855, 12819.0, 12876.291803950686, 5998.970005150034, 6017.983975368213, 6056.0, 6062.151298818169, 6066.4227300902085, 981.1464026297167, 1037.3516552154904, 1091.82530795074, 1110.9166812489095, 1114.3425379026414, 22135.667964980537, 25951.74048259531, 26041.95832166692, 26206.475870482485, 26374.208773736435, 1154.6074334726234, 1209.8366720492797, 1225.7119576899422, 1243.4031664800946, 1264.563725514696, 13248.933755331162, 13301.66745831362, 13505.189688618715, 13672.65818354549, 13684.384202710902, 395846.0, 398521.0, 398583.0, 399148.0, 399452.0027399844, 41389.965250868365, 54295.45704542983, 54387.728061360234, 54492.0, 54618.72690636521, 1219.0552321950381, 1256.5225214418463, 1294.372229468707, 1303.7327347893658, 1427.0, 24817.62773558362, 26001.56991365493, 28847.711522885344, 29080.56379154272, 29279.852328568762, 38865.0, 38881.22237555176, 39282.60717392789, 39375.2124957505, 39439.0, 372430.0, 376798.0, 378806.0, 378851.0, 378929.0, 32310.19224519406, 32451.67548324581, 32460.35079298448, 32501.349972999935, 32509.34981300408, 41163.0, 41822.0, 41860.37209441922, 43067.7846610765, 43349.13301734011, 28541.001064962627, 30816.0, 33840.984770456926, 34022.0, 34852.47721284132, 34189.31621367509, 34246.0, 34924.47613285854, 35386.29227415489, 35661.64338356583, 35534.644653553136, 35854.924352269474, 35867.46198806968, 35886.820565897004, 39739.40390894081, 32246.54890529885, 34350.48474272838, 34412.13969650779, 39827.60172398239, 40032.79983600063, 29702.811887524258, 29803.254918627208, 30534.38931221319, 31117.8444107778, 31120.53319200259], "value": 18589.450545902862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.56774116213325, 397.75339289640425, 403.42310495990733, 408.6975638027859, 436.9781510924453, 20485.0, 21129.73221606705, 21278.361649150513, 21924.0, 22163.0, 21777.782222177775, 21920.89039554804, 22165.778342216574, 22541.661875071888, 22778.430539236488, 6342.14381058557, 6436.292007879129, 6470.126532918066, 6481.93518064818, 6490.643014634194, 6206.0, 6397.680115994205, 6455.289918109004, 6512.283648798629, 6526.401031747228, 6427.421532062113, 6483.092367068614, 6511.251206111287, 6518.315576864432, 6544.312847151052, 6203.0, 6469.902951455732, 6511.0558968949235, 6519.348065193491, 6525.314841941576, 6059.697015149225, 6336.081268216129, 6346.9682651586445, 6350.682465876687, 6374.330695277022, 26360.60459093115, 26471.73528264731, 26579.73420265792, 26630.86684566584, 27026.864865675743, 2801.9299517512227, 2903.7096290371005, 2909.3890283040587, 2912.0972498525525, 2913.9708602914125, 16319.265633046542, 16339.26473308704, 16782.412615558518, 16880.07159606221, 17469.301227950866, 1929.1897403090736, 2024.5242368043498, 2033.9389818305326, 2060.443680206336, 2086.374087773662, 125338.0, 129232.0, 158985.0, 161662.0, 162845.0, 17783.46649600514, 21902.561948761253, 22545.88727056387, 22702.659460108112, 22968.27737919663, 36174.45738313928, 36222.45666314955, 36296.27407451836, 36451.27097458036, 36494.53301936365, 9295.860562091573, 9544.95227523858, 9640.566174522164, 9820.607175713034, 9821.508924553744, 7605.733799316998, 7614.466987310946, 7617.238276172338, 7694.576798276036, 7767.0, 10875.293105948089, 10949.343039417661, 10959.397233152253, 11114.944425277821, 11130.942560456744, 3788.242351529705, 3805.4291856221234, 4148.481439820022, 4181.323952670294, 4185.162967406531, 873.5850471026212, 993.8757655293089, 1027.291169093323, 1043.7025447747355, 1081.588996181446, 23132.65301020486, 23569.41076473102, 23687.289381318587, 23719.407014824767, 23724.64413033806, 889.8432038350119, 953.4660590069583, 977.2816979520047, 980.6616717232544, 992.9602815887428, 10179.389236645826, 11050.668479945614, 11312.547498099984, 11620.012298954684, 11767.88232117685, 537126.0, 572660.0, 713434.0, 719341.0, 729795.0, 143334.84997725041, 145491.0, 148216.0, 149659.50340496455, 151014.24492877466, 1213.8118591618313, 1244.9315287659085, 1309.8821106100497, 1316.2694704438936, 1338.6653336665834, 18583.72124418162, 21307.0, 21504.269575340943, 21748.13007479683, 21865.344039678836, 49128.0, 62002.20990055368, 62100.0, 62415.6879215601, 62856.0, 70887.9366809488, 79965.0, 81682.59158704168, 89052.5547372259, 89347.55326223327, 11671.649850504498, 11965.0, 12011.4594843234, 12313.753724925631, 12512.436940337524, 13698.972577056562, 13734.725305494034, 13758.724825503234, 14044.929775351058, 14133.717325653635, 8734.868976965223, 9731.805363892541, 11526.0, 11754.529818807152, 11846.466908989289, 10528.210384221062, 10576.629817956642, 11416.372099534605, 11709.707257318294, 11774.764504710029, 10471.895281047093, 11631.709207269885, 11719.0, 12064.457099430721, 12154.453049612612, 11941.940290298493, 12019.09856760764, 12242.265464072185, 12272.140950133406, 12405.317707525812, 11540.596079137189, 11667.474963626826, 11886.762264754483, 11963.820542692041, 12065.81901271464], "value": 11630.074740198292, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.4709089909484, 1539.7613369927665, 1558.1196623907492, 1598.6562888978867, 1612.7822743929569, 9363.15731584159, 9614.230861531078, 10512.053915147635, 11112.833307500385, 11142.220044596872, 10388.480575971209, 10738.463076846147, 10757.031867131956, 10768.138548916088, 10991.890081099187, 2299.6665483504926, 2345.226075395124, 2351.6825228594093, 2356.552255071531, 2357.7288611809604, 1671.9884469895721, 1932.420273917826, 2328.0, 2349.3891588187025, 2379.4765151666693, 1906.4852489827738, 2317.0, 2331.079223706635, 2333.871637059961, 2341.7072865891764, 2277.6697378880135, 2283.1324096843177, 2287.2223444029028, 2291.0606651272897, 2294.2314324701247, 2265.501589650274, 2278.715160604924, 2347.448349637834, 2351.6354964980455, 2352.141468364052, 11129.387883666395, 11205.327680339205, 11215.439228038565, 11224.887751122465, 11245.83131253032, 5749.108888122348, 5880.9411905880825, 5903.439173278532, 5907.054871220627, 5933.881322373529, 3381.678740519647, 3463.428534291839, 3668.321360548307, 3675.761075530082, 3687.631236876318, 1127.6729748372961, 1153.5039932828881, 1158.5018442069907, 1197.4312201704208, 1213.1083653514659, 12300.446479908336, 12449.626511204588, 13657.8390836779, 15147.56098170683, 15216.771748423782, 4727.385439892861, 4795.496472870298, 4841.878953026132, 4907.2393778964315, 4918.606511479073, 12639.873601264053, 12654.81017784734, 12686.492540298284, 12708.173968692005, 12711.110222284351, 5732.05421105513, 5821.941780582225, 5825.33008703996, 5834.154047663065, 5924.555658325643, 4495.43807024122, 5003.649744517848, 5189.273501709764, 5216.947830521722, 5322.281491998608, 3910.902227444337, 4016.8995775105855, 4027.436158937751, 4094.897627559335, 4104.117614712851, 938.9530523473799, 1129.6836885672026, 1130.1354463835173, 1140.3408041299888, 1146.9770604587861, 770.622395026433, 786.3198333441532, 807.1766797866261, 809.6032943857467, 815.0820064170256, 6321.304656487782, 6385.680715964183, 6646.734130634817, 6674.132362792806, 6697.760914230883, 909.5043201455222, 986.6398764451068, 999.8400255959011, 1007.2445665750687, 1037.5019990404496, 3930.8231129599235, 4070.3690927906223, 4185.476815398075, 4259.765712885759, 4350.195213885441, 12984.117302991013, 13272.27002514871, 13445.663858403617, 13467.595972120656, 13471.0, 12797.488100475877, 13038.934805326102, 13305.80041299362, 13306.933465332804, 13406.664833379244, 9881.456519891475, 9930.751731206634, 10037.996200379903, 10066.345687530433, 10068.59725610982, 6377.585456945284, 6404.103425520338, 6432.9385651367, 6484.1246431731115, 6569.343065693392, 11810.173287869766, 11934.462949167482, 12036.699082523008, 12073.154879158375, 12173.57392491294, 11947.82078268844, 12073.698157546132, 12282.75434491323, 12360.134790564574, 12390.194637348544, 7807.726729564438, 8036.919630803617, 8727.956360218159, 8995.505247211466, 9140.497272650067, 10243.795124097625, 10317.9484102579, 10394.688159355232, 10430.42632655181, 10439.582416703246, 8980.910190898006, 9042.819143617222, 9069.274458043208, 9144.131307525775, 9197.816043679222, 8670.479771213748, 8851.69019084329, 8976.596053177753, 8993.775155621162, 9068.0, 6434.967825160844, 7699.345555627834, 7744.651490683045, 7811.296983271533, 7873.724419645285, 5809.883802324014, 5825.3883342248455, 5891.440313170242, 5923.052311630118, 6010.038393856962, 5230.34620672416, 5698.572607054404, 5952.970235148797, 5996.433904874156, 6009.248843894513], "value": 5044.452243754027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.37912927153127, 379.9753016053956, 381.8548951398468, 389.58509187715083, 393.7165241026462, 4166.895552947642, 4558.37041254051, 4917.262410638406, 5084.288199652052, 5187.533122019017, 4363.6509079273665, 4423.380726698265, 5063.999999999991, 5064.620153488494, 5116.948830511694, 3573.731970102253, 4146.475495828537, 4172.937405938906, 4206.558311377307, 4219.2405367033925, 4194.811942923385, 4266.935995960063, 4275.0, 4282.293421585435, 4315.82736690532, 3609.0, 3650.507181530499, 3750.8124593770203, 4265.53079161292, 4299.5485474025245, 3594.9101272468138, 3611.9277614447697, 3844.7693138411646, 3939.2712348215387, 3983.0881177034894, 3648.5074514940675, 3887.3391523441082, 3912.2371137628174, 3915.9216815663813, 3934.288584465738, 4450.020995381011, 4517.932231016537, 4910.508949105061, 5041.470645582234, 5076.670016448956, 4406.725476287996, 4874.326794924513, 4878.658493905428, 4936.432310284327, 4952.554270115671, 4243.554426785205, 5257.789688412459, 5454.509094181542, 5522.199281104217, 5526.917096243559, 3827.923441531154, 4125.29869922114, 4218.865511798424, 4326.048269380732, 4341.9131617367475, 4635.860924172281, 5244.580433565306, 5560.666360018412, 5658.43415658435, 5854.97072514639, 3450.9309813803584, 3888.2806680764147, 3903.497153595886, 4545.909081818345, 4559.788502576248, 4045.1707399982934, 4122.793860306972, 4455.532169122261, 4621.6302695784925, 4673.564929776611, 4478.57453541913, 4959.429665588431, 4975.577075948585, 4991.5258050485145, 5021.7740201690285, 4714.81140754366, 5496.6701997880255, 5504.256925315031, 5556.916156441334, 5626.887462250732, 1438.3383643523887, 1466.538040517255, 1478.2165452310078, 1563.2881994216316, 1568.9293981770847, 1086.7174534621056, 1105.6075093341908, 1165.8076417391035, 1166.5800311887713, 1170.7658468306372, 4529.230030894756, 4777.402824646919, 5163.772642098688, 5173.71544565045, 5202.309249493854, 4934.432540257916, 5223.093570846614, 5275.892062666806, 5770.980156945036, 5800.50695690871, 4312.698111132253, 4605.723656580616, 4848.0546293472435, 4859.878503037452, 4962.354893863775, 2604.3852811257143, 2726.4001919577663, 2738.589211618273, 2755.7244275572284, 2987.9701202988126, 4937.0, 5092.0, 5897.262842144732, 5912.320083190488, 6005.948958932169, 5040.420351659533, 5407.161889907071, 5408.269883565668, 5550.093712315334, 5855.560832937546, 4766.880827979328, 5436.782528698887, 5488.545535433033, 5599.380511078377, 5709.914351284817, 4953.925691114709, 5069.524913093924, 5412.83761487156, 5691.121929763085, 5697.4587414195585, 4498.572635599613, 4897.779599917941, 5471.699056551928, 5597.944020559742, 5667.603267771216, 5343.759530821045, 5451.918221226605, 5660.499967508531, 5880.294364676266, 5881.470667639933, 3709.8516059358403, 4110.862351577103, 4377.299632058855, 4403.955960440355, 4428.247197976288, 4680.859574212779, 5013.568419316702, 5167.483251674803, 5435.347758269033, 5640.830775076754, 5154.974225128851, 5161.896762064813, 5517.227588137584, 5542.418046105262, 5543.916841247304, 4776.283557466269, 4992.450830408579, 5107.744612769421, 5110.642255042111, 5381.730913454233, 4160.148611654211, 4794.640401969936, 4900.754962251802, 4961.975190124026, 5211.60912931524, 5129.820456284012, 5296.7351632418995, 5404.351477822686, 5480.314960629921, 5511.5039646432015, 4656.231721765871, 4659.83504123969, 5298.6290959634, 5323.760430780701, 5372.307723067222], "value": 4117.603317971329, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.424624684635, 714.4891402647106, 773.4122067228905, 799.1728560939428, 800.4596897094461, 15116.697666046672, 15604.375824966988, 16138.0, 16216.918915405437, 16318.347266109356, 15027.173505457196, 15041.699166016673, 15174.0, 15197.316120774563, 15198.088114713126, 931.9487428191446, 969.9563519641598, 979.7550612346913, 981.2150279776187, 982.9606815727362, 798.409177208867, 923.6628630549868, 967.8935317115112, 974.5273542331963, 980.568549838069, 977.9706608801712, 982.5971351745785, 984.1782111936542, 994.3983889746708, 995.5569771451707, 980.9803803923917, 986.9654562090292, 989.1839232633107, 990.5889056041734, 990.7770751580908, 737.3216640690578, 740.7851723000324, 741.4142827166532, 742.7548908860064, 743.353282644103, 16179.91910040454, 16436.83563164377, 16518.587035324093, 16582.419615313527, 16696.916515417346, 14557.490487832874, 14721.630605704748, 14861.777073343908, 14891.10653360791, 15486.993345432624, 8867.600957956844, 11461.828072578917, 11555.306681599046, 11943.0, 12129.818052729217, 3266.7059964603063, 3684.6499582539614, 3782.0328674307534, 3789.2232092421264, 3873.0898238913833, 78250.60874695647, 83529.58235208785, 93021.53489232578, 102462.0, 107251.46374268079, 9480.24158067353, 10289.0, 11390.544378224944, 11627.825582616268, 11826.11304152192, 21163.0, 21764.12943482243, 22304.0, 23739.931703073402, 24305.878470607535, 7987.800304992422, 8043.0, 8053.959730201312, 8133.389995750343, 8258.256756891788, 4183.958160418357, 4210.642095421924, 4239.292457517627, 4285.37862010013, 4293.592108749664, 3468.826558672107, 3530.135116896377, 3543.309054734302, 3572.1962558424148, 3572.374834404021, 644.9967750161219, 646.4279112984948, 651.680676468527, 655.3741177175881, 674.150570281449, 590.819799961016, 662.4634046422317, 664.9468042556584, 678.2403707847144, 680.7991642465386, 9985.650502232533, 10044.745951261199, 10096.495175241209, 10231.0, 10310.639127630497, 639.9200099987502, 685.3078390825302, 688.7795905310353, 697.919739229995, 700.7127077898037, 4436.44544431946, 4610.631149508032, 4791.353167322437, 4791.5687588117235, 4806.831760888352, 96201.51899240458, 99908.0, 100389.0, 101384.0, 101415.0, 63701.0, 84481.0, 85991.57004214938, 86212.0, 86715.0, 60002.0, 64299.678501607195, 64366.678166608865, 64947.02579461312, 65312.0, 9290.303227257848, 9481.146696797321, 9660.855087173839, 9691.321607487691, 9711.66009189675, 40709.59290407058, 42248.5775142257, 43311.0, 45247.86880327886, 47095.529044710485, 61052.38947610467, 63646.68176659087, 65800.0, 67456.0, 69101.65449172923, 13175.407106680032, 13650.795238071238, 13808.723825523231, 14034.859651403356, 14394.568162955127, 14679.41282348694, 14690.485832995793, 14742.189179595225, 14808.0, 15017.924910375377, 13487.527936522174, 13635.659108522366, 13663.863361366259, 13690.863091369358, 13962.371693273624, 13223.471061157446, 13268.535601254296, 13528.526501572398, 13961.969780533831, 13969.371378287799, 13256.0, 13264.668383290495, 13297.867021329663, 13411.664708382368, 13766.65583360424, 9100.954495227481, 11030.669079927615, 11100.278481898651, 11208.439578020903, 11583.536658533565, 6441.57953909471, 10274.897251027693, 11326.37704926237, 11359.772804544029, 11505.022073123879], "value": 7533.261292256423, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 125.0, 124.0, 134.0, 160.0, 178.0, 151.0, 120.0, 120.0, 119.0], "value": 133.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 130.0, 149.0, 169.0, 114.0, 111.0, 114.0, 116.0, 134.0, 112.0], "value": 129.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 221.0, 206.0, 212.0, 199.0, 200.0, 198.0, 202.0, 203.0, 198.0], "value": 206.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 61.0, 88.0, 63.0, 65.0, 73.0, 88.0, 101.0, 90.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 58.0, 84.0, 91.0, 58.0, 69.0, 104.0, 60.0, 88.0, 116.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 98.0, 90.0, 89.0, 89.0, 109.0, 90.0, 89.0, 90.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 139.0, 154.0, 96.0, 96.0, 96.0, 98.0, 152.0, 96.0, 96.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 93.0, 93.0, 89.0, 104.0, 93.0, 91.0, 90.0, 88.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 69.0, 67.0, 66.0, 67.0, 68.0, 68.0, 69.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 63.0, 60.0, 66.0, 61.0, 58.0, 56.0, 59.0, 59.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 96.0, 109.0, 110.0, 110.0, 87.0, 88.0, 89.0, 85.0], "value": 94.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 160.0, 152.0, 146.0, 145.0, 148.0, 156.0, 155.0, 212.0, 164.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 188.0, 177.0, 171.0, 177.0, 249.0, 241.0, 171.0, 170.0, 232.0], "value": 195.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 84.0, 89.0, 87.0, 93.0, 80.0, 67.0, 70.0, 66.0], "value": 77.7, "unit": "score"}]}]} 08:59:49 INFO - Return code: 0 08:59:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:49 ERROR - # TBPL SUCCESS # 08:59:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:49 INFO - 2017-03-09 08:59:49.384 screenresolution[2463:38389] starting screenresolution argv=screenresolution get 08:59:49 INFO - 2017-03-09 08:59:49.388 screenresolution[2463:38389] Display 0: 1600x1200x32@60 08:59:49 INFO - 2017-03-09 08:59:49.394 screenresolution[2464:38392] starting screenresolution argv=screenresolution list 08:59:49 INFO - Available Modes on Display 0 08:59:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:49 INFO - Intel Iris: 08:59:49 INFO - Chipset Model: Intel Iris 08:59:49 INFO - Type: GPU 08:59:49 INFO - Bus: Built-In 08:59:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:49 INFO - Vendor: Intel (0x8086) 08:59:49 INFO - Device ID: 0x0a2e 08:59:49 INFO - Revision ID: 0x0009 08:59:49 INFO - Displays: 08:59:49 INFO - Display: 08:59:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:49 INFO - Display Serial Number: 1600x1200 60 08:59:49 INFO - Main Display: Yes 08:59:49 INFO - Mirror: Off 08:59:49 INFO - Online: Yes 08:59:49 INFO - Rotation: Supported 08:59:49 INFO - Return code: 0 08:59:49 INFO - Running post-action listener: _resource_record_post_action 08:59:49 INFO - [mozharness: 2017-03-09 16:59:49.635084Z] Finished run-tests step (success) 08:59:49 INFO - Running post-run listener: _resource_record_post_run 08:59:49 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 282624; Write bytes: 512799232; Read time: 2; Write time: 1540 08:59:49 INFO - TinderboxPrint: CPU usage
54.7% 08:59:49 INFO - TinderboxPrint: I/O read bytes / time
282,624 / 2 08:59:49 INFO - TinderboxPrint: I/O write bytes / time
512,799,232 / 1,540 08:59:49 INFO - TinderboxPrint: CPU idle
2,174.7 (45.3%) 08:59:49 INFO - TinderboxPrint: CPU system
971.3 (20.2%) 08:59:49 INFO - TinderboxPrint: CPU user
1,659.8 (34.5%) 08:59:49 INFO - TinderboxPrint: Swap in / out
209,559,552 / 0 08:59:49 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205173248; Write bytes: 200863744; Read time: 15792; Write time: 371 08:59:49 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 282624; Write bytes: 301163008; Read time: 2; Write time: 1134 08:59:50 INFO - Running post-run listener: _upload_blobber_files 08:59:50 INFO - Blob upload gear active. 08:59:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:50 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 08:59:50 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'] 08:59:50 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 08:59:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:59:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:59:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:51 INFO - (blobuploader) - INFO - Done attempting. 08:59:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:59:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:59:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:52 INFO - (blobuploader) - INFO - Done attempting. 08:59:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:59:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:59:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:53 INFO - (blobuploader) - INFO - Done attempting. 08:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:55 INFO - (blobuploader) - INFO - Done attempting. 08:59:55 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:55 INFO - Return code: 0 08:59:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/855062a9ce228f422af785932757984dc4bee7d541c25ab401682feda05b8bcf9879f6cb7da4bc7d376c06e6cb3b1caf8dc3c922e728a165142dc46b7206c6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2180f2c413f57cd3d8d306bd59e8249aaf6eace36ec62c9cd2c2ac9cc2e7497be6d24150959a9ef2c613ff94189af2ed073aefe59a39af3cd5aee92e7d9ee3f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9dcb0e84cf24b159bdb424f1d9b7e0689c11a821f926f44ce39b1ea5f32b589d6754065dcc208fb1d7c30a5a97dd82b923fa356e6a78d5f4fc26f70dfdd7aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e46f1cbadc45fb6ee8eb1cc6e28766477bba2eea51b6822da739a7e0c853379125524e1fe2540c4249ae27e6462f3947e6429e6891e02b74357f919a373cd0"} 08:59:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:55 INFO - Contents: 08:59:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/855062a9ce228f422af785932757984dc4bee7d541c25ab401682feda05b8bcf9879f6cb7da4bc7d376c06e6cb3b1caf8dc3c922e728a165142dc46b7206c6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2180f2c413f57cd3d8d306bd59e8249aaf6eace36ec62c9cd2c2ac9cc2e7497be6d24150959a9ef2c613ff94189af2ed073aefe59a39af3cd5aee92e7d9ee3f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9dcb0e84cf24b159bdb424f1d9b7e0689c11a821f926f44ce39b1ea5f32b589d6754065dcc208fb1d7c30a5a97dd82b923fa356e6a78d5f4fc26f70dfdd7aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e46f1cbadc45fb6ee8eb1cc6e28766477bba2eea51b6822da739a7e0c853379125524e1fe2540c4249ae27e6462f3947e6429e6891e02b74357f919a373cd0"} 08:59:55 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:55 INFO - Copying logs to upload dir... 08:59:55 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.181098 ========= master_lag: 2.64 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-09 08:59:58.546065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 08:59:58.549071) ========= 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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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/855062a9ce228f422af785932757984dc4bee7d541c25ab401682feda05b8bcf9879f6cb7da4bc7d376c06e6cb3b1caf8dc3c922e728a165142dc46b7206c6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2180f2c413f57cd3d8d306bd59e8249aaf6eace36ec62c9cd2c2ac9cc2e7497be6d24150959a9ef2c613ff94189af2ed073aefe59a39af3cd5aee92e7d9ee3f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9dcb0e84cf24b159bdb424f1d9b7e0689c11a821f926f44ce39b1ea5f32b589d6754065dcc208fb1d7c30a5a97dd82b923fa356e6a78d5f4fc26f70dfdd7aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e46f1cbadc45fb6ee8eb1cc6e28766477bba2eea51b6822da739a7e0c853379125524e1fe2540c4249ae27e6462f3947e6429e6891e02b74357f919a373cd0"} build_url:https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/HYyjobebRnuhLKdz7SzwSg/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/855062a9ce228f422af785932757984dc4bee7d541c25ab401682feda05b8bcf9879f6cb7da4bc7d376c06e6cb3b1caf8dc3c922e728a165142dc46b7206c6c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2180f2c413f57cd3d8d306bd59e8249aaf6eace36ec62c9cd2c2ac9cc2e7497be6d24150959a9ef2c613ff94189af2ed073aefe59a39af3cd5aee92e7d9ee3f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee9dcb0e84cf24b159bdb424f1d9b7e0689c11a821f926f44ce39b1ea5f32b589d6754065dcc208fb1d7c30a5a97dd82b923fa356e6a78d5f4fc26f70dfdd7aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e46f1cbadc45fb6ee8eb1cc6e28766477bba2eea51b6822da739a7e0c853379125524e1fe2540c4249ae27e6462f3947e6429e6891e02b74357f919a373cd0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 08:59:58.591842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:59:58.592182) ========= 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.jJnCbX8JQY/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.JTIuD7R4CU/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005356 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 08:59:58.640324) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 08:59:58.640638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 08:59:58.640941) ========= ========= Total master_lag: 2.79 =========