builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0278 starttime: 1494434353.74 results: success (0) buildid: 20170510081522 builduid: dca611a43d0f4795a306ee7bda4e47c8 revision: 6b0cf48f6481fc2d27b888a2e35878f7f57b75a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.743754) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.744321) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.744644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.771894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.772276) ========= 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.zse8QcW0AH/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.1WU6a0J9g9/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-05-10 09:39:13-- 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% 20.0M=0.001s 2017-05-10 09:39:13 (20.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130145 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.932248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.932612) ========= 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.zse8QcW0AH/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.1WU6a0J9g9/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.024966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:13.987297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 09:39:13.987940) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6b0cf48f6481fc2d27b888a2e35878f7f57b75a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6b0cf48f6481fc2d27b888a2e35878f7f57b75a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zse8QcW0AH/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.1WU6a0J9g9/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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-05-10 09:39:14,096 truncating revision to first 12 chars 2017-05-10 09:39:14,096 Setting DEBUG logging. 2017-05-10 09:39:14,096 attempt 1/10 2017-05-10 09:39:14,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6b0cf48f6481?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 09:39:15,870 unpacking tar archive at: mozilla-beta-6b0cf48f6481/testing/mozharness/ program finished with exit code 0 elapsedTime=2.571424 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-10 09:39:16.586457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:16.586829) ========= script_repo_revision: 6b0cf48f6481fc2d27b888a2e35878f7f57b75a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:16.587287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:16.587598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 09:39:16.606968) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-10 09:39:16.607302) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zse8QcW0AH/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.1WU6a0J9g9/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:39:16 INFO - MultiFileLogger online at 20170510 09:39:16 in /builds/slave/test 09:39:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:39:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:16 INFO - {'append_to_log': False, 09:39:16 INFO - 'base_work_dir': '/builds/slave/test', 09:39:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:39:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:16 INFO - 'branch': 'Mozilla-Beta', 09:39:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:16 INFO - 'config_files': ('talos/mac_config.py',), 09:39:16 INFO - 'default_actions': ('clobber', 09:39:16 INFO - 'read-buildbot-config', 09:39:16 INFO - 'download-and-extract', 09:39:16 INFO - 'populate-webroot', 09:39:16 INFO - 'create-virtualenv', 09:39:16 INFO - 'install', 09:39:16 INFO - 'run-tests'), 09:39:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:16 INFO - 'download_minidump_stackwalk': True, 09:39:16 INFO - 'download_symbols': 'ondemand', 09:39:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:16 INFO - 'gecko_profile': False, 09:39:16 INFO - 'gecko_profile_interval': 0, 09:39:16 INFO - 'installer_path': 'installer.exe', 09:39:16 INFO - 'log_level': 'info', 09:39:16 INFO - 'log_name': 'talos', 09:39:16 INFO - 'log_to_console': True, 09:39:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:39:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:39:16 INFO - 'opt_config_files': (), 09:39:16 INFO - 'pip_index': False, 09:39:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:16 INFO - 'cmd': ('bash', 09:39:16 INFO - '-c', 09:39:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:16 INFO - 'enabled': True, 09:39:16 INFO - 'halt_on_failure': False, 09:39:16 INFO - 'name': 'check_screen_resolution'},), 09:39:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:16 INFO - 'cmd': ('bash', 09:39:16 INFO - '-c', 09:39:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:16 INFO - 'enabled': True, 09:39:16 INFO - 'halt_on_failure': False, 09:39:16 INFO - 'name': 'check_screen_resolution'},), 09:39:16 INFO - 'run_cmd_checks_enabled': True, 09:39:16 INFO - 'suite': 'dromaeojs-e10s', 09:39:16 INFO - 'system_bits': '32', 09:39:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:16 INFO - 'title': 't-yosemite-r7-0278', 09:39:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:16 INFO - 'use_talos_json': True, 09:39:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:16 INFO - 'work_dir': 'build'} 09:39:16 INFO - [mozharness: 2017-05-10 16:39:16.823530Z] Running clobber step. 09:39:16 INFO - Running pre-action listener: _resource_record_pre_action 09:39:16 INFO - Running main action method: clobber 09:39:16 INFO - rmtree: /builds/slave/test/build 09:39:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:19 INFO - Running post-action listener: _resource_record_post_action 09:39:19 INFO - [mozharness: 2017-05-10 16:39:19.269429Z] Finished clobber step (success) 09:39:19 INFO - [mozharness: 2017-05-10 16:39:19.269581Z] Running read-buildbot-config step. 09:39:19 INFO - Running pre-action listener: _resource_record_pre_action 09:39:19 INFO - Running main action method: read_buildbot_config 09:39:19 INFO - Using buildbot properties: 09:39:19 INFO - { 09:39:19 INFO - "project": "", 09:39:19 INFO - "product": "firefox", 09:39:19 INFO - "script_repo_revision": "production", 09:39:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:39:19 INFO - "repository": "", 09:39:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:39:19 INFO - "buildid": "20170510081522", 09:39:19 INFO - "pgo_build": "False", 09:39:19 INFO - "basedir": "/builds/slave/test", 09:39:19 INFO - "buildnumber": 30, 09:39:19 INFO - "slavename": "t-yosemite-r7-0278", 09:39:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:39:19 INFO - "platform": "yosemite_r7", 09:39:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:39:19 INFO - "branch": "mozilla-beta", 09:39:19 INFO - "repo_path": "releases/mozilla-beta", 09:39:19 INFO - "revision": "6b0cf48f6481fc2d27b888a2e35878f7f57b75a9", 09:39:19 INFO - "stage_platform": "macosx64", 09:39:19 INFO - "builduid": "dca611a43d0f4795a306ee7bda4e47c8", 09:39:19 INFO - "slavebuilddir": "test" 09:39:19 INFO - } 09:39:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 09:39:19 INFO - Running post-action listener: _resource_record_post_action 09:39:19 INFO - [mozharness: 2017-05-10 16:39:19.273057Z] Finished read-buildbot-config step (success) 09:39:19 INFO - [mozharness: 2017-05-10 16:39:19.273200Z] Running download-and-extract step. 09:39:19 INFO - Running pre-action listener: _resource_record_pre_action 09:39:19 INFO - Running main action method: download_and_extract 09:39:19 INFO - mkdir: /builds/slave/test/build/tests 09: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')]} 09:39:19 INFO - trying https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 09:39:19 INFO - Downloading https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 09:39:20 INFO - Downloaded 1287 bytes. 09:39:20 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:39:20 INFO - Using the following test package requirements: 09:39:20 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 09:39:20 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:39:20 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 09:39:20 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 09:39:20 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:39:20 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 09:39:20 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:39:20 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 09:39:20 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 09:39:20 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 09:39:20 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:39:20 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 09:39:20 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 09:39:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:39:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:39:20 INFO - Fetch https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:39:22 INFO - Expected file size: 51225203 09:39:22 INFO - Obtained file size: 51225203 09:39:37 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:39:39 INFO - Expected file size: 51225203 09:39:39 INFO - Obtained file size: 51225203 09:39:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 09:39:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 09:39:54 INFO - Fetch https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 09:39:55 INFO - Expected file size: 14404449 09:39:55 INFO - Obtained file size: 14404449 09:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:55 INFO - trying https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:39:55 INFO - Downloading https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 09:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 09:39:57 INFO - Downloaded 59571003 bytes. 09:39:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:39:57 INFO - mkdir: /builds/slave/test/properties 09:39:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:57 INFO - Contents: 09:39:57 INFO - build_url:https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:39:58 INFO - Running post-action listener: _resource_record_post_action 09:39:58 INFO - Running post-action listener: set_extra_try_arguments 09:39:58 INFO - [mozharness: 2017-05-10 16:39:58.591927Z] Finished download-and-extract step (success) 09:39:58 INFO - [mozharness: 2017-05-10 16:39:58.592078Z] Running populate-webroot step. 09:39:58 INFO - Running pre-action listener: _resource_record_pre_action 09:39:58 INFO - Running main action method: populate_webroot 09:39:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:58 INFO - '--tppagecycles', 09:39:58 INFO - '7'], 09:39:58 INFO - 'tests': ['tsvgm']}}, 09:39:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['damp', 'tps']}, 09:39:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'tests': ['damp', 'tps']}, 09:39:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['dromaeo_dom']}, 09:39:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['basic_compositor_video']}, 09:39:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['a11yr', 09:39:58 INFO - 'ts_paint', 09:39:58 INFO - 'tpaint', 09:39:58 INFO - 'sessionrestore', 09:39:58 INFO - 'sessionrestore_no_auto_restore', 09:39:58 INFO - 'tabpaint']}, 09:39:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:58 INFO - 'ts_paint', 09:39:58 INFO - 'tpaint', 09:39:58 INFO - 'sessionrestore', 09:39:58 INFO - 'sessionrestore_no_auto_restore', 09:39:58 INFO - 'tabpaint']}, 09:39:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:58 INFO - 'ts_paint', 09:39:58 INFO - 'tpaint', 09:39:58 INFO - 'sessionrestore', 09:39:58 INFO - 'sessionrestore_no_auto_restore', 09:39:58 INFO - 'tabpaint']}, 09:39:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:58 INFO - 'ts_paint', 09:39:58 INFO - 'tpaint', 09:39:58 INFO - 'sessionrestore', 09:39:58 INFO - 'sessionrestore_no_auto_restore', 09:39:58 INFO - 'tabpaint']}, 09:39:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['a11yr', 09:39:58 INFO - 'ts_paint', 09:39:58 INFO - 'tpaint', 09:39:58 INFO - 'sessionrestore', 09:39:58 INFO - 'sessionrestore_no_auto_restore', 09:39:58 INFO - 'tabpaint']}, 09:39:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['a11yr', 09:39:58 INFO - 'ts_paint', 09:39:58 INFO - 'tpaint', 09:39:58 INFO - 'sessionrestore', 09:39:58 INFO - 'sessionrestore_no_auto_restore', 09:39:58 INFO - 'tabpaint']}, 09:39:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['tsvgx', 09:39:58 INFO - 'tsvgr_opacity', 09:39:58 INFO - 'tart', 09:39:58 INFO - 'tscrollx', 09:39:58 INFO - 'cart', 09:39:58 INFO - 'tsvg_static']}, 09:39:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:58 INFO - 'tsvgr_opacity', 09:39:58 INFO - 'tart', 09:39:58 INFO - 'tscrollx', 09:39:58 INFO - 'cart', 09:39:58 INFO - 'tsvg_static']}, 09:39:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'talos_options': ['--disable-e10s'], 09:39:58 INFO - 'tests': ['tp5o']}, 09:39:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:39:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'talos_options': ['--disable-e10s', 09:39:58 INFO - '--xperf_path', 09:39:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:58 INFO - 'tests': ['tp5n']}, 09:39:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:39:58 INFO - 'talos_options': ['--xperf_path', 09:39:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:58 INFO - 'tests': ['tp5n']}}, 09:39:58 INFO - 'talos.zip': {'path': '', 09:39:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:58 INFO - Running post-action listener: _resource_record_post_action 09:39:58 INFO - [mozharness: 2017-05-10 16:39:58.610639Z] Finished populate-webroot step (success) 09:39:58 INFO - [mozharness: 2017-05-10 16:39:58.610771Z] Running create-virtualenv step. 09:39:58 INFO - Running pre-action listener: _resource_record_pre_action 09:39:58 INFO - Running main action method: create_virtualenv 09:39:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:58 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 09:39:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:58 INFO - Using real prefix '/tools/python27' 09:39:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:02 INFO - Installing pip.................done. 09:40:02 INFO - Return code: 0 09:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:40:02 INFO - Reading from file tmpfile_stdout 09:40:02 INFO - Output received: 09:40:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:40:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:02 INFO - 'HOME': '/Users/cltbld', 09:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:02 INFO - 'LOGNAME': 'cltbld', 09:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:02 INFO - 'MOZ_NO_REMOTE': '1', 09:40:02 INFO - 'NO_EM_RESTART': '1', 09:40:02 INFO - 'PAGER': '/bin/cat', 09:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:02 INFO - 'PWD': '/builds/slave/test', 09:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:02 INFO - 'SHELL': '/bin/bash', 09:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:02 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:02 INFO - 'USER': 'cltbld', 09:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:02 INFO - 'XPC_FLAGS': '0x0', 09:40:02 INFO - 'XPC_SERVICE_NAME': '0', 09:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:40:02 INFO - Cleaning up... 09:40:02 INFO - Return code: 0 09:40:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:02 INFO - 'HOME': '/Users/cltbld', 09:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:02 INFO - 'LOGNAME': 'cltbld', 09:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:02 INFO - 'MOZ_NO_REMOTE': '1', 09:40:02 INFO - 'NO_EM_RESTART': '1', 09:40:02 INFO - 'PAGER': '/bin/cat', 09:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:02 INFO - 'PWD': '/builds/slave/test', 09:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:02 INFO - 'SHELL': '/bin/bash', 09:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:02 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:02 INFO - 'USER': 'cltbld', 09:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:02 INFO - 'XPC_FLAGS': '0x0', 09:40:02 INFO - 'XPC_SERVICE_NAME': '0', 09:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:03 INFO - Downloading/unpacking psutil>=3.1.1 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:05 INFO - Installing collected packages: psutil 09:40:05 INFO - Running setup.py install for psutil 09:40:05 INFO - building 'psutil._psutil_osx' extension 09:40:05 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 09:40:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:40:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:40:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:40:06 INFO - building 'psutil._psutil_posix' extension 09:40:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:40:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:40:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:40:06 INFO - ^ 09:40:06 INFO - 1 warning generated. 09:40:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:40:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:06 INFO - Successfully installed psutil 09:40:06 INFO - Cleaning up... 09:40:06 INFO - Return code: 0 09:40:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:06 INFO - 'HOME': '/Users/cltbld', 09:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:06 INFO - 'LOGNAME': 'cltbld', 09:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:06 INFO - 'MOZ_NO_REMOTE': '1', 09:40:06 INFO - 'NO_EM_RESTART': '1', 09:40:06 INFO - 'PAGER': '/bin/cat', 09:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:06 INFO - 'PWD': '/builds/slave/test', 09:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:06 INFO - 'SHELL': '/bin/bash', 09:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:06 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:06 INFO - 'USER': 'cltbld', 09:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:06 INFO - 'XPC_FLAGS': '0x0', 09:40:06 INFO - 'XPC_SERVICE_NAME': '0', 09:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:40:08 INFO - Installing collected packages: mozsystemmonitor 09:40:08 INFO - Running setup.py install for mozsystemmonitor 09:40:08 INFO - Successfully installed mozsystemmonitor 09:40:08 INFO - Cleaning up... 09:40:08 INFO - Return code: 0 09:40:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:09 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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:09 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 09:40:09 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 09:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:09 INFO - 'HOME': '/Users/cltbld', 09:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:09 INFO - 'LOGNAME': 'cltbld', 09:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:09 INFO - 'MOZ_NO_REMOTE': '1', 09:40:09 INFO - 'NO_EM_RESTART': '1', 09:40:09 INFO - 'PAGER': '/bin/cat', 09:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:09 INFO - 'PWD': '/builds/slave/test', 09:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:09 INFO - 'SHELL': '/bin/bash', 09:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:09 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:09 INFO - 'USER': 'cltbld', 09:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:09 INFO - 'XPC_FLAGS': '0x0', 09:40:09 INFO - 'XPC_SERVICE_NAME': '0', 09:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:09 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:09 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 09:40:09 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 09:40:09 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 09:40:09 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 09:40:09 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 09:40:09 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 09:40:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:11 INFO - warning: no files found matching '*.txt' 09:40:11 INFO - no previously-included directories found matching 'build' 09:40:11 INFO - no previously-included directories found matching 'dist' 09:40:11 INFO - no previously-included directories found matching '.git*' 09:40:11 INFO - Installing collected packages: jsonschema, functools32 09:40:11 INFO - Running setup.py install for functools32 09:40:11 INFO - warning: no files found matching '*.txt' 09:40:11 INFO - no previously-included directories found matching 'build' 09:40:11 INFO - no previously-included directories found matching 'dist' 09:40:11 INFO - no previously-included directories found matching '.git*' 09:40:11 INFO - Successfully installed jsonschema functools32 09:40:11 INFO - Cleaning up... 09:40:11 INFO - Return code: 0 09:40:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40:11 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')]} 09:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:11 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')]} 09:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:40:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:40:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:11 INFO - 'HOME': '/Users/cltbld', 09:40:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:11 INFO - 'LOGNAME': 'cltbld', 09:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:11 INFO - 'MOZ_NO_REMOTE': '1', 09:40:11 INFO - 'NO_EM_RESTART': '1', 09:40:11 INFO - 'PAGER': '/bin/cat', 09:40:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:11 INFO - 'PWD': '/builds/slave/test', 09:40:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:11 INFO - 'SHELL': '/bin/bash', 09:40:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:11 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:11 INFO - 'USER': 'cltbld', 09:40:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:11 INFO - 'XPC_FLAGS': '0x0', 09:40:11 INFO - 'XPC_SERVICE_NAME': '0', 09:40:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:12 INFO - Cleaning up... 09:40:12 INFO - Return code: 0 09:40:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:12 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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:12 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 09:40:12 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 09:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:12 INFO - 'HOME': '/Users/cltbld', 09:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:12 INFO - 'LOGNAME': 'cltbld', 09:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:12 INFO - 'MOZ_NO_REMOTE': '1', 09:40:12 INFO - 'NO_EM_RESTART': '1', 09:40:12 INFO - 'PAGER': '/bin/cat', 09:40:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:12 INFO - 'PWD': '/builds/slave/test', 09:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:12 INFO - 'SHELL': '/bin/bash', 09:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:12 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:12 INFO - 'USER': 'cltbld', 09:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:12 INFO - 'XPC_FLAGS': '0x0', 09:40:12 INFO - 'XPC_SERVICE_NAME': '0', 09:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:12 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 09:40:12 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 09:40:12 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 09:40:12 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 09:40:12 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 09:40:12 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 09:40:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:13 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 09:40:13 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 09:40:13 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 09:40:13 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 09:40:13 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 09:40:13 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 09:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:14 INFO - Downloading docopt-0.6.1.tar.gz 09:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:14 INFO - Running setup.py install for blobuploader 09:40:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:14 INFO - Running setup.py install for requests 09:40:15 INFO - Running setup.py install for docopt 09:40:15 INFO - Successfully installed blobuploader requests docopt 09:40:15 INFO - Cleaning up... 09:40:15 INFO - Return code: 0 09:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:15 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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:15 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 09:40:15 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 09:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:15 INFO - 'HOME': '/Users/cltbld', 09:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:15 INFO - 'LOGNAME': 'cltbld', 09:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:15 INFO - 'MOZ_NO_REMOTE': '1', 09:40:15 INFO - 'NO_EM_RESTART': '1', 09:40:15 INFO - 'PAGER': '/bin/cat', 09:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:15 INFO - 'PWD': '/builds/slave/test', 09:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:15 INFO - 'SHELL': '/bin/bash', 09:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:15 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:15 INFO - 'USER': 'cltbld', 09:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:15 INFO - 'XPC_FLAGS': '0x0', 09:40:15 INFO - 'XPC_SERVICE_NAME': '0', 09:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:15 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-ZVtjyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-TsJqsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-CL2FZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_Yx9CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-nfAVp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Va0bki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-AGtYC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-NZPp9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vdfiXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0Vx1wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:16 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-HcPiWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-iXp24z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-DGvhkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-9DRQVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-A16Y66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-3zgIdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:17 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-wtAZ_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:17 INFO - Running setup.py install for manifestparser 09:40:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:17 INFO - Running setup.py install for mozcrash 09:40:17 INFO - Running setup.py install for mozdebug 09:40:18 INFO - Running setup.py install for mozdevice 09:40:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Running setup.py install for mozfile 09:40:18 INFO - Running setup.py install for mozhttpd 09:40:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Running setup.py install for mozinfo 09:40:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Running setup.py install for mozInstall 09:40:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:18 INFO - Running setup.py install for mozleak 09:40:19 INFO - Running setup.py install for mozlog 09:40:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:19 INFO - Running setup.py install for moznetwork 09:40:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:19 INFO - Running setup.py install for mozprocess 09:40:19 INFO - Running setup.py install for mozprofile 09:40:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:19 INFO - Running setup.py install for mozrunner 09:40:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:19 INFO - Running setup.py install for mozscreenshot 09:40:20 INFO - Running setup.py install for moztest 09:40:20 INFO - Running setup.py install for mozversion 09:40:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:20 INFO - Cleaning up... 09:40:20 INFO - Return code: 0 09:40:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:20 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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:20 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 09:40:20 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 09:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:20 INFO - 'HOME': '/Users/cltbld', 09:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:20 INFO - 'LOGNAME': 'cltbld', 09:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:20 INFO - 'MOZ_NO_REMOTE': '1', 09:40:20 INFO - 'NO_EM_RESTART': '1', 09:40:20 INFO - 'PAGER': '/bin/cat', 09:40:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:20 INFO - 'PWD': '/builds/slave/test', 09:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:20 INFO - 'SHELL': '/bin/bash', 09:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:20 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:20 INFO - 'USER': 'cltbld', 09:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:20 INFO - 'XPC_FLAGS': '0x0', 09:40:20 INFO - 'XPC_SERVICE_NAME': '0', 09:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:20 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-vtJ6Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:20 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)) 09:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:20 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6YLuHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:20 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)) 09:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:20 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-aUFVtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:20 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)) 09:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:20 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-tvGfFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6dDhIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-IkiN6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-hC2nzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-0t40UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-gti2Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-_9FAsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-HZaNZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-YuBODH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:21 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-6Jnqr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:21 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)) 09:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-OW1ADp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:22 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)) 09:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-Qpw6OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:22 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)) 09:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-VbheLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:22 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)) 09:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:22 INFO - Running setup.py (path:/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/pip-its760-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:22 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)) 09:40:22 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)) 09:40:22 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)) 09:40:22 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)) 09:40:22 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)) 09:40:22 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)) 09:40:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:23 INFO - Downloading blessings-1.6.tar.gz 09:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:23 INFO - Installing collected packages: blessings 09:40:23 INFO - Running setup.py install for blessings 09:40:24 INFO - Successfully installed blessings 09:40:24 INFO - Cleaning up... 09:40:24 INFO - Return code: 0 09:40:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:24 INFO - Reading from file tmpfile_stdout 09:40:24 INFO - Current package versions: 09:40:24 INFO - blessings == 1.6 09:40:24 INFO - blobuploader == 1.2.4 09:40:24 INFO - docopt == 0.6.1 09:40:24 INFO - functools32 == 3.2.3-2 09:40:24 INFO - jsonschema == 2.5.1 09:40:24 INFO - manifestparser == 1.1 09:40:24 INFO - mozInstall == 1.12 09:40:24 INFO - mozcrash == 1.0 09:40:24 INFO - mozdebug == 0.1 09:40:24 INFO - mozdevice == 0.49 09:40:24 INFO - mozfile == 1.2 09:40:24 INFO - mozhttpd == 0.7 09:40:24 INFO - mozinfo == 0.9 09:40:24 INFO - mozleak == 0.1 09:40:24 INFO - mozlog == 3.4 09:40:24 INFO - moznetwork == 0.27 09:40:24 INFO - mozprocess == 0.25 09:40:24 INFO - mozprofile == 0.28 09:40:24 INFO - mozrunner == 6.13 09:40:24 INFO - mozscreenshot == 0.1 09:40:24 INFO - mozsystemmonitor == 0.3 09:40:24 INFO - moztest == 0.8 09:40:24 INFO - mozversion == 1.4 09:40:24 INFO - psutil == 3.1.1 09:40:24 INFO - requests == 1.2.3 09:40:24 INFO - wsgiref == 0.1.2 09:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:24 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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:24 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 09:40:24 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 09:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:24 INFO - 'HOME': '/Users/cltbld', 09:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:24 INFO - 'LOGNAME': 'cltbld', 09:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:24 INFO - 'MOZ_NO_REMOTE': '1', 09:40:24 INFO - 'NO_EM_RESTART': '1', 09:40:24 INFO - 'PAGER': '/bin/cat', 09:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:24 INFO - 'PWD': '/builds/slave/test', 09:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:24 INFO - 'SHELL': '/bin/bash', 09:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:24 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:24 INFO - 'USER': 'cltbld', 09:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:24 INFO - 'XPC_FLAGS': '0x0', 09:40:24 INFO - 'XPC_SERVICE_NAME': '0', 09:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 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)) 09:40:24 INFO - Cleaning up... 09:40:24 INFO - Return code: 0 09:40:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:24 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 0x1033c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac8567c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, '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.zse8QcW0AH/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.1WU6a0J9g9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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 09:40:24 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 09:40:24 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 09:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:24 INFO - 'HOME': '/Users/cltbld', 09:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:24 INFO - 'LOGNAME': 'cltbld', 09:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:24 INFO - 'MOZ_NO_REMOTE': '1', 09:40:24 INFO - 'NO_EM_RESTART': '1', 09:40:24 INFO - 'PAGER': '/bin/cat', 09:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:24 INFO - 'PWD': '/builds/slave/test', 09:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:24 INFO - 'SHELL': '/bin/bash', 09:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:24 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:24 INFO - 'USER': 'cltbld', 09:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:24 INFO - 'XPC_FLAGS': '0x0', 09:40:24 INFO - 'XPC_SERVICE_NAME': '0', 09:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:24 INFO - Cleaning up... 09:40:24 INFO - Return code: 0 09:40:24 INFO - Running post-action listener: _resource_record_post_action 09:40:24 INFO - Running post-action listener: _start_resource_monitoring 09:40:25 INFO - Starting resource monitoring. 09:40:25 INFO - [mozharness: 2017-05-10 16:40:25.008987Z] Finished create-virtualenv step (success) 09:40:25 INFO - [mozharness: 2017-05-10 16:40:25.009747Z] Running install step. 09:40:25 INFO - Running pre-action listener: _resource_record_pre_action 09:40:25 INFO - Running main action method: install 09:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:25 INFO - Reading from file tmpfile_stdout 09:40:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:25 INFO - Reading from file tmpfile_stdout 09:40:25 INFO - Output received: 09:40:25 INFO - Usage: mozinstall [options] installer 09:40:25 INFO - Options: 09:40:25 INFO - -h, --help show this help message and exit 09:40:25 INFO - -d DEST, --destination=DEST 09:40:25 INFO - Directory to install application into. [default: 09:40:25 INFO - "/builds/slave/test"] 09:40:25 INFO - --app=APP Application being installed. [default: firefox] 09:40:25 INFO - mkdir: /builds/slave/test/build/application 09:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:40:40 INFO - Reading from file tmpfile_stdout 09:40:40 INFO - Output received: 09:40:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:40:40 INFO - Running post-action listener: _resource_record_post_action 09:40:40 INFO - [mozharness: 2017-05-10 16:40:40.065415Z] Finished install step (success) 09:40:40 INFO - [mozharness: 2017-05-10 16:40:40.065549Z] Running run-tests step. 09:40:40 INFO - Running pre-action listener: _resource_record_pre_action 09:40:40 INFO - Running main action method: run_tests 09:40:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:40:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:40:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:40:40 INFO - 2017-05-10 09:40:40.079 screenresolution[1637:7304] starting screenresolution argv=screenresolution get 09:40:40 INFO - 2017-05-10 09:40:40.081 screenresolution[1637:7304] Display 0: 1600x1200x32@60 09:40:40 INFO - 2017-05-10 09:40:40.087 screenresolution[1638:7306] starting screenresolution argv=screenresolution list 09:40:40 INFO - Available Modes on Display 0 09:40:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:40:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:40:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:40:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:40:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:40:40 INFO - Intel Iris: 09:40:40 INFO - Chipset Model: Intel Iris 09:40:40 INFO - Type: GPU 09:40:40 INFO - Bus: Built-In 09:40:40 INFO - VRAM (Dynamic, Max): 1536 MB 09:40:40 INFO - Vendor: Intel (0x8086) 09:40:40 INFO - Device ID: 0x0a2e 09:40:40 INFO - Revision ID: 0x0009 09:40:40 INFO - Displays: 09:40:40 INFO - Display: 09:40:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:40:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:40:40 INFO - Display Serial Number: 1600x1200 60 09:40:40 INFO - Main Display: Yes 09:40:40 INFO - Mirror: Off 09:40:40 INFO - Online: Yes 09:40:40 INFO - Rotation: Supported 09:40:40 INFO - Return code: 0 09:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:40 INFO - Python 2.7.3 09:40:40 INFO - Return code: 0 09:40:40 INFO - grabbing minidump binary from tooltool 09:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:40 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 0x10319fd30>, '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 0x1030c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103194be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:40 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 09:40:40 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 09:40:40 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 09:40:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:40 INFO - Return code: 0 09:40:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:40:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:40 INFO - ENV: RUST_BACKTRACE is now 1 09:40:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:40:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 09:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0278 --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 09:40:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zse8QcW0AH/Render', 09:40:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:40 INFO - 'HOME': '/Users/cltbld', 09:40:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:40 INFO - 'LOGNAME': 'cltbld', 09:40:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:40 INFO - 'MOZ_NO_REMOTE': '1', 09:40:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:40 INFO - 'NO_EM_RESTART': '1', 09:40:40 INFO - 'PAGER': '/bin/cat', 09:40:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:40 INFO - 'PWD': '/builds/slave/test', 09:40:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:40 INFO - 'RUST_BACKTRACE': '1', 09:40:40 INFO - 'SHELL': '/bin/bash', 09:40:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1WU6a0J9g9/Listeners', 09:40:40 INFO - 'TMPDIR': '/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/', 09:40:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:40 INFO - 'USER': 'cltbld', 09:40:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:40 INFO - 'XPC_FLAGS': '0x0', 09:40:40 INFO - 'XPC_SERVICE_NAME': '0', 09:40:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0278', '--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 09:40:40 INFO - mozversion application_buildid: 20170510081522 09:40:40 INFO - mozversion application_changeset: 6b0cf48f6481fc2d27b888a2e35878f7f57b75a9 09:40:40 INFO - mozversion application_display_name: Firefox 09:40:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:40 INFO - mozversion application_name: Firefox 09:40:40 INFO - mozversion application_remotingname: firefox 09:40:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:40:40 INFO - mozversion application_vendor: Mozilla 09:40:40 INFO - mozversion application_version: 54.0 09:40:40 INFO - mozversion platform_buildid: 20170510081522 09:40:40 INFO - mozversion platform_changeset: 6b0cf48f6481fc2d27b888a2e35878f7f57b75a9 09:40:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:40:40 INFO - mozversion platform_version: 54.0 09:40:40 INFO - using testdate: 1494434440 09:40:40 INFO - actual date: 1494434440 09:40:40 INFO - starting webserver on 'localhost:49239' 09:40:40 INFO - SUITE-START | Running 2 tests 09:40:40 INFO - TEST-START | dromaeo_css 09:40:40 INFO - operating with platform_type : mac_ 09:40:40 INFO - Initialising browser for dromaeo_css test... 09:40:40 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpTZo6Ae/profile http://localhost:49239/getInfo.html) 09:40:43 INFO - PROCESS | 1648 | 2017-05-10 09:40:43.332 plugin-container[1652:7473] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 09:40:43 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:43 INFO - PROCESS | 1648 | 2017-05-10 09:40:43.332 plugin-container[1652:7473] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1f, name = 'com.apple.CFPasteboardClient' 09:40:43 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:43 INFO - PROCESS | 1648 | 2017-05-10 09:40:43.332 plugin-container[1652:7473] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:40:43 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:40:43 INFO - PROCESS | 1648 | colorDepth:24 09:40:43 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:40:43 INFO - PROCESS | 1648 | __metrics 09:40:43 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 09:40:44 INFO - TEST-INFO | 1648: exit 0 09:40:44 INFO - Browser initialized. 09:40:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:44 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpTZo6Ae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:46 INFO - PROCESS | 1653 | 2017-05-10 09:40:46.539 plugin-container[1654:7602] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8947, name = 'com.apple.tsm.portname' 09:40:46 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:46 INFO - PROCESS | 1653 | 2017-05-10 09:40:46.540 plugin-container[1654:7602] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 09:40:46 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:40:46 INFO - PROCESS | 1653 | 2017-05-10 09:40:46.540 plugin-container[1654:7602] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:40:56 INFO - PROCESS | 1653 | RSS: Main: 174379008 09:40:56 INFO - PROCESS | 1653 | 09:43:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 09:44:00 INFO - PROCESS | 1653 | RSS: Main: 193110016 09:44:00 INFO - PROCESS | 1653 | 09:47:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 09:47:03 INFO - PROCESS | 1653 | RSS: Main: 202629120 09:47:03 INFO - PROCESS | 1653 | 09:50:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 09:50:06 INFO - PROCESS | 1653 | RSS: Main: 204210176 09:50:06 INFO - PROCESS | 1653 | 09:53:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 09:53:09 INFO - PROCESS | 1653 | RSS: Main: 207298560 09:53:09 INFO - PROCESS | 1653 | 09:56:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 09:56:12 INFO - PROCESS | 1653 | RSS: Main: 210866176 09:56:12 INFO - PROCESS | 1653 | 09:59:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 09:59:15 INFO - PROCESS | 1653 | RSS: Main: 208953344 09:59:15 INFO - PROCESS | 1653 | 09:59:15 INFO - PROCESS | 1653 | __start_tp_report 09:59:15 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:59:15 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:59:15 INFO - PROCESS | 1653 | |i|pagename|runs| 09:59:15 INFO - PROCESS | 1653 | |0;dojo.html;3679;3685.98157009215;3698.2233730916505;3705.295993761186;3716.5725941516735;5142.894277730287;6220.267123151332;6224.066390041496;6244.656543890084;6276.05859121132;5232.581393488521;6232.3144454110125;6233.750649974007;6256.562040657156;6257.061440783885;5581.10702287633;5631.7184140793;5662.773489060453;5671.2060311556415;5721.656700597978;5723.713814309289;5724.427557244263;5730.36965933747;5733.827985160431;5746.454086861741;5490.862728431781;5508.283923089993;5651.124075768263;5704.401037891003;5769.423057694239;5625.634333768312;5633.183188437674;5641.435856414367;5682.119271512922;5685.289338832646;5527.419620939824;5673.092305231144;5676.063449530822;5684.602077854552;5742.339630942453;6128.479079278267;6230.626162430269;6297.748090076391;6335.334789847092;6344.333844946306;6470.611763294218;6474.5791523550815;6479.222493300834;6542.182227221598;6552.50856185788;6778;6797.864042719118;6805.761798337035;6815;6816;6289.622622642656;6292.622442653455;6302.96848515759;6325.841853953642;6340.556161068727;6634.469242460592;6648.268690444047;6914.308569143045;6985.5808651481075;6993.965030174817;6459.741610335628;6462;6493;6506.512011599054;6516.120323756232;6371.681415929185;6736.696848641823;6739.359760822714;6800.217974932946;6805.285445028201;6304.243490781044;6609;6611.471082313404;6635.86728265432;6640.435562977201;6461.289258181596;6469.611823290524;6546.70539825709;6569.901451478232;6589.209294884645;5390.191471279261;5405.027095122837;5412.945870541323;5418.214358917935;5431.891362172734;4032.9596704032583;4765.142274390643;4777.8327758528285;4783.760811959458;4818.879528011757;5302.257683924254;6214.9689251554355;6252.906206406908;6273.686315684197;6331.715072821734;6764.289749576224;6780.796576102724;6788.59268443895;6797.2523022467485;6818.454523638097;5639.154126881001;6373.139626150503;6374.139491168633;6375.585586936927;6395.52033597482;5729.054705973468;5803.5357171426185;5863.384344643836;5900.527957763368;5989.700514974234;6837.145356830496;6847.109875716224;6900.861982760417;6908.861822763617;6968.895466567904;5620.578456615688;6593.3736295051895;6756;6760.1549806274215;6766.695498702472;6910.101686780687;6978.860422791618;6988.266232045766;7049.471289653194;7072.5402848814665;6374;6385.840353991188;6540.869182616416;6556.3443655634055;6615.305392933673;6761.898571521529;6777.525573210025;6793.422559082534;6793.456523478011;6798.388145066968;6239.656818874824;6316.3683631638305;6429.32492088324;6494.220693516808;6565.704543295467;5445.292112025411;6556.803295901131;6559.114519539992;6562.77030303937;6599.8020059398295;4729.668923175344;5113.8977220454635;5941.31674857397;6295.527835412271;6425.775097871552;6557.147570815763;6558.376954189344;6578.8355291118105;6578.934210658023;6625.039369291329;6412.775552855627;6413.0701048348665;6438.356164383524;6441.937080381685;6451.967740161269 09:59:15 INFO - PROCESS | 1653 | |1;ext.html;798.7124635131352;831.5218749219199;839.366278459763;905.3933864310911;969.6509256667603;38191.427128593095;39447.99999999996;39521;41089.58910410895;41256.58743412572;25193.748062519368;39044.804775976154;39257.60742392582;39303.80348098263;39313;8185;8324.583770811465;8336.208060234298;11340.829887551694;11623.360715160705;11363.31820090793;11496.137789665767;11509.251898626604;11510.712232194179;11516.942415287911;11457.770844583103;11474.770504589904;11479.713007174803;11487.195896287263;11509.597164099257;9322.16100550947;11432.771344573104;11444.771104577861;11470.827937580943;11514.942425287862;10387.220958428072;11276.774464510663;11285.435728213557;11316;11338.546458141664;35374;35563.28873422517;35940.46089308662;36028.459573106426;36161.38386161389;3275.475923852196;3517.520148295446;3751.193493398905;3897.2010737798682;3954.228925359556;26547.601785973227;27939.58090628642;28066.017689380773;30070.398592028254;30086.54870176949;2721.391483400887;3211.277462570926;3288.7369010479106;3293.752968527346;3306.2395649000864;290968;331438;349394;352960.23519882496;353864;45431.77284113624;46512.76743616328;53556.46443535515;56220.43779562152;56569.5857603555;58412.12381814276;58548;58706.82586348249;58823.52941176505;59303.40696592979;16031.839681603034;16147.273372698257;16156.434524791575;16157.192140392934;16166.75749863753;13373.46506139763;13428.328583570783;13429.26139062361;13431.194128352136;13431.932840335736;13981.650458738613;14069.43722251119;14150.36323365451;14218.573442796733;14262;5354.812581559627;6399.744010239631;6400.23197216337;6449.161608990801;6452.193475815523;1118.6911313762917;1132.8753837077916;1154.163231657042;1162.7151347919814;1208.7582483503334;24796;26916.84665226777;29196;29198.416031679248;29585.704142958293;1125.1842414249604;1227.6071657069651;1233.1491271022965;1256.108163204117;1265.038570686285;13039.608811735663;14758.926205368904;14986.40054397812;15034.624134396508;15269.389224430899;483045;485947;492214.53892730305;492393;512999;49986.00027999492;50282.74858625756;50461.99076018459;50474.73813154627;50490.74754626277;1484.5768955847748;1489.0767724011182;1522.596511924341;1527.6562773375902;1537.3235776258634;26689.466210676066;27912.44175116527;28381;28402;28444.14667559894;41862.79068604759;42406.57593424026;43195;43608.12783744371;44244.33633495436;491304;492011;492322;492593;493449;29388;30681;31985.680143199203;33451.330973380886;33676.49485257772;40656;41372.58627413688;41519.58480415157;41588.58411415968;42405.363919540614;23173.884130579238;28592.714072859006;29158.56262156112;29281.41437171287;30423.39153216879;28882.27794305159;29243.561346579394;29779.957701480344;29895.70104299016;29968.700312996592;30594.08217753471;34145.82927085349;35020.47469287912;35421.29157416786;36571.451428228065;22266.0482208032;29884;30976.84511577428;31019.68980310168;31029.534556982115;21215.257465988616;23552.411189719707;23656.29031129069;24219.39451513726;24975.87512062428 09:59:15 INFO - PROCESS | 1653 | |2;jquery.html;418.742473378872;428.3018679552329;440.9140217657556;444.76362645798764;448.824958266276;20607;21934.341969740894;22432.87835608219;23033.424164395856;23322.300330990056;23117;23571.646425303592;23826.213034022476;24171.637425438632;24187;6891.207511136234;6962.7911162665205;7025.402840758542;7122.252163522833;7249.855002899939;6955.547889387199;7090.042844216042;7098.041764361797;7898.249666281694;8306.169383061706;8137.267645911867;8388.8741668875;8408.033076196254;8423.663053477883;8426.536540490271;8239.629216685233;8368.163183681643;8389.874151887758;8408.579571021424;8427.283680887133;7653.617319134021;8023;8060.5566693831815;8092.2486354639705;8148.144444833326;27378;29259.41481170386;30405.543916841045;31108;31559.053228402954;3526.100844284691;3567.357875582394;3583.175869550018;3630.4009838376637;3646.4165733482782;17816.91091544534;17857.285708571642;18087.276508939627;18240;18432.815671843244;1997.0813425824138;2055.9309159237114;2106.178590349765;2143.9892800536054;2145.9463513412134;154023;159991;164013;184136;188235.17647235302;20442.897785510977;21576.784232157792;26097;27475.587866182024;27733.168004959884;44636.55363446324;44704;44976.3253551197;45766.542334576894;45875.31187032197;12106.728793476734;12264.264144151379;12286.447109880077;12327.013838892866;12403.317817520123;10053.447060411601;10069;10111.533827594958;10206.540705668263;10319.019693129141;11589.188756786943;11971;12064.517419303305;12078.637640870787;12151.513939442324;4248.787560621957;4856.562909338177;4882.804687812448;4975.676581022222;5003.649744517922;943.1700103908516;965.4062751407974;984.315900449181;996.2217441866379;1001.2690735762789;16928.661426771396;18386.448406547825;19166.616667666847;19295.8070419294;19367.225310987404;884.752269364579;989.772352358947;989.8812142542797;1022.8823685276288;1032.8554002439664;9678.27412944032;9889.50552472388;9991.600335986479;10005;10054.949725251327;382171;382544;382811;384926;698769;156825.2158739222;163123;166673.3332666682;169485.63115309292;170156;1082.805095082877;1229.9569515067108;1233.3216730798026;1276.7701813673443;1282.179405180685;14137.43450261978;17051.806373554227;17346.392876249272;17455;17646.94118352903;63968.3603163981;64118.67940660267;65775;66403;66495.66752166208;91223;92152.53923730338;92584;93904.53047734717;94547;7753.883691744742;10495;11528.193026488065;11772.823407649063;12003.099767517297;10213.693589192337;12486.812697809723;13014.089013768946;13622.250776207404;13816.171029738249;11164.665060048212;11458.828117578076;11512.769744605228;11549.82675259855;11982.58060967862;10626.681199564026;10688.572457101629;10892.673219803419;10920.7269818252;10984.560617575527;11735.119866010255;11764.764704706029;11947.522099116286;12070.155089143676;12087.939560302142;11688.94799468052;11778.234414763014;11913.82129268079;11917.463714133059;12127.332996685267;9619.797525309335;9678.70963871085;11383.317000979967;11534.462418267967;11705.005074568757 09:59:15 INFO - PROCESS | 1653 | |3;mootools.html;1589.4039735099338;1633.322171298911;1642.3020216408024;1651.0506458786197;1651.7026935151675;10988.285761425503;11340.262882912604;11729.882701172986;11734.178607497468;11736.706582335435;11457;11626;11662.358570278631;11664.416779161029;11670.591529296476;2108.736407949006;2475.962860557093;2523.3565440812567;2526.166365099522;2526.406294520786;2431.9270421887372;2505.47385049139;2513.3716570857287;2514.1326242446416;2532.696076470826;2475.665785119013;2483.962740558893;2489.178571071542;2524.873756312177;2524.911628093017;2439.4389290463114;2447.473793134485;2477.417806815397;2480.231128350217;2483.2301986384186;2476.182859656309;2490.838095523803;2495.2763698527406;2502.199296225209;2516.0061775598538;11311.151663625178;11549.249298795552;11576.247543909703;11584.710382240428;11613.012893904028;5753.942460575383;5754.4533269339345;6003.459688628001;6189;6211.09939058834;3726.2361215950937;3803.125281185315;3845.442410850411;3861.073342397832;3961.5840336764513;1246.1712960881002;1274.9426275817611;1281.4713557847645;1308.2281453942219;1329.2954733991;14116.788248176286;14433.566992990227;14609.342579583945;14687.33906974178;15333.693326133527;4790.137775200497;4836.903261934742;4969.950300496948;4981.028699403581;4997.425296090923;12166.391680415943;12169.574064907685;12172.330521821208;12174.208676436003;12186.57346992851;6091.360407157274;6102.328743838174;6111.449969502766;6111.724972376253;6142.815715528542;4682.391289132391;5414.106672399089;5523.199136125239;5607.243022192033;5623.578231632644;3366.9326613468083;4057.0919168233013;4105.384192371168;4136.276151673445;4143.295639741251;1097.358045543366;1098.549594666183;1100.7523307255963;1112.2992514715677;1114.921955463126;965.5365424596092;971.6939164163266;989.4706332112286;1003.8092762375126;1013.9746506337253;6152.78465253714;6647.235567909753;6831.658417079127;6838.7264509420065;6861.4853885958755;959.6113574002541;996.8903420623726;1005.7787286796893;1037.7976294622476;1041.8697662792151;3708.2027364116843;4054.5134583850127;4364.498082720528;4438.178936896685;4507.909841803145;11217.943910280397;13590.116642418408;14192.503262385768;14198.219097949712;14215.786763198561;13156.473741050442;13411.329433528479;14107;14123.858761412459;14135.85864141366;9115.088491150964;10291.742706432398;10440.947795261127;10540.262181647364;10599.523021464052;6471.838204044937;6946.756863509753;7022.824429389306;7114.537555058904;7384.446166537424;11743.88256117428;12131.454084566392;12139.817902731289;12169.452374642986;12200.938995304967;12221.38893055326;12370.44333004999;12461.813072804096;12496.625101246977;12520.561780337644;9337.673181438617;9445.0554944505;9587.904120958701;9599.952000239955;9670.75823104428;8881.866771998297;10284.434356110485;10492.422916739653;10623.681289561326;10723.517441715298;9177.449353038839;9535.809283814424;9614.375065620712;9778.951105244429;9793.510324483605;9307.86038209441;9363.063693630582;9390.201832844285;9457.6367355675;9504;8042.356611470951;8116.959415202886;8188.303994160563;8198.795030124294;8206.138355472589;6062.42406971337;6147.415995480422;6160;6161.507079433724;6199.070139479114;5963.165156878127;6040.36576159497;6162.722677479434;6175.505959523317;6239.032949892774 09:59:16 INFO - PROCESS | 1653 | |4;prototype.html;352.7495478210471;392.9646331830138;394.5048963550745;409.75619506393684;412.173591948144;4594.333821595871;5224.84325470236;5524.281843360358;5543.611947163695;5642.830715078554;5396.815878631606;5420.7018613976215;5478.643888147268;5570.387257401682;5598.776048958037;3610;3672.559292884844;4109.0959988802415;4394.846180383687;4581.540936592868;3622.279417276786;3952.9802350988207;4556.20266453371;4569.497355290915;4638.744869032202;3691.870784522542;4555.544445555451;4565.748883811389;4578.015726618776;4622.953770462286;3538.8053657048854;4272.209641216385;4283.550227226127;4435.800388982503;4476.776161191928;3854.383298672199;3864.207837393356;4005.73962692427;4028.3353246714255;4232.492100947875;4584.839530616446;4789.012559787684;4830.275458681191;5453.263809385761;5517.393086760453;4392.802323895432;4778;5215.452377500384;5342.252084708144;5404.189371594253;5305.230741542455;5540.36285827131;5934.258217722785;5969.552283578705;5982.73077711504;3993.7803420811842;4733.958529123587;4735.887066539361;4790.688605240648;4838.733869637169;5884.499817515516;6139.969300153471;6166.7224974876235;6170.907436388457;6306.369363063703;4808.567228949341;4815.422149342031;4835.661503694778;4854.466008739036;4864.78108485119;4227.7463352198965;4267.807948642257;4440.888977775517;4897.608191344684;4913.606911447076;4416.621284717194;4883.58489528387;5262.368515778055;5268.577484079354;5313.57491400687;5211.869703257449;5668.546516278688;5730.312362516524;5875.237428771437;5890.262372600093;1450.354592206479;1456.6817030587124;1564.9765253521207;1676.8155502894672;1682.6634673065437;1107.534835369147;1196.389841181004;1219.518285283385;1247.8564965028957;1276.9273809999459;5039.3448851649055;5059.544640982329;5435.83692489226;5638.4925356718095;5653.9151912721345;5498.3127109111365;5787.508061814793;6004.849878753066;6073.96963015191;6174.406749165361;4839.685420447659;5176.374850519281;5523.944760552343;5551.528120109755;5560.415281644793;2878.870450829718;3159.162821852211;3160.115167753033;3161.1780936956557;3161.3361194149024;5416.9436959792465;6044.24446944132;6266;6337.904931426032;6344.904826427607;6052.485538729169;6294.937050629526;6313.337099604567;6313.526485513605;6353.618782873043;5554.555635549146;5600.803971860965;5720.166459341849;6053.818385448443;6325.7153428094925;4850.981293928315;5546.4453554644215;5678.488935995781;5713.800016999385;6231.594946328474;4750.857474275777;5030.359061492745;5355.705436201047;5562.443755624405;5854.9121763174435;6322.430981211713;6329.430351268224;6383.265924418752;6408.967955160194;6429.260635027032;4278.893027674333;4317.812601534603;4538;4787.162246606899;4805.026797264814;5030.805438546622;5675.517581005661;5775.8521605724145;5776.797812076557;6081.817545473643;5021;5717.799877004285;6010.377198156386;6071.9336734948565;6091.451769340781;5393.379761327341;5730.684812335361;5916.290045194604;5995.880082398415;6016.037434010537;4871.780769865293;4882.924756978341;5567.749451274622;5797.8550536236935;5915.881682366415;5307.65500242483;5551.446334685928;6043.667598282137;6099.0483045425035;6125;5023.522765337433;5497.890042199214;5675.758075560213;5847.883042339215;5945.732442040205 09:59:16 INFO - PROCESS | 1653 | |5;yui.html;733.3363306207877;778.6573907480705;813.4346629092779;872.2411501993265;892.4868200784548;12771.489140434383;16047.51857444277;16138.273777680004;16964.745528817046;17891.91054044728;15668.294926728297;15941;16106;16605.169741512906;16625.584360390996;988.7577543501852;990.1880458024423;993.8658281132027;994.8507723841445;995.5320999130397;857.4726543175964;982.79852630211;987.3039507147444;1016.5628779624758;1036.533559898045;1060.4538662588734;1075.779465209634;1075.8655168103987;1078.7087486378712;1080.8865069167741;1071.3625392891217;1071.4160782373624;1074.0548317480607;1075.021730225495;1078.0620859851979;778.9961050194713;786.6184900323339;792.029763539665;793.8412317536515;794.3486341200218;16730.912490688188;16871.91564042184;17017;18106.094695265318;18382.1728022238;14431.278436078153;14872.851271487254;14907.03104298228;14965.625859353495;15124.697506049928;11937.820932686016;12022.69943251417;12058.095642826824;12210.276459089637;12699.746005079847;3700.204456041937;3808;3925.2738243425056;3934.921301573981;3949.822257998397;91842.5407872963;97496;110590;112072.31891521634;114154.99999999917;11319.830202546967;11391;11429.142814288962;11726.765464690658;11767.411629418495;22943.541129177323;23070.961806718737;23118.1908633197;23386.883065584563;23413.06347746105;6393.552451328455;8224.712135075244;8276.875846862302;8278.71024514139;8434.325253979667;4562.8631141065825;4578.793954272066;4618.237990731492;4631.397918270671;4676.602488788491;3680.8895733128047;3736.4768932349493;3751.9062023449087;3776.527934008249;3776.773393596338;656.4387448731361;658.7430901948244;661.8940969444866;675.3482889012126;677.806825054857;674.6862708840413;681.9590824550543;709.521073275537;719.9640017999079;738.770980995893;10754.516046777757;10895;11064.723381915517;11172.44137793107;11285.322880627189;683.3610574113121;693.8508220732567;697.0798545919338;697.5640224859463;698.6297262450807;3852.4221366794645;4262.46719160105;4408.9118217636105;5023.547880690755;5245.344331958505;79790.60104699439;103428;103531;105470;107195;71570.2842971574;74330;74848.62575687087;77196.84204736934;86527;51860.74069629628;72752;74274.62862685652;76595.61702191342;77846.22153778504;11213.710423301425;11265.549378025114;11305.491252893475;11355.716107097389;11564.248323858923;50181.74909125431;50272.748636258046;50864.745676271385;51757.49516320188;52204.73897630488;50868.74565627148;64073;64307.67846160739;64451.67774161099;66048.00927985988;13430.664233394244;13590.93204533971;13722.451101956209;13749.931250343685;13889.652758681113;15391.69216615639;15808.288627012042;16361.34554617802;16680.999140051637;16951.915240424212;14441.927790360982;14898.957073004785;14943.252837358306;15549;15745.763813543035;12759.808602870778;13687;14669.926650367106;14671.92664036673;15335;13820.930895345458;14414.711705766036;14551.563453096423;14584.708305833612;14685.706285874436;10277;10609.184442658472;10686.0916822071;10870.021698047214;11128.22102452853;10023.847257565474;11037.282576632493;12035;12274.509019639114;12419.130660854014 09:59:16 INFO - PROCESS | 1653 | __end_tp_report 09:59:16 INFO - PROCESS | 1653 | __start_cc_report 09:59:16 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,393 09:59:16 INFO - PROCESS | 1653 | __end_cc_report 09:59:16 INFO - PROCESS | 1653 | __startTimestamp1494435555988__endTimestamp 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:59:16 INFO - PROCESS | 1653 | Number of tests: 6 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:6157.85 Median:6374.00 stddev:709.41 (11.1%) stddev-sans-first:684.41 09:59:16 INFO - PROCESS | 1653 | Values: 3679.0 3686.0 3698.2 3705.3 3716.6 5142.9 6220.3 6224.1 6244.7 6276.1 5232.6 6232.3 6233.8 6256.6 6257.1 5581.1 5631.7 5662.8 5671.2 5721.7 5723.7 5724.4 5730.4 5733.8 5746.5 5490.9 5508.3 5651.1 5704.4 5769.4 5625.6 5633.2 5641.4 5682.1 5685.3 5527.4 5673.1 5676.1 5684.6 5742.3 6128.5 6230.6 6297.7 6335.3 6344.3 6470.6 6474.6 6479.2 6542.2 6552.5 6778.0 6797.9 6805.8 6815.0 6816.0 6289.6 6292.6 6303.0 6325.8 6340.6 6634.5 6648.3 6914.3 6985.6 6994.0 6459.7 6462.0 6493.0 6506.5 6516.1 6371.7 6736.7 6739.4 6800.2 6805.3 6304.2 6609.0 6611.5 6635.9 6640.4 6461.3 6469.6 6546.7 6569.9 6589.2 5390.2 5405.0 5412.9 5418.2 5431.9 4033.0 4765.1 4777.8 4783.8 4818.9 5302.3 6215.0 6252.9 6273.7 6331.7 6764.3 6780.8 6788.6 6797.3 6818.5 5639.2 6373.1 6374.1 6375.6 6395.5 5729.1 5803.5 5863.4 5900.5 5989.7 6837.1 6847.1 6900.9 6908.9 6968.9 5620.6 6593.4 6756.0 6760.2 6766.7 6910.1 6978.9 6988.3 7049.5 7072.5 6374.0 6385.8 6540.9 6556.3 6615.3 6761.9 6777.5 6793.4 6793.5 6798.4 6239.7 6316.4 6429.3 6494.2 6565.7 5445.3 6556.8 6559.1 6562.8 6599.8 4729.7 5113.9 5941.3 6295.5 6425.8 6557.1 6558.4 6578.8 6578.9 6625.0 6412.8 6413.1 6438.4 6441.9 6452.0 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:57514.36 Median:30254.97 stddev:118856.80 (392.9%) stddev-sans-first:119113.94 09:59:16 INFO - PROCESS | 1653 | Values: 798.7 831.5 839.4 905.4 969.7 38191.4 39448.0 39521.0 41089.6 41256.6 25193.7 39044.8 39257.6 39303.8 39313.0 8185.0 8324.6 8336.2 11340.8 11623.4 11363.3 11496.1 11509.3 11510.7 11516.9 11457.8 11474.8 11479.7 11487.2 11509.6 9322.2 11432.8 11444.8 11470.8 11514.9 10387.2 11276.8 11285.4 11316.0 11338.5 35374.0 35563.3 35940.5 36028.5 36161.4 3275.5 3517.5 3751.2 3897.2 3954.2 26547.6 27939.6 28066.0 30070.4 30086.5 2721.4 3211.3 3288.7 3293.8 3306.2 290968.0 331438.0 349394.0 352960.2 353864.0 45431.8 46512.8 53556.5 56220.4 56569.6 58412.1 58548.0 58706.8 58823.5 59303.4 16031.8 16147.3 16156.4 16157.2 16166.8 13373.5 13428.3 13429.3 13431.2 13431.9 13981.7 14069.4 14150.4 14218.6 14262.0 5354.8 6399.7 6400.2 6449.2 6452.2 1118.7 1132.9 1154.2 1162.7 1208.8 24796.0 26916.8 29196.0 29198.4 29585.7 1125.2 1227.6 1233.1 1256.1 1265.0 13039.6 14758.9 14986.4 15034.6 15269.4 483045.0 485947.0 492214.5 492393.0 512999.0 49986.0 50282.7 50462.0 50474.7 50490.7 1484.6 1489.1 1522.6 1527.7 1537.3 26689.5 27912.4 28381.0 28402.0 28444.1 41862.8 42406.6 43195.0 43608.1 44244.3 491304.0 492011.0 492322.0 492593.0 493449.0 29388.0 30681.0 31985.7 33451.3 33676.5 40656.0 41372.6 41519.6 41588.6 42405.4 23173.9 28592.7 29158.6 29281.4 30423.4 28882.3 29243.6 29780.0 29895.7 29968.7 30594.1 34145.8 35020.5 35421.3 36571.5 22266.0 29884.0 30976.8 31019.7 31029.5 21215.3 23552.4 23656.3 24219.4 24975.9 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:36584.40 Median:22183.61 stddev:82488.34 (371.8%) stddev-sans-first:82675.05 09:59:16 INFO - PROCESS | 1653 | Values: 418.7 428.3 440.9 444.8 448.8 20607.0 21934.3 22432.9 23033.4 23322.3 23117.0 23571.6 23826.2 24171.6 24187.0 6891.2 6962.8 7025.4 7122.3 7249.9 6955.5 7090.0 7098.0 7898.2 8306.2 8137.3 8388.9 8408.0 8423.7 8426.5 8239.6 8368.2 8389.9 8408.6 8427.3 7653.6 8023.0 8060.6 8092.2 8148.1 27378.0 29259.4 30405.5 31108.0 31559.1 3526.1 3567.4 3583.2 3630.4 3646.4 17816.9 17857.3 18087.3 18240.0 18432.8 1997.1 2055.9 2106.2 2144.0 2145.9 154023.0 159991.0 164013.0 184136.0 188235.2 20442.9 21576.8 26097.0 27475.6 27733.2 44636.6 44704.0 44976.3 45766.5 45875.3 12106.7 12264.3 12286.4 12327.0 12403.3 10053.4 10069.0 10111.5 10206.5 10319.0 11589.2 11971.0 12064.5 12078.6 12151.5 4248.8 4856.6 4882.8 4975.7 5003.6 943.2 965.4 984.3 996.2 1001.3 16928.7 18386.4 19166.6 19295.8 19367.2 884.8 989.8 989.9 1022.9 1032.9 9678.3 9889.5 9991.6 10005.0 10054.9 382171.0 382544.0 382811.0 384926.0 698769.0 156825.2 163123.0 166673.3 169485.6 170156.0 1082.8 1230.0 1233.3 1276.8 1282.2 14137.4 17051.8 17346.4 17455.0 17646.9 63968.4 64118.7 65775.0 66403.0 66495.7 91223.0 92152.5 92584.0 93904.5 94547.0 7753.9 10495.0 11528.2 11772.8 12003.1 10213.7 12486.8 13014.1 13622.3 13816.2 11164.7 11458.8 11512.8 11549.8 11982.6 10626.7 10688.6 10892.7 10920.7 10984.6 11735.1 11764.8 11947.5 12070.2 12087.9 11688.9 11778.2 11913.8 11917.5 12127.3 9619.8 9678.7 11383.3 11534.5 11705.0 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:6916.97 Median:2515.07 stddev:4234.12 (168.3%) stddev-sans-first:4227.07 09:59:16 INFO - PROCESS | 1653 | Values: 1589.4 1633.3 1642.3 1651.1 1651.7 10988.3 11340.3 11729.9 11734.2 11736.7 11457.0 11626.0 11662.4 11664.4 11670.6 2108.7 2476.0 2523.4 2526.2 2526.4 2431.9 2505.5 2513.4 2514.1 2532.7 2475.7 2484.0 2489.2 2524.9 2524.9 2439.4 2447.5 2477.4 2480.2 2483.2 2476.2 2490.8 2495.3 2502.2 2516.0 11311.2 11549.2 11576.2 11584.7 11613.0 5753.9 5754.5 6003.5 6189.0 6211.1 3726.2 3803.1 3845.4 3861.1 3961.6 1246.2 1274.9 1281.5 1308.2 1329.3 14116.8 14433.6 14609.3 14687.3 15333.7 4790.1 4836.9 4970.0 4981.0 4997.4 12166.4 12169.6 12172.3 12174.2 12186.6 6091.4 6102.3 6111.4 6111.7 6142.8 4682.4 5414.1 5523.2 5607.2 5623.6 3366.9 4057.1 4105.4 4136.3 4143.3 1097.4 1098.5 1100.8 1112.3 1114.9 965.5 971.7 989.5 1003.8 1014.0 6152.8 6647.2 6831.7 6838.7 6861.5 959.6 996.9 1005.8 1037.8 1041.9 3708.2 4054.5 4364.5 4438.2 4507.9 11217.9 13590.1 14192.5 14198.2 14215.8 13156.5 13411.3 14107.0 14123.9 14135.9 9115.1 10291.7 10440.9 10540.3 10599.5 6471.8 6946.8 7022.8 7114.5 7384.4 11743.9 12131.5 12139.8 12169.5 12200.9 12221.4 12370.4 12461.8 12496.6 12520.6 9337.7 9445.1 9587.9 9600.0 9670.8 8881.9 10284.4 10492.4 10623.7 10723.5 9177.4 9535.8 9614.4 9779.0 9793.5 9307.9 9363.1 9390.2 9457.6 9504.0 8042.4 8117.0 8188.3 8198.8 8206.1 6062.4 6147.4 6160.0 6161.5 6199.1 5963.2 6040.4 6162.7 6175.5 6239.0 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4872.04 Median:5306.44 stddev:1397.66 (26.3%) stddev-sans-first:1359.79 09:59:16 INFO - PROCESS | 1653 | Values: 352.7 393.0 394.5 409.8 412.2 4594.3 5224.8 5524.3 5543.6 5642.8 5396.8 5420.7 5478.6 5570.4 5598.8 3610.0 3672.6 4109.1 4394.8 4581.5 3622.3 3953.0 4556.2 4569.5 4638.7 3691.9 4555.5 4565.7 4578.0 4623.0 3538.8 4272.2 4283.6 4435.8 4476.8 3854.4 3864.2 4005.7 4028.3 4232.5 4584.8 4789.0 4830.3 5453.3 5517.4 4392.8 4778.0 5215.5 5342.3 5404.2 5305.2 5540.4 5934.3 5969.6 5982.7 3993.8 4734.0 4735.9 4790.7 4838.7 5884.5 6140.0 6166.7 6170.9 6306.4 4808.6 4815.4 4835.7 4854.5 4864.8 4227.7 4267.8 4440.9 4897.6 4913.6 4416.6 4883.6 5262.4 5268.6 5313.6 5211.9 5668.5 5730.3 5875.2 5890.3 1450.4 1456.7 1565.0 1676.8 1682.7 1107.5 1196.4 1219.5 1247.9 1276.9 5039.3 5059.5 5435.8 5638.5 5653.9 5498.3 5787.5 6004.8 6074.0 6174.4 4839.7 5176.4 5523.9 5551.5 5560.4 2878.9 3159.2 3160.1 3161.2 3161.3 5416.9 6044.2 6266.0 6337.9 6344.9 6052.5 6294.9 6313.3 6313.5 6353.6 5554.6 5600.8 5720.2 6053.8 6325.7 4851.0 5546.4 5678.5 5713.8 6231.6 4750.9 5030.4 5355.7 5562.4 5854.9 6322.4 6329.4 6383.3 6409.0 6429.3 4278.9 4317.8 4538.0 4787.2 4805.0 5030.8 5675.5 5775.9 5776.8 6081.8 5021.0 5717.8 6010.4 6071.9 6091.5 5393.4 5730.7 5916.3 5995.9 6016.0 4871.8 4882.9 5567.7 5797.9 5915.9 5307.7 5551.4 6043.7 6099.0 6125.0 5023.5 5497.9 5675.8 5847.9 5945.7 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:20217.22 Median:17454.46 stddev:27773.12 (159.1%) stddev-sans-first:27812.50 09:59:16 INFO - PROCESS | 1653 | Values: 733.3 778.7 813.4 872.2 892.5 12771.5 16047.5 16138.3 16964.7 17891.9 15668.3 15941.0 16106.0 16605.2 16625.6 988.8 990.2 993.9 994.9 995.5 857.5 982.8 987.3 1016.6 1036.5 1060.5 1075.8 1075.9 1078.7 1080.9 1071.4 1071.4 1074.1 1075.0 1078.1 779.0 786.6 792.0 793.8 794.3 16730.9 16871.9 17017.0 18106.1 18382.2 14431.3 14872.9 14907.0 14965.6 15124.7 11937.8 12022.7 12058.1 12210.3 12699.7 3700.2 3808.0 3925.3 3934.9 3949.8 91842.5 97496.0 110590.0 112072.3 114155.0 11319.8 11391.0 11429.1 11726.8 11767.4 22943.5 23071.0 23118.2 23386.9 23413.1 6393.6 8224.7 8276.9 8278.7 8434.3 4562.9 4578.8 4618.2 4631.4 4676.6 3680.9 3736.5 3751.9 3776.5 3776.8 656.4 658.7 661.9 675.3 677.8 674.7 682.0 709.5 720.0 738.8 10754.5 10895.0 11064.7 11172.4 11285.3 683.4 693.9 697.1 697.6 698.6 3852.4 4262.5 4408.9 5023.5 5245.3 79790.6 103428.0 103531.0 105470.0 107195.0 71570.3 74330.0 74848.6 77196.8 86527.0 51860.7 72752.0 74274.6 76595.6 77846.2 11213.7 11265.5 11305.5 11355.7 11564.2 50181.7 50272.7 50864.7 51757.5 52204.7 50868.7 64073.0 64307.7 64451.7 66048.0 13430.7 13590.9 13722.5 13749.9 13889.7 15391.7 15808.3 16361.3 16681.0 16951.9 14441.9 14899.0 14943.3 15549.0 15745.8 12759.8 13687.0 14669.9 14671.9 15335.0 13820.9 14414.7 14551.6 14584.7 14685.7 10277.0 10609.2 10686.1 10870.0 11128.2 10023.8 11037.3 12035.0 12274.5 12419.1 09:59:16 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:59:16 INFO - PROCESS | 1653 | 09:59:16 INFO - TEST-INFO | 1653: exit 0 09:59:16 INFO - TEST-OK | dromaeo_css | took 1115864ms 09:59:16 INFO - TEST-START | kraken 09:59:16 INFO - operating with platform_type : mac_ 09:59:16 INFO - Initialising browser for kraken test... 09:59:16 INFO - TEST-INFO | started process 1775 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpn6uebC/profile http://localhost:49239/getInfo.html) 09:59:19 INFO - PROCESS | 1775 | 2017-05-10 09:59:19.120 plugin-container[1777:10263] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843b, name = 'com.apple.tsm.portname' 09:59:19 INFO - PROCESS | 1775 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:59:19 INFO - PROCESS | 1775 | 2017-05-10 09:59:19.121 plugin-container[1777:10263] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x420b, name = 'com.apple.CFPasteboardClient' 09:59:19 INFO - PROCESS | 1775 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:59:19 INFO - PROCESS | 1775 | 2017-05-10 09:59:19.121 plugin-container[1777:10263] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:59:19 INFO - PROCESS | 1775 | __metrics Screen width/height:1600/1200 09:59:19 INFO - PROCESS | 1775 | colorDepth:24 09:59:19 INFO - PROCESS | 1775 | Browser inner width/height: 1024/689 09:59:19 INFO - PROCESS | 1775 | __metrics 09:59:19 ERROR - PROCESS | 1775 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 09:59:19 INFO - TEST-INFO | 1775: exit 0 09:59:19 INFO - Browser initialized. 09:59:19 INFO - Running cycle 1/1 for kraken test... 09:59:19 INFO - TEST-INFO | started process 1778 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/tmpn6uebC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:22 INFO - PROCESS | 1778 | 2017-05-10 09:59:22.201 plugin-container[1779:10387] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 09:59:22 INFO - PROCESS | 1778 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:59:22 INFO - PROCESS | 1778 | 2017-05-10 09:59:22.202 plugin-container[1779:10387] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 09:59:22 INFO - PROCESS | 1778 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:59:22 INFO - PROCESS | 1778 | 2017-05-10 09:59:22.202 plugin-container[1779:10387] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:59:31 INFO - PROCESS | 1778 | RSS: Main: 174350336 09:59:31 INFO - PROCESS | 1778 | 09:59:35 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:36 INFO - PROCESS | 1778 | RSS: Main: 187797504 09:59:36 INFO - PROCESS | 1778 | 09:59:38 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 09:59:39 INFO - PROCESS | 1778 | RSS: Main: 195735552 09:59:39 INFO - PROCESS | 1778 | 09:59:42 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 09:59:43 INFO - PROCESS | 1778 | RSS: Main: 199516160 09:59:43 INFO - PROCESS | 1778 | 09:59:45 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 09:59:45 INFO - PROCESS | 1778 | RSS: Main: 200826880 09:59:45 INFO - PROCESS | 1778 | 09:59:47 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:48 INFO - PROCESS | 1778 | RSS: Main: 201175040 09:59:48 INFO - PROCESS | 1778 | 09:59:51 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:52 INFO - PROCESS | 1778 | RSS: Main: 205459456 09:59:52 INFO - PROCESS | 1778 | 09:59:55 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:56 INFO - PROCESS | 1778 | RSS: Main: 204902400 09:59:56 INFO - PROCESS | 1778 | 09:59:59 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 09:59:59 INFO - PROCESS | 1778 | RSS: Main: 205258752 09:59:59 INFO - PROCESS | 1778 | 10:00:01 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:02 INFO - PROCESS | 1778 | RSS: Main: 205185024 10:00:02 INFO - PROCESS | 1778 | 10:00:04 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:00:04 INFO - PROCESS | 1778 | RSS: Main: 204738560 10:00:04 INFO - PROCESS | 1778 | 10:00:06 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:00:07 INFO - PROCESS | 1778 | RSS: Main: 204718080 10:00:07 INFO - PROCESS | 1778 | 10:00:10 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:11 INFO - PROCESS | 1778 | RSS: Main: 205127680 10:00:11 INFO - PROCESS | 1778 | 10:00:13 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:14 INFO - PROCESS | 1778 | RSS: Main: 204804096 10:00:14 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 10:00:16 INFO - PROCESS | 1778 | RSS: Main: 206962688 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | __start_tp_report 10:00:16 INFO - PROCESS | 1778 | _x_x_mozilla_page_load 10:00:16 INFO - PROCESS | 1778 | _x_x_mozilla_page_load_details 10:00:16 INFO - PROCESS | 1778 | |i|pagename|runs| 10:00:16 INFO - PROCESS | 1778 | |0;ai-astar;87;117;168;183;181;122;139;159;120;120 10:00:16 INFO - PROCESS | 1778 | |1;audio-beat-detection;144;110;120;170;122;110;108;112;126;111 10:00:16 INFO - PROCESS | 1778 | |2;audio-dft;215;194;221;179;264;278;207;193;194;195 10:00:16 INFO - PROCESS | 1778 | |3;audio-fft;85;58;62;87;81;71;59;60;72;61 10:00:16 INFO - PROCESS | 1778 | |4;audio-oscillator;80;69;87;72;66;70;82;70;74;84 10:00:16 INFO - PROCESS | 1778 | |5;imaging-gaussian-blur;90;91;90;91;97;96;135;134;89;88 10:00:16 INFO - PROCESS | 1778 | |6;imaging-darkroom;94;120;110;113;153;153;95;95;97;150 10:00:16 INFO - PROCESS | 1778 | |7;imaging-desaturate;91;92;91;137;140;90;83;144;147;95 10:00:16 INFO - PROCESS | 1778 | |8;json-parse-financial;65;64;65;66;66;69;67;88;105;105 10:00:16 INFO - PROCESS | 1778 | |9;json-stringify-tinderbox;48;65;107;91;65;58;58;61;57;57 10:00:16 INFO - PROCESS | 1778 | |10;stanford-crypto-aes;84;82;86;82;83;85;84;90;89;104 10:00:16 INFO - PROCESS | 1778 | |11;stanford-crypto-ccm;144;135;136;162;152;139;144;130;149;152 10:00:16 INFO - PROCESS | 1778 | |12;stanford-crypto-pbkdf2;163;166;164;164;165;170;166;163;179;164 10:00:16 INFO - PROCESS | 1778 | |13;stanford-crypto-sha256-iterative;64;64;66;63;67;66;65;66;65;63 10:00:16 INFO - PROCESS | 1778 | __end_tp_report 10:00:16 INFO - PROCESS | 1778 | __start_cc_report 10:00:16 INFO - PROCESS | 1778 | _x_x_mozilla_cycle_collect,986 10:00:16 INFO - PROCESS | 1778 | __end_cc_report 10:00:16 INFO - PROCESS | 1778 | __startTimestamp1494435616387__endTimestamp 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | ------- Summary: start ------- 10:00:16 INFO - PROCESS | 1778 | Number of tests: 14 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#0] ai-astar Cycles:10 Average:139.60 Median:163.50 stddev:31.86 (19.5%) stddev-sans-first:27.53 10:00:16 INFO - PROCESS | 1778 | Values: 87.0 117.0 168.0 183.0 181.0 122.0 139.0 159.0 120.0 120.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:121.00 stddev:19.71 (16.3%) stddev-sans-first:19.43 10:00:16 INFO - PROCESS | 1778 | Values: 144.0 110.0 120.0 170.0 122.0 110.0 108.0 112.0 126.0 111.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#2] audio-dft Cycles:10 Average:214.00 Median:211.00 stddev:32.53 (15.4%) stddev-sans-first:34.50 10:00:16 INFO - PROCESS | 1778 | Values: 215.0 194.0 221.0 179.0 264.0 278.0 207.0 193.0 194.0 195.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#3] audio-fft Cycles:10 Average:69.60 Median:71.50 stddev:11.30 (15.8%) stddev-sans-first:10.52 10:00:16 INFO - PROCESS | 1778 | Values: 85.0 58.0 62.0 87.0 81.0 71.0 59.0 60.0 72.0 61.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.00 stddev:7.26 (9.4%) stddev-sans-first:7.51 10:00:16 INFO - PROCESS | 1778 | Values: 80.0 69.0 87.0 72.0 66.0 70.0 82.0 70.0 74.0 84.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#5] imaging-gaussian-blur Cycles:10 Average:100.10 Median:90.50 stddev:18.36 (20.3%) stddev-sans-first:19.10 10:00:16 INFO - PROCESS | 1778 | Values: 90.0 91.0 90.0 91.0 97.0 96.0 135.0 134.0 89.0 88.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#6] imaging-darkroom Cycles:10 Average:118.00 Median:123.50 stddev:25.04 (20.3%) stddev-sans-first:25.00 10:00:16 INFO - PROCESS | 1778 | Values: 94.0 120.0 110.0 113.0 153.0 153.0 95.0 95.0 97.0 150.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#7] imaging-desaturate Cycles:10 Average:111.00 Median:90.50 stddev:26.96 (29.8%) stddev-sans-first:27.61 10:00:16 INFO - PROCESS | 1778 | Values: 91.0 92.0 91.0 137.0 140.0 90.0 83.0 144.0 147.0 95.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#8] json-parse-financial Cycles:10 Average:76.00 Median:66.00 stddev:16.81 (25.5%) stddev-sans-first:17.35 10:00:16 INFO - PROCESS | 1778 | Values: 65.0 64.0 65.0 66.0 66.0 69.0 67.0 88.0 105.0 105.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:59.50 stddev:18.08 (30.4%) stddev-sans-first:17.87 10:00:16 INFO - PROCESS | 1778 | Values: 48.0 65.0 107.0 91.0 65.0 58.0 58.0 61.0 57.0 57.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:84.50 stddev:6.59 (7.8%) stddev-sans-first:6.91 10:00:16 INFO - PROCESS | 1778 | Values: 84.0 82.0 86.0 82.0 83.0 85.0 84.0 90.0 89.0 104.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:146.50 stddev:9.67 (6.6%) stddev-sans-first:10.26 10:00:16 INFO - PROCESS | 1778 | Values: 144.0 135.0 136.0 162.0 152.0 139.0 144.0 130.0 149.0 152.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:165.50 stddev:4.88 (2.9%) stddev-sans-first:5.02 10:00:16 INFO - PROCESS | 1778 | Values: 163.0 166.0 164.0 164.0 165.0 170.0 166.0 163.0 179.0 164.0 10:00:16 INFO - PROCESS | 1778 | 10:00:16 INFO - PROCESS | 1778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:1.37 (2.1%) stddev-sans-first:1.41 10:00:16 INFO - PROCESS | 1778 | Values: 64.0 64.0 66.0 63.0 67.0 66.0 65.0 66.0 65.0 63.0 10:00:16 INFO - PROCESS | 1778 | -------- Summary: end -------- 10:00:16 INFO - PROCESS | 1778 | 10:00:17 INFO - TEST-INFO | 1778: exit 0 10:00:17 INFO - TEST-OK | kraken | took 60658ms 10:00:17 INFO - SUITE-END | took 1176s 10:00:17 INFO - Completed test suite (00:19:36) 10:00:17 INFO - javascript benchmark 10:00:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8043.115680320487, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3679.0, 3685.98157009215, 3698.2233730916505, 3705.295993761186, 3716.5725941516735, 5142.894277730287, 6220.267123151332, 6224.066390041496, 6244.656543890084, 6276.05859121132, 5232.581393488521, 6232.3144454110125, 6233.750649974007, 6256.562040657156, 6257.061440783885, 5581.10702287633, 5631.7184140793, 5662.773489060453, 5671.2060311556415, 5721.656700597978, 5723.713814309289, 5724.427557244263, 5730.36965933747, 5733.827985160431, 5746.454086861741, 5490.862728431781, 5508.283923089993, 5651.124075768263, 5704.401037891003, 5769.423057694239, 5625.634333768312, 5633.183188437674, 5641.435856414367, 5682.119271512922, 5685.289338832646, 5527.419620939824, 5673.092305231144, 5676.063449530822, 5684.602077854552, 5742.339630942453, 6128.479079278267, 6230.626162430269, 6297.748090076391, 6335.334789847092, 6344.333844946306, 6470.611763294218, 6474.5791523550815, 6479.222493300834, 6542.182227221598, 6552.50856185788, 6778.0, 6797.864042719118, 6805.761798337035, 6815.0, 6816.0, 6289.622622642656, 6292.622442653455, 6302.96848515759, 6325.841853953642, 6340.556161068727, 6634.469242460592, 6648.268690444047, 6914.308569143045, 6985.5808651481075, 6993.965030174817, 6459.741610335628, 6462.0, 6493.0, 6506.512011599054, 6516.120323756232, 6371.681415929185, 6736.696848641823, 6739.359760822714, 6800.217974932946, 6805.285445028201, 6304.243490781044, 6609.0, 6611.471082313404, 6635.86728265432, 6640.435562977201, 6461.289258181596, 6469.611823290524, 6546.70539825709, 6569.901451478232, 6589.209294884645, 5390.191471279261, 5405.027095122837, 5412.945870541323, 5418.214358917935, 5431.891362172734, 4032.9596704032583, 4765.142274390643, 4777.8327758528285, 4783.760811959458, 4818.879528011757, 5302.257683924254, 6214.9689251554355, 6252.906206406908, 6273.686315684197, 6331.715072821734, 6764.289749576224, 6780.796576102724, 6788.59268443895, 6797.2523022467485, 6818.454523638097, 5639.154126881001, 6373.139626150503, 6374.139491168633, 6375.585586936927, 6395.52033597482, 5729.054705973468, 5803.5357171426185, 5863.384344643836, 5900.527957763368, 5989.700514974234, 6837.145356830496, 6847.109875716224, 6900.861982760417, 6908.861822763617, 6968.895466567904, 5620.578456615688, 6593.3736295051895, 6756.0, 6760.1549806274215, 6766.695498702472, 6910.101686780687, 6978.860422791618, 6988.266232045766, 7049.471289653194, 7072.5402848814665, 6374.0, 6385.840353991188, 6540.869182616416, 6556.3443655634055, 6615.305392933673, 6761.898571521529, 6777.525573210025, 6793.422559082534, 6793.456523478011, 6798.388145066968, 6239.656818874824, 6316.3683631638305, 6429.32492088324, 6494.220693516808, 6565.704543295467, 5445.292112025411, 6556.803295901131, 6559.114519539992, 6562.77030303937, 6599.8020059398295, 4729.668923175344, 5113.8977220454635, 5941.31674857397, 6295.527835412271, 6425.775097871552, 6557.147570815763, 6558.376954189344, 6578.8355291118105, 6578.934210658023, 6625.039369291329, 6412.775552855627, 6413.0701048348665, 6438.356164383524, 6441.937080381685, 6451.967740161269], "value": 6114.931859937705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.7124635131352, 831.5218749219199, 839.366278459763, 905.3933864310911, 969.6509256667603, 38191.427128593095, 39447.99999999996, 39521.0, 41089.58910410895, 41256.58743412572, 25193.748062519368, 39044.804775976154, 39257.60742392582, 39303.80348098263, 39313.0, 8185.0, 8324.583770811465, 8336.208060234298, 11340.829887551694, 11623.360715160705, 11363.31820090793, 11496.137789665767, 11509.251898626604, 11510.712232194179, 11516.942415287911, 11457.770844583103, 11474.770504589904, 11479.713007174803, 11487.195896287263, 11509.597164099257, 9322.16100550947, 11432.771344573104, 11444.771104577861, 11470.827937580943, 11514.942425287862, 10387.220958428072, 11276.774464510663, 11285.435728213557, 11316.0, 11338.546458141664, 35374.0, 35563.28873422517, 35940.46089308662, 36028.459573106426, 36161.38386161389, 3275.475923852196, 3517.520148295446, 3751.193493398905, 3897.2010737798682, 3954.228925359556, 26547.601785973227, 27939.58090628642, 28066.017689380773, 30070.398592028254, 30086.54870176949, 2721.391483400887, 3211.277462570926, 3288.7369010479106, 3293.752968527346, 3306.2395649000864, 290968.0, 331438.0, 349394.0, 352960.23519882496, 353864.0, 45431.77284113624, 46512.76743616328, 53556.46443535515, 56220.43779562152, 56569.5857603555, 58412.12381814276, 58548.0, 58706.82586348249, 58823.52941176505, 59303.40696592979, 16031.839681603034, 16147.273372698257, 16156.434524791575, 16157.192140392934, 16166.75749863753, 13373.46506139763, 13428.328583570783, 13429.26139062361, 13431.194128352136, 13431.932840335736, 13981.650458738613, 14069.43722251119, 14150.36323365451, 14218.573442796733, 14262.0, 5354.812581559627, 6399.744010239631, 6400.23197216337, 6449.161608990801, 6452.193475815523, 1118.6911313762917, 1132.8753837077916, 1154.163231657042, 1162.7151347919814, 1208.7582483503334, 24796.0, 26916.84665226777, 29196.0, 29198.416031679248, 29585.704142958293, 1125.1842414249604, 1227.6071657069651, 1233.1491271022965, 1256.108163204117, 1265.038570686285, 13039.608811735663, 14758.926205368904, 14986.40054397812, 15034.624134396508, 15269.389224430899, 483045.0, 485947.0, 492214.53892730305, 492393.0, 512999.0, 49986.00027999492, 50282.74858625756, 50461.99076018459, 50474.73813154627, 50490.74754626277, 1484.5768955847748, 1489.0767724011182, 1522.596511924341, 1527.6562773375902, 1537.3235776258634, 26689.466210676066, 27912.44175116527, 28381.0, 28402.0, 28444.14667559894, 41862.79068604759, 42406.57593424026, 43195.0, 43608.12783744371, 44244.33633495436, 491304.0, 492011.0, 492322.0, 492593.0, 493449.0, 29388.0, 30681.0, 31985.680143199203, 33451.330973380886, 33676.49485257772, 40656.0, 41372.58627413688, 41519.58480415157, 41588.58411415968, 42405.363919540614, 23173.884130579238, 28592.714072859006, 29158.56262156112, 29281.41437171287, 30423.39153216879, 28882.27794305159, 29243.561346579394, 29779.957701480344, 29895.70104299016, 29968.700312996592, 30594.08217753471, 34145.82927085349, 35020.47469287912, 35421.29157416786, 36571.451428228065, 22266.0482208032, 29884.0, 30976.84511577428, 31019.68980310168, 31029.534556982115, 21215.257465988616, 23552.411189719707, 23656.29031129069, 24219.39451513726, 24975.87512062428], "value": 19170.179370205915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.742473378872, 428.3018679552329, 440.9140217657556, 444.76362645798764, 448.824958266276, 20607.0, 21934.341969740894, 22432.87835608219, 23033.424164395856, 23322.300330990056, 23117.0, 23571.646425303592, 23826.213034022476, 24171.637425438632, 24187.0, 6891.207511136234, 6962.7911162665205, 7025.402840758542, 7122.252163522833, 7249.855002899939, 6955.547889387199, 7090.042844216042, 7098.041764361797, 7898.249666281694, 8306.169383061706, 8137.267645911867, 8388.8741668875, 8408.033076196254, 8423.663053477883, 8426.536540490271, 8239.629216685233, 8368.163183681643, 8389.874151887758, 8408.579571021424, 8427.283680887133, 7653.617319134021, 8023.0, 8060.5566693831815, 8092.2486354639705, 8148.144444833326, 27378.0, 29259.41481170386, 30405.543916841045, 31108.0, 31559.053228402954, 3526.100844284691, 3567.357875582394, 3583.175869550018, 3630.4009838376637, 3646.4165733482782, 17816.91091544534, 17857.285708571642, 18087.276508939627, 18240.0, 18432.815671843244, 1997.0813425824138, 2055.9309159237114, 2106.178590349765, 2143.9892800536054, 2145.9463513412134, 154023.0, 159991.0, 164013.0, 184136.0, 188235.17647235302, 20442.897785510977, 21576.784232157792, 26097.0, 27475.587866182024, 27733.168004959884, 44636.55363446324, 44704.0, 44976.3253551197, 45766.542334576894, 45875.31187032197, 12106.728793476734, 12264.264144151379, 12286.447109880077, 12327.013838892866, 12403.317817520123, 10053.447060411601, 10069.0, 10111.533827594958, 10206.540705668263, 10319.019693129141, 11589.188756786943, 11971.0, 12064.517419303305, 12078.637640870787, 12151.513939442324, 4248.787560621957, 4856.562909338177, 4882.804687812448, 4975.676581022222, 5003.649744517922, 943.1700103908516, 965.4062751407974, 984.315900449181, 996.2217441866379, 1001.2690735762789, 16928.661426771396, 18386.448406547825, 19166.616667666847, 19295.8070419294, 19367.225310987404, 884.752269364579, 989.772352358947, 989.8812142542797, 1022.8823685276288, 1032.8554002439664, 9678.27412944032, 9889.50552472388, 9991.600335986479, 10005.0, 10054.949725251327, 382171.0, 382544.0, 382811.0, 384926.0, 698769.0, 156825.2158739222, 163123.0, 166673.3332666682, 169485.63115309292, 170156.0, 1082.805095082877, 1229.9569515067108, 1233.3216730798026, 1276.7701813673443, 1282.179405180685, 14137.43450261978, 17051.806373554227, 17346.392876249272, 17455.0, 17646.94118352903, 63968.3603163981, 64118.67940660267, 65775.0, 66403.0, 66495.66752166208, 91223.0, 92152.53923730338, 92584.0, 93904.53047734717, 94547.0, 7753.883691744742, 10495.0, 11528.193026488065, 11772.823407649063, 12003.099767517297, 10213.693589192337, 12486.812697809723, 13014.089013768946, 13622.250776207404, 13816.171029738249, 11164.665060048212, 11458.828117578076, 11512.769744605228, 11549.82675259855, 11982.58060967862, 10626.681199564026, 10688.572457101629, 10892.673219803419, 10920.7269818252, 10984.560617575527, 11735.119866010255, 11764.764704706029, 11947.522099116286, 12070.155089143676, 12087.939560302142, 11688.94799468052, 11778.234414763014, 11913.82129268079, 11917.463714133059, 12127.332996685267, 9619.797525309335, 9678.70963871085, 11383.317000979967, 11534.462418267967, 11705.005074568757], "value": 12270.378955906774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1589.4039735099338, 1633.322171298911, 1642.3020216408024, 1651.0506458786197, 1651.7026935151675, 10988.285761425503, 11340.262882912604, 11729.882701172986, 11734.178607497468, 11736.706582335435, 11457.0, 11626.0, 11662.358570278631, 11664.416779161029, 11670.591529296476, 2108.736407949006, 2475.962860557093, 2523.3565440812567, 2526.166365099522, 2526.406294520786, 2431.9270421887372, 2505.47385049139, 2513.3716570857287, 2514.1326242446416, 2532.696076470826, 2475.665785119013, 2483.962740558893, 2489.178571071542, 2524.873756312177, 2524.911628093017, 2439.4389290463114, 2447.473793134485, 2477.417806815397, 2480.231128350217, 2483.2301986384186, 2476.182859656309, 2490.838095523803, 2495.2763698527406, 2502.199296225209, 2516.0061775598538, 11311.151663625178, 11549.249298795552, 11576.247543909703, 11584.710382240428, 11613.012893904028, 5753.942460575383, 5754.4533269339345, 6003.459688628001, 6189.0, 6211.09939058834, 3726.2361215950937, 3803.125281185315, 3845.442410850411, 3861.073342397832, 3961.5840336764513, 1246.1712960881002, 1274.9426275817611, 1281.4713557847645, 1308.2281453942219, 1329.2954733991, 14116.788248176286, 14433.566992990227, 14609.342579583945, 14687.33906974178, 15333.693326133527, 4790.137775200497, 4836.903261934742, 4969.950300496948, 4981.028699403581, 4997.425296090923, 12166.391680415943, 12169.574064907685, 12172.330521821208, 12174.208676436003, 12186.57346992851, 6091.360407157274, 6102.328743838174, 6111.449969502766, 6111.724972376253, 6142.815715528542, 4682.391289132391, 5414.106672399089, 5523.199136125239, 5607.243022192033, 5623.578231632644, 3366.9326613468083, 4057.0919168233013, 4105.384192371168, 4136.276151673445, 4143.295639741251, 1097.358045543366, 1098.549594666183, 1100.7523307255963, 1112.2992514715677, 1114.921955463126, 965.5365424596092, 971.6939164163266, 989.4706332112286, 1003.8092762375126, 1013.9746506337253, 6152.78465253714, 6647.235567909753, 6831.658417079127, 6838.7264509420065, 6861.4853885958755, 959.6113574002541, 996.8903420623726, 1005.7787286796893, 1037.7976294622476, 1041.8697662792151, 3708.2027364116843, 4054.5134583850127, 4364.498082720528, 4438.178936896685, 4507.909841803145, 11217.943910280397, 13590.116642418408, 14192.503262385768, 14198.219097949712, 14215.786763198561, 13156.473741050442, 13411.329433528479, 14107.0, 14123.858761412459, 14135.85864141366, 9115.088491150964, 10291.742706432398, 10440.947795261127, 10540.262181647364, 10599.523021464052, 6471.838204044937, 6946.756863509753, 7022.824429389306, 7114.537555058904, 7384.446166537424, 11743.88256117428, 12131.454084566392, 12139.817902731289, 12169.452374642986, 12200.938995304967, 12221.38893055326, 12370.44333004999, 12461.813072804096, 12496.625101246977, 12520.561780337644, 9337.673181438617, 9445.0554944505, 9587.904120958701, 9599.952000239955, 9670.75823104428, 8881.866771998297, 10284.434356110485, 10492.422916739653, 10623.681289561326, 10723.517441715298, 9177.449353038839, 9535.809283814424, 9614.375065620712, 9778.951105244429, 9793.510324483605, 9307.86038209441, 9363.063693630582, 9390.201832844285, 9457.6367355675, 9504.0, 8042.356611470951, 8116.959415202886, 8188.303994160563, 8198.795030124294, 8206.138355472589, 6062.42406971337, 6147.415995480422, 6160.0, 6161.507079433724, 6199.070139479114, 5963.165156878127, 6040.36576159497, 6162.722677479434, 6175.505959523317, 6239.032949892774], "value": 5314.913047430909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.7495478210471, 392.9646331830138, 394.5048963550745, 409.75619506393684, 412.173591948144, 4594.333821595871, 5224.84325470236, 5524.281843360358, 5543.611947163695, 5642.830715078554, 5396.815878631606, 5420.7018613976215, 5478.643888147268, 5570.387257401682, 5598.776048958037, 3610.0, 3672.559292884844, 4109.0959988802415, 4394.846180383687, 4581.540936592868, 3622.279417276786, 3952.9802350988207, 4556.20266453371, 4569.497355290915, 4638.744869032202, 3691.870784522542, 4555.544445555451, 4565.748883811389, 4578.015726618776, 4622.953770462286, 3538.8053657048854, 4272.209641216385, 4283.550227226127, 4435.800388982503, 4476.776161191928, 3854.383298672199, 3864.207837393356, 4005.73962692427, 4028.3353246714255, 4232.492100947875, 4584.839530616446, 4789.012559787684, 4830.275458681191, 5453.263809385761, 5517.393086760453, 4392.802323895432, 4778.0, 5215.452377500384, 5342.252084708144, 5404.189371594253, 5305.230741542455, 5540.36285827131, 5934.258217722785, 5969.552283578705, 5982.73077711504, 3993.7803420811842, 4733.958529123587, 4735.887066539361, 4790.688605240648, 4838.733869637169, 5884.499817515516, 6139.969300153471, 6166.7224974876235, 6170.907436388457, 6306.369363063703, 4808.567228949341, 4815.422149342031, 4835.661503694778, 4854.466008739036, 4864.78108485119, 4227.7463352198965, 4267.807948642257, 4440.888977775517, 4897.608191344684, 4913.606911447076, 4416.621284717194, 4883.58489528387, 5262.368515778055, 5268.577484079354, 5313.57491400687, 5211.869703257449, 5668.546516278688, 5730.312362516524, 5875.237428771437, 5890.262372600093, 1450.354592206479, 1456.6817030587124, 1564.9765253521207, 1676.8155502894672, 1682.6634673065437, 1107.534835369147, 1196.389841181004, 1219.518285283385, 1247.8564965028957, 1276.9273809999459, 5039.3448851649055, 5059.544640982329, 5435.83692489226, 5638.4925356718095, 5653.9151912721345, 5498.3127109111365, 5787.508061814793, 6004.849878753066, 6073.96963015191, 6174.406749165361, 4839.685420447659, 5176.374850519281, 5523.944760552343, 5551.528120109755, 5560.415281644793, 2878.870450829718, 3159.162821852211, 3160.115167753033, 3161.1780936956557, 3161.3361194149024, 5416.9436959792465, 6044.24446944132, 6266.0, 6337.904931426032, 6344.904826427607, 6052.485538729169, 6294.937050629526, 6313.337099604567, 6313.526485513605, 6353.618782873043, 5554.555635549146, 5600.803971860965, 5720.166459341849, 6053.818385448443, 6325.7153428094925, 4850.981293928315, 5546.4453554644215, 5678.488935995781, 5713.800016999385, 6231.594946328474, 4750.857474275777, 5030.359061492745, 5355.705436201047, 5562.443755624405, 5854.9121763174435, 6322.430981211713, 6329.430351268224, 6383.265924418752, 6408.967955160194, 6429.260635027032, 4278.893027674333, 4317.812601534603, 4538.0, 4787.162246606899, 4805.026797264814, 5030.805438546622, 5675.517581005661, 5775.8521605724145, 5776.797812076557, 6081.817545473643, 5021.0, 5717.799877004285, 6010.377198156386, 6071.9336734948565, 6091.451769340781, 5393.379761327341, 5730.684812335361, 5916.290045194604, 5995.880082398415, 6016.037434010537, 4871.780769865293, 4882.924756978341, 5567.749451274622, 5797.8550536236935, 5915.881682366415, 5307.65500242483, 5551.446334685928, 6043.667598282137, 6099.0483045425035, 6125.0, 5023.522765337433, 5497.890042199214, 5675.758075560213, 5847.883042339215, 5945.732442040205], "value": 4463.572647370699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.3363306207877, 778.6573907480705, 813.4346629092779, 872.2411501993265, 892.4868200784548, 12771.489140434383, 16047.51857444277, 16138.273777680004, 16964.745528817046, 17891.91054044728, 15668.294926728297, 15941.0, 16106.0, 16605.169741512906, 16625.584360390996, 988.7577543501852, 990.1880458024423, 993.8658281132027, 994.8507723841445, 995.5320999130397, 857.4726543175964, 982.79852630211, 987.3039507147444, 1016.5628779624758, 1036.533559898045, 1060.4538662588734, 1075.779465209634, 1075.8655168103987, 1078.7087486378712, 1080.8865069167741, 1071.3625392891217, 1071.4160782373624, 1074.0548317480607, 1075.021730225495, 1078.0620859851979, 778.9961050194713, 786.6184900323339, 792.029763539665, 793.8412317536515, 794.3486341200218, 16730.912490688188, 16871.91564042184, 17017.0, 18106.094695265318, 18382.1728022238, 14431.278436078153, 14872.851271487254, 14907.03104298228, 14965.625859353495, 15124.697506049928, 11937.820932686016, 12022.69943251417, 12058.095642826824, 12210.276459089637, 12699.746005079847, 3700.204456041937, 3808.0, 3925.2738243425056, 3934.921301573981, 3949.822257998397, 91842.5407872963, 97496.0, 110590.0, 112072.31891521634, 114154.99999999917, 11319.830202546967, 11391.0, 11429.142814288962, 11726.765464690658, 11767.411629418495, 22943.541129177323, 23070.961806718737, 23118.1908633197, 23386.883065584563, 23413.06347746105, 6393.552451328455, 8224.712135075244, 8276.875846862302, 8278.71024514139, 8434.325253979667, 4562.8631141065825, 4578.793954272066, 4618.237990731492, 4631.397918270671, 4676.602488788491, 3680.8895733128047, 3736.4768932349493, 3751.9062023449087, 3776.527934008249, 3776.773393596338, 656.4387448731361, 658.7430901948244, 661.8940969444866, 675.3482889012126, 677.806825054857, 674.6862708840413, 681.9590824550543, 709.521073275537, 719.9640017999079, 738.770980995893, 10754.516046777757, 10895.0, 11064.723381915517, 11172.44137793107, 11285.322880627189, 683.3610574113121, 693.8508220732567, 697.0798545919338, 697.5640224859463, 698.6297262450807, 3852.4221366794645, 4262.46719160105, 4408.9118217636105, 5023.547880690755, 5245.344331958505, 79790.60104699439, 103428.0, 103531.0, 105470.0, 107195.0, 71570.2842971574, 74330.0, 74848.62575687087, 77196.84204736934, 86527.0, 51860.74069629628, 72752.0, 74274.62862685652, 76595.61702191342, 77846.22153778504, 11213.710423301425, 11265.549378025114, 11305.491252893475, 11355.716107097389, 11564.248323858923, 50181.74909125431, 50272.748636258046, 50864.745676271385, 51757.49516320188, 52204.73897630488, 50868.74565627148, 64073.0, 64307.67846160739, 64451.67774161099, 66048.00927985988, 13430.664233394244, 13590.93204533971, 13722.451101956209, 13749.931250343685, 13889.652758681113, 15391.69216615639, 15808.288627012042, 16361.34554617802, 16680.999140051637, 16951.915240424212, 14441.927790360982, 14898.957073004785, 14943.252837358306, 15549.0, 15745.763813543035, 12759.808602870778, 13687.0, 14669.926650367106, 14671.92664036673, 15335.0, 13820.930895345458, 14414.711705766036, 14551.563453096423, 14584.708305833612, 14685.706285874436, 10277.0, 10609.184442658472, 10686.0916822071, 10870.021698047214, 11128.22102452853, 10023.847257565474, 11037.282576632493, 12035.0, 12274.509019639114, 12419.130660854014], "value": 7933.274934465894, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 117.0, 168.0, 183.0, 181.0, 122.0, 139.0, 159.0, 120.0, 120.0], "value": 139.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 120.0, 170.0, 122.0, 110.0, 108.0, 112.0, 126.0, 111.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 194.0, 221.0, 179.0, 264.0, 278.0, 207.0, 193.0, 194.0, 195.0], "value": 214.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 58.0, 62.0, 87.0, 81.0, 71.0, 59.0, 60.0, 72.0, 61.0], "value": 69.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 69.0, 87.0, 72.0, 66.0, 70.0, 82.0, 70.0, 74.0, 84.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 90.0, 91.0, 97.0, 96.0, 135.0, 134.0, 89.0, 88.0], "value": 100.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 120.0, 110.0, 113.0, 153.0, 153.0, 95.0, 95.0, 97.0, 150.0], "value": 118.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 91.0, 137.0, 140.0, 90.0, 83.0, 144.0, 147.0, 95.0], "value": 111.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 66.0, 66.0, 69.0, 67.0, 88.0, 105.0, 105.0], "value": 76.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 65.0, 107.0, 91.0, 65.0, 58.0, 58.0, 61.0, 57.0, 57.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 86.0, 82.0, 83.0, 85.0, 84.0, 90.0, 89.0, 104.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 135.0, 136.0, 162.0, 152.0, 139.0, 144.0, 130.0, 149.0, 152.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 164.0, 165.0, 170.0, 166.0, 163.0, 179.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 63.0, 67.0, 66.0, 65.0, 66.0, 65.0, 63.0], "value": 64.9, "unit": "score"}]}]} 10:00:17 INFO - Return code: 0 10:00:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:00:17 ERROR - # TBPL SUCCESS # 10:00:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:17 INFO - 2017-05-10 10:00:17.713 screenresolution[1789:10783] starting screenresolution argv=screenresolution get 10:00:17 INFO - 2017-05-10 10:00:17.716 screenresolution[1789:10783] Display 0: 1600x1200x32@60 10:00:17 INFO - 2017-05-10 10:00:17.722 screenresolution[1790:10786] starting screenresolution argv=screenresolution list 10:00:17 INFO - Available Modes on Display 0 10:00:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:17 INFO - Intel Iris: 10:00:17 INFO - Chipset Model: Intel Iris 10:00:17 INFO - Type: GPU 10:00:17 INFO - Bus: Built-In 10:00:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:17 INFO - Vendor: Intel (0x8086) 10:00:17 INFO - Device ID: 0x0a2e 10:00:17 INFO - Revision ID: 0x0009 10:00:17 INFO - Displays: 10:00:17 INFO - Display: 10:00:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:17 INFO - Display Serial Number: 1600x1200 60 10:00:17 INFO - Main Display: Yes 10:00:17 INFO - Mirror: Off 10:00:17 INFO - Online: Yes 10:00:17 INFO - Rotation: Supported 10:00:17 INFO - Return code: 0 10:00:17 INFO - Running post-action listener: _resource_record_post_action 10:00:17 INFO - [mozharness: 2017-05-10 17:00:17.958128Z] Finished run-tests step (success) 10:00:17 INFO - Running post-run listener: _resource_record_post_run 10:00:18 INFO - Total resource usage - Wall time: 1192s; CPU: 55.0%; Read bytes: 41162752; Write bytes: 429427200; Read time: 269; Write time: 1493 10:00:18 INFO - TinderboxPrint: CPU usage
54.5% 10:00:18 INFO - TinderboxPrint: I/O read bytes / time
41,162,752 / 269 10:00:18 INFO - TinderboxPrint: I/O write bytes / time
429,427,200 / 1,493 10:00:18 INFO - TinderboxPrint: CPU idle
2,169.2 (45.5%) 10:00:18 INFO - TinderboxPrint: CPU system
959.3 (20.1%) 10:00:18 INFO - TinderboxPrint: CPU user
1,641.0 (34.4%) 10:00:18 INFO - TinderboxPrint: Swap in / out
162,054,144 / 0 10:00:18 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123232768; Write bytes: 124889088; Read time: 11172; Write time: 293 10:00:18 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 36997120; Write bytes: 303137280; Read time: 241; Write time: 1195 10:00:18 INFO - Running post-run listener: _upload_blobber_files 10:00:18 INFO - Blob upload gear active. 10:00:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:18 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 10:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:19 INFO - (blobuploader) - INFO - Done attempting. 10:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:21 INFO - (blobuploader) - INFO - Done attempting. 10:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:22 INFO - (blobuploader) - INFO - Done attempting. 10:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:00:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:24 INFO - (blobuploader) - INFO - Done attempting. 10:00:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:24 INFO - Return code: 0 10:00:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cfb9d27281321aed05efaa3bf44ba012b60b4c0e2ffbc4f5f0c460be534390ff49adb289a25fa039e4a4a68ce27c4e75b0ec0318df7d2ab1070230d0194231", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1089325c001d6222c4af0b583dde6370a8f7c9980f66405982a957f59339c66ad7e782cd68d72a35fbb7a6a4823af233fb5309e360752684bc82820d09be62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa5189cc1a2adc8549e07d7c0009fcb641758d4b780c337462cc140fbcd6e91be786f9fbd87c0bf35b12d3368c81340f2ee0e718b70c8595f3de0676f5b318a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aebed45efe141fd42f6c72f57f0828629eaadf8c5d1e1ada7b86b64fb611c889aba6944b76665836239276d8da3bffc4e9aaa71fc96c4b4948d332e9e4abec8"} 10:00:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:24 INFO - Contents: 10:00:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cfb9d27281321aed05efaa3bf44ba012b60b4c0e2ffbc4f5f0c460be534390ff49adb289a25fa039e4a4a68ce27c4e75b0ec0318df7d2ab1070230d0194231", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1089325c001d6222c4af0b583dde6370a8f7c9980f66405982a957f59339c66ad7e782cd68d72a35fbb7a6a4823af233fb5309e360752684bc82820d09be62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa5189cc1a2adc8549e07d7c0009fcb641758d4b780c337462cc140fbcd6e91be786f9fbd87c0bf35b12d3368c81340f2ee0e718b70c8595f3de0676f5b318a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aebed45efe141fd42f6c72f57f0828629eaadf8c5d1e1ada7b86b64fb611c889aba6944b76665836239276d8da3bffc4e9aaa71fc96c4b4948d332e9e4abec8"} 10:00:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:24 INFO - Copying logs to upload dir... 10:00:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.730065 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-05-10 10:00:24.377325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 10:00:24.380657) ========= 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.zse8QcW0AH/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.1WU6a0J9g9/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cfb9d27281321aed05efaa3bf44ba012b60b4c0e2ffbc4f5f0c460be534390ff49adb289a25fa039e4a4a68ce27c4e75b0ec0318df7d2ab1070230d0194231", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1089325c001d6222c4af0b583dde6370a8f7c9980f66405982a957f59339c66ad7e782cd68d72a35fbb7a6a4823af233fb5309e360752684bc82820d09be62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa5189cc1a2adc8549e07d7c0009fcb641758d4b780c337462cc140fbcd6e91be786f9fbd87c0bf35b12d3368c81340f2ee0e718b70c8595f3de0676f5b318a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aebed45efe141fd42f6c72f57f0828629eaadf8c5d1e1ada7b86b64fb611c889aba6944b76665836239276d8da3bffc4e9aaa71fc96c4b4948d332e9e4abec8"} build_url:https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010926 build_url: 'https://queue.taskcluster.net/v1/task/bSN9sg_dSGGhX2By6AA7iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56cfb9d27281321aed05efaa3bf44ba012b60b4c0e2ffbc4f5f0c460be534390ff49adb289a25fa039e4a4a68ce27c4e75b0ec0318df7d2ab1070230d0194231", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f1089325c001d6222c4af0b583dde6370a8f7c9980f66405982a957f59339c66ad7e782cd68d72a35fbb7a6a4823af233fb5309e360752684bc82820d09be62f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa5189cc1a2adc8549e07d7c0009fcb641758d4b780c337462cc140fbcd6e91be786f9fbd87c0bf35b12d3368c81340f2ee0e718b70c8595f3de0676f5b318a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aebed45efe141fd42f6c72f57f0828629eaadf8c5d1e1ada7b86b64fb611c889aba6944b76665836239276d8da3bffc4e9aaa71fc96c4b4948d332e9e4abec8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 10:00:24.414491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 10:00:24.414830) ========= 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.zse8QcW0AH/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.1WU6a0J9g9/Listeners TMPDIR=/var/folders/jw/lfbylzg17jd15qryjvmblvym00000w/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.005110 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 10:00:24.463063) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 10:00:24.466462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 10:00:24.466791) ========= ========= Total master_lag: 0.19 =========