builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0059 starttime: 1490348110.88 results: success (0) buildid: 20170324004022 builduid: 6121278665674a7d82b1841cee834a44 revision: 06b2530392f938ee62ade6659bdf40dee658b5cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:10.884437) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:10.885415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:10.886077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:10.912324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:10.912682) ========= 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.h2Lsf78eAm/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.trUfo0y6IL/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-24 02:35:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2017-03-24 02:35:11 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172904 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:11.113335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:11.113694) ========= 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.h2Lsf78eAm/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.trUfo0y6IL/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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.020994 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:11.163483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 02:35:11.163988) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 06b2530392f938ee62ade6659bdf40dee658b5cb --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-aurora --rev 06b2530392f938ee62ade6659bdf40dee658b5cb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h2Lsf78eAm/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.trUfo0y6IL/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-24 02:35:11,263 truncating revision to first 12 chars 2017-03-24 02:35:11,263 Setting DEBUG logging. 2017-03-24 02:35:11,263 attempt 1/10 2017-03-24 02:35:11,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/06b2530392f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 02:35:12,266 unpacking tar archive at: mozilla-aurora-06b2530392f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267893 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 02:35:12.459144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:12.459828) ========= script_repo_revision: 06b2530392f938ee62ade6659bdf40dee658b5cb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:12.460697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:12.461293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 02:35:12.483672) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-24 02:35:12.484423) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h2Lsf78eAm/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.trUfo0y6IL/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:35:12 INFO - MultiFileLogger online at 20170324 02:35:12 in /builds/slave/test 02:35:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:35:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:35:12 INFO - {'append_to_log': False, 02:35:12 INFO - 'base_work_dir': '/builds/slave/test', 02:35:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:35:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:35:12 INFO - 'branch': 'Mozilla-Aurora', 02:35:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:35:12 INFO - 'config_files': ('talos/mac_config.py',), 02:35:12 INFO - 'default_actions': ('clobber', 02:35:12 INFO - 'read-buildbot-config', 02:35:12 INFO - 'download-and-extract', 02:35:12 INFO - 'populate-webroot', 02:35:12 INFO - 'create-virtualenv', 02:35:12 INFO - 'install', 02:35:12 INFO - 'run-tests'), 02:35:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:35:12 INFO - 'download_minidump_stackwalk': True, 02:35:12 INFO - 'download_symbols': 'ondemand', 02:35:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:35:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:35:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:35:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:35:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:35:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:35:12 INFO - 'gecko_profile': False, 02:35:12 INFO - 'gecko_profile_interval': 0, 02:35:12 INFO - 'installer_path': 'installer.exe', 02:35:12 INFO - 'log_level': 'info', 02:35:12 INFO - 'log_name': 'talos', 02:35:12 INFO - 'log_to_console': True, 02:35:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:35:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:35:12 INFO - 'opt_config_files': (), 02:35:12 INFO - 'pip_index': False, 02:35:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:35:12 INFO - 'cmd': ('bash', 02:35:12 INFO - '-c', 02:35:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:35:12 INFO - 'enabled': True, 02:35:12 INFO - 'halt_on_failure': False, 02:35:12 INFO - 'name': 'check_screen_resolution'},), 02:35:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:35:12 INFO - 'cmd': ('bash', 02:35:12 INFO - '-c', 02:35:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:35:12 INFO - 'enabled': True, 02:35:12 INFO - 'halt_on_failure': False, 02:35:12 INFO - 'name': 'check_screen_resolution'},), 02:35:12 INFO - 'run_cmd_checks_enabled': True, 02:35:12 INFO - 'suite': 'dromaeojs-e10s', 02:35:12 INFO - 'system_bits': '32', 02:35:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:35:12 INFO - 'title': 't-yosemite-r7-0059', 02:35:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:35:12 INFO - 'use_talos_json': True, 02:35:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:35:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:35:12 INFO - 'work_dir': 'build'} 02:35:12 INFO - [mozharness: 2017-03-24 09:35:12.704438Z] Running clobber step. 02:35:12 INFO - Running pre-action listener: _resource_record_pre_action 02:35:12 INFO - Running main action method: clobber 02:35:12 INFO - rmtree: /builds/slave/test/build 02:35:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:15 INFO - Running post-action listener: _resource_record_post_action 02:35:15 INFO - [mozharness: 2017-03-24 09:35:15.828090Z] Finished clobber step (success) 02:35:15 INFO - [mozharness: 2017-03-24 09:35:15.828225Z] Running read-buildbot-config step. 02:35:15 INFO - Running pre-action listener: _resource_record_pre_action 02:35:15 INFO - Running main action method: read_buildbot_config 02:35:15 INFO - Using buildbot properties: 02:35:15 INFO - { 02:35:15 INFO - "project": "", 02:35:15 INFO - "product": "firefox", 02:35:15 INFO - "script_repo_revision": "production", 02:35:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:35:15 INFO - "repository": "", 02:35:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:35:15 INFO - "buildid": "20170324004022", 02:35:15 INFO - "stage_platform": "macosx64", 02:35:15 INFO - "basedir": "/builds/slave/test", 02:35:15 INFO - "nightly_build": "True", 02:35:15 INFO - "buildnumber": 1, 02:35:15 INFO - "slavename": "t-yosemite-r7-0059", 02:35:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:35:15 INFO - "platform": "yosemite_r7", 02:35:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:35:15 INFO - "branch": "mozilla-aurora", 02:35:15 INFO - "repo_path": "releases/mozilla-aurora", 02:35:15 INFO - "revision": "06b2530392f938ee62ade6659bdf40dee658b5cb", 02:35:15 INFO - "pgo_build": "False", 02:35:15 INFO - "builduid": "6121278665674a7d82b1841cee834a44", 02:35:15 INFO - "slavebuilddir": "test" 02:35:15 INFO - } 02:35:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:35:15 INFO - Running post-action listener: _resource_record_post_action 02:35:15 INFO - [mozharness: 2017-03-24 09:35:15.831508Z] Finished read-buildbot-config step (success) 02:35:15 INFO - [mozharness: 2017-03-24 09:35:15.831627Z] Running download-and-extract step. 02:35:15 INFO - Running pre-action listener: _resource_record_pre_action 02:35:15 INFO - Running main action method: download_and_extract 02:35:15 INFO - mkdir: /builds/slave/test/build/tests 02:35: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')]} 02:35:15 INFO - trying https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:35:15 INFO - Downloading https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:35:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:35:16 INFO - Downloaded 1199 bytes. 02:35:16 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:35:16 INFO - Using the following test package requirements: 02:35:16 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:35:16 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:35:16 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:35:16 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'jsshell-mac.zip'], 02:35:16 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:35:16 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:35:16 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:35:16 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:35:16 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:35:16 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:35:16 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:35:16 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:35:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:35:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:35:16 INFO - Fetch https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:35:18 INFO - Expected file size: 51782272 02:35:18 INFO - Obtained file size: 51782272 02:35:34 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:35:35 INFO - Expected file size: 51782272 02:35:35 INFO - Obtained file size: 51782272 02:35:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:35:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:35:51 INFO - Fetch https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:35:52 INFO - Expected file size: 14404438 02:35:52 INFO - Obtained file size: 14404438 02:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:52 INFO - trying https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:35:52 INFO - Downloading https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:35:54 INFO - Downloaded 74807361 bytes. 02:35:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:35:54 INFO - mkdir: /builds/slave/test/properties 02:35:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:35:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:35:54 INFO - Contents: 02:35:54 INFO - build_url:https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:35:55 INFO - Running post-action listener: _resource_record_post_action 02:35:55 INFO - Running post-action listener: set_extra_try_arguments 02:35:55 INFO - [mozharness: 2017-03-24 09:35:55.528961Z] Finished download-and-extract step (success) 02:35:55 INFO - [mozharness: 2017-03-24 09:35:55.529083Z] Running populate-webroot step. 02:35:55 INFO - Running pre-action listener: _resource_record_pre_action 02:35:55 INFO - Running main action method: populate_webroot 02:35:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:35:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:35:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:35:55 INFO - '--tppagecycles', 02:35:55 INFO - '7'], 02:35:55 INFO - 'tests': ['tsvgm']}}, 02:35:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:35:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:35:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:35:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:35:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['damp', 'tps']}, 02:35:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'tests': ['damp', 'tps']}, 02:35:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['dromaeo_dom']}, 02:35:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:35:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['basic_compositor_video']}, 02:35:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:35:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['a11yr', 02:35:55 INFO - 'ts_paint', 02:35:55 INFO - 'tpaint', 02:35:55 INFO - 'sessionrestore', 02:35:55 INFO - 'sessionrestore_no_auto_restore', 02:35:55 INFO - 'tabpaint']}, 02:35:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:35:55 INFO - 'ts_paint', 02:35:55 INFO - 'tpaint', 02:35:55 INFO - 'sessionrestore', 02:35:55 INFO - 'sessionrestore_no_auto_restore', 02:35:55 INFO - 'tabpaint']}, 02:35:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:35:55 INFO - 'ts_paint', 02:35:55 INFO - 'tpaint', 02:35:55 INFO - 'sessionrestore', 02:35:55 INFO - 'sessionrestore_no_auto_restore', 02:35:55 INFO - 'tabpaint']}, 02:35:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:35:55 INFO - 'ts_paint', 02:35:55 INFO - 'tpaint', 02:35:55 INFO - 'sessionrestore', 02:35:55 INFO - 'sessionrestore_no_auto_restore', 02:35:55 INFO - 'tabpaint']}, 02:35:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['a11yr', 02:35:55 INFO - 'ts_paint', 02:35:55 INFO - 'tpaint', 02:35:55 INFO - 'sessionrestore', 02:35:55 INFO - 'sessionrestore_no_auto_restore', 02:35:55 INFO - 'tabpaint']}, 02:35:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['a11yr', 02:35:55 INFO - 'ts_paint', 02:35:55 INFO - 'tpaint', 02:35:55 INFO - 'sessionrestore', 02:35:55 INFO - 'sessionrestore_no_auto_restore', 02:35:55 INFO - 'tabpaint']}, 02:35:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['tsvgx', 02:35:55 INFO - 'tsvgr_opacity', 02:35:55 INFO - 'tart', 02:35:55 INFO - 'tscrollx', 02:35:55 INFO - 'cart', 02:35:55 INFO - 'tsvg_static']}, 02:35:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:35:55 INFO - 'tsvgr_opacity', 02:35:55 INFO - 'tart', 02:35:55 INFO - 'tscrollx', 02:35:55 INFO - 'cart', 02:35:55 INFO - 'tsvg_static']}, 02:35:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'talos_options': ['--disable-e10s'], 02:35:55 INFO - 'tests': ['tp5o']}, 02:35:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:35:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'talos_options': ['--disable-e10s', 02:35:55 INFO - '--xperf_path', 02:35:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:55 INFO - 'tests': ['tp5n']}, 02:35:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:35:55 INFO - 'talos_options': ['--xperf_path', 02:35:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:55 INFO - 'tests': ['tp5n']}}, 02:35:55 INFO - 'talos.zip': {'path': '', 02:35:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:35:55 INFO - Running post-action listener: _resource_record_post_action 02:35:55 INFO - [mozharness: 2017-03-24 09:35:55.547214Z] Finished populate-webroot step (success) 02:35:55 INFO - [mozharness: 2017-03-24 09:35:55.547370Z] Running create-virtualenv step. 02:35:55 INFO - Running pre-action listener: _resource_record_pre_action 02:35:55 INFO - Running main action method: create_virtualenv 02:35:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:35:55 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 02:35:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:35:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:35:55 INFO - Using real prefix '/tools/python27' 02:35:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:35:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:35:59 INFO - Installing pip.................done. 02:35:59 INFO - Return code: 0 02:35:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:35:59 INFO - Reading from file tmpfile_stdout 02:35:59 INFO - Output received: 02:35:59 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) 02:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:59 INFO - 'HOME': '/Users/cltbld', 02:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:59 INFO - 'LOGNAME': 'cltbld', 02:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:59 INFO - 'MOZ_NO_REMOTE': '1', 02:35:59 INFO - 'NO_EM_RESTART': '1', 02:35:59 INFO - 'PAGER': '/bin/cat', 02:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:59 INFO - 'PWD': '/builds/slave/test', 02:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:59 INFO - 'SHELL': '/bin/bash', 02:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:35:59 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:59 INFO - 'USER': 'cltbld', 02:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:59 INFO - 'XPC_FLAGS': '0x0', 02:35:59 INFO - 'XPC_SERVICE_NAME': '0', 02:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:59 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 02:35:59 INFO - Cleaning up... 02:35:59 INFO - Return code: 0 02:35:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:59 INFO - 'HOME': '/Users/cltbld', 02:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:59 INFO - 'LOGNAME': 'cltbld', 02:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:59 INFO - 'MOZ_NO_REMOTE': '1', 02:35:59 INFO - 'NO_EM_RESTART': '1', 02:35:59 INFO - 'PAGER': '/bin/cat', 02:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:59 INFO - 'PWD': '/builds/slave/test', 02:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:59 INFO - 'SHELL': '/bin/bash', 02:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:35:59 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:59 INFO - 'USER': 'cltbld', 02:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:59 INFO - 'XPC_FLAGS': '0x0', 02:35:59 INFO - 'XPC_SERVICE_NAME': '0', 02:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:00 INFO - Downloading/unpacking psutil>=3.1.1 02:36:00 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 02:36:00 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 02:36:00 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 02:36:00 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 02:36:00 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 02:36:00 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 02:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:03 INFO - Installing collected packages: psutil 02:36:03 INFO - Running setup.py install for psutil 02:36:03 INFO - building 'psutil._psutil_osx' extension 02:36:03 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 02:36:03 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 02:36:03 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 02:36:04 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 02:36:04 INFO - building 'psutil._psutil_posix' extension 02:36:04 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 02:36:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:36:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:36:04 INFO - ^ 02:36:04 INFO - 1 warning generated. 02:36:04 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 02:36:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:04 INFO - Successfully installed psutil 02:36:04 INFO - Cleaning up... 02:36:04 INFO - Return code: 0 02:36:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:36:04 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')]} 02:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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')]} 02:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36:04 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 02:36:04 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 02:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:04 INFO - 'HOME': '/Users/cltbld', 02:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:04 INFO - 'LOGNAME': 'cltbld', 02:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:04 INFO - 'MOZ_NO_REMOTE': '1', 02:36:04 INFO - 'NO_EM_RESTART': '1', 02:36:04 INFO - 'PAGER': '/bin/cat', 02:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:04 INFO - 'PWD': '/builds/slave/test', 02:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:04 INFO - 'SHELL': '/bin/bash', 02:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:04 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:04 INFO - 'USER': 'cltbld', 02:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:04 INFO - 'XPC_FLAGS': '0x0', 02:36:04 INFO - 'XPC_SERVICE_NAME': '0', 02:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:36:04 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 02:36:04 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 02:36:04 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 02:36:04 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 02:36:04 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 02:36:04 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 02:36:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:36:07 INFO - Installing collected packages: mozsystemmonitor 02:36:07 INFO - Running setup.py install for mozsystemmonitor 02:36:07 INFO - Successfully installed mozsystemmonitor 02:36:07 INFO - Cleaning up... 02:36:07 INFO - Return code: 0 02:36:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:08 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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36:08 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 02:36:08 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 02:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:08 INFO - 'HOME': '/Users/cltbld', 02:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:08 INFO - 'LOGNAME': 'cltbld', 02:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:08 INFO - 'MOZ_NO_REMOTE': '1', 02:36:08 INFO - 'NO_EM_RESTART': '1', 02:36:08 INFO - 'PAGER': '/bin/cat', 02:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:08 INFO - 'PWD': '/builds/slave/test', 02:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:08 INFO - 'SHELL': '/bin/bash', 02:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:08 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:08 INFO - 'USER': 'cltbld', 02:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:08 INFO - 'XPC_FLAGS': '0x0', 02:36:08 INFO - 'XPC_SERVICE_NAME': '0', 02:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:36:08 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 02:36:08 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 02:36:08 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 02:36:08 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 02:36:08 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 02:36:08 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 02:36:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:11 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:11 INFO - warning: no files found matching '*.txt' 02:36:11 INFO - no previously-included directories found matching 'build' 02:36:11 INFO - no previously-included directories found matching 'dist' 02:36:11 INFO - no previously-included directories found matching '.git*' 02:36:11 INFO - Installing collected packages: jsonschema, functools32 02:36:12 INFO - Running setup.py install for functools32 02:36:12 INFO - warning: no files found matching '*.txt' 02:36:12 INFO - no previously-included directories found matching 'build' 02:36:12 INFO - no previously-included directories found matching 'dist' 02:36:12 INFO - no previously-included directories found matching '.git*' 02:36:12 INFO - Successfully installed jsonschema functools32 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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', '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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:36: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 functools32==3.2.3-2 02:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:12 INFO - 'HOME': '/Users/cltbld', 02:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PAGER': '/bin/cat', 02:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:12 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - 'XPC_FLAGS': '0x0', 02:36:12 INFO - 'XPC_SERVICE_NAME': '0', 02:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36: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 02:36: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 02:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:12 INFO - 'HOME': '/Users/cltbld', 02:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PAGER': '/bin/cat', 02:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:12 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - 'XPC_FLAGS': '0x0', 02:36:12 INFO - 'XPC_SERVICE_NAME': '0', 02:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:16 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 02:36:16 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 02:36:16 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 02:36:16 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 02:36:16 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 02:36:16 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 02:36:16 INFO - Downloading docopt-0.6.1.tar.gz 02:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:16 INFO - Running setup.py install for blobuploader 02:36:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:16 INFO - Running setup.py install for requests 02:36:17 INFO - Running setup.py install for docopt 02:36:17 INFO - Successfully installed blobuploader requests docopt 02:36:17 INFO - Cleaning up... 02:36:17 INFO - Return code: 0 02:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:17 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')]} 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 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')]} 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36:17 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 02:36:17 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 02:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:17 INFO - 'HOME': '/Users/cltbld', 02:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:17 INFO - 'LOGNAME': 'cltbld', 02:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:17 INFO - 'MOZ_NO_REMOTE': '1', 02:36:17 INFO - 'NO_EM_RESTART': '1', 02:36:17 INFO - 'PAGER': '/bin/cat', 02:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:17 INFO - 'PWD': '/builds/slave/test', 02:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:17 INFO - 'SHELL': '/bin/bash', 02:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:17 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:17 INFO - 'USER': 'cltbld', 02:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:17 INFO - 'XPC_FLAGS': '0x0', 02:36:17 INFO - 'XPC_SERVICE_NAME': '0', 02:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-q682e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-U1nqWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-e4Wtqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-v0pYHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-lpoLnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-5iXsDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-tEBzJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-CecGEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:18 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-L3Z4_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-rOleAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-_MfzAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-BoE2_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-K3DpbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-FpSjxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-swdkw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-XPndTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:19 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-JfSZBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:19 INFO - Running setup.py install for manifestparser 02:36:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:20 INFO - Running setup.py install for mozcrash 02:36:20 INFO - Running setup.py install for mozdebug 02:36:20 INFO - Running setup.py install for mozdevice 02:36:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:20 INFO - Running setup.py install for mozfile 02:36:20 INFO - Running setup.py install for mozhttpd 02:36:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:20 INFO - Running setup.py install for mozinfo 02:36:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:20 INFO - Running setup.py install for mozInstall 02:36:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Running setup.py install for mozleak 02:36:21 INFO - Running setup.py install for mozlog 02:36:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Running setup.py install for moznetwork 02:36:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Running setup.py install for mozprocess 02:36:21 INFO - Running setup.py install for mozprofile 02:36:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:21 INFO - Running setup.py install for mozrunner 02:36:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:22 INFO - Running setup.py install for mozscreenshot 02:36:22 INFO - Running setup.py install for moztest 02:36:22 INFO - Running setup.py install for mozversion 02:36:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:22 INFO - Cleaning up... 02:36:22 INFO - Return code: 0 02:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:22 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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36:22 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 02:36:22 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 02:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:22 INFO - 'HOME': '/Users/cltbld', 02:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:22 INFO - 'LOGNAME': 'cltbld', 02:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:22 INFO - 'MOZ_NO_REMOTE': '1', 02:36:22 INFO - 'NO_EM_RESTART': '1', 02:36:22 INFO - 'PAGER': '/bin/cat', 02:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:22 INFO - 'PWD': '/builds/slave/test', 02:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:22 INFO - 'SHELL': '/bin/bash', 02:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:22 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:22 INFO - 'USER': 'cltbld', 02:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:22 INFO - 'XPC_FLAGS': '0x0', 02:36:22 INFO - 'XPC_SERVICE_NAME': '0', 02:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:22 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-38saF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:22 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)) 02:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:22 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-aClPEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:22 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)) 02:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:22 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-J0Qx_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-yfhu7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-HDNLwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Mm_jem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-SG2rBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pHRKYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-wQh80I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-L8yCJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pa3EX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:23 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)) 02:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:23 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-zCavj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:24 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)) 02:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:24 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-ThmlKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:24 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)) 02:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:24 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-3Hl5uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:24 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)) 02:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:24 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-3LIDWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:24 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)) 02:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:24 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-CqE68Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:24 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)) 02:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:24 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-MZV5kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:24 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)) 02:36:24 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)) 02:36:24 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)) 02:36:24 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)) 02:36:24 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)) 02:36:24 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)) 02:36:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:27 INFO - Downloading blessings-1.6.tar.gz 02:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:27 INFO - Installing collected packages: blessings 02:36:27 INFO - Running setup.py install for blessings 02:36:27 INFO - Successfully installed blessings 02:36:27 INFO - Cleaning up... 02:36:27 INFO - Return code: 0 02:36:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:27 INFO - Reading from file tmpfile_stdout 02:36:27 INFO - Current package versions: 02:36:27 INFO - blessings == 1.6 02:36:27 INFO - blobuploader == 1.2.4 02:36:27 INFO - docopt == 0.6.1 02:36:27 INFO - functools32 == 3.2.3-2 02:36:27 INFO - jsonschema == 2.5.1 02:36:27 INFO - manifestparser == 1.1 02:36:27 INFO - mozInstall == 1.12 02:36:27 INFO - mozcrash == 1.0 02:36:27 INFO - mozdebug == 0.1 02:36:27 INFO - mozdevice == 0.49 02:36:27 INFO - mozfile == 1.2 02:36:27 INFO - mozhttpd == 0.7 02:36:27 INFO - mozinfo == 0.9 02:36:27 INFO - mozleak == 0.1 02:36:27 INFO - mozlog == 3.4 02:36:27 INFO - moznetwork == 0.27 02:36:27 INFO - mozprocess == 0.25 02:36:27 INFO - mozprofile == 0.28 02:36:27 INFO - mozrunner == 6.13 02:36:27 INFO - mozscreenshot == 0.1 02:36:27 INFO - mozsystemmonitor == 0.3 02:36:27 INFO - moztest == 0.8 02:36:27 INFO - mozversion == 1.4 02:36:27 INFO - psutil == 3.1.1 02:36:27 INFO - requests == 1.2.3 02:36:27 INFO - wsgiref == 0.1.2 02:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:27 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 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36:27 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 02:36:27 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 02:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:27 INFO - 'HOME': '/Users/cltbld', 02:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:27 INFO - 'LOGNAME': 'cltbld', 02:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:27 INFO - 'MOZ_NO_REMOTE': '1', 02:36:27 INFO - 'NO_EM_RESTART': '1', 02:36:27 INFO - 'PAGER': '/bin/cat', 02:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:27 INFO - 'PWD': '/builds/slave/test', 02:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:27 INFO - 'SHELL': '/bin/bash', 02:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:27 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:27 INFO - 'USER': 'cltbld', 02:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:27 INFO - 'XPC_FLAGS': '0x0', 02:36:27 INFO - 'XPC_SERVICE_NAME': '0', 02:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 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)) 02:36:28 INFO - Cleaning up... 02:36:28 INFO - Return code: 0 02:36:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:28 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')]} 02:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:28 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')]} 02:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b878b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b87b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faadb46e950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, '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.h2Lsf78eAm/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.trUfo0y6IL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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 02:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:28 INFO - 'HOME': '/Users/cltbld', 02:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:28 INFO - 'LOGNAME': 'cltbld', 02:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:28 INFO - 'MOZ_NO_REMOTE': '1', 02:36:28 INFO - 'NO_EM_RESTART': '1', 02:36:28 INFO - 'PAGER': '/bin/cat', 02:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:28 INFO - 'PWD': '/builds/slave/test', 02:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:28 INFO - 'SHELL': '/bin/bash', 02:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:28 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:28 INFO - 'USER': 'cltbld', 02:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:28 INFO - 'XPC_FLAGS': '0x0', 02:36:28 INFO - 'XPC_SERVICE_NAME': '0', 02:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:36:28 INFO - Cleaning up... 02:36:28 INFO - Return code: 0 02:36:28 INFO - Running post-action listener: _resource_record_post_action 02:36:28 INFO - Running post-action listener: _start_resource_monitoring 02:36:28 INFO - Starting resource monitoring. 02:36:28 INFO - [mozharness: 2017-03-24 09:36:28.466036Z] Finished create-virtualenv step (success) 02:36:28 INFO - [mozharness: 2017-03-24 09:36:28.467026Z] Running install step. 02:36:28 INFO - Running pre-action listener: _resource_record_pre_action 02:36:28 INFO - Running main action method: install 02:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:28 INFO - Reading from file tmpfile_stdout 02:36:28 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:28 INFO - Reading from file tmpfile_stdout 02:36:28 INFO - Output received: 02:36:28 INFO - Usage: mozinstall [options] installer 02:36:28 INFO - Options: 02:36:28 INFO - -h, --help show this help message and exit 02:36:28 INFO - -d DEST, --destination=DEST 02:36:28 INFO - Directory to install application into. [default: 02:36:28 INFO - "/builds/slave/test"] 02:36:28 INFO - --app=APP Application being installed. [default: firefox] 02:36:28 INFO - mkdir: /builds/slave/test/build/application 02:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:36:48 INFO - Reading from file tmpfile_stdout 02:36:48 INFO - Output received: 02:36:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:36:48 INFO - Running post-action listener: _resource_record_post_action 02:36:48 INFO - [mozharness: 2017-03-24 09:36:48.727943Z] Finished install step (success) 02:36:48 INFO - [mozharness: 2017-03-24 09:36:48.728082Z] Running run-tests step. 02:36:48 INFO - Running pre-action listener: _resource_record_pre_action 02:36:48 INFO - Running main action method: run_tests 02:36:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:36:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:36:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:36:48 INFO - 2017-03-24 02:36:48.742 screenresolution[2317:75452] starting screenresolution argv=screenresolution get 02:36:48 INFO - 2017-03-24 02:36:48.745 screenresolution[2317:75452] Display 0: 1600x1200x32@60 02:36:48 INFO - 2017-03-24 02:36:48.751 screenresolution[2318:75455] starting screenresolution argv=screenresolution list 02:36:48 INFO - Available Modes on Display 0 02:36:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:36:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:36:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:36:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:36:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:36:48 INFO - Intel Iris: 02:36:48 INFO - Chipset Model: Intel Iris 02:36:48 INFO - Type: GPU 02:36:48 INFO - Bus: Built-In 02:36:48 INFO - VRAM (Dynamic, Max): 1536 MB 02:36:48 INFO - Vendor: Intel (0x8086) 02:36:48 INFO - Device ID: 0x0a2e 02:36:48 INFO - Revision ID: 0x0009 02:36:48 INFO - Displays: 02:36:48 INFO - Display: 02:36:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:36:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:36:48 INFO - Display Serial Number: 1600x1200 60 02:36:48 INFO - Main Display: Yes 02:36:48 INFO - Mirror: Off 02:36:48 INFO - Online: Yes 02:36:48 INFO - Rotation: Supported 02:36:48 INFO - Return code: 0 02:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:48 INFO - Python 2.7.3 02:36:48 INFO - Return code: 0 02:36:48 INFO - grabbing minidump binary from tooltool 02:36:48 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')]} 02:36:48 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 0x10b656d30>, '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 0x10b57ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b64bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:48 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 02:36:48 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 02:36:48 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 02:36:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:49 INFO - Return code: 0 02:36:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:36:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:49 INFO - ENV: RUST_BACKTRACE is now 1 02:36:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:36:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 02:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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 02:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h2Lsf78eAm/Render', 02:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:49 INFO - 'HOME': '/Users/cltbld', 02:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:49 INFO - 'LOGNAME': 'cltbld', 02:36:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:49 INFO - 'MOZ_NO_REMOTE': '1', 02:36:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:49 INFO - 'NO_EM_RESTART': '1', 02:36:49 INFO - 'PAGER': '/bin/cat', 02:36:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:49 INFO - 'PWD': '/builds/slave/test', 02:36:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:49 INFO - 'RUST_BACKTRACE': '1', 02:36:49 INFO - 'SHELL': '/bin/bash', 02:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.trUfo0y6IL/Listeners', 02:36:49 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 02:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:49 INFO - 'USER': 'cltbld', 02:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:49 INFO - 'XPC_FLAGS': '0x0', 02:36:49 INFO - 'XPC_SERVICE_NAME': '0', 02:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 02:36:49 INFO - mozversion application_buildid: 20170324004022 02:36:49 INFO - mozversion application_changeset: 06b2530392f938ee62ade6659bdf40dee658b5cb 02:36:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:36:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:49 INFO - mozversion application_name: Firefox 02:36:49 INFO - mozversion application_remotingname: firefox-dev 02:36:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:36:49 INFO - mozversion application_vendor: Mozilla 02:36:49 INFO - mozversion application_version: 54.0a2 02:36:49 INFO - mozversion platform_buildid: 20170324004022 02:36:49 INFO - mozversion platform_changeset: 06b2530392f938ee62ade6659bdf40dee658b5cb 02:36:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:36:49 INFO - mozversion platform_version: 54.0a2 02:36:49 INFO - using testdate: 1490348209 02:36:49 INFO - actual date: 1490348209 02:36:49 INFO - starting webserver on 'localhost:60200' 02:36:49 INFO - SUITE-START | Running 2 tests 02:36:49 INFO - TEST-START | dromaeo_css 02:36:49 INFO - operating with platform_type : mac_ 02:36:49 INFO - Initialising browser for dromaeo_css test... 02:36:49 INFO - TEST-INFO | started process 2328 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpYC58UH/profile http://localhost:60200/getInfo.html) 02:36:52 INFO - PROCESS | 2328 | 2017-03-24 02:36:52.240 plugin-container[2331:75633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a3b, name = 'com.apple.tsm.portname' 02:36:52 INFO - PROCESS | 2328 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:36:52 INFO - PROCESS | 2328 | 2017-03-24 02:36:52.240 plugin-container[2331:75633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 02:36:52 INFO - PROCESS | 2328 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:36:52 INFO - PROCESS | 2328 | 2017-03-24 02:36:52.240 plugin-container[2331:75633] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:36:52 INFO - PROCESS | 2328 | __metrics Screen width/height:1600/1200 02:36:52 INFO - PROCESS | 2328 | colorDepth:24 02:36:52 INFO - PROCESS | 2328 | Browser inner width/height: 1024/689 02:36:52 INFO - PROCESS | 2328 | __metrics 02:36:52 ERROR - PROCESS | 2328 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:36:53 INFO - TEST-INFO | 2328: exit 0 02:36:53 INFO - Browser initialized. 02:36:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:36:53 INFO - TEST-INFO | started process 2332 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpYC58UH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:55 INFO - PROCESS | 2332 | 2017-03-24 02:36:55.551 plugin-container[2333:75763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 02:36:55 INFO - PROCESS | 2332 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:36:55 INFO - PROCESS | 2332 | 2017-03-24 02:36:55.552 plugin-container[2333:75763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 02:36:55 INFO - PROCESS | 2332 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:36:55 INFO - PROCESS | 2332 | 2017-03-24 02:36:55.552 plugin-container[2333:75763] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:37:05 INFO - PROCESS | 2332 | RSS: Main: 220626944 02:37:05 INFO - PROCESS | 2332 | 02:40:09 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60200/tests/dromaeo/cssquery-ext.html) 02:40:10 INFO - PROCESS | 2332 | RSS: Main: 244879360 02:40:10 INFO - PROCESS | 2332 | 02:41:53 INFO - PROCESS | 2332 | ************************* 02:41:53 INFO - PROCESS | 2332 | A coding exception was thrown and uncaught in a Task. 02:41:53 INFO - PROCESS | 2332 | 02:41:53 ERROR - PROCESS | 2332 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:41:53 INFO - PROCESS | 2332 | Full stack: 02:41:53 INFO - PROCESS | 2332 | ************************* 02:43:13 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-ext.html (next: http://localhost:60200/tests/dromaeo/cssquery-jquery.html) 02:43:13 INFO - PROCESS | 2332 | RSS: Main: 251678720 02:43:13 INFO - PROCESS | 2332 | 02:46:15 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60200/tests/dromaeo/cssquery-mootools.html) 02:46:16 INFO - PROCESS | 2332 | RSS: Main: 257822720 02:46:16 INFO - PROCESS | 2332 | 02:49:18 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60200/tests/dromaeo/cssquery-prototype.html) 02:49:18 INFO - PROCESS | 2332 | RSS: Main: 255729664 02:49:18 INFO - PROCESS | 2332 | 02:52:22 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60200/tests/dromaeo/cssquery-yui.html) 02:52:22 INFO - PROCESS | 2332 | RSS: Main: 260435968 02:52:22 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | Cycle 1(1): loaded http://localhost:60200/tests/dromaeo/cssquery-yui.html (next: http://localhost:60200/tests/dromaeo/cssquery-dojo.html) 02:55:25 INFO - PROCESS | 2332 | RSS: Main: 256540672 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | __start_tp_report 02:55:25 INFO - PROCESS | 2332 | _x_x_mozilla_page_load 02:55:25 INFO - PROCESS | 2332 | _x_x_mozilla_page_load_details 02:55:25 INFO - PROCESS | 2332 | |i|pagename|runs| 02:55:25 INFO - PROCESS | 2332 | |0;dojo.html;3490.3368360011596;3500.369933411988;3503.7021853142487;3539.769914955528;3570.4108822044363;6143.877122457554;6181.938180618193;6186.81439556814;6211.50307975362;6237;6137.815865524041;6197.977333739927;6218.906716399247;6228.84427889303;6263.436290733833;4460.397846290758;5512.614117011801;5574.916376254339;5593;5649.604527683064;5613.158026296048;5616.129499927518;5619.6066275360745;5629.971850140743;5660.009498337795;5430.484104010113;5437.238786569864;5565;5627.493525582697;5640.294963129609;5601.775928962837;5612.66324020556;5618.8595285118;5637.098064309732;5698.487136157724;5507.807226747084;5573.386927437979;5591.776328946838;5598.804041858515;5602.187682786014;5944.762209511614;5970.6716130612795;6115.082737589352;6193.1639228704;6229.781957631461;6436.195475565554;6445.871082578369;6479.611223326616;6514.153160089206;6516.413522782972;5176.275321454999;6628.536002479828;6678.899816502756;6687.966560167217;6695.2969938156275;4954.405471343462;6050.304215015241;6311.463525600284;6313.43179113882;6321.841953951142;6502.414782669583;6545.410913017851;6564;6633.170853643294;6702.229243637044;6396.328385519547;6439.54923155384;6447.838804029843;6450.258220304631;6501.967490162613;6628.005799130073;6663.13379260693;6692.631905245161;6699.832504187434;6705.597664140168;6230.408111229426;6332.905006424908;6350.428461438492;6589.308122647053;6615.470762339001;6250.718717657716;6319.873602528016;6415.422611964946;6438.291787903327;6520;4552.704074235164;5181.740912954338;5262.973720124539;5288.788448462095;5309.177077552986;4677.789499472532;4711.411073615798;4751.95248047522;4754.120487709715;4758.857234282977;6086.452219300196;6131.50947924165;6282.2147231596055;6337.493000559944;6341.3341599132345;5786.247787787561;6137.693115344215;6409;6409.519286053564;6514.869702605922;6202.782902598477;6290.842728931813;6301.52738544611;6316.178896743394;6316.8420789479715;4927.236278376858;5861.7655293787775;5874.853128671817;5901.144334071621;5922.555808314308;5938.871614393252;6492.5455218134275;6546.967265163644;6817.863642727217;6895.241523432318;5425.782968681208;6536.3136870627895;6573.112629794917;6589.24223714279;6601.141851559267;6810.727570897307;6862.176538815374;6879.518433709793;6880.759173428906;6883.793486195422;6243.687815609111;6516.315786842313;6522.478201743944;6529.836754080996;6551.770688025897;4996;6350.301466838737;6493.545451818327;6552.508561857784;6553.475721942138;6379.712912918837;6383.36166383358;6388.233411990591;6392.9041064385;6409.3270206629495;6301.338359472189;6308.842278943063;6359.745610175726;6378.011408231731;6386.521010924106;5083.237514372726;5978.730957106854;6193.628382297076;6221.191245138103;6266.310705822265;6376.139221205263;6383.6808159592765;6387.169667943138;6392.52056095804;6394.4884409246215;4886.413630364379;6070.666113363631;6130.703893785035;6237.033259844731;6298.937010630018 02:55:25 INFO - PROCESS | 2332 | |1;ext.html;634.8571571396436;752.3003606645817;834.9999999999998;956.2493442647519;965.2519297544407;39022.804885975565;39904.002399940015;41100.58899411009;41498;41660.79169604155;39201.803990980006;39470.40794388086;39518.01204969877;39583.802080989626;39645;7921.168277330884;8077.515349079044;10592.152627789797;10879.347239165636;11025.724356891062;10803.621873234439;10876.67369978898;10916.563337466532;10919.344839309628;10939.781204375908;10854.565817367335;10886.61896833611;10914.727131821688;10917;10925.399103049329;9503.857442138373;10540.156787457023;10901.509432075576;10904.236703430763;10910.5090270938;8775;10567.841482377693;10646.680599582025;10649.148068154529;10659.093977011964;34428.48357274643;34690.30619387623;34757.783477578414;34788.82605586981;34792.478112828074;3729.533808273966;3773.8679146230024;3774.565924918642;3793.9620603793883;3794.905127371838;25244.242672719847;25439.491210175693;25823.870880645663;26735.465290694272;27409;3057.5107982722657;3107.9533806992913;3130.906072817819;3146.0561831450473;3194.7923384979904;299701;366402;370140;371259.14370428247;373578;46113.5388646116;46705.53294467012;46770.5322946773;46833;46940;48130.556083317555;48145;48351.75824120857;48355.5164448351;48591.02817943692;13899.374528146258;14150.716985660229;14297.92851035759;14310.28448577567;14587.635309117357;12208.20646657982;12227.633171004883;12375.081862311356;12379.566715164927;12386.31875246852;11986.940065299792;12230.510779568718;12234.938825305817;12250.203736757083;12381;5808.825735227865;5834.27071616048;5859.326177489558;5860.443257890493;5872.354041055481;1069.4011353641986;1102.3496137279044;1115.252780636975;1118.2060736876747;1168.1589255735857;24874.875625621757;27710.5843412349;27775.86112069467;27783.861080694467;27945.860270698515;1195.5397172088808;1230.2003697596633;1241.819936109259;1285.9807102893465;1292.7285270093198;14195.162387138053;14298.499552515612;14409.207493587954;14484.420623174956;14510.419583216764;499276;500238.4988075036;504998;505713;506164;50086.49913500891;51230.74384628053;58919.41080589225;59324;59628.40371596228;1408.190290582919;1436.633658417097;1444.0108525660166;1448.6595650022236;1455.0033227239164;27701.445971080062;27729.306767330978;28338;28555.42889142247;28920;41886.162276754905;41902.79048604737;41925;41964.790176048926;42076.57923420849;403827;405403;407270;409201;409877;30224;30435.543466847572;30823.383532329677;30839.2290192747;30840;38699.22601547897;39785;40130.79607611776;40437.79781101076;40469.797651011555;32150.678493214768;33641.831790840886;33890.830545847115;34847.303053939286;34855.302893942484;31603.683963160074;33181.17047073843;33856.66143338535;34270.657293426746;34576.82711586426;33302.00093997184;33555.161120972174;33759.83120084384;34250.82874585711;34276.31447371088;26934.057307994128;28308.71691283061;30236.84881575578;30379.936702215316;30425.847870760503;21859.78140218641;22778.974946127797;23056.769432306133;23522.411939701644;23723.64414533749 02:55:25 INFO - PROCESS | 2332 | |2;jquery.html;351.50086876635174;416.2798358839206;419.64330319228657;419.71459407602816;455.08754946332596;19796.90101549492;20688.99999999998;21354.35936921891;22040.669389959163;22315.888420557876;20627.27804526838;20655.586888262227;21495.817730024843;22073.117075317008;22489.100435982542;6399.040143978417;6706.195256569218;6720.059191713164;6734.528582999192;6749.291324410915;4696.577308042276;6646.9667651661675;6681.699323530428;6725.125733654618;6727.394534491895;6433.356664333576;6648.734050637969;6691.19705635322;6710.29541898101;6733.932660673379;6643.966780166116;6683.2648408675;6697.263301036882;6697.3637504437;6734.3939045485895;6289.496840252768;6471.191101112361;6505.251896031969;6530.379613936669;6539.803805885784;20585.69121463179;25617.231483055537;25917.481650366888;26054;27003.864980675167;3188.28263640679;3217.3404452087266;3318.3529211803707;3330.8342080271955;3350.8994730158133;15746.685066298724;15861.603459913478;16107.275172617261;16651;16780.2448889799;1989.5125694205012;2038.9082491287927;2046.7543894732728;2051.907664155102;2064.040221297104;148240;158106;164937.17531412386;166871;168818;20707.378778636365;20957.580848382946;21724.782752172592;21830.672539911597;22013.779862201493;31958.881439149984;32341.51487727686;32487;32523.18692032671;32537;10272.589096436208;10319.277650564538;10463.319884207654;10619.94690026545;10697.304675196086;6242.531810114168;8780.165884241114;8815.25070369013;9001.009888912215;9002.234810041089;7709.691612335556;9748.853767193497;9855.11303982645;10041.497925103862;10051.69844904654;4209.97895010523;4322.308430651081;4331.436913201263;4348.021650149174;4350.608445239944;708.9007538944552;910.7267819654078;921.5484412637759;948.5873644964324;1043.3687618990552;21479.570408591742;22003;22090.88954555217;22116.889415552818;22121;898.9232786364225;932.5523748600709;935.2004036548789;943.7263193673895;959.2828836382936;11214.607488738018;11284.153688473398;11333.716657083638;11437.370944598128;11457.484413201426;751734;751766;756399;756425;756659;149657.75513367308;150903;159340;169807.30192698163;180335.29497057555;1181.1023622047135;1233.6237447578574;1250.6060590914014;1256.214865708932;1256.5664845628244;19440.513987150436;19851.900740496207;20089.99550022464;20203.292884748964;20347.49131271671;45797.08405831798;64348.678256608415;64596.677016614616;65467.34532654803;67525.66237168782;93672.53163734138;94126;94545;94548.52725736327;96062;11628.418579070843;11700.590479333183;11958.820617690568;11970.880291197325;12152.696182595506;13186.340682965621;13268.402921868732;13532.79700804469;13549.59351219465;13638.522651707142;8536.615852286537;11420.029297509805;11715.882841171479;11803.645890623295;11836.58571950012;8929.374943753875;11256.774864502828;11298.152638552307;11517.07863370945;11549.48027338755;11298.378589177346;11444.198906076495;11590.42047897585;11784.528618855149;11938.820917686067;8836.690715825172;11609.3614851184;11827;11935.582254621047;11943.940280298542;10674.35953842772;11087.279326843729;11093;11313.7737245253;11740.882591173979 02:55:25 INFO - PROCESS | 2332 | |3;mootools.html;1532.639829640035;1562.609347663085;1570.5366916759556;1581.6836632673464;1584.7781310616513;10373.688789336322;10827.566897324108;10943.726406839833;11230;11440.71398215045;11322.547098116065;11491.885081149187;11535.250208736426;11552;11558.075353971682;2394.8682822444716;2425.3936515871032;2432.781049705526;2434.7565243475688;2438.829281950264;2345.9061637534564;2384.0940442631777;2400.59189937711;2402.243293362585;2402.6756387887585;2339.5203983183405;2353.5881220786378;2358.068562917655;2363.929082127539;2368.2539999899977;2009.7387339645898;2311.156427903803;2324.035525257025;2335.2760644200266;2348.1429278313376;1956.8943546895957;2327.8021368183727;2410.240774156135;2413.179518963561;2417.6494408310696;11211.047060999825;11271.267367621078;11324.9807517323;11405.258658187275;11411.714707132305;5470.890582188374;5876.441738034922;5940.2871655401195;5952.107183922403;5962.135490353918;3318.469044952796;3590.5870824855215;3649.3066317399607;3679.7056235501364;3680.687141592941;1116.8659760828752;1164.545827127421;1180.8996235320008;1197.3713800254848;1219.5365761010848;11740;13963.58109256724;14066.859331406657;15475.458358957496;15622.843771562253;4678.415198100238;4749.691270067504;4803.927941080887;4822.035592881438;4839.346688197048;11876.168668193317;11963.940180299043;12040.518379264731;12051.698707532381;12068.577599783965;5761.308642962871;5773.220615216892;5782.624129431573;5825.097109947965;5837.620554663933;4988.127077761377;5162.92255616166;5250.606204534675;5250.868728281747;5258.579313654898;3827.9043023924623;4010.137820368635;4014.8193331300163;4065.2276067547073;4078.877633670995;1024.5235965276183;1027.1525991057408;1034.2915103154364;1043.2488608202234;1044.2742294105524;919.5126582911067;929.2240978782658;940.0881145289059;947.8341290274312;963.677168148664;5370.355557333145;6582.407583317428;6640.468762498988;6805.217399999064;6834.2482326944;965.3958769343885;968.2592816495387;980.9852852207223;990.7126933189438;1005.3716427232979;4235.639970602533;4326.978365108154;4342.1532801103485;4459.732416055047;4466.57567531084;11377;13341.533046343331;13663.043586949017;13779.173249604855;13810.964177686714;11891.405429728478;12620.495180192873;12844.036697247744;13134;13710.725785484234;9132.452052876848;10177.440240786827;10274;10368.481575921174;10407.58369665205;6493.53895373556;6768.695408706521;6840.289927518121;6877.561219390305;6922.965385173042;12119.636410907335;12248.877511224773;12320.260784352968;12631.684207894876;12651.810222846481;11460.484278207667;11929.761404772029;12522.311272880079;12873.163244389085;13004.089713719948;9232.076792320715;9506.572204250964;9586.760330991781;9592.328537002622;9616.278779091455;9775.608975640895;9988.950055249677;10027.749306267402;10433.373997560171;10527.578896844041;8957.491902267375;9089.318301127574;9293.395929264576;9477.668281610111;9568.95215523918;8212.58937053133;9146;9151.77120571991;9162.312826537904;9191.862122068309;7076.7615667257;7454.25457454272;7931.960340198262;7965.561894095648;7987.400944929037;4977.576905962889;5427.1859221115565;5779.7110144493445;5874.295084589877;5898.616589921641;5978.3423823378525;6001.939980600138;6023.156758053964;6090.817275481742;6152.477039451696 02:55:25 INFO - PROCESS | 2332 | |4;prototype.html;351.39384561631203;379.45358683495766;380.7506083515297;391.68199010330227;392.3917927212821;4854.23796557668;5088.18589025756;5349;5389.595780316472;5484.36929753078;4415.624671902884;4421.845235416753;4664.790084446199;4895.681780684253;5263.236830659562;3922.607739226069;4238.9152216955645;4417.4699036115635;4420.58004489573;4428.674945653525;3900.8244628991765;4366.410534577839;4366.868993930171;4464.486584042828;4509.391232183646;3779.8677046303383;4414.161309351213;4417.514073451917;4426.800793964279;4456.420665313521;4093.406456063884;4257.87226383209;4361.781910904474;4454.287314029756;4458.754768487715;3484.337975784593;3929.9760623279035;3970.563238043813;4006.779627120507;4075.247643513288;4748.7863046163;4765.712458020135;5050.086183208006;5198.896022079537;5232.508735010541;4550.453945526558;4578.496365399803;5088.745562721849;5104.269215969439;5110.233464980245;4467.955320446819;4764.809407623691;5421.593380496479;5699.8005069822775;5738.254026976508;4272.547333906456;4322.104190192578;4626.236670949289;4633.351330813689;4634.189016922059;4882.877928051792;4992.475790042066;5897.8820423591715;6108.664023478706;6139.846503837395;3980.960190398117;4230.703850730481;4244.957550424518;4619.422572178478;4672.878509157777;4327.944226492391;4516.299973504112;4531.235946072893;4726.669133160714;4741.241401375763;4881;4990.675606085593;5054.418741844662;5063.341765570526;5159.25190847325;4630.699004564693;4663.766811659403;4928.704277743275;5631.436856314418;5668.688222147822;1322.6891680455085;1363.83633963923;1386.9791953120712;1449.289847974506;1585.635303880114;1036.6475398364591;1064.966982027432;1101.7245688577855;1145.3242586873785;1194.2444606428537;4423.92075724409;4901.068796928644;5403.9459605403445;5413.729313534308;5489.011977843947;4809.9038019239415;4980.501949805063;5279.973600131974;5298.2052692096495;6058.515318774487;4350.847720329773;4436.00189957257;4777.522247775195;4842.280990248481;5234.398044224887;2759.613654088429;2917.4311009352973;2997.1607949774098;3110.8444577771475;3119.4229067622564;5176.7411629418375;5236.9738151309;5482.643628164156;5779.682117483579;6088.169001414363;5430.864228394322;5496.780128794883;5764.07774756037;5870.55970802183;6141.9078713818435;5144.408393034849;5381.730913454312;5472.972635136799;5823.4467725566;6218.072397556772;4959.851204463872;5239.397469291081;5944.8811023780145;6018.51851851842;6037.788677396446;5635.140403666698;5688.431156884279;5704.543636509153;5753.713483454853;5851.561132914963;5032.949670503394;5033.546980771748;5436;6127.56002339441;6132.632042077311;4223.873283801491;4297.677674174512;4375.912481750411;4561.384213131185;4591.8392856249875;4791.5687588117235;5241.68549887008;5546.334439867242;5627.634203776742;5897.764089436375;5099.501244390296;5233.319668443078;5633.183188437735;5717.914231286451;5837.919984802825;4830.281999122509;5211.791528338824;5275.604329675213;5321.201819726917;5660.745266462936;4271.974726065784;5192.506711862367;5218.504242096995;5459.235707000944;5515.145152501369;4786.329913811999;4870.634702397264;4921.458639549575;5602.299712535933;5628.465295796893;4646.883827904329;5147.716875571729;5457.699826509422;5472.835814925399;5493.478119578634 02:55:25 INFO - PROCESS | 2332 | |5;yui.html;643.9259485159207;708.1219288082779;737.1854101218154;747.6261869065464;758.041078036284;15168.620784480394;16131.628811551018;16413.425530106448;16541.586460338483;16596.751048734277;12931.999999999976;14642.121472711644;14733.042352247096;15323;15335.769963450557;763.4159867701213;938.8920274168455;941.6892425499568;942.354487176283;942.5381563034133;889.7864512516982;934.2339281788936;940.8588711693267;941.0589410589411;941.55276243784;828.5194587139445;963.889152747436;982.1651596143257;984.9852252216223;985.1183191044012;963.373807025432;975.5414954971152;979.192166462664;979.5738853598672;980.1227901028611;723.3381455967783;724.5254358395259;724.9963750181269;725.3580581185636;741.8479211761576;15831.841681583268;16271.430499932563;16295.429659961845;16884.577885552837;17060.232289547;13748.312584370742;13988.650283742885;14084.436622535086;14183.219922904236;14233.217173055582;11727.648170554898;11749.94125029378;11764.176507644468;11821.17251792375;11884.465199065977;3326.935380678184;3607.2424790793966;3672.173760903802;3828;3832.0419895026243;89388.99999999935;111240.4437977813;117799;118315.4084229582;118429;10354.896451035544;10582.365058096539;10838.241323107464;10842.132629389629;10862.34825910448;21679.241226556995;22046.11815527361;22071;22310.996005179804;22386.328410147722;7709.884351734729;7726.922730772732;7773.339266162439;7852.685892564347;7865.213478652204;4251.426057482262;4288.24955632763;4385.561443855653;4423.690341676116;4436.955630443719;3402.880899168567;3450.1719587298867;3483.89548313551;3487.1805125795418;3496.283261931298;629.9433051025338;639.4213237020504;639.5810743962712;652.5399593286721;664.6875968294991;659.6470888074857;662.7050962321721;688.1054628982303;689.3210187964851;704.383664293743;10102;10189.046774717208;10366.015228553275;10456.163506919429;10485.790284194274;660.6729668813872;688.6502455187788;697.3201128899283;709.8260926073145;723.0780754538006;4957;4993.475685053089;5020.2720605511995;5058.671186372948;5060.7722652480725;84933.57533212418;107889;112930.43534782274;113955;114950;80118.59940700259;81606.18393816105;82069.17930820615;82274.58862705767;84838.57580712056;60372.09441858464;75206.87189692158;76104.61947690338;76151.23848761553;76783.61608192035;8031.35749140079;11073.83389249178;11240.775184496428;11309.773804523698;11438.885611143782;44567;48940;49619;51507;51640.74179629078;63065;67765.61171941482;70818;71032.09323487258;73003;9849.606015759577;10789.40658263803;11287.153463490435;12898.806517902427;13263.071584988958;14885.776713349092;15082.849171508584;15119.017263877813;15229.695406091594;15538.378464861731;11346.432678365883;13877.236751978335;14166.291685415481;14196.858031419966;14659.633509162357;12076.45655945467;13409.664758380728;13628.93185534066;14096.929515352358;14443.638909027359;13293.933530332286;13747.725045499234;13851.861481385056;14083.155010699391;14319.427222910967;11105;11184.552617895193;11363.886361136283;11520.481578329163;11693.356865372487;9685.515724213621;10616.150707943192;11359.659210223706;11491.310521368745;11582.88417115818 02:55:25 INFO - PROCESS | 2332 | __end_tp_report 02:55:25 INFO - PROCESS | 2332 | __start_cc_report 02:55:25 INFO - PROCESS | 2332 | _x_x_mozilla_cycle_collect,412 02:55:25 INFO - PROCESS | 2332 | __end_cc_report 02:55:25 INFO - PROCESS | 2332 | __startTimestamp1490349325916__endTimestamp 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | ------- Summary: start ------- 02:55:25 INFO - PROCESS | 2332 | Number of tests: 6 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | [#0] dojo.html Cycles:165 Average:6025.57 Median:6266.31 stddev:696.64 (11.1%) stddev-sans-first:669.78 02:55:25 INFO - PROCESS | 2332 | Values: 3490.3 3500.4 3503.7 3539.8 3570.4 6143.9 6181.9 6186.8 6211.5 6237.0 6137.8 6198.0 6218.9 6228.8 6263.4 4460.4 5512.6 5574.9 5593.0 5649.6 5613.2 5616.1 5619.6 5630.0 5660.0 5430.5 5437.2 5565.0 5627.5 5640.3 5601.8 5612.7 5618.9 5637.1 5698.5 5507.8 5573.4 5591.8 5598.8 5602.2 5944.8 5970.7 6115.1 6193.2 6229.8 6436.2 6445.9 6479.6 6514.2 6516.4 5176.3 6628.5 6678.9 6688.0 6695.3 4954.4 6050.3 6311.5 6313.4 6321.8 6502.4 6545.4 6564.0 6633.2 6702.2 6396.3 6439.5 6447.8 6450.3 6502.0 6628.0 6663.1 6692.6 6699.8 6705.6 6230.4 6332.9 6350.4 6589.3 6615.5 6250.7 6319.9 6415.4 6438.3 6520.0 4552.7 5181.7 5263.0 5288.8 5309.2 4677.8 4711.4 4752.0 4754.1 4758.9 6086.5 6131.5 6282.2 6337.5 6341.3 5786.2 6137.7 6409.0 6409.5 6514.9 6202.8 6290.8 6301.5 6316.2 6316.8 4927.2 5861.8 5874.9 5901.1 5922.6 5938.9 6492.5 6547.0 6817.9 6895.2 5425.8 6536.3 6573.1 6589.2 6601.1 6810.7 6862.2 6879.5 6880.8 6883.8 6243.7 6516.3 6522.5 6529.8 6551.8 4996.0 6350.3 6493.5 6552.5 6553.5 6379.7 6383.4 6388.2 6392.9 6409.3 6301.3 6308.8 6359.7 6378.0 6386.5 5083.2 5978.7 6193.6 6221.2 6266.3 6376.1 6383.7 6387.2 6392.5 6394.5 4886.4 6070.7 6130.7 6237.0 6298.9 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | [#1] ext.html Cycles:180 Average:55628.43 Median:17374.87 stddev:113359.53 (652.4%) stddev-sans-first:113602.33 02:55:25 INFO - PROCESS | 2332 | Values: 634.9 752.3 835.0 956.2 965.3 39022.8 39904.0 41100.6 41498.0 41660.8 39201.8 39470.4 39518.0 39583.8 39645.0 7921.2 8077.5 10592.2 10879.3 11025.7 10803.6 10876.7 10916.6 10919.3 10939.8 10854.6 10886.6 10914.7 10917.0 10925.4 9503.9 10540.2 10901.5 10904.2 10910.5 8775.0 10567.8 10646.7 10649.1 10659.1 34428.5 34690.3 34757.8 34788.8 34792.5 3729.5 3773.9 3774.6 3794.0 3794.9 25244.2 25439.5 25823.9 26735.5 27409.0 3057.5 3108.0 3130.9 3146.1 3194.8 299701.0 366402.0 370140.0 371259.1 373578.0 46113.5 46705.5 46770.5 46833.0 46940.0 48130.6 48145.0 48351.8 48355.5 48591.0 13899.4 14150.7 14297.9 14310.3 14587.6 12208.2 12227.6 12375.1 12379.6 12386.3 11986.9 12230.5 12234.9 12250.2 12381.0 5808.8 5834.3 5859.3 5860.4 5872.4 1069.4 1102.3 1115.3 1118.2 1168.2 24874.9 27710.6 27775.9 27783.9 27945.9 1195.5 1230.2 1241.8 1286.0 1292.7 14195.2 14298.5 14409.2 14484.4 14510.4 499276.0 500238.5 504998.0 505713.0 506164.0 50086.5 51230.7 58919.4 59324.0 59628.4 1408.2 1436.6 1444.0 1448.7 1455.0 27701.4 27729.3 28338.0 28555.4 28920.0 41886.2 41902.8 41925.0 41964.8 42076.6 403827.0 405403.0 407270.0 409201.0 409877.0 30224.0 30435.5 30823.4 30839.2 30840.0 38699.2 39785.0 40130.8 40437.8 40469.8 32150.7 33641.8 33890.8 34847.3 34855.3 31603.7 33181.2 33856.7 34270.7 34576.8 33302.0 33555.2 33759.8 34250.8 34276.3 26934.1 28308.7 30236.8 30379.9 30425.8 21859.8 22779.0 23056.8 23522.4 23723.6 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | [#2] jquery.html Cycles:180 Average:43909.41 Median:22082.00 stddev:126303.68 (572.0%) stddev-sans-first:126615.64 02:55:25 INFO - PROCESS | 2332 | Values: 351.5 416.3 419.6 419.7 455.1 19796.9 20689.0 21354.4 22040.7 22315.9 20627.3 20655.6 21495.8 22073.1 22489.1 6399.0 6706.2 6720.1 6734.5 6749.3 4696.6 6647.0 6681.7 6725.1 6727.4 6433.4 6648.7 6691.2 6710.3 6733.9 6644.0 6683.3 6697.3 6697.4 6734.4 6289.5 6471.2 6505.3 6530.4 6539.8 20585.7 25617.2 25917.5 26054.0 27003.9 3188.3 3217.3 3318.4 3330.8 3350.9 15746.7 15861.6 16107.3 16651.0 16780.2 1989.5 2038.9 2046.8 2051.9 2064.0 148240.0 158106.0 164937.2 166871.0 168818.0 20707.4 20957.6 21724.8 21830.7 22013.8 31958.9 32341.5 32487.0 32523.2 32537.0 10272.6 10319.3 10463.3 10619.9 10697.3 6242.5 8780.2 8815.3 9001.0 9002.2 7709.7 9748.9 9855.1 10041.5 10051.7 4210.0 4322.3 4331.4 4348.0 4350.6 708.9 910.7 921.5 948.6 1043.4 21479.6 22003.0 22090.9 22116.9 22121.0 898.9 932.6 935.2 943.7 959.3 11214.6 11284.2 11333.7 11437.4 11457.5 751734.0 751766.0 756399.0 756425.0 756659.0 149657.8 150903.0 159340.0 169807.3 180335.3 1181.1 1233.6 1250.6 1256.2 1256.6 19440.5 19851.9 20090.0 20203.3 20347.5 45797.1 64348.7 64596.7 65467.3 67525.7 93672.5 94126.0 94545.0 94548.5 96062.0 11628.4 11700.6 11958.8 11970.9 12152.7 13186.3 13268.4 13532.8 13549.6 13638.5 8536.6 11420.0 11715.9 11803.6 11836.6 8929.4 11256.8 11298.2 11517.1 11549.5 11298.4 11444.2 11590.4 11784.5 11938.8 8836.7 11609.4 11827.0 11935.6 11943.9 10674.4 11087.3 11093.0 11313.8 11740.9 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | [#3] mootools.html Cycles:180 Average:6729.37 Median:2433.77 stddev:4164.60 (171.1%) stddev-sans-first:4157.98 02:55:25 INFO - PROCESS | 2332 | Values: 1532.6 1562.6 1570.5 1581.7 1584.8 10373.7 10827.6 10943.7 11230.0 11440.7 11322.5 11491.9 11535.3 11552.0 11558.1 2394.9 2425.4 2432.8 2434.8 2438.8 2345.9 2384.1 2400.6 2402.2 2402.7 2339.5 2353.6 2358.1 2363.9 2368.3 2009.7 2311.2 2324.0 2335.3 2348.1 1956.9 2327.8 2410.2 2413.2 2417.6 11211.0 11271.3 11325.0 11405.3 11411.7 5470.9 5876.4 5940.3 5952.1 5962.1 3318.5 3590.6 3649.3 3679.7 3680.7 1116.9 1164.5 1180.9 1197.4 1219.5 11740.0 13963.6 14066.9 15475.5 15622.8 4678.4 4749.7 4803.9 4822.0 4839.3 11876.2 11963.9 12040.5 12051.7 12068.6 5761.3 5773.2 5782.6 5825.1 5837.6 4988.1 5162.9 5250.6 5250.9 5258.6 3827.9 4010.1 4014.8 4065.2 4078.9 1024.5 1027.2 1034.3 1043.2 1044.3 919.5 929.2 940.1 947.8 963.7 5370.4 6582.4 6640.5 6805.2 6834.2 965.4 968.3 981.0 990.7 1005.4 4235.6 4327.0 4342.2 4459.7 4466.6 11377.0 13341.5 13663.0 13779.2 13811.0 11891.4 12620.5 12844.0 13134.0 13710.7 9132.5 10177.4 10274.0 10368.5 10407.6 6493.5 6768.7 6840.3 6877.6 6923.0 12119.6 12248.9 12320.3 12631.7 12651.8 11460.5 11929.8 12522.3 12873.2 13004.1 9232.1 9506.6 9586.8 9592.3 9616.3 9775.6 9989.0 10027.7 10433.4 10527.6 8957.5 9089.3 9293.4 9477.7 9569.0 8212.6 9146.0 9151.8 9162.3 9191.9 7076.8 7454.3 7932.0 7965.6 7987.4 4977.6 5427.2 5779.7 5874.3 5898.6 5978.3 6001.9 6023.2 6090.8 6152.5 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | [#4] prototype.html Cycles:180 Average:4620.36 Median:4889.28 stddev:1291.87 (26.4%) stddev-sans-first:1255.13 02:55:25 INFO - PROCESS | 2332 | Values: 351.4 379.5 380.8 391.7 392.4 4854.2 5088.2 5349.0 5389.6 5484.4 4415.6 4421.8 4664.8 4895.7 5263.2 3922.6 4238.9 4417.5 4420.6 4428.7 3900.8 4366.4 4366.9 4464.5 4509.4 3779.9 4414.2 4417.5 4426.8 4456.4 4093.4 4257.9 4361.8 4454.3 4458.8 3484.3 3930.0 3970.6 4006.8 4075.2 4748.8 4765.7 5050.1 5198.9 5232.5 4550.5 4578.5 5088.7 5104.3 5110.2 4468.0 4764.8 5421.6 5699.8 5738.3 4272.5 4322.1 4626.2 4633.4 4634.2 4882.9 4992.5 5897.9 6108.7 6139.8 3981.0 4230.7 4245.0 4619.4 4672.9 4327.9 4516.3 4531.2 4726.7 4741.2 4881.0 4990.7 5054.4 5063.3 5159.3 4630.7 4663.8 4928.7 5631.4 5668.7 1322.7 1363.8 1387.0 1449.3 1585.6 1036.6 1065.0 1101.7 1145.3 1194.2 4423.9 4901.1 5403.9 5413.7 5489.0 4809.9 4980.5 5280.0 5298.2 6058.5 4350.8 4436.0 4777.5 4842.3 5234.4 2759.6 2917.4 2997.2 3110.8 3119.4 5176.7 5237.0 5482.6 5779.7 6088.2 5430.9 5496.8 5764.1 5870.6 6141.9 5144.4 5381.7 5473.0 5823.4 6218.1 4959.9 5239.4 5944.9 6018.5 6037.8 5635.1 5688.4 5704.5 5753.7 5851.6 5032.9 5033.5 5436.0 6127.6 6132.6 4223.9 4297.7 4375.9 4561.4 4591.8 4791.6 5241.7 5546.3 5627.6 5897.8 5099.5 5233.3 5633.2 5717.9 5837.9 4830.3 5211.8 5275.6 5321.2 5660.7 4272.0 5192.5 5218.5 5459.2 5515.1 4786.3 4870.6 4921.5 5602.3 5628.5 4646.9 5147.7 5457.7 5472.8 5493.5 02:55:25 INFO - PROCESS | 2332 | 02:55:25 INFO - PROCESS | 2332 | [#5] yui.html Cycles:180 Average:20553.37 Median:3551.76 stddev:29600.73 (833.4%) stddev-sans-first:29646.02 02:55:25 INFO - PROCESS | 2332 | Values: 643.9 708.1 737.2 747.6 758.0 15168.6 16131.6 16413.4 16541.6 16596.8 12932.0 14642.1 14733.0 15323.0 15335.8 763.4 938.9 941.7 942.4 942.5 889.8 934.2 940.9 941.1 941.6 828.5 963.9 982.2 985.0 985.1 963.4 975.5 979.2 979.6 980.1 723.3 724.5 725.0 725.4 741.8 15831.8 16271.4 16295.4 16884.6 17060.2 13748.3 13988.7 14084.4 14183.2 14233.2 11727.6 11749.9 11764.2 11821.2 11884.5 3326.9 3607.2 3672.2 3828.0 3832.0 89389.0 111240.4 117799.0 118315.4 118429.0 10354.9 10582.4 10838.2 10842.1 10862.3 21679.2 22046.1 22071.0 22311.0 22386.3 7709.9 7726.9 7773.3 7852.7 7865.2 4251.4 4288.2 4385.6 4423.7 4437.0 3402.9 3450.2 3483.9 3487.2 3496.3 629.9 639.4 639.6 652.5 664.7 659.6 662.7 688.1 689.3 704.4 10102.0 10189.0 10366.0 10456.2 10485.8 660.7 688.7 697.3 709.8 723.1 4957.0 4993.5 5020.3 5058.7 5060.8 84933.6 107889.0 112930.4 113955.0 114950.0 80118.6 81606.2 82069.2 82274.6 84838.6 60372.1 75206.9 76104.6 76151.2 76783.6 8031.4 11073.8 11240.8 11309.8 11438.9 44567.0 48940.0 49619.0 51507.0 51640.7 63065.0 67765.6 70818.0 71032.1 73003.0 9849.6 10789.4 11287.2 12898.8 13263.1 14885.8 15082.8 15119.0 15229.7 15538.4 11346.4 13877.2 14166.3 14196.9 14659.6 12076.5 13409.7 13628.9 14096.9 14443.6 13293.9 13747.7 13851.9 14083.2 14319.4 11105.0 11184.6 11363.9 11520.5 11693.4 9685.5 10616.2 11359.7 11491.3 11582.9 02:55:25 INFO - PROCESS | 2332 | -------- Summary: end -------- 02:55:25 INFO - PROCESS | 2332 | 02:55:26 INFO - TEST-INFO | 2332: exit 0 02:55:26 INFO - TEST-OK | dromaeo_css | took 1117304ms 02:55:26 INFO - TEST-START | kraken 02:55:26 INFO - operating with platform_type : mac_ 02:55:26 INFO - Initialising browser for kraken test... 02:55:26 INFO - TEST-INFO | started process 2336 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpW5XYaK/profile http://localhost:60200/getInfo.html) 02:55:29 INFO - PROCESS | 2336 | 2017-03-24 02:55:29.407 plugin-container[2338:77854] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 02:55:29 INFO - PROCESS | 2336 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:55:29 INFO - PROCESS | 2336 | 2017-03-24 02:55:29.408 plugin-container[2338:77854] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:55:29 INFO - PROCESS | 2336 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:55:29 INFO - PROCESS | 2336 | 2017-03-24 02:55:29.408 plugin-container[2338:77854] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:55:29 INFO - PROCESS | 2336 | __metrics Screen width/height:1600/1200 02:55:29 INFO - PROCESS | 2336 | colorDepth:24 02:55:29 INFO - PROCESS | 2336 | Browser inner width/height: 1024/689 02:55:29 INFO - PROCESS | 2336 | __metrics 02:55:29 ERROR - PROCESS | 2336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:55:30 INFO - TEST-INFO | 2336: exit 0 02:55:30 INFO - Browser initialized. 02:55:30 INFO - Running cycle 1/1 for kraken test... 02:55:30 INFO - TEST-INFO | started process 2339 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpW5XYaK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:32 INFO - PROCESS | 2339 | 2017-03-24 02:55:32.655 plugin-container[2340:77981] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 02:55:32 INFO - PROCESS | 2339 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:55:32 INFO - PROCESS | 2339 | 2017-03-24 02:55:32.656 plugin-container[2340:77981] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 02:55:32 INFO - PROCESS | 2339 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:55:32 INFO - PROCESS | 2339 | 2017-03-24 02:55:32.656 plugin-container[2340:77981] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:55:42 INFO - PROCESS | 2339 | RSS: Main: 220942336 02:55:42 INFO - PROCESS | 2339 | 02:55:45 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:46 INFO - PROCESS | 2339 | RSS: Main: 235651072 02:55:46 INFO - PROCESS | 2339 | 02:55:49 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-dft) 02:55:49 INFO - PROCESS | 2339 | RSS: Main: 243687424 02:55:49 INFO - PROCESS | 2339 | 02:55:53 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-fft) 02:55:53 INFO - PROCESS | 2339 | RSS: Main: 247422976 02:55:53 INFO - PROCESS | 2339 | 02:55:55 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60200/tests/kraken/driver.html?testName=audio-oscillator) 02:55:56 INFO - PROCESS | 2339 | RSS: Main: 248860672 02:55:56 INFO - PROCESS | 2339 | 02:55:58 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:55:59 INFO - PROCESS | 2339 | RSS: Main: 248840192 02:55:59 INFO - PROCESS | 2339 | 02:56:02 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60200/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:02 INFO - PROCESS | 2339 | RSS: Main: 253317120 02:56:02 INFO - PROCESS | 2339 | 02:56:06 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60200/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:06 INFO - PROCESS | 2339 | RSS: Main: 252809216 02:56:06 INFO - PROCESS | 2339 | 02:56:10 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60200/tests/kraken/driver.html?testName=json-parse-financial) 02:56:10 INFO - PROCESS | 2339 | RSS: Main: 252772352 02:56:10 INFO - PROCESS | 2339 | 02:56:12 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:13 INFO - PROCESS | 2339 | RSS: Main: 252461056 02:56:13 INFO - PROCESS | 2339 | 02:56:14 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:15 INFO - PROCESS | 2339 | RSS: Main: 252403712 02:56:15 INFO - PROCESS | 2339 | 02:56:17 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:18 INFO - PROCESS | 2339 | RSS: Main: 252506112 02:56:18 INFO - PROCESS | 2339 | 02:56:21 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:22 INFO - PROCESS | 2339 | RSS: Main: 253153280 02:56:22 INFO - PROCESS | 2339 | 02:56:25 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:25 INFO - PROCESS | 2339 | RSS: Main: 252841984 02:56:25 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | Cycle 1(1): loaded http://localhost:60200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60200/tests/kraken/driver.html?testName=ai-astar) 02:56:27 INFO - PROCESS | 2339 | RSS: Main: 255950848 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | __start_tp_report 02:56:27 INFO - PROCESS | 2339 | _x_x_mozilla_page_load 02:56:27 INFO - PROCESS | 2339 | _x_x_mozilla_page_load_details 02:56:27 INFO - PROCESS | 2339 | |i|pagename|runs| 02:56:27 INFO - PROCESS | 2339 | |0;ai-astar;108;121;117;120;119;118;121;118;119;121 02:56:27 INFO - PROCESS | 2339 | |1;audio-beat-detection;148;125;152;184;114;114;115;117;119;151 02:56:27 INFO - PROCESS | 2339 | |2;audio-dft;196;198;197;237;286;206;197;196;201;197 02:56:27 INFO - PROCESS | 2339 | |3;audio-fft;90;61;56;89;89;63;60;61;76;59 02:56:27 INFO - PROCESS | 2339 | |4;audio-oscillator;95;69;85;69;73;71;84;95;102;97 02:56:27 INFO - PROCESS | 2339 | |5;imaging-gaussian-blur;90;89;95;89;119;139;138;87;89;93 02:56:27 INFO - PROCESS | 2339 | |6;imaging-darkroom;103;95;140;92;155;99;98;157;156;127 02:56:27 INFO - PROCESS | 2339 | |7;imaging-desaturate;87;106;90;91;90;97;142;111;134;141 02:56:27 INFO - PROCESS | 2339 | |8;json-parse-financial;59;69;63;58;99;109;110;104;68;70 02:56:27 INFO - PROCESS | 2339 | |9;json-stringify-tinderbox;58;65;61;64;62;58;62;60;61;61 02:56:27 INFO - PROCESS | 2339 | |10;stanford-crypto-aes;85;88;83;86;77;92;75;108;105;104 02:56:27 INFO - PROCESS | 2339 | |11;stanford-crypto-ccm;139;147;149;159;150;152;164;150;206;152 02:56:27 INFO - PROCESS | 2339 | |12;stanford-crypto-pbkdf2;172;175;168;167;169;191;169;170;170;170 02:56:27 INFO - PROCESS | 2339 | |13;stanford-crypto-sha256-iterative;68;66;80;89;83;86;86;68;62;67 02:56:27 INFO - PROCESS | 2339 | __end_tp_report 02:56:27 INFO - PROCESS | 2339 | __start_cc_report 02:56:27 INFO - PROCESS | 2339 | _x_x_mozilla_cycle_collect,1012 02:56:27 INFO - PROCESS | 2339 | __end_cc_report 02:56:27 INFO - PROCESS | 2339 | __startTimestamp1490349387835__endTimestamp 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | ------- Summary: start ------- 02:56:27 INFO - PROCESS | 2339 | Number of tests: 14 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#0] ai-astar Cycles:10 Average:118.20 Median:119.50 stddev:3.85 (3.2%) stddev-sans-first:1.50 02:56:27 INFO - PROCESS | 2339 | Values: 108.0 121.0 117.0 120.0 119.0 118.0 121.0 118.0 119.0 121.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:136.50 stddev:23.72 (17.4%) stddev-sans-first:24.61 02:56:27 INFO - PROCESS | 2339 | Values: 148.0 125.0 152.0 184.0 114.0 114.0 115.0 117.0 119.0 151.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#2] audio-dft Cycles:10 Average:211.10 Median:199.50 stddev:29.12 (14.6%) stddev-sans-first:30.37 02:56:27 INFO - PROCESS | 2339 | Values: 196.0 198.0 197.0 237.0 286.0 206.0 197.0 196.0 201.0 197.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#3] audio-fft Cycles:10 Average:70.40 Median:69.50 stddev:14.08 (20.3%) stddev-sans-first:13.03 02:56:27 INFO - PROCESS | 2339 | Values: 90.0 61.0 56.0 89.0 89.0 63.0 60.0 61.0 76.0 59.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:84.50 stddev:12.81 (15.2%) stddev-sans-first:12.95 02:56:27 INFO - PROCESS | 2339 | Values: 95.0 69.0 85.0 69.0 73.0 71.0 84.0 95.0 102.0 97.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#5] imaging-gaussian-blur Cycles:10 Average:102.80 Median:89.00 stddev:20.96 (23.5%) stddev-sans-first:21.71 02:56:27 INFO - PROCESS | 2339 | Values: 90.0 89.0 95.0 89.0 119.0 139.0 138.0 87.0 89.0 93.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#6] imaging-darkroom Cycles:10 Average:122.20 Median:124.50 stddev:27.72 (22.3%) stddev-sans-first:28.51 02:56:27 INFO - PROCESS | 2339 | Values: 103.0 95.0 140.0 92.0 155.0 99.0 98.0 157.0 156.0 127.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#7] imaging-desaturate Cycles:10 Average:108.90 Median:88.50 stddev:22.17 (25.1%) stddev-sans-first:22.06 02:56:27 INFO - PROCESS | 2339 | Values: 87.0 106.0 90.0 91.0 90.0 97.0 142.0 111.0 134.0 141.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#8] json-parse-financial Cycles:10 Average:80.90 Median:65.50 stddev:21.73 (33.2%) stddev-sans-first:21.55 02:56:27 INFO - PROCESS | 2339 | Values: 59.0 69.0 63.0 58.0 99.0 109.0 110.0 104.0 68.0 70.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:2.25 (3.7%) stddev-sans-first:2.07 02:56:27 INFO - PROCESS | 2339 | Values: 58.0 65.0 61.0 64.0 62.0 58.0 62.0 60.0 61.0 61.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.00 stddev:11.72 (14.0%) stddev-sans-first:12.27 02:56:27 INFO - PROCESS | 2339 | Values: 85.0 88.0 83.0 86.0 77.0 92.0 75.0 108.0 105.0 104.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:152.00 stddev:18.53 (12.2%) stddev-sans-first:18.50 02:56:27 INFO - PROCESS | 2339 | Values: 139.0 147.0 149.0 159.0 150.0 152.0 164.0 150.0 206.0 152.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:170.00 stddev:7.00 (4.1%) stddev-sans-first:7.42 02:56:27 INFO - PROCESS | 2339 | Values: 172.0 175.0 168.0 167.0 169.0 191.0 169.0 170.0 170.0 170.0 02:56:27 INFO - PROCESS | 2339 | 02:56:27 INFO - PROCESS | 2339 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:81.50 stddev:10.20 (12.5%) stddev-sans-first:10.45 02:56:27 INFO - PROCESS | 2339 | Values: 68.0 66.0 80.0 89.0 83.0 86.0 86.0 68.0 62.0 67.0 02:56:27 INFO - PROCESS | 2339 | -------- Summary: end -------- 02:56:27 INFO - PROCESS | 2339 | 02:56:28 INFO - TEST-INFO | 2339: exit 0 02:56:28 INFO - TEST-OK | kraken | took 62058ms 02:56:28 INFO - SUITE-END | took 1179s 02:56:29 INFO - Completed test suite (00:19:39) 02:56:29 INFO - javascript benchmark 02:56:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7752.766242981685, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3490.3368360011596, 3500.369933411988, 3503.7021853142487, 3539.769914955528, 3570.4108822044363, 6143.877122457554, 6181.938180618193, 6186.81439556814, 6211.50307975362, 6237.0, 6137.815865524041, 6197.977333739927, 6218.906716399247, 6228.84427889303, 6263.436290733833, 4460.397846290758, 5512.614117011801, 5574.916376254339, 5593.0, 5649.604527683064, 5613.158026296048, 5616.129499927518, 5619.6066275360745, 5629.971850140743, 5660.009498337795, 5430.484104010113, 5437.238786569864, 5565.0, 5627.493525582697, 5640.294963129609, 5601.775928962837, 5612.66324020556, 5618.8595285118, 5637.098064309732, 5698.487136157724, 5507.807226747084, 5573.386927437979, 5591.776328946838, 5598.804041858515, 5602.187682786014, 5944.762209511614, 5970.6716130612795, 6115.082737589352, 6193.1639228704, 6229.781957631461, 6436.195475565554, 6445.871082578369, 6479.611223326616, 6514.153160089206, 6516.413522782972, 5176.275321454999, 6628.536002479828, 6678.899816502756, 6687.966560167217, 6695.2969938156275, 4954.405471343462, 6050.304215015241, 6311.463525600284, 6313.43179113882, 6321.841953951142, 6502.414782669583, 6545.410913017851, 6564.0, 6633.170853643294, 6702.229243637044, 6396.328385519547, 6439.54923155384, 6447.838804029843, 6450.258220304631, 6501.967490162613, 6628.005799130073, 6663.13379260693, 6692.631905245161, 6699.832504187434, 6705.597664140168, 6230.408111229426, 6332.905006424908, 6350.428461438492, 6589.308122647053, 6615.470762339001, 6250.718717657716, 6319.873602528016, 6415.422611964946, 6438.291787903327, 6520.0, 4552.704074235164, 5181.740912954338, 5262.973720124539, 5288.788448462095, 5309.177077552986, 4677.789499472532, 4711.411073615798, 4751.95248047522, 4754.120487709715, 4758.857234282977, 6086.452219300196, 6131.50947924165, 6282.2147231596055, 6337.493000559944, 6341.3341599132345, 5786.247787787561, 6137.693115344215, 6409.0, 6409.519286053564, 6514.869702605922, 6202.782902598477, 6290.842728931813, 6301.52738544611, 6316.178896743394, 6316.8420789479715, 4927.236278376858, 5861.7655293787775, 5874.853128671817, 5901.144334071621, 5922.555808314308, 5938.871614393252, 6492.5455218134275, 6546.967265163644, 6817.863642727217, 6895.241523432318, 5425.782968681208, 6536.3136870627895, 6573.112629794917, 6589.24223714279, 6601.141851559267, 6810.727570897307, 6862.176538815374, 6879.518433709793, 6880.759173428906, 6883.793486195422, 6243.687815609111, 6516.315786842313, 6522.478201743944, 6529.836754080996, 6551.770688025897, 4996.0, 6350.301466838737, 6493.545451818327, 6552.508561857784, 6553.475721942138, 6379.712912918837, 6383.36166383358, 6388.233411990591, 6392.9041064385, 6409.3270206629495, 6301.338359472189, 6308.842278943063, 6359.745610175726, 6378.011408231731, 6386.521010924106, 5083.237514372726, 5978.730957106854, 6193.628382297076, 6221.191245138103, 6266.310705822265, 6376.139221205263, 6383.6808159592765, 6387.169667943138, 6392.52056095804, 6394.4884409246215, 4886.413630364379, 6070.666113363631, 6130.703893785035, 6237.033259844731, 6298.937010630018], "value": 5984.605699035094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.8571571396436, 752.3003606645817, 834.9999999999998, 956.2493442647519, 965.2519297544407, 39022.804885975565, 39904.002399940015, 41100.58899411009, 41498.0, 41660.79169604155, 39201.803990980006, 39470.40794388086, 39518.01204969877, 39583.802080989626, 39645.0, 7921.168277330884, 8077.515349079044, 10592.152627789797, 10879.347239165636, 11025.724356891062, 10803.621873234439, 10876.67369978898, 10916.563337466532, 10919.344839309628, 10939.781204375908, 10854.565817367335, 10886.61896833611, 10914.727131821688, 10917.0, 10925.399103049329, 9503.857442138373, 10540.156787457023, 10901.509432075576, 10904.236703430763, 10910.5090270938, 8775.0, 10567.841482377693, 10646.680599582025, 10649.148068154529, 10659.093977011964, 34428.48357274643, 34690.30619387623, 34757.783477578414, 34788.82605586981, 34792.478112828074, 3729.533808273966, 3773.8679146230024, 3774.565924918642, 3793.9620603793883, 3794.905127371838, 25244.242672719847, 25439.491210175693, 25823.870880645663, 26735.465290694272, 27409.0, 3057.5107982722657, 3107.9533806992913, 3130.906072817819, 3146.0561831450473, 3194.7923384979904, 299701.0, 366402.0, 370140.0, 371259.14370428247, 373578.0, 46113.5388646116, 46705.53294467012, 46770.5322946773, 46833.0, 46940.0, 48130.556083317555, 48145.0, 48351.75824120857, 48355.5164448351, 48591.02817943692, 13899.374528146258, 14150.716985660229, 14297.92851035759, 14310.28448577567, 14587.635309117357, 12208.20646657982, 12227.633171004883, 12375.081862311356, 12379.566715164927, 12386.31875246852, 11986.940065299792, 12230.510779568718, 12234.938825305817, 12250.203736757083, 12381.0, 5808.825735227865, 5834.27071616048, 5859.326177489558, 5860.443257890493, 5872.354041055481, 1069.4011353641986, 1102.3496137279044, 1115.252780636975, 1118.2060736876747, 1168.1589255735857, 24874.875625621757, 27710.5843412349, 27775.86112069467, 27783.861080694467, 27945.860270698515, 1195.5397172088808, 1230.2003697596633, 1241.819936109259, 1285.9807102893465, 1292.7285270093198, 14195.162387138053, 14298.499552515612, 14409.207493587954, 14484.420623174956, 14510.419583216764, 499276.0, 500238.4988075036, 504998.0, 505713.0, 506164.0, 50086.49913500891, 51230.74384628053, 58919.41080589225, 59324.0, 59628.40371596228, 1408.190290582919, 1436.633658417097, 1444.0108525660166, 1448.6595650022236, 1455.0033227239164, 27701.445971080062, 27729.306767330978, 28338.0, 28555.42889142247, 28920.0, 41886.162276754905, 41902.79048604737, 41925.0, 41964.790176048926, 42076.57923420849, 403827.0, 405403.0, 407270.0, 409201.0, 409877.0, 30224.0, 30435.543466847572, 30823.383532329677, 30839.2290192747, 30840.0, 38699.22601547897, 39785.0, 40130.79607611776, 40437.79781101076, 40469.797651011555, 32150.678493214768, 33641.831790840886, 33890.830545847115, 34847.303053939286, 34855.302893942484, 31603.683963160074, 33181.17047073843, 33856.66143338535, 34270.657293426746, 34576.82711586426, 33302.00093997184, 33555.161120972174, 33759.83120084384, 34250.82874585711, 34276.31447371088, 26934.057307994128, 28308.71691283061, 30236.84881575578, 30379.936702215316, 30425.847870760503, 21859.78140218641, 22778.974946127797, 23056.769432306133, 23522.411939701644, 23723.64414533749], "value": 18691.265661147238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.50086876635174, 416.2798358839206, 419.64330319228657, 419.71459407602816, 455.08754946332596, 19796.90101549492, 20688.99999999998, 21354.35936921891, 22040.669389959163, 22315.888420557876, 20627.27804526838, 20655.586888262227, 21495.817730024843, 22073.117075317008, 22489.100435982542, 6399.040143978417, 6706.195256569218, 6720.059191713164, 6734.528582999192, 6749.291324410915, 4696.577308042276, 6646.9667651661675, 6681.699323530428, 6725.125733654618, 6727.394534491895, 6433.356664333576, 6648.734050637969, 6691.19705635322, 6710.29541898101, 6733.932660673379, 6643.966780166116, 6683.2648408675, 6697.263301036882, 6697.3637504437, 6734.3939045485895, 6289.496840252768, 6471.191101112361, 6505.251896031969, 6530.379613936669, 6539.803805885784, 20585.69121463179, 25617.231483055537, 25917.481650366888, 26054.0, 27003.864980675167, 3188.28263640679, 3217.3404452087266, 3318.3529211803707, 3330.8342080271955, 3350.8994730158133, 15746.685066298724, 15861.603459913478, 16107.275172617261, 16651.0, 16780.2448889799, 1989.5125694205012, 2038.9082491287927, 2046.7543894732728, 2051.907664155102, 2064.040221297104, 148240.0, 158106.0, 164937.17531412386, 166871.0, 168818.0, 20707.378778636365, 20957.580848382946, 21724.782752172592, 21830.672539911597, 22013.779862201493, 31958.881439149984, 32341.51487727686, 32487.0, 32523.18692032671, 32537.0, 10272.589096436208, 10319.277650564538, 10463.319884207654, 10619.94690026545, 10697.304675196086, 6242.531810114168, 8780.165884241114, 8815.25070369013, 9001.009888912215, 9002.234810041089, 7709.691612335556, 9748.853767193497, 9855.11303982645, 10041.497925103862, 10051.69844904654, 4209.97895010523, 4322.308430651081, 4331.436913201263, 4348.021650149174, 4350.608445239944, 708.9007538944552, 910.7267819654078, 921.5484412637759, 948.5873644964324, 1043.3687618990552, 21479.570408591742, 22003.0, 22090.88954555217, 22116.889415552818, 22121.0, 898.9232786364225, 932.5523748600709, 935.2004036548789, 943.7263193673895, 959.2828836382936, 11214.607488738018, 11284.153688473398, 11333.716657083638, 11437.370944598128, 11457.484413201426, 751734.0, 751766.0, 756399.0, 756425.0, 756659.0, 149657.75513367308, 150903.0, 159340.0, 169807.30192698163, 180335.29497057555, 1181.1023622047135, 1233.6237447578574, 1250.6060590914014, 1256.214865708932, 1256.5664845628244, 19440.513987150436, 19851.900740496207, 20089.99550022464, 20203.292884748964, 20347.49131271671, 45797.08405831798, 64348.678256608415, 64596.677016614616, 65467.34532654803, 67525.66237168782, 93672.53163734138, 94126.0, 94545.0, 94548.52725736327, 96062.0, 11628.418579070843, 11700.590479333183, 11958.820617690568, 11970.880291197325, 12152.696182595506, 13186.340682965621, 13268.402921868732, 13532.79700804469, 13549.59351219465, 13638.522651707142, 8536.615852286537, 11420.029297509805, 11715.882841171479, 11803.645890623295, 11836.58571950012, 8929.374943753875, 11256.774864502828, 11298.152638552307, 11517.07863370945, 11549.48027338755, 11298.378589177346, 11444.198906076495, 11590.42047897585, 11784.528618855149, 11938.820917686067, 8836.690715825172, 11609.3614851184, 11827.0, 11935.582254621047, 11943.940280298542, 10674.35953842772, 11087.279326843729, 11093.0, 11313.7737245253, 11740.882591173979], "value": 11669.325484759094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.639829640035, 1562.609347663085, 1570.5366916759556, 1581.6836632673464, 1584.7781310616513, 10373.688789336322, 10827.566897324108, 10943.726406839833, 11230.0, 11440.71398215045, 11322.547098116065, 11491.885081149187, 11535.250208736426, 11552.0, 11558.075353971682, 2394.8682822444716, 2425.3936515871032, 2432.781049705526, 2434.7565243475688, 2438.829281950264, 2345.9061637534564, 2384.0940442631777, 2400.59189937711, 2402.243293362585, 2402.6756387887585, 2339.5203983183405, 2353.5881220786378, 2358.068562917655, 2363.929082127539, 2368.2539999899977, 2009.7387339645898, 2311.156427903803, 2324.035525257025, 2335.2760644200266, 2348.1429278313376, 1956.8943546895957, 2327.8021368183727, 2410.240774156135, 2413.179518963561, 2417.6494408310696, 11211.047060999825, 11271.267367621078, 11324.9807517323, 11405.258658187275, 11411.714707132305, 5470.890582188374, 5876.441738034922, 5940.2871655401195, 5952.107183922403, 5962.135490353918, 3318.469044952796, 3590.5870824855215, 3649.3066317399607, 3679.7056235501364, 3680.687141592941, 1116.8659760828752, 1164.545827127421, 1180.8996235320008, 1197.3713800254848, 1219.5365761010848, 11740.0, 13963.58109256724, 14066.859331406657, 15475.458358957496, 15622.843771562253, 4678.415198100238, 4749.691270067504, 4803.927941080887, 4822.035592881438, 4839.346688197048, 11876.168668193317, 11963.940180299043, 12040.518379264731, 12051.698707532381, 12068.577599783965, 5761.308642962871, 5773.220615216892, 5782.624129431573, 5825.097109947965, 5837.620554663933, 4988.127077761377, 5162.92255616166, 5250.606204534675, 5250.868728281747, 5258.579313654898, 3827.9043023924623, 4010.137820368635, 4014.8193331300163, 4065.2276067547073, 4078.877633670995, 1024.5235965276183, 1027.1525991057408, 1034.2915103154364, 1043.2488608202234, 1044.2742294105524, 919.5126582911067, 929.2240978782658, 940.0881145289059, 947.8341290274312, 963.677168148664, 5370.355557333145, 6582.407583317428, 6640.468762498988, 6805.217399999064, 6834.2482326944, 965.3958769343885, 968.2592816495387, 980.9852852207223, 990.7126933189438, 1005.3716427232979, 4235.639970602533, 4326.978365108154, 4342.1532801103485, 4459.732416055047, 4466.57567531084, 11377.0, 13341.533046343331, 13663.043586949017, 13779.173249604855, 13810.964177686714, 11891.405429728478, 12620.495180192873, 12844.036697247744, 13134.0, 13710.725785484234, 9132.452052876848, 10177.440240786827, 10274.0, 10368.481575921174, 10407.58369665205, 6493.53895373556, 6768.695408706521, 6840.289927518121, 6877.561219390305, 6922.965385173042, 12119.636410907335, 12248.877511224773, 12320.260784352968, 12631.684207894876, 12651.810222846481, 11460.484278207667, 11929.761404772029, 12522.311272880079, 12873.163244389085, 13004.089713719948, 9232.076792320715, 9506.572204250964, 9586.760330991781, 9592.328537002622, 9616.278779091455, 9775.608975640895, 9988.950055249677, 10027.749306267402, 10433.373997560171, 10527.578896844041, 8957.491902267375, 9089.318301127574, 9293.395929264576, 9477.668281610111, 9568.95215523918, 8212.58937053133, 9146.0, 9151.77120571991, 9162.312826537904, 9191.862122068309, 7076.7615667257, 7454.25457454272, 7931.960340198262, 7965.561894095648, 7987.400944929037, 4977.576905962889, 5427.1859221115565, 5779.7110144493445, 5874.295084589877, 5898.616589921641, 5978.3423823378525, 6001.939980600138, 6023.156758053964, 6090.817275481742, 6152.477039451696], "value": 5135.837473951822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.39384561631203, 379.45358683495766, 380.7506083515297, 391.68199010330227, 392.3917927212821, 4854.23796557668, 5088.18589025756, 5349.0, 5389.595780316472, 5484.36929753078, 4415.624671902884, 4421.845235416753, 4664.790084446199, 4895.681780684253, 5263.236830659562, 3922.607739226069, 4238.9152216955645, 4417.4699036115635, 4420.58004489573, 4428.674945653525, 3900.8244628991765, 4366.410534577839, 4366.868993930171, 4464.486584042828, 4509.391232183646, 3779.8677046303383, 4414.161309351213, 4417.514073451917, 4426.800793964279, 4456.420665313521, 4093.406456063884, 4257.87226383209, 4361.781910904474, 4454.287314029756, 4458.754768487715, 3484.337975784593, 3929.9760623279035, 3970.563238043813, 4006.779627120507, 4075.247643513288, 4748.7863046163, 4765.712458020135, 5050.086183208006, 5198.896022079537, 5232.508735010541, 4550.453945526558, 4578.496365399803, 5088.745562721849, 5104.269215969439, 5110.233464980245, 4467.955320446819, 4764.809407623691, 5421.593380496479, 5699.8005069822775, 5738.254026976508, 4272.547333906456, 4322.104190192578, 4626.236670949289, 4633.351330813689, 4634.189016922059, 4882.877928051792, 4992.475790042066, 5897.8820423591715, 6108.664023478706, 6139.846503837395, 3980.960190398117, 4230.703850730481, 4244.957550424518, 4619.422572178478, 4672.878509157777, 4327.944226492391, 4516.299973504112, 4531.235946072893, 4726.669133160714, 4741.241401375763, 4881.0, 4990.675606085593, 5054.418741844662, 5063.341765570526, 5159.25190847325, 4630.699004564693, 4663.766811659403, 4928.704277743275, 5631.436856314418, 5668.688222147822, 1322.6891680455085, 1363.83633963923, 1386.9791953120712, 1449.289847974506, 1585.635303880114, 1036.6475398364591, 1064.966982027432, 1101.7245688577855, 1145.3242586873785, 1194.2444606428537, 4423.92075724409, 4901.068796928644, 5403.9459605403445, 5413.729313534308, 5489.011977843947, 4809.9038019239415, 4980.501949805063, 5279.973600131974, 5298.2052692096495, 6058.515318774487, 4350.847720329773, 4436.00189957257, 4777.522247775195, 4842.280990248481, 5234.398044224887, 2759.613654088429, 2917.4311009352973, 2997.1607949774098, 3110.8444577771475, 3119.4229067622564, 5176.7411629418375, 5236.9738151309, 5482.643628164156, 5779.682117483579, 6088.169001414363, 5430.864228394322, 5496.780128794883, 5764.07774756037, 5870.55970802183, 6141.9078713818435, 5144.408393034849, 5381.730913454312, 5472.972635136799, 5823.4467725566, 6218.072397556772, 4959.851204463872, 5239.397469291081, 5944.8811023780145, 6018.51851851842, 6037.788677396446, 5635.140403666698, 5688.431156884279, 5704.543636509153, 5753.713483454853, 5851.561132914963, 5032.949670503394, 5033.546980771748, 5436.0, 6127.56002339441, 6132.632042077311, 4223.873283801491, 4297.677674174512, 4375.912481750411, 4561.384213131185, 4591.8392856249875, 4791.5687588117235, 5241.68549887008, 5546.334439867242, 5627.634203776742, 5897.764089436375, 5099.501244390296, 5233.319668443078, 5633.183188437735, 5717.914231286451, 5837.919984802825, 4830.281999122509, 5211.791528338824, 5275.604329675213, 5321.201819726917, 5660.745266462936, 4271.974726065784, 5192.506711862367, 5218.504242096995, 5459.235707000944, 5515.145152501369, 4786.329913811999, 4870.634702397264, 4921.458639549575, 5602.299712535933, 5628.465295796893, 4646.883827904329, 5147.716875571729, 5457.699826509422, 5472.835814925399, 5493.478119578634], "value": 4239.734595851278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.9259485159207, 708.1219288082779, 737.1854101218154, 747.6261869065464, 758.041078036284, 15168.620784480394, 16131.628811551018, 16413.425530106448, 16541.586460338483, 16596.751048734277, 12931.999999999976, 14642.121472711644, 14733.042352247096, 15323.0, 15335.769963450557, 763.4159867701213, 938.8920274168455, 941.6892425499568, 942.354487176283, 942.5381563034133, 889.7864512516982, 934.2339281788936, 940.8588711693267, 941.0589410589411, 941.55276243784, 828.5194587139445, 963.889152747436, 982.1651596143257, 984.9852252216223, 985.1183191044012, 963.373807025432, 975.5414954971152, 979.192166462664, 979.5738853598672, 980.1227901028611, 723.3381455967783, 724.5254358395259, 724.9963750181269, 725.3580581185636, 741.8479211761576, 15831.841681583268, 16271.430499932563, 16295.429659961845, 16884.577885552837, 17060.232289547, 13748.312584370742, 13988.650283742885, 14084.436622535086, 14183.219922904236, 14233.217173055582, 11727.648170554898, 11749.94125029378, 11764.176507644468, 11821.17251792375, 11884.465199065977, 3326.935380678184, 3607.2424790793966, 3672.173760903802, 3828.0, 3832.0419895026243, 89388.99999999935, 111240.4437977813, 117799.0, 118315.4084229582, 118429.0, 10354.896451035544, 10582.365058096539, 10838.241323107464, 10842.132629389629, 10862.34825910448, 21679.241226556995, 22046.11815527361, 22071.0, 22310.996005179804, 22386.328410147722, 7709.884351734729, 7726.922730772732, 7773.339266162439, 7852.685892564347, 7865.213478652204, 4251.426057482262, 4288.24955632763, 4385.561443855653, 4423.690341676116, 4436.955630443719, 3402.880899168567, 3450.1719587298867, 3483.89548313551, 3487.1805125795418, 3496.283261931298, 629.9433051025338, 639.4213237020504, 639.5810743962712, 652.5399593286721, 664.6875968294991, 659.6470888074857, 662.7050962321721, 688.1054628982303, 689.3210187964851, 704.383664293743, 10102.0, 10189.046774717208, 10366.015228553275, 10456.163506919429, 10485.790284194274, 660.6729668813872, 688.6502455187788, 697.3201128899283, 709.8260926073145, 723.0780754538006, 4957.0, 4993.475685053089, 5020.2720605511995, 5058.671186372948, 5060.7722652480725, 84933.57533212418, 107889.0, 112930.43534782274, 113955.0, 114950.0, 80118.59940700259, 81606.18393816105, 82069.17930820615, 82274.58862705767, 84838.57580712056, 60372.09441858464, 75206.87189692158, 76104.61947690338, 76151.23848761553, 76783.61608192035, 8031.35749140079, 11073.83389249178, 11240.775184496428, 11309.773804523698, 11438.885611143782, 44567.0, 48940.0, 49619.0, 51507.0, 51640.74179629078, 63065.0, 67765.61171941482, 70818.0, 71032.09323487258, 73003.0, 9849.606015759577, 10789.40658263803, 11287.153463490435, 12898.806517902427, 13263.071584988958, 14885.776713349092, 15082.849171508584, 15119.017263877813, 15229.695406091594, 15538.378464861731, 11346.432678365883, 13877.236751978335, 14166.291685415481, 14196.858031419966, 14659.633509162357, 12076.45655945467, 13409.664758380728, 13628.93185534066, 14096.929515352358, 14443.638909027359, 13293.933530332286, 13747.725045499234, 13851.861481385056, 14083.155010699391, 14319.427222910967, 11105.0, 11184.552617895193, 11363.886361136283, 11520.481578329163, 11693.356865372487, 9685.515724213621, 10616.150707943192, 11359.659210223706, 11491.310521368745, 11582.88417115818], "value": 7638.875610068969, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 117.0, 120.0, 119.0, 118.0, 121.0, 118.0, 119.0, 121.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 152.0, 184.0, 114.0, 114.0, 115.0, 117.0, 119.0, 151.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 197.0, 237.0, 286.0, 206.0, 197.0, 196.0, 201.0, 197.0], "value": 211.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 61.0, 56.0, 89.0, 89.0, 63.0, 60.0, 61.0, 76.0, 59.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 69.0, 85.0, 69.0, 73.0, 71.0, 84.0, 95.0, 102.0, 97.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 95.0, 89.0, 119.0, 139.0, 138.0, 87.0, 89.0, 93.0], "value": 102.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 95.0, 140.0, 92.0, 155.0, 99.0, 98.0, 157.0, 156.0, 127.0], "value": 122.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 106.0, 90.0, 91.0, 90.0, 97.0, 142.0, 111.0, 134.0, 141.0], "value": 108.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 69.0, 63.0, 58.0, 99.0, 109.0, 110.0, 104.0, 68.0, 70.0], "value": 80.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 61.0, 64.0, 62.0, 58.0, 62.0, 60.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 83.0, 86.0, 77.0, 92.0, 75.0, 108.0, 105.0, 104.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 147.0, 149.0, 159.0, 150.0, 152.0, 164.0, 150.0, 206.0, 152.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 168.0, 167.0, 169.0, 191.0, 169.0, 170.0, 170.0, 170.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 80.0, 89.0, 83.0, 86.0, 86.0, 68.0, 62.0, 67.0], "value": 75.5, "unit": "score"}]}]} 02:56:29 INFO - Return code: 0 02:56:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:56:29 ERROR - # TBPL SUCCESS # 02:56:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:29 INFO - 2017-03-24 02:56:29.180 screenresolution[2344:78368] starting screenresolution argv=screenresolution get 02:56:29 INFO - 2017-03-24 02:56:29.182 screenresolution[2344:78368] Display 0: 1600x1200x32@60 02:56:29 INFO - 2017-03-24 02:56:29.188 screenresolution[2345:78371] starting screenresolution argv=screenresolution list 02:56:29 INFO - Available Modes on Display 0 02:56:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:29 INFO - Intel Iris: 02:56:29 INFO - Chipset Model: Intel Iris 02:56:29 INFO - Type: GPU 02:56:29 INFO - Bus: Built-In 02:56:29 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:29 INFO - Vendor: Intel (0x8086) 02:56:29 INFO - Device ID: 0x0a2e 02:56:29 INFO - Revision ID: 0x0009 02:56:29 INFO - Displays: 02:56:29 INFO - Display: 02:56:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:29 INFO - Display Serial Number: 1600x1200 60 02:56:29 INFO - Main Display: Yes 02:56:29 INFO - Mirror: Off 02:56:29 INFO - Online: Yes 02:56:29 INFO - Rotation: Supported 02:56:29 INFO - Return code: 0 02:56:29 INFO - Running post-action listener: _resource_record_post_action 02:56:29 INFO - [mozharness: 2017-03-24 09:56:29.424555Z] Finished run-tests step (success) 02:56:29 INFO - Running post-run listener: _resource_record_post_run 02:56:29 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 991232; Write bytes: 512067072; Read time: 9; Write time: 1708 02:56:29 INFO - TinderboxPrint: CPU usage
54.7% 02:56:29 INFO - TinderboxPrint: I/O read bytes / time
991,232 / 9 02:56:29 INFO - TinderboxPrint: I/O write bytes / time
512,067,072 / 1,708 02:56:29 INFO - TinderboxPrint: CPU idle
2,174.6 (45.3%) 02:56:29 INFO - TinderboxPrint: CPU system
972.4 (20.3%) 02:56:29 INFO - TinderboxPrint: CPU user
1,654.7 (34.5%) 02:56:29 INFO - TinderboxPrint: Swap in / out
209,203,200 / 0 02:56:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206301696; Write bytes: 202491904; Read time: 15625; Write time: 509 02:56:29 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 978944; Write bytes: 298524160; Read time: 9; Write time: 1160 02:56:29 INFO - Running post-run listener: _upload_blobber_files 02:56:29 INFO - Blob upload gear active. 02:56:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:29 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 02:56:29 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:29 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:31 INFO - (blobuploader) - INFO - Done attempting. 02:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:32 INFO - (blobuploader) - INFO - Done attempting. 02:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:32 INFO - (blobuploader) - INFO - Done attempting. 02:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:35 INFO - (blobuploader) - INFO - Done attempting. 02:56:35 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:35 INFO - Return code: 0 02:56:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30e1d86c18db92dee1a01707074d478b853c71007a37751cc6e19c945e81c46185ebe31cc99649b5dd3b4d918ef691d899251289d88c361dd16683604487a032", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3568d081fb3dd3a67103056b4ea93ecba627e3638bfad57cec02ca702cca3f0d22d89bdf30decbecaec38337d0156d4cff5a66d92ffa9f23822a40e84fa8517", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ef9b066edfacb2018297b90e053e4cc1ef4e6603b226fb1eff09942ef25743fb87b9a31d2728bfd03cc3f4fc024bb1963d09276324326143b6c01655bd561b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bab51d5cf1f745c3c10a159910696f340ed332bea705560c99ce76ce1a24afd8a0f71ab6b6bbbc7556dbb81d5ca48bd14d478de901a29abe154556ca102c2cbf"} 02:56:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:35 INFO - Contents: 02:56:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30e1d86c18db92dee1a01707074d478b853c71007a37751cc6e19c945e81c46185ebe31cc99649b5dd3b4d918ef691d899251289d88c361dd16683604487a032", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3568d081fb3dd3a67103056b4ea93ecba627e3638bfad57cec02ca702cca3f0d22d89bdf30decbecaec38337d0156d4cff5a66d92ffa9f23822a40e84fa8517", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ef9b066edfacb2018297b90e053e4cc1ef4e6603b226fb1eff09942ef25743fb87b9a31d2728bfd03cc3f4fc024bb1963d09276324326143b6c01655bd561b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bab51d5cf1f745c3c10a159910696f340ed332bea705560c99ce76ce1a24afd8a0f71ab6b6bbbc7556dbb81d5ca48bd14d478de901a29abe154556ca102c2cbf"} 02:56:35 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:35 INFO - Copying logs to upload dir... 02:56:35 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.823213 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-24 02:56:35.350477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 02:56:35.354396) ========= 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.h2Lsf78eAm/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.trUfo0y6IL/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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-Aurora/sha512/30e1d86c18db92dee1a01707074d478b853c71007a37751cc6e19c945e81c46185ebe31cc99649b5dd3b4d918ef691d899251289d88c361dd16683604487a032", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3568d081fb3dd3a67103056b4ea93ecba627e3638bfad57cec02ca702cca3f0d22d89bdf30decbecaec38337d0156d4cff5a66d92ffa9f23822a40e84fa8517", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ef9b066edfacb2018297b90e053e4cc1ef4e6603b226fb1eff09942ef25743fb87b9a31d2728bfd03cc3f4fc024bb1963d09276324326143b6c01655bd561b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bab51d5cf1f745c3c10a159910696f340ed332bea705560c99ce76ce1a24afd8a0f71ab6b6bbbc7556dbb81d5ca48bd14d478de901a29abe154556ca102c2cbf"} build_url:https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010999 build_url: 'https://queue.taskcluster.net/v1/task/FcOziXOeRpuqNS749P4fKA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30e1d86c18db92dee1a01707074d478b853c71007a37751cc6e19c945e81c46185ebe31cc99649b5dd3b4d918ef691d899251289d88c361dd16683604487a032", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3568d081fb3dd3a67103056b4ea93ecba627e3638bfad57cec02ca702cca3f0d22d89bdf30decbecaec38337d0156d4cff5a66d92ffa9f23822a40e84fa8517", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ef9b066edfacb2018297b90e053e4cc1ef4e6603b226fb1eff09942ef25743fb87b9a31d2728bfd03cc3f4fc024bb1963d09276324326143b6c01655bd561b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bab51d5cf1f745c3c10a159910696f340ed332bea705560c99ce76ce1a24afd8a0f71ab6b6bbbc7556dbb81d5ca48bd14d478de901a29abe154556ca102c2cbf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 02:56:35.388369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:56:35.388798) ========= 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.h2Lsf78eAm/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.trUfo0y6IL/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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.005213 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:56:35.437832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 02:56:35.438148) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 02:56:35.438453) ========= ========= Total master_lag: 0.19 =========