builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0131 starttime: 1488622364.76 results: success (0) buildid: 20170304004003 builduid: 908ec1f2444a41d5bf72d90feaa9a2d0 revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:44.760176) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:44.760654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:44.760976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:44.786923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 02:12:44.787310) ========= 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.pPu1fvYc8U/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.ax09j26OnI/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-04 02:12:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-03-04 02:12:45 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.164422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 02:12:45.975656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:45.975985) ========= 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.pPu1fvYc8U/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.ax09j26OnI/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.022185 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:46.025663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-04 02:12:46.026038) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --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 e11b1a808700d7428c6ce94ca22921ae000424c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pPu1fvYc8U/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.ax09j26OnI/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-04 02:12:45,971 truncating revision to first 12 chars 2017-03-04 02:12:45,972 Setting DEBUG logging. 2017-03-04 02:12:45,972 attempt 1/10 2017-03-04 02:12:45,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e11b1a808700?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-04 02:12:48,489 unpacking tar archive at: mozilla-aurora-e11b1a808700/testing/mozharness/ program finished with exit code 0 elapsedTime=2.768715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-04 02:12:48.818662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.819177) ========= script_repo_revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.819572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.819851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.840317) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 50 secs) (at 2017-03-04 02:12:48.840829) ========= /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.pPu1fvYc8U/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.ax09j26OnI/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:12:48 INFO - MultiFileLogger online at 20170304 02:12:48 in /builds/slave/test 02:12:48 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:12:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:48 INFO - {'append_to_log': False, 02:12:48 INFO - 'base_work_dir': '/builds/slave/test', 02:12:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:12:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:48 INFO - 'branch': 'Mozilla-Aurora', 02:12:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:48 INFO - 'config_files': ('talos/mac_config.py',), 02:12:48 INFO - 'default_actions': ('clobber', 02:12:48 INFO - 'read-buildbot-config', 02:12:48 INFO - 'download-and-extract', 02:12:48 INFO - 'populate-webroot', 02:12:48 INFO - 'create-virtualenv', 02:12:48 INFO - 'install', 02:12:48 INFO - 'run-tests'), 02:12:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:48 INFO - 'download_minidump_stackwalk': True, 02:12:48 INFO - 'download_symbols': 'ondemand', 02:12:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:48 INFO - 'installer_path': 'installer.exe', 02:12:48 INFO - 'log_level': 'info', 02:12:48 INFO - 'log_name': 'talos', 02:12:48 INFO - 'log_to_console': True, 02:12:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:12:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:12:48 INFO - 'opt_config_files': (), 02:12:48 INFO - 'pip_index': False, 02:12:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:12:48 INFO - 'cmd': ('bash', 02:12:48 INFO - '-c', 02:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:12:48 INFO - 'enabled': True, 02:12:48 INFO - 'halt_on_failure': False, 02:12:48 INFO - 'name': 'check_screen_resolution'},), 02:12:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:12:48 INFO - 'cmd': ('bash', 02:12:48 INFO - '-c', 02:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:12:48 INFO - 'enabled': True, 02:12:48 INFO - 'halt_on_failure': False, 02:12:48 INFO - 'name': 'check_screen_resolution'},), 02:12:48 INFO - 'run_cmd_checks_enabled': True, 02:12:48 INFO - 'sps_profile': False, 02:12:48 INFO - 'sps_profile_interval': 0, 02:12:48 INFO - 'suite': 'dromaeojs-e10s', 02:12:48 INFO - 'system_bits': '32', 02:12:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:48 INFO - 'title': 't-yosemite-r7-0131', 02:12:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:48 INFO - 'use_talos_json': True, 02:12:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:48 INFO - 'work_dir': 'build'} 02:12:48 INFO - [mozharness: 2017-03-04 10:12:48.910249Z] Running clobber step. 02:12:48 INFO - Running pre-action listener: _resource_record_pre_action 02:12:48 INFO - Running main action method: clobber 02:12:48 INFO - rmtree: /builds/slave/test/build 02:12:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:51 INFO - Running post-action listener: _resource_record_post_action 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.126107Z] Finished clobber step (success) 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.126259Z] Running read-buildbot-config step. 02:12:51 INFO - Running pre-action listener: _resource_record_pre_action 02:12:51 INFO - Running main action method: read_buildbot_config 02:12:51 INFO - Using buildbot properties: 02:12:51 INFO - { 02:12:51 INFO - "project": "", 02:12:51 INFO - "product": "firefox", 02:12:51 INFO - "script_repo_revision": "production", 02:12:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:12:51 INFO - "repository": "", 02:12:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:12:51 INFO - "buildid": "20170304004003", 02:12:51 INFO - "stage_platform": "macosx64", 02:12:51 INFO - "basedir": "/builds/slave/test", 02:12:51 INFO - "nightly_build": "True", 02:12:51 INFO - "buildnumber": 3, 02:12:51 INFO - "slavename": "t-yosemite-r7-0131", 02:12:51 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:12:51 INFO - "platform": "yosemite_r7", 02:12:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:12:51 INFO - "branch": "mozilla-aurora", 02:12:51 INFO - "repo_path": "releases/mozilla-aurora", 02:12:51 INFO - "revision": "e11b1a808700d7428c6ce94ca22921ae000424c1", 02:12:51 INFO - "pgo_build": "False", 02:12:51 INFO - "builduid": "908ec1f2444a41d5bf72d90feaa9a2d0", 02:12:51 INFO - "slavebuilddir": "test" 02:12:51 INFO - } 02:12:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:12:51 INFO - Running post-action listener: _resource_record_post_action 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.130884Z] Finished read-buildbot-config step (success) 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.131066Z] Running download-and-extract step. 02:12:51 INFO - Running pre-action listener: _resource_record_pre_action 02:12:51 INFO - Running main action method: download_and_extract 02:12:51 INFO - mkdir: /builds/slave/test/build/tests 02:12:51 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:12:51 INFO - trying https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:12:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:12:53 INFO - Downloaded 1199 bytes. 02:12:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:12:53 INFO - Using the following test package requirements: 02:12:53 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:12:53 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:12:53 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:12:53 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'jsshell-mac.zip'], 02:12:53 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:12:53 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:12:53 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:12:53 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:12:53 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:12:53 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:12:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:12:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:12:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:12:54 INFO - Expected file size: 16357897 02:12:54 INFO - Obtained file size: 16357897 02:13:00 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:13:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:13:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:13:00 INFO - Fetch https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:13:01 INFO - Expected file size: 16357897 02:13:01 INFO - Obtained file size: 16357897 02:13:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:13:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:13:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:13:22 INFO - Expected file size: 14403650 02:13:22 INFO - Obtained file size: 14403650 02:13: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:13:22 INFO - trying https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:13:22 INFO - Downloading https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:14:15 INFO - Downloaded 74004951 bytes. 02:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:14:15 INFO - mkdir: /builds/slave/test/properties 02:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:15 INFO - Contents: 02:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:14:17 INFO - Running post-action listener: _resource_record_post_action 02:14:17 INFO - Running post-action listener: set_extra_try_arguments 02:14:17 INFO - [mozharness: 2017-03-04 10:14:17.950363Z] Finished download-and-extract step (success) 02:14:17 INFO - [mozharness: 2017-03-04 10:14:17.950500Z] Running populate-webroot step. 02:14:17 INFO - Running pre-action listener: _resource_record_pre_action 02:14:17 INFO - Running main action method: populate_webroot 02:14:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:17 INFO - '--tppagecycles', 02:14:17 INFO - '7'], 02:14:17 INFO - 'tests': ['tsvgm']}}, 02:14:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:14:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:14:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:14:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['damp', 'tps']}, 02:14:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'tests': ['damp', 'tps']}, 02:14:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['dromaeo_dom']}, 02:14:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['basic_compositor_video']}, 02:14:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:14:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['a11yr', 02:14:17 INFO - 'ts_paint', 02:14:17 INFO - 'tpaint', 02:14:17 INFO - 'sessionrestore', 02:14:17 INFO - 'sessionrestore_no_auto_restore', 02:14:17 INFO - 'tabpaint']}, 02:14:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:14:17 INFO - 'ts_paint', 02:14:17 INFO - 'tpaint', 02:14:17 INFO - 'sessionrestore', 02:14:17 INFO - 'sessionrestore_no_auto_restore', 02:14:17 INFO - 'tabpaint']}, 02:14:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:14:17 INFO - 'ts_paint', 02:14:17 INFO - 'tpaint', 02:14:17 INFO - 'sessionrestore', 02:14:17 INFO - 'sessionrestore_no_auto_restore', 02:14:17 INFO - 'tabpaint']}, 02:14:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:14:17 INFO - 'ts_paint', 02:14:17 INFO - 'tpaint', 02:14:17 INFO - 'sessionrestore', 02:14:17 INFO - 'sessionrestore_no_auto_restore', 02:14:17 INFO - 'tabpaint']}, 02:14:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['a11yr', 02:14:17 INFO - 'ts_paint', 02:14:17 INFO - 'tpaint', 02:14:17 INFO - 'sessionrestore', 02:14:17 INFO - 'sessionrestore_no_auto_restore', 02:14:17 INFO - 'tabpaint']}, 02:14:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['a11yr', 02:14:17 INFO - 'ts_paint', 02:14:17 INFO - 'tpaint', 02:14:17 INFO - 'sessionrestore', 02:14:17 INFO - 'sessionrestore_no_auto_restore', 02:14:17 INFO - 'tabpaint']}, 02:14:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['tsvgx', 02:14:17 INFO - 'tsvgr_opacity', 02:14:17 INFO - 'tart', 02:14:17 INFO - 'tscrollx', 02:14:17 INFO - 'cart', 02:14:17 INFO - 'tsvg_static']}, 02:14:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:14:17 INFO - 'tsvgr_opacity', 02:14:17 INFO - 'tart', 02:14:17 INFO - 'tscrollx', 02:14:17 INFO - 'cart', 02:14:17 INFO - 'tsvg_static']}, 02:14:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'talos_options': ['--disable-e10s'], 02:14:17 INFO - 'tests': ['tp5o']}, 02:14:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:14:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'talos_options': ['--disable-e10s', 02:14:17 INFO - '--xperf_path', 02:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:17 INFO - 'tests': ['tp5n']}, 02:14:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:14:17 INFO - 'talos_options': ['--xperf_path', 02:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:17 INFO - 'tests': ['tp5n']}}, 02:14:17 INFO - 'talos.zip': {'path': '', 02:14:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:17 INFO - Running post-action listener: _resource_record_post_action 02:14:17 INFO - [mozharness: 2017-03-04 10:14:17.968673Z] Finished populate-webroot step (success) 02:14:17 INFO - [mozharness: 2017-03-04 10:14:17.968789Z] Running create-virtualenv step. 02:14:17 INFO - Running pre-action listener: _resource_record_pre_action 02:14:17 INFO - Running main action method: create_virtualenv 02:14:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:14:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:18 INFO - Using real prefix '/tools/python27' 02:14:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:21 INFO - Installing pip.................done. 02:14:21 INFO - Return code: 0 02:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:14:21 INFO - Reading from file tmpfile_stdout 02:14:21 INFO - Output received: 02:14:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:14:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:23 INFO - 'HOME': '/Users/cltbld', 02:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:23 INFO - 'LOGNAME': 'cltbld', 02:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:23 INFO - 'MOZ_NO_REMOTE': '1', 02:14:23 INFO - 'NO_EM_RESTART': '1', 02:14:23 INFO - 'PAGER': '/bin/cat', 02:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:23 INFO - 'PWD': '/builds/slave/test', 02:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:23 INFO - 'SHELL': '/bin/bash', 02:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:14:23 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:23 INFO - 'USER': 'cltbld', 02:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:23 INFO - 'XPC_FLAGS': '0x0', 02:14:23 INFO - 'XPC_SERVICE_NAME': '0', 02:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:24 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:14:24 INFO - Cleaning up... 02:14:24 INFO - Return code: 0 02:14:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:24 INFO - 'HOME': '/Users/cltbld', 02:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:24 INFO - 'LOGNAME': 'cltbld', 02:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:24 INFO - 'MOZ_NO_REMOTE': '1', 02:14:24 INFO - 'NO_EM_RESTART': '1', 02:14:24 INFO - 'PAGER': '/bin/cat', 02:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:24 INFO - 'PWD': '/builds/slave/test', 02:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:24 INFO - 'SHELL': '/bin/bash', 02:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:14:24 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:24 INFO - 'USER': 'cltbld', 02:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:24 INFO - 'XPC_FLAGS': '0x0', 02:14:24 INFO - 'XPC_SERVICE_NAME': '0', 02:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:24 INFO - Downloading/unpacking psutil>=3.1.1 02:14: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:14: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:14: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:14: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:14: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:14: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:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:41 INFO - Installing collected packages: psutil 02:14:41 INFO - Running setup.py install for psutil 02:14:41 INFO - building 'psutil._psutil_osx' extension 02:14:41 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:14:41 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:14:41 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:14:42 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:14:42 INFO - building 'psutil._psutil_posix' extension 02:14:42 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:14:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:14:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:14:42 INFO - ^ 02:14:42 INFO - 1 warning generated. 02:14:42 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:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:42 INFO - Successfully installed psutil 02:14:42 INFO - Cleaning up... 02:14:42 INFO - Return code: 0 02:14:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14:42 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:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:42 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:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:42 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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:14:42 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:14:42 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:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:42 INFO - 'HOME': '/Users/cltbld', 02:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:42 INFO - 'LOGNAME': 'cltbld', 02:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:42 INFO - 'MOZ_NO_REMOTE': '1', 02:14:42 INFO - 'NO_EM_RESTART': '1', 02:14:42 INFO - 'PAGER': '/bin/cat', 02:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:42 INFO - 'PWD': '/builds/slave/test', 02:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:42 INFO - 'SHELL': '/bin/bash', 02:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:14:42 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:42 INFO - 'USER': 'cltbld', 02:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:42 INFO - 'XPC_FLAGS': '0x0', 02:14:42 INFO - 'XPC_SERVICE_NAME': '0', 02:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:46 INFO - Installing collected packages: mozsystemmonitor 02:14:46 INFO - Running setup.py install for mozsystemmonitor 02:14:46 INFO - Successfully installed mozsystemmonitor 02:14:46 INFO - Cleaning up... 02:14:47 INFO - Return code: 0 02:14:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:14:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:14:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:47 INFO - 'HOME': '/Users/cltbld', 02:14:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:47 INFO - 'LOGNAME': 'cltbld', 02:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:47 INFO - 'MOZ_NO_REMOTE': '1', 02:14:47 INFO - 'NO_EM_RESTART': '1', 02:14:47 INFO - 'PAGER': '/bin/cat', 02:14:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:47 INFO - 'PWD': '/builds/slave/test', 02:14:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:47 INFO - 'SHELL': '/bin/bash', 02:14:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:14:47 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:14:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:47 INFO - 'USER': 'cltbld', 02:14:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:47 INFO - 'XPC_FLAGS': '0x0', 02:14:47 INFO - 'XPC_SERVICE_NAME': '0', 02:14:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:56 INFO - warning: no files found matching '*.txt' 02:14:56 INFO - no previously-included directories found matching 'build' 02:14:56 INFO - no previously-included directories found matching 'dist' 02:14:56 INFO - no previously-included directories found matching '.git*' 02:14:56 INFO - Installing collected packages: jsonschema, functools32 02:14:56 INFO - Running setup.py install for functools32 02:14:56 INFO - warning: no files found matching '*.txt' 02:14:56 INFO - no previously-included directories found matching 'build' 02:14:56 INFO - no previously-included directories found matching 'dist' 02:14:56 INFO - no previously-included directories found matching '.git*' 02:14:56 INFO - Successfully installed jsonschema functools32 02:14:56 INFO - Cleaning up... 02:14:57 INFO - Return code: 0 02:14:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:14:57 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:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:57 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:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:57 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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:14:57 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:14:57 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:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:57 INFO - 'HOME': '/Users/cltbld', 02:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:57 INFO - 'LOGNAME': 'cltbld', 02:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:57 INFO - 'MOZ_NO_REMOTE': '1', 02:14:57 INFO - 'NO_EM_RESTART': '1', 02:14:57 INFO - 'PAGER': '/bin/cat', 02:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:57 INFO - 'PWD': '/builds/slave/test', 02:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:57 INFO - 'SHELL': '/bin/bash', 02:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:14:57 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:57 INFO - 'USER': 'cltbld', 02:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:57 INFO - 'XPC_FLAGS': '0x0', 02:14:57 INFO - 'XPC_SERVICE_NAME': '0', 02:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:14:57 INFO - Cleaning up... 02:14:57 INFO - Return code: 0 02:14:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:57 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:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:57 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:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:57 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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:14:57 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:14:57 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:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:57 INFO - 'HOME': '/Users/cltbld', 02:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:57 INFO - 'LOGNAME': 'cltbld', 02:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:57 INFO - 'MOZ_NO_REMOTE': '1', 02:14:57 INFO - 'NO_EM_RESTART': '1', 02:14:57 INFO - 'PAGER': '/bin/cat', 02:14:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:57 INFO - 'PWD': '/builds/slave/test', 02:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:57 INFO - 'SHELL': '/bin/bash', 02:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:14:57 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:57 INFO - 'USER': 'cltbld', 02:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:57 INFO - 'XPC_FLAGS': '0x0', 02:14:57 INFO - 'XPC_SERVICE_NAME': '0', 02:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:14:57 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:15:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:15:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:15: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:15: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:15: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:15: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:15: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:15: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:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:15:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:15: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:15: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:15: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:15: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:15: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:15: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:15:16 INFO - Downloading docopt-0.6.1.tar.gz 02:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:15:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:15:16 INFO - Running setup.py install for blobuploader 02:15:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:15:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:15:17 INFO - Running setup.py install for requests 02:15:17 INFO - Running setup.py install for docopt 02:15:17 INFO - Successfully installed blobuploader requests docopt 02:15:17 INFO - Cleaning up... 02:15:17 INFO - Return code: 0 02:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15: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:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:15: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:15: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:15:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:15:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:17 INFO - 'HOME': '/Users/cltbld', 02:15:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:17 INFO - 'LOGNAME': 'cltbld', 02:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:17 INFO - 'MOZ_NO_REMOTE': '1', 02:15:17 INFO - 'NO_EM_RESTART': '1', 02:15:17 INFO - 'PAGER': '/bin/cat', 02:15:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:17 INFO - 'PWD': '/builds/slave/test', 02:15:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:17 INFO - 'SHELL': '/bin/bash', 02:15:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:15:17 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:15:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:17 INFO - 'USER': 'cltbld', 02:15:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:17 INFO - 'XPC_FLAGS': '0x0', 02:15:17 INFO - 'XPC_SERVICE_NAME': '0', 02:15:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-aI8U7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-t_YUv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-0K1Ch9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-3qJK_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-3Ab39C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-6ltGqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-tPh2Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-pTNVbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-dJG2dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-lWhjop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-BlNBlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-c9IBkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Z_IX0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-CoCDMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-rBtXbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-SGD92m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hQ_6HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:15:19 INFO - Running setup.py install for manifestparser 02:15:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:15:19 INFO - Running setup.py install for mozcrash 02:15:20 INFO - Running setup.py install for mozdebug 02:15:20 INFO - Running setup.py install for mozdevice 02:15:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Running setup.py install for mozfile 02:15:20 INFO - Running setup.py install for mozhttpd 02:15:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Running setup.py install for mozinfo 02:15:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Running setup.py install for mozInstall 02:15:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:15:20 INFO - Running setup.py install for mozleak 02:15:21 INFO - Running setup.py install for mozlog 02:15:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:15:21 INFO - Running setup.py install for moznetwork 02:15:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:15:21 INFO - Running setup.py install for mozprocess 02:15:21 INFO - Running setup.py install for mozprofile 02:15:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:15:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:15:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:15:21 INFO - Running setup.py install for mozrunner 02:15:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:15:21 INFO - Running setup.py install for mozscreenshot 02:15:22 INFO - Running setup.py install for moztest 02:15:22 INFO - Running setup.py install for mozversion 02:15:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:15:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:15:22 INFO - Cleaning up... 02:15:22 INFO - Return code: 0 02:15:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15: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:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:24 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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:15:24 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:15:24 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:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:24 INFO - 'HOME': '/Users/cltbld', 02:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:24 INFO - 'LOGNAME': 'cltbld', 02:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:24 INFO - 'MOZ_NO_REMOTE': '1', 02:15:24 INFO - 'NO_EM_RESTART': '1', 02:15:24 INFO - 'PAGER': '/bin/cat', 02:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:24 INFO - 'PWD': '/builds/slave/test', 02:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:24 INFO - 'SHELL': '/bin/bash', 02:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:15:24 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:24 INFO - 'USER': 'cltbld', 02:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:24 INFO - 'XPC_FLAGS': '0x0', 02:15:24 INFO - 'XPC_SERVICE_NAME': '0', 02:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-aVve9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Q_oGJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-jbXl3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-JdEshX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-3Zla5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-bcMxTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-AEpdli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Nr4PbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-1VajAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-__rokX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-NB6lKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-8DRb5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TDO0FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-NvdKmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-aUXCzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-O3MY0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:26 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-HLNBx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:27 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:15:33 INFO - Downloading blessings-1.6.tar.gz 02:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:15:34 INFO - Installing collected packages: blessings 02:15:34 INFO - Running setup.py install for blessings 02:15:34 INFO - Successfully installed blessings 02:15:34 INFO - Cleaning up... 02:15:34 INFO - Return code: 0 02:15:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:34 INFO - Reading from file tmpfile_stdout 02:15:34 INFO - Current package versions: 02:15:34 INFO - blessings == 1.6 02:15:34 INFO - blobuploader == 1.2.4 02:15:34 INFO - docopt == 0.6.1 02:15:34 INFO - functools32 == 3.2.3-2 02:15:34 INFO - jsonschema == 2.5.1 02:15:34 INFO - manifestparser == 1.1 02:15:34 INFO - mozInstall == 1.12 02:15:34 INFO - mozcrash == 1.0 02:15:34 INFO - mozdebug == 0.1 02:15:34 INFO - mozdevice == 0.49 02:15:34 INFO - mozfile == 1.2 02:15:34 INFO - mozhttpd == 0.7 02:15:34 INFO - mozinfo == 0.9 02:15:34 INFO - mozleak == 0.1 02:15:34 INFO - mozlog == 3.4 02:15:34 INFO - moznetwork == 0.27 02:15:34 INFO - mozprocess == 0.24 02:15:34 INFO - mozprofile == 0.28 02:15:34 INFO - mozrunner == 6.13 02:15:34 INFO - mozscreenshot == 0.1 02:15:34 INFO - mozsystemmonitor == 0.3 02:15:34 INFO - moztest == 0.8 02:15:34 INFO - mozversion == 1.4 02:15:34 INFO - psutil == 3.1.1 02:15:34 INFO - requests == 1.2.3 02:15:34 INFO - wsgiref == 0.1.2 02:15:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:34 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 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:15:34 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:15:34 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:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:34 INFO - 'HOME': '/Users/cltbld', 02:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:34 INFO - 'LOGNAME': 'cltbld', 02:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:34 INFO - 'MOZ_NO_REMOTE': '1', 02:15:34 INFO - 'NO_EM_RESTART': '1', 02:15:34 INFO - 'PAGER': '/bin/cat', 02:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:34 INFO - 'PWD': '/builds/slave/test', 02:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:34 INFO - 'SHELL': '/bin/bash', 02:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:15:34 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:34 INFO - 'USER': 'cltbld', 02:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:34 INFO - 'XPC_FLAGS': '0x0', 02:15:34 INFO - 'XPC_SERVICE_NAME': '0', 02:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 INFO - Cleaning up... 02:15:34 INFO - Return code: 0 02:15:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c45b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c48768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb97b5d5d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, '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.pPu1fvYc8U/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.ax09j26OnI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:34 INFO - 'HOME': '/Users/cltbld', 02:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:34 INFO - 'LOGNAME': 'cltbld', 02:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:34 INFO - 'MOZ_NO_REMOTE': '1', 02:15:34 INFO - 'NO_EM_RESTART': '1', 02:15:34 INFO - 'PAGER': '/bin/cat', 02:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:34 INFO - 'PWD': '/builds/slave/test', 02:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:34 INFO - 'SHELL': '/bin/bash', 02:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:15:34 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:34 INFO - 'USER': 'cltbld', 02:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:34 INFO - 'XPC_FLAGS': '0x0', 02:15:34 INFO - 'XPC_SERVICE_NAME': '0', 02:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:15:35 INFO - Cleaning up... 02:15:35 INFO - Return code: 0 02:15:35 INFO - Running post-action listener: _resource_record_post_action 02:15:35 INFO - Running post-action listener: _start_resource_monitoring 02:15:35 INFO - Starting resource monitoring. 02:15:35 INFO - [mozharness: 2017-03-04 10:15:35.201868Z] Finished create-virtualenv step (success) 02:15:35 INFO - [mozharness: 2017-03-04 10:15:35.202830Z] Running install step. 02:15:35 INFO - Running pre-action listener: _resource_record_pre_action 02:15:35 INFO - Running main action method: install 02:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:35 INFO - Reading from file tmpfile_stdout 02:15:35 INFO - Detecting whether we're running mozinstall >=1.0... 02:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:15:35 INFO - Reading from file tmpfile_stdout 02:15:35 INFO - Output received: 02:15:35 INFO - Usage: mozinstall [options] installer 02:15:35 INFO - Options: 02:15:35 INFO - -h, --help show this help message and exit 02:15:35 INFO - -d DEST, --destination=DEST 02:15:35 INFO - Directory to install application into. [default: 02:15:35 INFO - "/builds/slave/test"] 02:15:35 INFO - --app=APP Application being installed. [default: firefox] 02:15:35 INFO - mkdir: /builds/slave/test/build/application 02:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:15:55 INFO - Reading from file tmpfile_stdout 02:15:55 INFO - Output received: 02:15:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:15:55 INFO - Running post-action listener: _resource_record_post_action 02:15:55 INFO - [mozharness: 2017-03-04 10:15:55.595628Z] Finished install step (success) 02:15:55 INFO - [mozharness: 2017-03-04 10:15:55.595798Z] Running run-tests step. 02:15:55 INFO - Running pre-action listener: _resource_record_pre_action 02:15:55 INFO - Running main action method: run_tests 02:15:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:15:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:15:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:15:55 INFO - 2017-03-04 02:15:55.610 screenresolution[3146:55158] starting screenresolution argv=screenresolution get 02:15:55 INFO - 2017-03-04 02:15:55.613 screenresolution[3146:55158] Display 0: 1600x1200x32@60 02:15:55 INFO - 2017-03-04 02:15:55.619 screenresolution[3147:55161] starting screenresolution argv=screenresolution list 02:15:55 INFO - Available Modes on Display 0 02:15:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:15:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:15:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:15:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:15:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:15:55 INFO - Intel Iris: 02:15:55 INFO - Chipset Model: Intel Iris 02:15:55 INFO - Type: GPU 02:15:55 INFO - Bus: Built-In 02:15:55 INFO - VRAM (Dynamic, Max): 1536 MB 02:15:55 INFO - Vendor: Intel (0x8086) 02:15:55 INFO - Device ID: 0x0a2e 02:15:55 INFO - Revision ID: 0x0009 02:15:55 INFO - Displays: 02:15:55 INFO - Display: 02:15:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:15:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:15:55 INFO - Display Serial Number: 1600x1200 60 02:15:55 INFO - Main Display: Yes 02:15:55 INFO - Mirror: Off 02:15:55 INFO - Online: Yes 02:15:55 INFO - Rotation: Supported 02:15:55 INFO - Return code: 0 02:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:55 INFO - Python 2.7.3 02:15:55 INFO - Return code: 0 02:15:55 INFO - grabbing minidump binary from tooltool 02:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:55 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 0x104a23d30>, '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 0x10494adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a18be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:55 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:15:55 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:15:55 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:15:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:55 INFO - Return code: 0 02:15:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:15:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:15:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:55 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/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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:15:55 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/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --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:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPu1fvYc8U/Render', 02:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:55 INFO - 'HOME': '/Users/cltbld', 02:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:55 INFO - 'LOGNAME': 'cltbld', 02:15:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:55 INFO - 'MOZ_NO_REMOTE': '1', 02:15:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:55 INFO - 'NO_EM_RESTART': '1', 02:15:55 INFO - 'PAGER': '/bin/cat', 02:15:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:55 INFO - 'PWD': '/builds/slave/test', 02:15:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:55 INFO - 'SHELL': '/bin/bash', 02:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ax09j26OnI/Listeners', 02:15:55 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 02:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:55 INFO - 'USER': 'cltbld', 02:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:55 INFO - 'XPC_FLAGS': '0x0', 02:15:55 INFO - 'XPC_SERVICE_NAME': '0', 02:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:55 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/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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:15:56 INFO - mozversion application_buildid: 20170304004003 02:15:56 INFO - mozversion application_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 02:15:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:15:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:56 INFO - mozversion application_name: Firefox 02:15:56 INFO - mozversion application_remotingname: firefox-dev 02:15:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:56 INFO - mozversion application_vendor: Mozilla 02:15:56 INFO - mozversion application_version: 53.0a2 02:15:56 INFO - mozversion platform_buildid: 20170304004003 02:15:56 INFO - mozversion platform_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 02:15:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:56 INFO - mozversion platform_version: 53.0a2 02:15:56 INFO - using testdate: 1488622556 02:15:56 INFO - actual date: 1488622556 02:15:56 INFO - starting webserver on 'localhost:63701' 02:15:56 INFO - SUITE-START | Running 2 tests 02:15:56 INFO - TEST-START | dromaeo_css 02:15:56 INFO - operating with platform_type : mac_ 02:15:56 INFO - Initialising browser for dromaeo_css test... 02:15:56 INFO - TEST-INFO | started process 3157 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpUznkap/profile http://localhost:63701/getInfo.html) 02:15:59 INFO - PROCESS | 3157 | 2017-03-04 02:15:59.276 plugin-container[3160:55335] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954f, name = 'com.apple.tsm.portname' 02:15:59 INFO - PROCESS | 3157 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:15:59 INFO - PROCESS | 3157 | 2017-03-04 02:15:59.276 plugin-container[3160:55335] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 02:15:59 INFO - PROCESS | 3157 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:15:59 INFO - PROCESS | 3157 | 2017-03-04 02:15:59.276 plugin-container[3160:55335] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:15:59 INFO - PROCESS | 3157 | __metrics Screen width/height:1600/1200 02:15:59 INFO - PROCESS | 3157 | colorDepth:24 02:15:59 INFO - PROCESS | 3157 | Browser inner width/height: 1024/689 02:15:59 INFO - PROCESS | 3157 | __metrics 02:15:59 ERROR - PROCESS | 3157 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:16:00 INFO - TEST-INFO | 3157: exit 0 02:16:00 INFO - Browser initialized. 02:16:00 INFO - Running cycle 1/1 for dromaeo_css test... 02:16:00 INFO - TEST-INFO | started process 3161 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpUznkap/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:02 INFO - PROCESS | 3161 | 2017-03-04 02:16:02.723 plugin-container[3162:55475] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 02:16:02 INFO - PROCESS | 3161 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:16:02 INFO - PROCESS | 3161 | 2017-03-04 02:16:02.724 plugin-container[3162:55475] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 02:16:02 INFO - PROCESS | 3161 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:16:02 INFO - PROCESS | 3161 | 2017-03-04 02:16:02.724 plugin-container[3162:55475] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:16:12 INFO - PROCESS | 3161 | RSS: Main: 218972160 02:16:12 INFO - PROCESS | 3161 | 02:19:14 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:63701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:63701/tests/dromaeo/cssquery-ext.html) 02:19:16 INFO - PROCESS | 3161 | RSS: Main: 239951872 02:19:16 INFO - PROCESS | 3161 | 02:21:00 INFO - PROCESS | 3161 | ************************* 02:21:00 INFO - PROCESS | 3161 | A coding exception was thrown and uncaught in a Task. 02:21:00 INFO - PROCESS | 3161 | 02:21:00 ERROR - PROCESS | 3161 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:21:00 INFO - PROCESS | 3161 | Full stack: 02:21:00 INFO - PROCESS | 3161 | ************************* 02:22:18 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:63701/tests/dromaeo/cssquery-ext.html (next: http://localhost:63701/tests/dromaeo/cssquery-jquery.html) 02:22:19 INFO - PROCESS | 3161 | RSS: Main: 246964224 02:22:19 INFO - PROCESS | 3161 | 02:25:21 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:63701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:63701/tests/dromaeo/cssquery-mootools.html) 02:25:22 INFO - PROCESS | 3161 | RSS: Main: 253284352 02:25:22 INFO - PROCESS | 3161 | 02:28:23 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:63701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:63701/tests/dromaeo/cssquery-prototype.html) 02:28:24 INFO - PROCESS | 3161 | RSS: Main: 249798656 02:28:24 INFO - PROCESS | 3161 | 02:31:27 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:63701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:63701/tests/dromaeo/cssquery-yui.html) 02:31:28 INFO - PROCESS | 3161 | RSS: Main: 253448192 02:31:28 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | Cycle 1(1): loaded http://localhost:63701/tests/dromaeo/cssquery-yui.html (next: http://localhost:63701/tests/dromaeo/cssquery-dojo.html) 02:34:31 INFO - PROCESS | 3161 | RSS: Main: 255795200 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | __start_tp_report 02:34:31 INFO - PROCESS | 3161 | _x_x_mozilla_page_load 02:34:31 INFO - PROCESS | 3161 | _x_x_mozilla_page_load_details 02:34:31 INFO - PROCESS | 3161 | |i|pagename|runs| 02:34:31 INFO - PROCESS | 3161 | |0;dojo.html;2923.2984083819874;3353.9496907546386;3380.273241253132;3414.334204830059;3436.8453419596117;5714.200011998319;5784.56615753818;5796.159556864252;5805.448482394171;5806.187133801266;5788.652680839153;5805.709714514279;5820.621659592134;5842.269716285465;5848.824535263938;5241.816536421226;5278.1291086970605;5291.729984803638;5329.493698098674;5340.225667278242;5249.711265880375;5253.264542963988;5338.145896656536;5356.196570514415;5374.274472946141;5153.871153221162;5181.870453238662;5192.896142077175;5289.603279753996;5290.629655924067;5201.55786758126;5253.894922101536;5272.182811664198;5280.234366016906;5287.973560132214;5199.324087868591;5207.791688332462;5211.1922651989;5225.294585230983;5289.867753306198;5628.774849006035;5640.182173584848;5691.231683722686;5729.570282228808;5797.623154494987;5596.832095037155;6027.547933904974;6217.751289948396;6242.906356404657;6247.781327653511;6209.534284928648;6212.130301757712;6213.844653883644;6220.34686357935;6225.8132256032395;5149.176131818966;5659.518940889988;5814.244148260741;5941.7920372787175;5983.282006159288;6190.81427557174;6235.906461403082;6236.906446403307;6250.281217660027;6318.241810982619;5222.634415590948;5782.190493330853;5975.492083172892;6207.255129384503;6229.252489701174;5454.372747134131;5708.743106560215;6249.78125765596;6257.937420625826;6269;5303.204519322056;6125.632462052202;6178.227721534809;6194.38056194386;6195.31851496335;6173.722182501798;6203.379662033761;6208.068789681584;6218.81343559694;6222.377762223741;5010.89978200434;5057.595392368602;5071.695698258116;5078;5082.237664350377;4442.666799989949;4443.0669559392245;4444.644428445717;4536.115457485825;4550.0899820035465;5865.237519122486;5927.73325200367;5981.820545383645;5995.2206213192;6048.697565121726;6110.133516259585;6224.968875155595;6250.593711408835;6263.217097862767;6266.467350275187;5822.446867547576;5894.528437724972;5930.406959304035;5951.851203719942;6036.788712395045;5554.527865131428;5559.388467268597;5573.052581061229;5578.30271216098;5581.023320918905;5529.806456773994;6434.64609446485;6435.774747883802;6440.581362211441;6442.452391546771;6124.899720462962;6139.1855040903665;6141.056449558148;6145.385461453998;6161.44546990773;6358.300586935341;6384.265809431975;6392.584482008655;6398.584092034003;6398.90401643985;6196.256449226122;6201.410865967726;6203.379662033761;6213.099100630293;6216.813495595139;5147.665401749025;6034.577579569564;6131.529590167291;6189.81430557084;6245.937540624717;6197.597156184834;6200.534959878118;6200.7519699211525;6203.937960620336;6219.253689557282;6191.690415479118;6194.38056194377;6206.627602343874;6210.161628180138;6212.782552610637;5814.970925145347;5962.522998160223;5976.312724036791;6063.181470501602;6118.418750218722;6117.431594453999;6210;6216.595921265103;6217.4715149212825;6226.439620434183;6131.54013449002;6138.478229350555;6141.938580614136;6153.13856060143;6160.907586386297 02:34:31 INFO - PROCESS | 3161 | |1;ext.html;479.1566842357452;501.87954890826205;512.8743457852827;514.0002694758696;576.8327185116317;31615.68384316156;40467.39298910519;40475.78572642818;40691.79654101733;40728.38907416391;42310;42975.14049719004;43039.78480107603;43068.78465607668;43081.569184308144;8393.53835539045;8594.398392112524;9106.681266155703;9449.338546301762;11400.71498212543;11310.208285420023;11544.884551154508;11559.075273978062;11568.768624627503;11588.304701717923;11572.247803892762;11609.071274298036;11612.6516204514;11616.186866919277;11677.883221167807;10132.290739648228;11536.653900383002;11547.769044619145;11594.76810463786;11603.129765267597;9996.100350968447;11313.660590182308;11433.656990290305;11469.483873225641;11484.540618375255;41006.1798764026;41115.97210069742;41223;41238;41238.79380603108;3116.3144108296137;3960.2277555876617;4055.168690418457;4062.9796851015853;4064.6748260139116;29806.956756513417;29866.552001719992;29983.550246746316;31218.687813121804;31583.368332633218;3017.1853599528004;3146.3078122812944;3264.2165880188822;3273.7053665170247;3274.9017529474154;473141;493069;515773;522823;524528;58991.705041475376;59477.70261148667;59487.40512594905;59518.40481595129;59641;61369.38630613726;61387.38612613817;61647;61819.763604727654;61922;15981.041137531785;16096.67806643884;16217.675646487005;16268.26792794327;16270.43053493122;11235.269707468988;11463.197576169589;12976.740465190644;13188.208707477583;13190.934045329712;20347.491312717004;22211;22272.88863555672;22297.55404891893;22331.106755729914;7789.298963093349;8859.89251343582;8905.643774249087;9043.914730232415;9131.452112873116;875.9781005474914;883.5405589093635;890.3055616618918;910.977225569366;928.2991341537096;29266.268343291587;29484;30367.24081897926;30554.69445305563;31093.22266943299;930.2186163622589;1023.6928921323573;1047.7107520068673;1055.567217440861;1078.9514471848786;14433.494827680981;14471.421143154155;14644.267786610626;14822.332995015251;14890.329935152944;688267;694073;695535;695842;696546;52833.47166528286;52986;53249.668758280575;53277.73361133247;53335.733321333144;1417.305520295048;1439.0502268502737;1449.2970909109074;1452.2883786944533;1453.6075259680038;23975.52048959046;27169;28144.74610905595;28332.71667283383;28474.85762571174;47432.2885156716;48012.7599362001;48077.51922480731;48081.519184809105;48123.278150827064;520553;525800;527574;528148;528989;25757.484850303263;25989.870050649624;26604.866975664998;26648;27193;42653.36019959641;43094.56905430905;43849.34225986677;44080;44148;36008.099797505274;36222.8188859054;36421.635783641825;36467.63532364748;37714.622853771114;36259.409150118365;36364.636353636124;37250.6274937258;37379.81310093432;37630.87107386783;33876;34702.30595388129;34704.65295347014;35979.46030809487;36026.63973360233;30024.24939376533;32032.35935281328;32204.355912881143;32378.838105809322;32380.514292286105;21745.34763957084;22791.772082278963;22902;23981.880090599436;24330.75669243285 02:34:31 INFO - PROCESS | 3161 | |2;jquery.html;392.3193259694431;399.24542614458676;403.26001786721366;405.7261348589702;427.78610694652673;18598;19104;21044.579108417824;21769.782302176955;21778.128874845006;21344.039518221678;21866.781332186674;21874.562508749816;21877.890610546965;22483.32550023498;5640.830775076744;5941.613795103304;5949.85125371867;5952.315483719362;5953.553483488734;5679.507103131565;5788.797392091277;5794.101914203306;5806.303243610772;5868.03177475716;5751.1373294006025;5784.884302313952;5787.855303617423;5789.710514474281;5790.305163380401;5461.15352120422;5742.885142297151;5779.566532510057;6026.939730602681;6047.455728984369;5892.823215303548;5894.292684877799;5904.881902361972;5940.2871655401195;5957.314908785502;13648.454061837614;13767.518136865161;13898.23559704216;13903.235322057282;15167.165805880672;2495.875206239699;2607.895684172631;2608.8304260223026;2621.685397752263;2622.3313055171;10189.54147063384;10650.893491065146;10936.343819370863;13647.181169129884;14482.05866618677;1534.8541888520685;1544.4440001599414;1826.3516451659734;1830.2770405689812;1857.5634725839418;117363.41318293354;118506;122636.38681806622;126693.99999999908;140338;11961.222520536137;12074.818877716842;12205.328706921204;12313.322767247888;12344.876551234373;15933.601659958362;15961.441349552942;15972.840271597368;16006.919965400099;16023.679526409407;7816.452848300564;8766.517841518651;8989.865152022725;9043.819123617623;9168.083191680911;7306.6711997959155;8852.159044890725;8879.866801997976;9011.27909767217;9034.412763170372;4829.806807727651;4904.975475122602;4912.38595175603;4983.725895075733;4986.775595098229;1790.1675720789895;1982.6133903888892;2053.3839848045827;2097.3171071762913;2098.643230650793;1012.9414761574172;1016.694991502561;1025.2105878473533;1048.4076496779296;1069.9411532365796;22277.777222227895;22494.550108998057;22686.659700104512;22710.091596336293;22789.88605056964;1055.6041484443333;1058.2962330050584;1092.7432053467428;1094.4527736131934;1101.8402331662026;9427;9877.950610246902;10275.434851083262;11186.328820270646;11840.644780656594;758559;765102;765490;767620.1618991869;785691;146934.26532867269;153188.234058829;155523.22238388736;156799;160882;977.5894124467741;1025.497506221946;1059.7668512927298;1062.8512008318842;1064.8615679961556;19576.902115489902;20022;20465.693014604494;20480.590388191853;20491.38525844227;62454.687726561075;62606;63049.68475157595;63180.68409657922;64301.356986429535;73359.63320183365;90208.09791901997;90301;90385.54807226185;92846.53576732073;6032.819015429544;8495.68316910855;8518.78703032429;8784.868226976729;8920.286377089948;10120;12505.874941250471;12718.236905785683;13100;13676.726465470834;11205.943970280423;11298.83051754208;11474.713132171428;11549.82675259855;11662;5361.383440904346;10723;11393.715157121138;11604.30374177552;11904.404779761151;11577.594784182513;11653.533858645898;11882.940585297018;12165.939170304091;12180;7097.964510177416;7656.5788881609815;7830.92169078302;7984;8907.955460222658;10501.527431265764;11515.366654834064;11559.479823408135;11676.70808229801;11805.763884722086 02:34:31 INFO - PROCESS | 3161 | |3;mootools.html;1314.3625341709271;1426.6219451845257;1432.8352239492456;1443.852137550647;1445.7975883376325;7637.541747495155;7891.447598668081;8187;8635.395522313433;8650.56747162641;8128.878066829002;8411.200935911078;8436.36727245456;8523.701670441536;8527.488350698963;2103.8737675739503;2329.4176455886027;2330.347502699247;2368.86971216583;2371.7865392114704;2073.8859362735043;2159.0608085482863;2320.8491448055825;2359.95280094398;2373.2287006722886;2074.7925207479284;2272.738635056965;2336.19401306549;2348.38941875112;2352.6588644646517;2330.417395651087;2337.3805941425535;2344.0975224538506;2348.260298006131;2357.2338989828204;2315.490592069759;2339.0643742502966;2364.84628499147;2367.1005018093015;2368.86971216583;8448.493090414533;8503.702370417068;8516.06323304436;8517.57412129391;8522.87215691765;4755.262934245197;5059.62052846038;5301.469853014668;5328.813491527817;5329.25390445338;3280.9343813123605;3459.238967427162;3545.3618348697223;3580.2481478889463;3601.94597081044;1074.5218377821873;1122.2200570603434;1192.8747481514404;1239.1883316427663;1273.8789814967563;9733.831940167154;10795.29830561011;10830.620928267474;10964.17768667345;11009.889901100967;4634.351190833286;4756.239001759702;4795.448523419782;4813.614910807127;4841.15279826029;9525.952370238105;9626.711198664052;9650.565724542412;9704.980976997314;9724.367916085432;5363.624546281801;5381.4349493303425;5393.892122157535;5409.621326507186;5423.945760542423;4712.929306060343;4852.272159176152;4911.066897289504;4924.0890435268875;4925.11347957364;3947.782871942071;3963.7621742694955;4050.594940505926;4113.526944401432;4123.36087906375;1188.9227200231958;1190.8451901252954;1229.0904730499367;1294.9287789171685;1318.5780550223835;773.1070613441484;777.149021821105;800.1118758178417;801.6272433318535;805.9838803223903;5525.11598144295;5529.198266251451;5593.692346920877;5669.262995810518;5752.597318187687;972.6644307713827;1014.4826138669332;1025.415513157493;1032.2722480651123;1066.6959916423937;3643.8529784537454;3860.2665493556133;3891.5135608048995;3940.172563761585;3968.6825053995613;9597.856032159523;10026.147777438853;10052.246081543914;10053.648122315684;10068.848967265498;8077.596120193967;9702.90297097034;9864.802703945881;10014.3490673106;10027.598896044077;7860.371170306362;7914.604269786488;7953.880691789628;7959.9602001989615;8004.479708818792;4979.626528010342;5409.86475338104;5461.153521204061;5521.558275338044;5647;7744.9157118002395;9061.682841100794;9230.030846760994;9233.215176709786;9316.114969077928;8761.211490965843;9231;9417.293702972167;9518.809623807347;9524.047595240421;7277.38142257914;7281.708731650675;7312.305330993547;7317.853642927005;7334;6834.453243740588;7743.690252389842;7936.127026027017;7950.324222441157;7950.920490795018;6055.818325450244;6459.547831651739;7149.82125446868;7151;7173.10336207974;6225.750969961151;7066.293370662893;7122.964385178041;7181.281871812777;7328.523645962995;6237.875242495215;6364.140840986593;6475.125858009297;6478.930976388843;6486.772962946275;4918.852434426973;5051.166557517969;5087.720175390241;5121.385433747974;5234.502722241381;4943.703377797344;4977.676451030671;5061.493850614909;5189.143791274398;5253.080710875658 02:34:31 INFO - PROCESS | 3161 | |4;prototype.html;302.64590429197835;349.7202238209432;356.1586981386124;369.58052610287314;370.32415841090017;4448.088141930904;5207.895842083156;5277.841664750054;5442.176870748304;5577.274954255946;5126.7952031272625;5247.973760131204;5424.83725488235;5462.613179828502;5494.81861399799;3918.392649139388;4142.668586513072;4330.891727706801;4332.2851729464755;4343.6959412841115;3925.8037098145123;4172.996961458502;4350.912981740364;4351.26028575143;4370.2570563004365;4107.917841643165;4129.67850287908;4144.772037537934;4155;4206.200821843855;3510.473428985647;3848.5189351331082;4125.608067233623;4140.358244472097;4182.393552934838;3088.7528997680133;3374.409478341305;3619.7647152935238;3625.492431059654;3645.125169959217;4390.582894625006;4791.3531673224015;5208.244804503326;5242.344706911636;5395.433479484637;3927.6857851371824;4100.856470023535;4375.343698445226;4740.549647783455;4769;4923.458419573844;4950.8267210647455;5641.960206705469;5686.658800471985;5713.2292686826495;3701.5002974598356;3869.690424766012;3871.187050719352;3927.960720392788;3952.1898010907694;5100.974495127501;5419.5393391561765;5871.765129394819;6128.264608246995;6185.16500272462;3440.2947395783804;3730.8880733578035;3975.660445225966;3989.5212574490665;4041.1715598302276;3433.733735734403;3920.882373528799;4053.3717273822604;4083.591640835952;4095.9385609215888;4487.596116349544;4672.789724462407;4727.95272047282;4732.479427262998;4736.4316282046375;5830.387809279964;5830.650160990269;5844.094165404369;5883.735231914574;5884.499817515473;1233.7470818482368;1247.4324182496941;1265.5001274496522;1304.4281640623026;1323.9338033098306;837.9078301386843;855.2516548020482;857.6655104509247;881.4006475596656;890.3055616619048;5150.793968241303;5160.7935682573025;5181.922271165936;5184.196449550326;5209;4807.687500312469;5294.182294112339;5322.2548843161985;5730.914036289459;5743.282089738783;4515.593596576324;4963.875903102379;5136.948630513647;5137.306463627438;5312.468753124656;2453.4425083628807;2633.8156329057165;2912.7961042726806;2981.3602518614675;3005.3087789808465;5031.974840125849;5147.665401748949;5360.91958620621;5871.7651293947765;5910.290765108214;4534.841280555231;5014.373203349582;5166.778285337341;5208.479152084837;5432.782688692408;5063.670861394145;5247.26840142752;5865.454272938421;5908.556858235649;5911.527077833763;4636.6058884995155;4914.164592019294;5156.510131537498;5365.248865158959;5723.484886360247;4823.421189457287;4915.778789954389;5195.635985626455;5222.477752224747;5427.592930530305;5000.749962501787;5398;5941.821745347646;5949.702514874152;5969.253843269591;3407.4718418645148;3773.943390849194;3818.9618103818607;3841.1165431951367;3851.8074096294513;4970.478099799469;5114.721319670082;5302.867428314323;5370.69060304073;5621.409751975983;5404.2163886235485;5665.518430933417;5682.460166284196;5805.287440205234;5850.444207800252;4752.168370535212;5074.543291103819;5309.33633295838;5823.912641310299;5834;5295.161008268974;5635.408282130317;5640.238567793295;5702.6863522506665;5759.790444006806;5670.829875103754;5695.316562012585;5749.281339832521;5786.566007549366;5817.738201781015;5504.339479262514;5691.516221121251;5707.5433965281845;5738.942610573841;5764.904668113045 02:34:31 INFO - PROCESS | 3161 | |5;yui.html;709.0357114324518;711.0862541634001;759.525296689569;771.9498232614881;852.8123812761194;14155.716885662294;14543.200123993176;15023.549293521184;15115.999999999985;15120.470783522578;14096.929515352434;14134.858651413482;14312.21282829444;14317.42730290787;14327.498537551188;848.4569875279826;852.8166444214493;857.1171693156059;857.438377862501;857.8069934264803;681.427600815315;702.722424642266;844.1178967978477;850.7745447456429;853.2789792625222;900.455224589124;904;913.7441516375392;914.6204325205032;914.8627705844143;803.6704950970133;843.9408542279431;912.9589168487435;916.3539704508372;918.7381596245071;673.0980486148584;682.2938258902012;683.8427161752825;684.565301033847;687.6321168175002;15258.465953691568;15515.534533963886;15553.766693499607;15672.373105075783;15695.843041569553;14201.218932958787;14605.415783368653;14628.049176803474;14707;14710.705785884222;11401.600943966921;11734.119941004374;11786.646400607995;11811.94094029533;11871.169018168732;2931.384409274055;3347.313800670857;3608.855645774166;3630.3283892479976;3798.092486988586;92527.53736231344;109099.8548794309;111945;113086;115666.4216678928;10814.675559733221;10932.125429965583;11130.942560456744;11442.599509017311;11680.70798230051;22702.091916323163;22973.655395169088;23109.884450577974;23346.883265583903;23357.2992810216;7781.377489800916;7860.135385107634;7872.33085187754;7914.327282181079;7956.443048986515;4238.491381034234;4250.723702959298;4357.128574285156;4395.296752519645;4525.615322697608;3397.694207521335;3446.327966046597;3463.740219483549;3493.1965647900615;3506.7895926244505;553.8449234214427;636.1570918532869;638.7796210307437;639.3766078073934;654.9639769812707;656.5174596671443;667.6594936582378;686.3116732837177;702.3994484715597;715.5921124958724;9529.666461673809;10008.149307308815;10023.398596084258;10041.799164016678;10257.230707696803;662.7580932959531;678.9117414736053;681.6693903456819;684.702488783752;691.9273476284917;4877.780499877514;4907.509249075135;4913.213885778258;4920.5571498565305;4921.335619691367;104259;106754.46622766837;107081;108036;109497.81004379867;78005.60997195091;89502;90070.54964725135;93002;95616.04383956072;75451.86822197672;79069;79352;80160;80735.19264807395;8861.91138088611;9437.811243775224;9561.713148605553;9656.134755307317;9705;47249;48470.5152948466;49820.25269621031;50586.2412063812;52037.09721770958;68610;70961.29038709546;71661.20846978867;72318.27681723326;73964.63017684878;12978.805317920427;13003.674908127372;13150.473981040652;13365.799513007507;13464.663383415102;14216.069516719204;14326.212058336892;14564.927175364055;14753.336099875745;14960;13237.271950042456;13265.933670331586;13348.733025339634;14090.295485225493;14096.718065638835;12985.610431687064;13189.538366157138;13638.318084095954;13876.514321999086;13927.226475795951;11604.593839215588;12500.31248281317;13187;13707.177569345871;13738.793918091036;9522.619095236112;10737.89262107369;10882.347059176474;10975.28660637056;11239.775204496027;9560.952195238979;10271.435071070864;10758.569657213624;10839.295445795999;10933.289336193122 02:34:31 INFO - PROCESS | 3161 | __end_tp_report 02:34:31 INFO - PROCESS | 3161 | __start_cc_report 02:34:31 INFO - PROCESS | 3161 | _x_x_mozilla_cycle_collect,396 02:34:31 INFO - PROCESS | 3161 | __end_cc_report 02:34:31 INFO - PROCESS | 3161 | __startTimestamp1488623671325__endTimestamp 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | ------- Summary: start ------- 02:34:31 INFO - PROCESS | 3161 | Number of tests: 6 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | [#0] dojo.html Cycles:165 Average:5761.84 Median:5981.82 stddev:636.95 (10.6%) stddev-sans-first:598.71 02:34:31 INFO - PROCESS | 3161 | Values: 2923.3 3353.9 3380.3 3414.3 3436.8 5714.2 5784.6 5796.2 5805.4 5806.2 5788.7 5805.7 5820.6 5842.3 5848.8 5241.8 5278.1 5291.7 5329.5 5340.2 5249.7 5253.3 5338.1 5356.2 5374.3 5153.9 5181.9 5192.9 5289.6 5290.6 5201.6 5253.9 5272.2 5280.2 5288.0 5199.3 5207.8 5211.2 5225.3 5289.9 5628.8 5640.2 5691.2 5729.6 5797.6 5596.8 6027.5 6217.8 6242.9 6247.8 6209.5 6212.1 6213.8 6220.3 6225.8 5149.2 5659.5 5814.2 5941.8 5983.3 6190.8 6235.9 6236.9 6250.3 6318.2 5222.6 5782.2 5975.5 6207.3 6229.3 5454.4 5708.7 6249.8 6257.9 6269.0 5303.2 6125.6 6178.2 6194.4 6195.3 6173.7 6203.4 6208.1 6218.8 6222.4 5010.9 5057.6 5071.7 5078.0 5082.2 4442.7 4443.1 4444.6 4536.1 4550.1 5865.2 5927.7 5981.8 5995.2 6048.7 6110.1 6225.0 6250.6 6263.2 6266.5 5822.4 5894.5 5930.4 5951.9 6036.8 5554.5 5559.4 5573.1 5578.3 5581.0 5529.8 6434.6 6435.8 6440.6 6442.5 6124.9 6139.2 6141.1 6145.4 6161.4 6358.3 6384.3 6392.6 6398.6 6398.9 6196.3 6201.4 6203.4 6213.1 6216.8 5147.7 6034.6 6131.5 6189.8 6245.9 6197.6 6200.5 6200.8 6203.9 6219.3 6191.7 6194.4 6206.6 6210.2 6212.8 5815.0 5962.5 5976.3 6063.2 6118.4 6117.4 6210.0 6216.6 6217.5 6226.4 6131.5 6138.5 6141.9 6153.1 6160.9 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | [#1] ext.html Cycles:180 Average:70341.36 Median:36017.37 stddev:155602.34 (432.0%) stddev-sans-first:155950.43 02:34:31 INFO - PROCESS | 3161 | Values: 479.2 501.9 512.9 514.0 576.8 31615.7 40467.4 40475.8 40691.8 40728.4 42310.0 42975.1 43039.8 43068.8 43081.6 8393.5 8594.4 9106.7 9449.3 11400.7 11310.2 11544.9 11559.1 11568.8 11588.3 11572.2 11609.1 11612.7 11616.2 11677.9 10132.3 11536.7 11547.8 11594.8 11603.1 9996.1 11313.7 11433.7 11469.5 11484.5 41006.2 41116.0 41223.0 41238.0 41238.8 3116.3 3960.2 4055.2 4063.0 4064.7 29807.0 29866.6 29983.6 31218.7 31583.4 3017.2 3146.3 3264.2 3273.7 3274.9 473141.0 493069.0 515773.0 522823.0 524528.0 58991.7 59477.7 59487.4 59518.4 59641.0 61369.4 61387.4 61647.0 61819.8 61922.0 15981.0 16096.7 16217.7 16268.3 16270.4 11235.3 11463.2 12976.7 13188.2 13190.9 20347.5 22211.0 22272.9 22297.6 22331.1 7789.3 8859.9 8905.6 9043.9 9131.5 876.0 883.5 890.3 911.0 928.3 29266.3 29484.0 30367.2 30554.7 31093.2 930.2 1023.7 1047.7 1055.6 1079.0 14433.5 14471.4 14644.3 14822.3 14890.3 688267.0 694073.0 695535.0 695842.0 696546.0 52833.5 52986.0 53249.7 53277.7 53335.7 1417.3 1439.1 1449.3 1452.3 1453.6 23975.5 27169.0 28144.7 28332.7 28474.9 47432.3 48012.8 48077.5 48081.5 48123.3 520553.0 525800.0 527574.0 528148.0 528989.0 25757.5 25989.9 26604.9 26648.0 27193.0 42653.4 43094.6 43849.3 44080.0 44148.0 36008.1 36222.8 36421.6 36467.6 37714.6 36259.4 36364.6 37250.6 37379.8 37630.9 33876.0 34702.3 34704.7 35979.5 36026.6 30024.2 32032.4 32204.4 32378.8 32380.5 21745.3 22791.8 22902.0 23981.9 24330.8 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | [#2] jquery.html Cycles:180 Average:41207.12 Median:21773.96 stddev:127800.07 (586.9%) stddev-sans-first:128121.83 02:34:31 INFO - PROCESS | 3161 | Values: 392.3 399.2 403.3 405.7 427.8 18598.0 19104.0 21044.6 21769.8 21778.1 21344.0 21866.8 21874.6 21877.9 22483.3 5640.8 5941.6 5949.9 5952.3 5953.6 5679.5 5788.8 5794.1 5806.3 5868.0 5751.1 5784.9 5787.9 5789.7 5790.3 5461.2 5742.9 5779.6 6026.9 6047.5 5892.8 5894.3 5904.9 5940.3 5957.3 13648.5 13767.5 13898.2 13903.2 15167.2 2495.9 2607.9 2608.8 2621.7 2622.3 10189.5 10650.9 10936.3 13647.2 14482.1 1534.9 1544.4 1826.4 1830.3 1857.6 117363.4 118506.0 122636.4 126694.0 140338.0 11961.2 12074.8 12205.3 12313.3 12344.9 15933.6 15961.4 15972.8 16006.9 16023.7 7816.5 8766.5 8989.9 9043.8 9168.1 7306.7 8852.2 8879.9 9011.3 9034.4 4829.8 4905.0 4912.4 4983.7 4986.8 1790.2 1982.6 2053.4 2097.3 2098.6 1012.9 1016.7 1025.2 1048.4 1069.9 22277.8 22494.6 22686.7 22710.1 22789.9 1055.6 1058.3 1092.7 1094.5 1101.8 9427.0 9878.0 10275.4 11186.3 11840.6 758559.0 765102.0 765490.0 767620.2 785691.0 146934.3 153188.2 155523.2 156799.0 160882.0 977.6 1025.5 1059.8 1062.9 1064.9 19576.9 20022.0 20465.7 20480.6 20491.4 62454.7 62606.0 63049.7 63180.7 64301.4 73359.6 90208.1 90301.0 90385.5 92846.5 6032.8 8495.7 8518.8 8784.9 8920.3 10120.0 12505.9 12718.2 13100.0 13676.7 11205.9 11298.8 11474.7 11549.8 11662.0 5361.4 10723.0 11393.7 11604.3 11904.4 11577.6 11653.5 11882.9 12165.9 12180.0 7098.0 7656.6 7830.9 7984.0 8908.0 10501.5 11515.4 11559.5 11676.7 11805.8 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | [#3] mootools.html Cycles:180 Average:5449.65 Median:5243.79 stddev:2936.30 (56.0%) stddev-sans-first:2928.09 02:34:31 INFO - PROCESS | 3161 | Values: 1314.4 1426.6 1432.8 1443.9 1445.8 7637.5 7891.4 8187.0 8635.4 8650.6 8128.9 8411.2 8436.4 8523.7 8527.5 2103.9 2329.4 2330.3 2368.9 2371.8 2073.9 2159.1 2320.8 2360.0 2373.2 2074.8 2272.7 2336.2 2348.4 2352.7 2330.4 2337.4 2344.1 2348.3 2357.2 2315.5 2339.1 2364.8 2367.1 2368.9 8448.5 8503.7 8516.1 8517.6 8522.9 4755.3 5059.6 5301.5 5328.8 5329.3 3280.9 3459.2 3545.4 3580.2 3601.9 1074.5 1122.2 1192.9 1239.2 1273.9 9733.8 10795.3 10830.6 10964.2 11009.9 4634.4 4756.2 4795.4 4813.6 4841.2 9526.0 9626.7 9650.6 9705.0 9724.4 5363.6 5381.4 5393.9 5409.6 5423.9 4712.9 4852.3 4911.1 4924.1 4925.1 3947.8 3963.8 4050.6 4113.5 4123.4 1188.9 1190.8 1229.1 1294.9 1318.6 773.1 777.1 800.1 801.6 806.0 5525.1 5529.2 5593.7 5669.3 5752.6 972.7 1014.5 1025.4 1032.3 1066.7 3643.9 3860.3 3891.5 3940.2 3968.7 9597.9 10026.1 10052.2 10053.6 10068.8 8077.6 9702.9 9864.8 10014.3 10027.6 7860.4 7914.6 7953.9 7960.0 8004.5 4979.6 5409.9 5461.2 5521.6 5647.0 7744.9 9061.7 9230.0 9233.2 9316.1 8761.2 9231.0 9417.3 9518.8 9524.0 7277.4 7281.7 7312.3 7317.9 7334.0 6834.5 7743.7 7936.1 7950.3 7950.9 6055.8 6459.5 7149.8 7151.0 7173.1 6225.8 7066.3 7123.0 7181.3 7328.5 6237.9 6364.1 6475.1 6478.9 6486.8 4918.9 5051.2 5087.7 5121.4 5234.5 4943.7 4977.7 5061.5 5189.1 5253.1 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | [#4] prototype.html Cycles:180 Average:4534.29 Median:5107.85 stddev:1378.60 (27.0%) stddev-sans-first:1345.38 02:34:31 INFO - PROCESS | 3161 | Values: 302.6 349.7 356.2 369.6 370.3 4448.1 5207.9 5277.8 5442.2 5577.3 5126.8 5248.0 5424.8 5462.6 5494.8 3918.4 4142.7 4330.9 4332.3 4343.7 3925.8 4173.0 4350.9 4351.3 4370.3 4107.9 4129.7 4144.8 4155.0 4206.2 3510.5 3848.5 4125.6 4140.4 4182.4 3088.8 3374.4 3619.8 3625.5 3645.1 4390.6 4791.4 5208.2 5242.3 5395.4 3927.7 4100.9 4375.3 4740.5 4769.0 4923.5 4950.8 5642.0 5686.7 5713.2 3701.5 3869.7 3871.2 3928.0 3952.2 5101.0 5419.5 5871.8 6128.3 6185.2 3440.3 3730.9 3975.7 3989.5 4041.2 3433.7 3920.9 4053.4 4083.6 4095.9 4487.6 4672.8 4728.0 4732.5 4736.4 5830.4 5830.7 5844.1 5883.7 5884.5 1233.7 1247.4 1265.5 1304.4 1323.9 837.9 855.3 857.7 881.4 890.3 5150.8 5160.8 5181.9 5184.2 5209.0 4807.7 5294.2 5322.3 5730.9 5743.3 4515.6 4963.9 5136.9 5137.3 5312.5 2453.4 2633.8 2912.8 2981.4 3005.3 5032.0 5147.7 5360.9 5871.8 5910.3 4534.8 5014.4 5166.8 5208.5 5432.8 5063.7 5247.3 5865.5 5908.6 5911.5 4636.6 4914.2 5156.5 5365.2 5723.5 4823.4 4915.8 5195.6 5222.5 5427.6 5000.7 5398.0 5941.8 5949.7 5969.3 3407.5 3773.9 3819.0 3841.1 3851.8 4970.5 5114.7 5302.9 5370.7 5621.4 5404.2 5665.5 5682.5 5805.3 5850.4 4752.2 5074.5 5309.3 5823.9 5834.0 5295.2 5635.4 5640.2 5702.7 5759.8 5670.8 5695.3 5749.3 5786.6 5817.7 5504.3 5691.5 5707.5 5738.9 5764.9 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - PROCESS | 3161 | [#5] yui.html Cycles:180 Average:20816.69 Median:4018.29 stddev:30210.09 (751.8%) stddev-sans-first:30257.11 02:34:31 INFO - PROCESS | 3161 | Values: 709.0 711.1 759.5 771.9 852.8 14155.7 14543.2 15023.5 15116.0 15120.5 14096.9 14134.9 14312.2 14317.4 14327.5 848.5 852.8 857.1 857.4 857.8 681.4 702.7 844.1 850.8 853.3 900.5 904.0 913.7 914.6 914.9 803.7 843.9 913.0 916.4 918.7 673.1 682.3 683.8 684.6 687.6 15258.5 15515.5 15553.8 15672.4 15695.8 14201.2 14605.4 14628.0 14707.0 14710.7 11401.6 11734.1 11786.6 11811.9 11871.2 2931.4 3347.3 3608.9 3630.3 3798.1 92527.5 109099.9 111945.0 113086.0 115666.4 10814.7 10932.1 11130.9 11442.6 11680.7 22702.1 22973.7 23109.9 23346.9 23357.3 7781.4 7860.1 7872.3 7914.3 7956.4 4238.5 4250.7 4357.1 4395.3 4525.6 3397.7 3446.3 3463.7 3493.2 3506.8 553.8 636.2 638.8 639.4 655.0 656.5 667.7 686.3 702.4 715.6 9529.7 10008.1 10023.4 10041.8 10257.2 662.8 678.9 681.7 684.7 691.9 4877.8 4907.5 4913.2 4920.6 4921.3 104259.0 106754.5 107081.0 108036.0 109497.8 78005.6 89502.0 90070.5 93002.0 95616.0 75451.9 79069.0 79352.0 80160.0 80735.2 8861.9 9437.8 9561.7 9656.1 9705.0 47249.0 48470.5 49820.3 50586.2 52037.1 68610.0 70961.3 71661.2 72318.3 73964.6 12978.8 13003.7 13150.5 13365.8 13464.7 14216.1 14326.2 14564.9 14753.3 14960.0 13237.3 13265.9 13348.7 14090.3 14096.7 12985.6 13189.5 13638.3 13876.5 13927.2 11604.6 12500.3 13187.0 13707.2 13738.8 9522.6 10737.9 10882.3 10975.3 11239.8 9561.0 10271.4 10758.6 10839.3 10933.3 02:34:31 INFO - PROCESS | 3161 | -------- Summary: end -------- 02:34:31 INFO - PROCESS | 3161 | 02:34:31 INFO - TEST-INFO | 3161: exit 0 02:34:31 INFO - TEST-OK | dromaeo_css | took 1115779ms 02:34:31 INFO - TEST-START | kraken 02:34:31 INFO - operating with platform_type : mac_ 02:34:31 INFO - Initialising browser for kraken test... 02:34:31 INFO - TEST-INFO | started process 3168 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpgosBMh/profile http://localhost:63701/getInfo.html) 02:34:35 INFO - PROCESS | 3168 | 2017-03-04 02:34:35.021 plugin-container[3170:57440] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 02:34:35 INFO - PROCESS | 3168 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:35 INFO - PROCESS | 3168 | 2017-03-04 02:34:35.021 plugin-container[3170:57440] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 02:34:35 INFO - PROCESS | 3168 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:35 INFO - PROCESS | 3168 | 2017-03-04 02:34:35.021 plugin-container[3170:57440] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:34:35 INFO - PROCESS | 3168 | __metrics Screen width/height:1600/1200 02:34:35 INFO - PROCESS | 3168 | colorDepth:24 02:34:35 INFO - PROCESS | 3168 | Browser inner width/height: 1024/689 02:34:35 INFO - PROCESS | 3168 | __metrics 02:34:35 ERROR - PROCESS | 3168 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:34:35 INFO - TEST-INFO | 3168: exit 0 02:34:35 INFO - Browser initialized. 02:34:35 INFO - Running cycle 1/1 for kraken test... 02:34:35 INFO - TEST-INFO | started process 3171 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpgosBMh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:38 INFO - PROCESS | 3171 | 2017-03-04 02:34:38.262 plugin-container[3172:57575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.tsm.portname' 02:34:38 INFO - PROCESS | 3171 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:38 INFO - PROCESS | 3171 | 2017-03-04 02:34:38.263 plugin-container[3172:57575] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f17, name = 'com.apple.CFPasteboardClient' 02:34:38 INFO - PROCESS | 3171 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:38 INFO - PROCESS | 3171 | 2017-03-04 02:34:38.263 plugin-container[3172:57575] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:34:47 INFO - PROCESS | 3171 | RSS: Main: 219226112 02:34:47 INFO - PROCESS | 3171 | 02:34:50 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:63701/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:51 INFO - PROCESS | 3171 | RSS: Main: 233115648 02:34:51 INFO - PROCESS | 3171 | 02:34:54 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:63701/tests/kraken/driver.html?testName=audio-dft) 02:34:55 INFO - PROCESS | 3171 | RSS: Main: 241963008 02:34:55 INFO - PROCESS | 3171 | 02:34:58 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:63701/tests/kraken/driver.html?testName=audio-fft) 02:34:59 INFO - PROCESS | 3171 | RSS: Main: 245133312 02:34:59 INFO - PROCESS | 3171 | 02:35:00 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:63701/tests/kraken/driver.html?testName=audio-oscillator) 02:35:01 INFO - PROCESS | 3171 | RSS: Main: 245047296 02:35:01 INFO - PROCESS | 3171 | 02:35:03 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:63701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:35:04 INFO - PROCESS | 3171 | RSS: Main: 245080064 02:35:04 INFO - PROCESS | 3171 | 02:35:07 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:63701/tests/kraken/driver.html?testName=imaging-darkroom) 02:35:07 INFO - PROCESS | 3171 | RSS: Main: 250081280 02:35:07 INFO - PROCESS | 3171 | 02:35:10 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:63701/tests/kraken/driver.html?testName=imaging-desaturate) 02:35:11 INFO - PROCESS | 3171 | RSS: Main: 250257408 02:35:11 INFO - PROCESS | 3171 | 02:35:14 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:63701/tests/kraken/driver.html?testName=json-parse-financial) 02:35:15 INFO - PROCESS | 3171 | RSS: Main: 249483264 02:35:15 INFO - PROCESS | 3171 | 02:35:16 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:63701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:35:17 INFO - PROCESS | 3171 | RSS: Main: 248717312 02:35:17 INFO - PROCESS | 3171 | 02:35:19 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:35:19 INFO - PROCESS | 3171 | RSS: Main: 248774656 02:35:19 INFO - PROCESS | 3171 | 02:35:21 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:35:22 INFO - PROCESS | 3171 | RSS: Main: 248770560 02:35:22 INFO - PROCESS | 3171 | 02:35:25 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:35:26 INFO - PROCESS | 3171 | RSS: Main: 249249792 02:35:26 INFO - PROCESS | 3171 | 02:35:29 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:35:30 INFO - PROCESS | 3171 | RSS: Main: 249290752 02:35:30 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | Cycle 1(1): loaded http://localhost:63701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:63701/tests/kraken/driver.html?testName=ai-astar) 02:35:31 INFO - PROCESS | 3171 | RSS: Main: 251277312 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | __start_tp_report 02:35:31 INFO - PROCESS | 3171 | _x_x_mozilla_page_load 02:35:31 INFO - PROCESS | 3171 | _x_x_mozilla_page_load_details 02:35:31 INFO - PROCESS | 3171 | |i|pagename|runs| 02:35:31 INFO - PROCESS | 3171 | |0;ai-astar;105;115;119;116;116;116;115;116;117;117 02:35:31 INFO - PROCESS | 3171 | |1;audio-beat-detection;158;112;114;150;116;114;137;135;154;118 02:35:31 INFO - PROCESS | 3171 | |2;audio-dft;202;195;199;199;200;198;198;195;204;195 02:35:31 INFO - PROCESS | 3171 | |3;audio-fft;86;60;59;89;62;61;60;59;72;59 02:35:31 INFO - PROCESS | 3171 | |4;audio-oscillator;82;69;84;94;93;98;107;71;71;82 02:35:31 INFO - PROCESS | 3171 | |5;imaging-gaussian-blur;90;87;89;86;92;85;94;123;123;86 02:35:31 INFO - PROCESS | 3171 | |6;imaging-darkroom;99;101;97;107;100;98;119;98;140;163 02:35:31 INFO - PROCESS | 3171 | |7;imaging-desaturate;91;133;145;96;91;94;92;93;93;96 02:35:31 INFO - PROCESS | 3171 | |8;json-parse-financial;59;60;60;62;63;62;62;63;62;62 02:35:31 INFO - PROCESS | 3171 | |9;json-stringify-tinderbox;68;76;75;82;72;71;71;71;73;73 02:35:31 INFO - PROCESS | 3171 | |10;stanford-crypto-aes;82;85;82;75;84;77;107;74;105;99 02:35:31 INFO - PROCESS | 3171 | |11;stanford-crypto-ccm;140;173;139;137;135;141;141;146;239;166 02:35:31 INFO - PROCESS | 3171 | |12;stanford-crypto-pbkdf2;221;193;205;169;145;163;217;213;181;167 02:35:31 INFO - PROCESS | 3171 | |13;stanford-crypto-sha256-iterative;68;66;66;68;66;65;67;68;66;66 02:35:31 INFO - PROCESS | 3171 | __end_tp_report 02:35:31 INFO - PROCESS | 3171 | __start_cc_report 02:35:31 INFO - PROCESS | 3171 | _x_x_mozilla_cycle_collect,971 02:35:31 INFO - PROCESS | 3171 | __end_cc_report 02:35:31 INFO - PROCESS | 3171 | __startTimestamp1488623731960__endTimestamp 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | ------- Summary: start ------- 02:35:31 INFO - PROCESS | 3171 | Number of tests: 14 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:3.77 (3.2%) stddev-sans-first:1.22 02:35:31 INFO - PROCESS | 3171 | Values: 105.0 115.0 119.0 116.0 116.0 116.0 115.0 116.0 117.0 117.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:136.00 stddev:18.27 (13.4%) stddev-sans-first:16.51 02:35:31 INFO - PROCESS | 3171 | Values: 158.0 112.0 114.0 150.0 116.0 114.0 137.0 135.0 154.0 118.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#2] audio-dft Cycles:10 Average:198.50 Median:199.00 stddev:3.03 (1.5%) stddev-sans-first:2.93 02:35:31 INFO - PROCESS | 3171 | Values: 202.0 195.0 199.0 199.0 200.0 198.0 198.0 195.0 204.0 195.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.50 stddev:11.64 (18.9%) stddev-sans-first:10.04 02:35:31 INFO - PROCESS | 3171 | Values: 86.0 60.0 59.0 89.0 62.0 61.0 60.0 59.0 72.0 59.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:83.00 stddev:12.76 (15.4%) stddev-sans-first:13.48 02:35:31 INFO - PROCESS | 3171 | Values: 82.0 69.0 84.0 94.0 93.0 98.0 107.0 71.0 71.0 82.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:88.00 stddev:14.77 (16.8%) stddev-sans-first:15.53 02:35:31 INFO - PROCESS | 3171 | Values: 90.0 87.0 89.0 86.0 92.0 85.0 94.0 123.0 123.0 86.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#6] imaging-darkroom Cycles:10 Average:112.20 Median:130.00 stddev:22.38 (17.2%) stddev-sans-first:23.23 02:35:31 INFO - PROCESS | 3171 | Values: 99.0 101.0 97.0 107.0 100.0 98.0 119.0 98.0 140.0 163.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:93.00 stddev:19.57 (21.0%) stddev-sans-first:20.32 02:35:31 INFO - PROCESS | 3171 | Values: 91.0 133.0 145.0 96.0 91.0 94.0 92.0 93.0 93.0 96.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.09 02:35:31 INFO - PROCESS | 3171 | Values: 59.0 60.0 60.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.00 stddev:3.82 (5.2%) stddev-sans-first:3.56 02:35:31 INFO - PROCESS | 3171 | Values: 68.0 76.0 75.0 82.0 72.0 71.0 71.0 71.0 73.0 73.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:82.00 stddev:12.22 (14.9%) stddev-sans-first:12.83 02:35:31 INFO - PROCESS | 3171 | Values: 82.0 85.0 82.0 75.0 84.0 77.0 107.0 74.0 105.0 99.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:143.50 stddev:31.93 (22.2%) stddev-sans-first:33.35 02:35:31 INFO - PROCESS | 3171 | Values: 140.0 173.0 139.0 137.0 135.0 141.0 141.0 146.0 239.0 166.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:199.00 stddev:26.23 (13.2%) stddev-sans-first:24.84 02:35:31 INFO - PROCESS | 3171 | Values: 221.0 193.0 205.0 169.0 145.0 163.0 217.0 213.0 181.0 167.0 02:35:31 INFO - PROCESS | 3171 | 02:35:31 INFO - PROCESS | 3171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 02:35:31 INFO - PROCESS | 3171 | Values: 68.0 66.0 66.0 68.0 66.0 65.0 67.0 68.0 66.0 66.0 02:35:31 INFO - PROCESS | 3171 | -------- Summary: end -------- 02:35:31 INFO - PROCESS | 3171 | 02:35:32 INFO - TEST-INFO | 3171: exit 0 02:35:32 INFO - TEST-OK | kraken | took 60834ms 02:35:32 INFO - SUITE-END | took 1176s 02:35:33 INFO - Completed test suite (00:19:36) 02:35:33 INFO - javascript benchmark 02:35:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7340.8172770473875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2923.2984083819874, 3353.9496907546386, 3380.273241253132, 3414.334204830059, 3436.8453419596117, 5714.200011998319, 5784.56615753818, 5796.159556864252, 5805.448482394171, 5806.187133801266, 5788.652680839153, 5805.709714514279, 5820.621659592134, 5842.269716285465, 5848.824535263938, 5241.816536421226, 5278.1291086970605, 5291.729984803638, 5329.493698098674, 5340.225667278242, 5249.711265880375, 5253.264542963988, 5338.145896656536, 5356.196570514415, 5374.274472946141, 5153.871153221162, 5181.870453238662, 5192.896142077175, 5289.603279753996, 5290.629655924067, 5201.55786758126, 5253.894922101536, 5272.182811664198, 5280.234366016906, 5287.973560132214, 5199.324087868591, 5207.791688332462, 5211.1922651989, 5225.294585230983, 5289.867753306198, 5628.774849006035, 5640.182173584848, 5691.231683722686, 5729.570282228808, 5797.623154494987, 5596.832095037155, 6027.547933904974, 6217.751289948396, 6242.906356404657, 6247.781327653511, 6209.534284928648, 6212.130301757712, 6213.844653883644, 6220.34686357935, 6225.8132256032395, 5149.176131818966, 5659.518940889988, 5814.244148260741, 5941.7920372787175, 5983.282006159288, 6190.81427557174, 6235.906461403082, 6236.906446403307, 6250.281217660027, 6318.241810982619, 5222.634415590948, 5782.190493330853, 5975.492083172892, 6207.255129384503, 6229.252489701174, 5454.372747134131, 5708.743106560215, 6249.78125765596, 6257.937420625826, 6269.0, 5303.204519322056, 6125.632462052202, 6178.227721534809, 6194.38056194386, 6195.31851496335, 6173.722182501798, 6203.379662033761, 6208.068789681584, 6218.81343559694, 6222.377762223741, 5010.89978200434, 5057.595392368602, 5071.695698258116, 5078.0, 5082.237664350377, 4442.666799989949, 4443.0669559392245, 4444.644428445717, 4536.115457485825, 4550.0899820035465, 5865.237519122486, 5927.73325200367, 5981.820545383645, 5995.2206213192, 6048.697565121726, 6110.133516259585, 6224.968875155595, 6250.593711408835, 6263.217097862767, 6266.467350275187, 5822.446867547576, 5894.528437724972, 5930.406959304035, 5951.851203719942, 6036.788712395045, 5554.527865131428, 5559.388467268597, 5573.052581061229, 5578.30271216098, 5581.023320918905, 5529.806456773994, 6434.64609446485, 6435.774747883802, 6440.581362211441, 6442.452391546771, 6124.899720462962, 6139.1855040903665, 6141.056449558148, 6145.385461453998, 6161.44546990773, 6358.300586935341, 6384.265809431975, 6392.584482008655, 6398.584092034003, 6398.90401643985, 6196.256449226122, 6201.410865967726, 6203.379662033761, 6213.099100630293, 6216.813495595139, 5147.665401749025, 6034.577579569564, 6131.529590167291, 6189.81430557084, 6245.937540624717, 6197.597156184834, 6200.534959878118, 6200.7519699211525, 6203.937960620336, 6219.253689557282, 6191.690415479118, 6194.38056194377, 6206.627602343874, 6210.161628180138, 6212.782552610637, 5814.970925145347, 5962.522998160223, 5976.312724036791, 6063.181470501602, 6118.418750218722, 6117.431594453999, 6210.0, 6216.595921265103, 6217.4715149212825, 6226.439620434183, 6131.54013449002, 6138.478229350555, 6141.938580614136, 6153.13856060143, 6160.907586386297], "value": 5721.907485548339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.1566842357452, 501.87954890826205, 512.8743457852827, 514.0002694758696, 576.8327185116317, 31615.68384316156, 40467.39298910519, 40475.78572642818, 40691.79654101733, 40728.38907416391, 42310.0, 42975.14049719004, 43039.78480107603, 43068.78465607668, 43081.569184308144, 8393.53835539045, 8594.398392112524, 9106.681266155703, 9449.338546301762, 11400.71498212543, 11310.208285420023, 11544.884551154508, 11559.075273978062, 11568.768624627503, 11588.304701717923, 11572.247803892762, 11609.071274298036, 11612.6516204514, 11616.186866919277, 11677.883221167807, 10132.290739648228, 11536.653900383002, 11547.769044619145, 11594.76810463786, 11603.129765267597, 9996.100350968447, 11313.660590182308, 11433.656990290305, 11469.483873225641, 11484.540618375255, 41006.1798764026, 41115.97210069742, 41223.0, 41238.0, 41238.79380603108, 3116.3144108296137, 3960.2277555876617, 4055.168690418457, 4062.9796851015853, 4064.6748260139116, 29806.956756513417, 29866.552001719992, 29983.550246746316, 31218.687813121804, 31583.368332633218, 3017.1853599528004, 3146.3078122812944, 3264.2165880188822, 3273.7053665170247, 3274.9017529474154, 473141.0, 493069.0, 515773.0, 522823.0, 524528.0, 58991.705041475376, 59477.70261148667, 59487.40512594905, 59518.40481595129, 59641.0, 61369.38630613726, 61387.38612613817, 61647.0, 61819.763604727654, 61922.0, 15981.041137531785, 16096.67806643884, 16217.675646487005, 16268.26792794327, 16270.43053493122, 11235.269707468988, 11463.197576169589, 12976.740465190644, 13188.208707477583, 13190.934045329712, 20347.491312717004, 22211.0, 22272.88863555672, 22297.55404891893, 22331.106755729914, 7789.298963093349, 8859.89251343582, 8905.643774249087, 9043.914730232415, 9131.452112873116, 875.9781005474914, 883.5405589093635, 890.3055616618918, 910.977225569366, 928.2991341537096, 29266.268343291587, 29484.0, 30367.24081897926, 30554.69445305563, 31093.22266943299, 930.2186163622589, 1023.6928921323573, 1047.7107520068673, 1055.567217440861, 1078.9514471848786, 14433.494827680981, 14471.421143154155, 14644.267786610626, 14822.332995015251, 14890.329935152944, 688267.0, 694073.0, 695535.0, 695842.0, 696546.0, 52833.47166528286, 52986.0, 53249.668758280575, 53277.73361133247, 53335.733321333144, 1417.305520295048, 1439.0502268502737, 1449.2970909109074, 1452.2883786944533, 1453.6075259680038, 23975.52048959046, 27169.0, 28144.74610905595, 28332.71667283383, 28474.85762571174, 47432.2885156716, 48012.7599362001, 48077.51922480731, 48081.519184809105, 48123.278150827064, 520553.0, 525800.0, 527574.0, 528148.0, 528989.0, 25757.484850303263, 25989.870050649624, 26604.866975664998, 26648.0, 27193.0, 42653.36019959641, 43094.56905430905, 43849.34225986677, 44080.0, 44148.0, 36008.099797505274, 36222.8188859054, 36421.635783641825, 36467.63532364748, 37714.622853771114, 36259.409150118365, 36364.636353636124, 37250.6274937258, 37379.81310093432, 37630.87107386783, 33876.0, 34702.30595388129, 34704.65295347014, 35979.46030809487, 36026.63973360233, 30024.24939376533, 32032.35935281328, 32204.355912881143, 32378.838105809322, 32380.514292286105, 21745.34763957084, 22791.772082278963, 22902.0, 23981.880090599436, 24330.75669243285], "value": 20148.987003642746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.3193259694431, 399.24542614458676, 403.26001786721366, 405.7261348589702, 427.78610694652673, 18598.0, 19104.0, 21044.579108417824, 21769.782302176955, 21778.128874845006, 21344.039518221678, 21866.781332186674, 21874.562508749816, 21877.890610546965, 22483.32550023498, 5640.830775076744, 5941.613795103304, 5949.85125371867, 5952.315483719362, 5953.553483488734, 5679.507103131565, 5788.797392091277, 5794.101914203306, 5806.303243610772, 5868.03177475716, 5751.1373294006025, 5784.884302313952, 5787.855303617423, 5789.710514474281, 5790.305163380401, 5461.15352120422, 5742.885142297151, 5779.566532510057, 6026.939730602681, 6047.455728984369, 5892.823215303548, 5894.292684877799, 5904.881902361972, 5940.2871655401195, 5957.314908785502, 13648.454061837614, 13767.518136865161, 13898.23559704216, 13903.235322057282, 15167.165805880672, 2495.875206239699, 2607.895684172631, 2608.8304260223026, 2621.685397752263, 2622.3313055171, 10189.54147063384, 10650.893491065146, 10936.343819370863, 13647.181169129884, 14482.05866618677, 1534.8541888520685, 1544.4440001599414, 1826.3516451659734, 1830.2770405689812, 1857.5634725839418, 117363.41318293354, 118506.0, 122636.38681806622, 126693.99999999908, 140338.0, 11961.222520536137, 12074.818877716842, 12205.328706921204, 12313.322767247888, 12344.876551234373, 15933.601659958362, 15961.441349552942, 15972.840271597368, 16006.919965400099, 16023.679526409407, 7816.452848300564, 8766.517841518651, 8989.865152022725, 9043.819123617623, 9168.083191680911, 7306.6711997959155, 8852.159044890725, 8879.866801997976, 9011.27909767217, 9034.412763170372, 4829.806807727651, 4904.975475122602, 4912.38595175603, 4983.725895075733, 4986.775595098229, 1790.1675720789895, 1982.6133903888892, 2053.3839848045827, 2097.3171071762913, 2098.643230650793, 1012.9414761574172, 1016.694991502561, 1025.2105878473533, 1048.4076496779296, 1069.9411532365796, 22277.777222227895, 22494.550108998057, 22686.659700104512, 22710.091596336293, 22789.88605056964, 1055.6041484443333, 1058.2962330050584, 1092.7432053467428, 1094.4527736131934, 1101.8402331662026, 9427.0, 9877.950610246902, 10275.434851083262, 11186.328820270646, 11840.644780656594, 758559.0, 765102.0, 765490.0, 767620.1618991869, 785691.0, 146934.26532867269, 153188.234058829, 155523.22238388736, 156799.0, 160882.0, 977.5894124467741, 1025.497506221946, 1059.7668512927298, 1062.8512008318842, 1064.8615679961556, 19576.902115489902, 20022.0, 20465.693014604494, 20480.590388191853, 20491.38525844227, 62454.687726561075, 62606.0, 63049.68475157595, 63180.68409657922, 64301.356986429535, 73359.63320183365, 90208.09791901997, 90301.0, 90385.54807226185, 92846.53576732073, 6032.819015429544, 8495.68316910855, 8518.78703032429, 8784.868226976729, 8920.286377089948, 10120.0, 12505.874941250471, 12718.236905785683, 13100.0, 13676.726465470834, 11205.943970280423, 11298.83051754208, 11474.713132171428, 11549.82675259855, 11662.0, 5361.383440904346, 10723.0, 11393.715157121138, 11604.30374177552, 11904.404779761151, 11577.594784182513, 11653.533858645898, 11882.940585297018, 12165.939170304091, 12180.0, 7097.964510177416, 7656.5788881609815, 7830.92169078302, 7984.0, 8907.955460222658, 10501.527431265764, 11515.366654834064, 11559.479823408135, 11676.70808229801, 11805.763884722086], "value": 9931.267452866115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.3625341709271, 1426.6219451845257, 1432.8352239492456, 1443.852137550647, 1445.7975883376325, 7637.541747495155, 7891.447598668081, 8187.0, 8635.395522313433, 8650.56747162641, 8128.878066829002, 8411.200935911078, 8436.36727245456, 8523.701670441536, 8527.488350698963, 2103.8737675739503, 2329.4176455886027, 2330.347502699247, 2368.86971216583, 2371.7865392114704, 2073.8859362735043, 2159.0608085482863, 2320.8491448055825, 2359.95280094398, 2373.2287006722886, 2074.7925207479284, 2272.738635056965, 2336.19401306549, 2348.38941875112, 2352.6588644646517, 2330.417395651087, 2337.3805941425535, 2344.0975224538506, 2348.260298006131, 2357.2338989828204, 2315.490592069759, 2339.0643742502966, 2364.84628499147, 2367.1005018093015, 2368.86971216583, 8448.493090414533, 8503.702370417068, 8516.06323304436, 8517.57412129391, 8522.87215691765, 4755.262934245197, 5059.62052846038, 5301.469853014668, 5328.813491527817, 5329.25390445338, 3280.9343813123605, 3459.238967427162, 3545.3618348697223, 3580.2481478889463, 3601.94597081044, 1074.5218377821873, 1122.2200570603434, 1192.8747481514404, 1239.1883316427663, 1273.8789814967563, 9733.831940167154, 10795.29830561011, 10830.620928267474, 10964.17768667345, 11009.889901100967, 4634.351190833286, 4756.239001759702, 4795.448523419782, 4813.614910807127, 4841.15279826029, 9525.952370238105, 9626.711198664052, 9650.565724542412, 9704.980976997314, 9724.367916085432, 5363.624546281801, 5381.4349493303425, 5393.892122157535, 5409.621326507186, 5423.945760542423, 4712.929306060343, 4852.272159176152, 4911.066897289504, 4924.0890435268875, 4925.11347957364, 3947.782871942071, 3963.7621742694955, 4050.594940505926, 4113.526944401432, 4123.36087906375, 1188.9227200231958, 1190.8451901252954, 1229.0904730499367, 1294.9287789171685, 1318.5780550223835, 773.1070613441484, 777.149021821105, 800.1118758178417, 801.6272433318535, 805.9838803223903, 5525.11598144295, 5529.198266251451, 5593.692346920877, 5669.262995810518, 5752.597318187687, 972.6644307713827, 1014.4826138669332, 1025.415513157493, 1032.2722480651123, 1066.6959916423937, 3643.8529784537454, 3860.2665493556133, 3891.5135608048995, 3940.172563761585, 3968.6825053995613, 9597.856032159523, 10026.147777438853, 10052.246081543914, 10053.648122315684, 10068.848967265498, 8077.596120193967, 9702.90297097034, 9864.802703945881, 10014.3490673106, 10027.598896044077, 7860.371170306362, 7914.604269786488, 7953.880691789628, 7959.9602001989615, 8004.479708818792, 4979.626528010342, 5409.86475338104, 5461.153521204061, 5521.558275338044, 5647.0, 7744.9157118002395, 9061.682841100794, 9230.030846760994, 9233.215176709786, 9316.114969077928, 8761.211490965843, 9231.0, 9417.293702972167, 9518.809623807347, 9524.047595240421, 7277.38142257914, 7281.708731650675, 7312.305330993547, 7317.853642927005, 7334.0, 6834.453243740588, 7743.690252389842, 7936.127026027017, 7950.324222441157, 7950.920490795018, 6055.818325450244, 6459.547831651739, 7149.82125446868, 7151.0, 7173.10336207974, 6225.750969961151, 7066.293370662893, 7122.964385178041, 7181.281871812777, 7328.523645962995, 6237.875242495215, 6364.140840986593, 6475.125858009297, 6478.930976388843, 6486.772962946275, 4918.852434426973, 5051.166557517969, 5087.720175390241, 5121.385433747974, 5234.502722241381, 4943.703377797344, 4977.676451030671, 5061.493850614909, 5189.143791274398, 5253.080710875658], "value": 4435.2712281365675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.64590429197835, 349.7202238209432, 356.1586981386124, 369.58052610287314, 370.32415841090017, 4448.088141930904, 5207.895842083156, 5277.841664750054, 5442.176870748304, 5577.274954255946, 5126.7952031272625, 5247.973760131204, 5424.83725488235, 5462.613179828502, 5494.81861399799, 3918.392649139388, 4142.668586513072, 4330.891727706801, 4332.2851729464755, 4343.6959412841115, 3925.8037098145123, 4172.996961458502, 4350.912981740364, 4351.26028575143, 4370.2570563004365, 4107.917841643165, 4129.67850287908, 4144.772037537934, 4155.0, 4206.200821843855, 3510.473428985647, 3848.5189351331082, 4125.608067233623, 4140.358244472097, 4182.393552934838, 3088.7528997680133, 3374.409478341305, 3619.7647152935238, 3625.492431059654, 3645.125169959217, 4390.582894625006, 4791.3531673224015, 5208.244804503326, 5242.344706911636, 5395.433479484637, 3927.6857851371824, 4100.856470023535, 4375.343698445226, 4740.549647783455, 4769.0, 4923.458419573844, 4950.8267210647455, 5641.960206705469, 5686.658800471985, 5713.2292686826495, 3701.5002974598356, 3869.690424766012, 3871.187050719352, 3927.960720392788, 3952.1898010907694, 5100.974495127501, 5419.5393391561765, 5871.765129394819, 6128.264608246995, 6185.16500272462, 3440.2947395783804, 3730.8880733578035, 3975.660445225966, 3989.5212574490665, 4041.1715598302276, 3433.733735734403, 3920.882373528799, 4053.3717273822604, 4083.591640835952, 4095.9385609215888, 4487.596116349544, 4672.789724462407, 4727.95272047282, 4732.479427262998, 4736.4316282046375, 5830.387809279964, 5830.650160990269, 5844.094165404369, 5883.735231914574, 5884.499817515473, 1233.7470818482368, 1247.4324182496941, 1265.5001274496522, 1304.4281640623026, 1323.9338033098306, 837.9078301386843, 855.2516548020482, 857.6655104509247, 881.4006475596656, 890.3055616619048, 5150.793968241303, 5160.7935682573025, 5181.922271165936, 5184.196449550326, 5209.0, 4807.687500312469, 5294.182294112339, 5322.2548843161985, 5730.914036289459, 5743.282089738783, 4515.593596576324, 4963.875903102379, 5136.948630513647, 5137.306463627438, 5312.468753124656, 2453.4425083628807, 2633.8156329057165, 2912.7961042726806, 2981.3602518614675, 3005.3087789808465, 5031.974840125849, 5147.665401748949, 5360.91958620621, 5871.7651293947765, 5910.290765108214, 4534.841280555231, 5014.373203349582, 5166.778285337341, 5208.479152084837, 5432.782688692408, 5063.670861394145, 5247.26840142752, 5865.454272938421, 5908.556858235649, 5911.527077833763, 4636.6058884995155, 4914.164592019294, 5156.510131537498, 5365.248865158959, 5723.484886360247, 4823.421189457287, 4915.778789954389, 5195.635985626455, 5222.477752224747, 5427.592930530305, 5000.749962501787, 5398.0, 5941.821745347646, 5949.702514874152, 5969.253843269591, 3407.4718418645148, 3773.943390849194, 3818.9618103818607, 3841.1165431951367, 3851.8074096294513, 4970.478099799469, 5114.721319670082, 5302.867428314323, 5370.69060304073, 5621.409751975983, 5404.2163886235485, 5665.518430933417, 5682.460166284196, 5805.287440205234, 5850.444207800252, 4752.168370535212, 5074.543291103819, 5309.33633295838, 5823.912641310299, 5834.0, 5295.161008268974, 5635.408282130317, 5640.238567793295, 5702.6863522506665, 5759.790444006806, 5670.829875103754, 5695.316562012585, 5749.281339832521, 5786.566007549366, 5817.738201781015, 5504.339479262514, 5691.516221121251, 5707.5433965281845, 5738.942610573841, 5764.904668113045], "value": 4102.030457514603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.0357114324518, 711.0862541634001, 759.525296689569, 771.9498232614881, 852.8123812761194, 14155.716885662294, 14543.200123993176, 15023.549293521184, 15115.999999999985, 15120.470783522578, 14096.929515352434, 14134.858651413482, 14312.21282829444, 14317.42730290787, 14327.498537551188, 848.4569875279826, 852.8166444214493, 857.1171693156059, 857.438377862501, 857.8069934264803, 681.427600815315, 702.722424642266, 844.1178967978477, 850.7745447456429, 853.2789792625222, 900.455224589124, 904.0, 913.7441516375392, 914.6204325205032, 914.8627705844143, 803.6704950970133, 843.9408542279431, 912.9589168487435, 916.3539704508372, 918.7381596245071, 673.0980486148584, 682.2938258902012, 683.8427161752825, 684.565301033847, 687.6321168175002, 15258.465953691568, 15515.534533963886, 15553.766693499607, 15672.373105075783, 15695.843041569553, 14201.218932958787, 14605.415783368653, 14628.049176803474, 14707.0, 14710.705785884222, 11401.600943966921, 11734.119941004374, 11786.646400607995, 11811.94094029533, 11871.169018168732, 2931.384409274055, 3347.313800670857, 3608.855645774166, 3630.3283892479976, 3798.092486988586, 92527.53736231344, 109099.8548794309, 111945.0, 113086.0, 115666.4216678928, 10814.675559733221, 10932.125429965583, 11130.942560456744, 11442.599509017311, 11680.70798230051, 22702.091916323163, 22973.655395169088, 23109.884450577974, 23346.883265583903, 23357.2992810216, 7781.377489800916, 7860.135385107634, 7872.33085187754, 7914.327282181079, 7956.443048986515, 4238.491381034234, 4250.723702959298, 4357.128574285156, 4395.296752519645, 4525.615322697608, 3397.694207521335, 3446.327966046597, 3463.740219483549, 3493.1965647900615, 3506.7895926244505, 553.8449234214427, 636.1570918532869, 638.7796210307437, 639.3766078073934, 654.9639769812707, 656.5174596671443, 667.6594936582378, 686.3116732837177, 702.3994484715597, 715.5921124958724, 9529.666461673809, 10008.149307308815, 10023.398596084258, 10041.799164016678, 10257.230707696803, 662.7580932959531, 678.9117414736053, 681.6693903456819, 684.702488783752, 691.9273476284917, 4877.780499877514, 4907.509249075135, 4913.213885778258, 4920.5571498565305, 4921.335619691367, 104259.0, 106754.46622766837, 107081.0, 108036.0, 109497.81004379867, 78005.60997195091, 89502.0, 90070.54964725135, 93002.0, 95616.04383956072, 75451.86822197672, 79069.0, 79352.0, 80160.0, 80735.19264807395, 8861.91138088611, 9437.811243775224, 9561.713148605553, 9656.134755307317, 9705.0, 47249.0, 48470.5152948466, 49820.25269621031, 50586.2412063812, 52037.09721770958, 68610.0, 70961.29038709546, 71661.20846978867, 72318.27681723326, 73964.63017684878, 12978.805317920427, 13003.674908127372, 13150.473981040652, 13365.799513007507, 13464.663383415102, 14216.069516719204, 14326.212058336892, 14564.927175364055, 14753.336099875745, 14960.0, 13237.271950042456, 13265.933670331586, 13348.733025339634, 14090.295485225493, 14096.718065638835, 12985.610431687064, 13189.538366157138, 13638.318084095954, 13876.514321999086, 13927.226475795951, 11604.593839215588, 12500.31248281317, 13187.0, 13707.177569345871, 13738.793918091036, 9522.619095236112, 10737.89262107369, 10882.347059176474, 10975.28660637056, 11239.775204496027, 9560.952195238979, 10271.435071070864, 10758.569657213624, 10839.295445795999, 10933.289336193122], "value": 7511.053927054638, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 119.0, 116.0, 116.0, 116.0, 115.0, 116.0, 117.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 112.0, 114.0, 150.0, 116.0, 114.0, 137.0, 135.0, 154.0, 118.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 195.0, 199.0, 199.0, 200.0, 198.0, 198.0, 195.0, 204.0, 195.0], "value": 198.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 59.0, 89.0, 62.0, 61.0, 60.0, 59.0, 72.0, 59.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 84.0, 94.0, 93.0, 98.0, 107.0, 71.0, 71.0, 82.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 86.0, 92.0, 85.0, 94.0, 123.0, 123.0, 86.0], "value": 95.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 97.0, 107.0, 100.0, 98.0, 119.0, 98.0, 140.0, 163.0], "value": 112.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 133.0, 145.0, 96.0, 91.0, 94.0, 92.0, 93.0, 93.0, 96.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 75.0, 82.0, 72.0, 71.0, 71.0, 71.0, 73.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 82.0, 75.0, 84.0, 77.0, 107.0, 74.0, 105.0, 99.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 173.0, 139.0, 137.0, 135.0, 141.0, 141.0, 146.0, 239.0, 166.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 193.0, 205.0, 169.0, 145.0, 163.0, 217.0, 213.0, 181.0, 167.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 68.0, 66.0, 65.0, 67.0, 68.0, 66.0, 66.0], "value": 66.6, "unit": "score"}]}]} 02:35:33 INFO - Return code: 0 02:35:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:35:33 ERROR - # TBPL SUCCESS # 02:35:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:35:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:35:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:35:33 INFO - 2017-03-04 02:35:33.256 screenresolution[3176:57971] starting screenresolution argv=screenresolution get 02:35:33 INFO - 2017-03-04 02:35:33.259 screenresolution[3176:57971] Display 0: 1600x1200x32@60 02:35:33 INFO - 2017-03-04 02:35:33.264 screenresolution[3177:57973] starting screenresolution argv=screenresolution list 02:35:33 INFO - Available Modes on Display 0 02:35:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:35:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:35:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:35:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:35:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:35:33 INFO - Intel Iris: 02:35:33 INFO - Chipset Model: Intel Iris 02:35:33 INFO - Type: GPU 02:35:33 INFO - Bus: Built-In 02:35:33 INFO - VRAM (Dynamic, Max): 1536 MB 02:35:33 INFO - Vendor: Intel (0x8086) 02:35:33 INFO - Device ID: 0x0a2e 02:35:33 INFO - Revision ID: 0x0009 02:35:33 INFO - Displays: 02:35:33 INFO - Display: 02:35:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:35:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:35:33 INFO - Display Serial Number: 1600x1200 60 02:35:33 INFO - Main Display: Yes 02:35:33 INFO - Mirror: Off 02:35:33 INFO - Online: Yes 02:35:33 INFO - Rotation: Supported 02:35:33 INFO - Return code: 0 02:35:33 INFO - Running post-action listener: _resource_record_post_action 02:35:33 INFO - [mozharness: 2017-03-04 10:35:33.507283Z] Finished run-tests step (success) 02:35:33 INFO - Running post-run listener: _resource_record_post_run 02:35:33 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 630784; Write bytes: 512593920; Read time: 7; Write time: 1634 02:35:33 INFO - TinderboxPrint: CPU usage
54.5% 02:35:33 INFO - TinderboxPrint: I/O read bytes / time
630,784 / 7 02:35:33 INFO - TinderboxPrint: I/O write bytes / time
512,593,920 / 1,634 02:35:33 INFO - TinderboxPrint: CPU idle
2,177.1 (45.5%) 02:35:33 INFO - TinderboxPrint: CPU system
960.2 (20.0%) 02:35:33 INFO - TinderboxPrint: CPU user
1,652.4 (34.5%) 02:35:33 INFO - TinderboxPrint: Swap in / out
207,925,248 / 0 02:35:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205429248; Write bytes: 199151616; Read time: 15816; Write time: 358 02:35:33 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 630784; Write bytes: 302473216; Read time: 7; Write time: 1244 02:35:33 INFO - Running post-run listener: _upload_blobber_files 02:35:33 INFO - Blob upload gear active. 02:35:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:35:33 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:35:33 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:35:33 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:35:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:35 INFO - (blobuploader) - INFO - Done attempting. 02:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:36 INFO - (blobuploader) - INFO - Done attempting. 02:35:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:35:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:36 INFO - (blobuploader) - INFO - Done attempting. 02:35:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:35:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:35:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:39 INFO - (blobuploader) - INFO - Done attempting. 02:35:39 INFO - (blobuploader) - INFO - Iteration through files over. 02:35:39 INFO - Return code: 0 02:35:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:35:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:35:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1534ad081831e8fa52b0df88e60bcfb1739731059131e8049313041fcc081da4353de2a120467e233d9a200d1bd134c15f9079b9b9a7be5f835d153c2b6e4c0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88f254f28e537816cc7f86ac93b03697e37de079178ff044e900c775e671b19598701462b2ef6bfaf58c49b11e3fa21246e06e87795ebff62b367895f1820cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/750c0204208c962de0c23cbcce5fdf82d4e57ff823cf6e8e76db87b54e0ee5716d1bfb575b85baec0945d82deebe5c7181b8f5d276a04069200230d458c5af9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c93e1447f518a4ccb8be268058efe274199bd8b6f5eb2d8dde30c1ca0cd11c8475dc8d77bc5651dadf296c5d368b4b26f0575b0517312d7ab73627fddf999b29"} 02:35:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:35:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:35:39 INFO - Contents: 02:35:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1534ad081831e8fa52b0df88e60bcfb1739731059131e8049313041fcc081da4353de2a120467e233d9a200d1bd134c15f9079b9b9a7be5f835d153c2b6e4c0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88f254f28e537816cc7f86ac93b03697e37de079178ff044e900c775e671b19598701462b2ef6bfaf58c49b11e3fa21246e06e87795ebff62b367895f1820cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/750c0204208c962de0c23cbcce5fdf82d4e57ff823cf6e8e76db87b54e0ee5716d1bfb575b85baec0945d82deebe5c7181b8f5d276a04069200230d458c5af9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c93e1447f518a4ccb8be268058efe274199bd8b6f5eb2d8dde30c1ca0cd11c8475dc8d77bc5651dadf296c5d368b4b26f0575b0517312d7ab73627fddf999b29"} 02:35:39 INFO - Running post-run listener: copy_logs_to_upload_dir 02:35:39 INFO - Copying logs to upload dir... 02:35:39 INFO - mkdir: /builds/slave/test/build/upload/logs 02:35:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1370.358555 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 50 secs) (at 2017-03-04 02:35:39.130294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 02:35:39.134017) ========= 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.pPu1fvYc8U/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.ax09j26OnI/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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/1534ad081831e8fa52b0df88e60bcfb1739731059131e8049313041fcc081da4353de2a120467e233d9a200d1bd134c15f9079b9b9a7be5f835d153c2b6e4c0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88f254f28e537816cc7f86ac93b03697e37de079178ff044e900c775e671b19598701462b2ef6bfaf58c49b11e3fa21246e06e87795ebff62b367895f1820cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/750c0204208c962de0c23cbcce5fdf82d4e57ff823cf6e8e76db87b54e0ee5716d1bfb575b85baec0945d82deebe5c7181b8f5d276a04069200230d458c5af9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c93e1447f518a4ccb8be268058efe274199bd8b6f5eb2d8dde30c1ca0cd11c8475dc8d77bc5651dadf296c5d368b4b26f0575b0517312d7ab73627fddf999b29"} build_url:https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1534ad081831e8fa52b0df88e60bcfb1739731059131e8049313041fcc081da4353de2a120467e233d9a200d1bd134c15f9079b9b9a7be5f835d153c2b6e4c0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b88f254f28e537816cc7f86ac93b03697e37de079178ff044e900c775e671b19598701462b2ef6bfaf58c49b11e3fa21246e06e87795ebff62b367895f1820cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/750c0204208c962de0c23cbcce5fdf82d4e57ff823cf6e8e76db87b54e0ee5716d1bfb575b85baec0945d82deebe5c7181b8f5d276a04069200230d458c5af9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c93e1447f518a4ccb8be268058efe274199bd8b6f5eb2d8dde30c1ca0cd11c8475dc8d77bc5651dadf296c5d368b4b26f0575b0517312d7ab73627fddf999b29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 02:35:39.168860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:35:39.169182) ========= 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.pPu1fvYc8U/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.ax09j26OnI/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005571 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:35:39.218484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 02:35:39.218804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 02:35:39.219117) ========= ========= Total master_lag: 0.07 =========