builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0355 starttime: 1492795269.11 results: success (0) buildid: 20170421072927 builduid: 8c567a83b73d46fd89e6e21d15541005 revision: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.109937) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.110396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.110672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.138521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.138919) ========= 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.blXOoU9iNZ/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.wDaDMtrV78/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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-04-21 10:21:09-- 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% 18.6M=0.001s 2017-04-21 10:21:09 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128827 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.293027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.293380) ========= 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.blXOoU9iNZ/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.wDaDMtrV78/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.027773 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:09.343015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 10:21:09.343369) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.blXOoU9iNZ/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.wDaDMtrV78/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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-04-21 10:21:09,453 truncating revision to first 12 chars 2017-04-21 10:21:09,453 Setting DEBUG logging. 2017-04-21 10:21:09,453 attempt 1/10 2017-04-21 10:21:09,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ca38cf3eba17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 10:21:10,670 unpacking tar archive at: mozilla-beta-ca38cf3eba17/testing/mozharness/ program finished with exit code 0 elapsedTime=1.495565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 10:21:10.863215) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:10.863545) ========= script_repo_revision: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:10.863950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:10.864219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:21:10.885030) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-21 10:21:10.885478) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.blXOoU9iNZ/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.wDaDMtrV78/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:21:11 INFO - MultiFileLogger online at 20170421 10:21:11 in /builds/slave/test 10:21:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:21:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:21:11 INFO - {'append_to_log': False, 10:21:11 INFO - 'base_work_dir': '/builds/slave/test', 10:21:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:21:11 INFO - 'branch': 'Mozilla-Beta', 10:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:21:11 INFO - 'config_files': ('talos/mac_config.py',), 10:21:11 INFO - 'default_actions': ('clobber', 10:21:11 INFO - 'read-buildbot-config', 10:21:11 INFO - 'download-and-extract', 10:21:11 INFO - 'populate-webroot', 10:21:11 INFO - 'create-virtualenv', 10:21:11 INFO - 'install', 10:21:11 INFO - 'run-tests'), 10:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:21:11 INFO - 'download_minidump_stackwalk': True, 10:21:11 INFO - 'download_symbols': 'ondemand', 10:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:21:11 INFO - 'gecko_profile': False, 10:21:11 INFO - 'gecko_profile_interval': 0, 10:21:11 INFO - 'installer_path': 'installer.exe', 10:21:11 INFO - 'log_level': 'info', 10:21:11 INFO - 'log_name': 'talos', 10:21:11 INFO - 'log_to_console': True, 10:21:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:21:11 INFO - 'opt_config_files': (), 10:21:11 INFO - 'pip_index': False, 10:21:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:21:11 INFO - 'cmd': ('bash', 10:21:11 INFO - '-c', 10:21:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:21:11 INFO - 'enabled': True, 10:21:11 INFO - 'halt_on_failure': False, 10:21:11 INFO - 'name': 'check_screen_resolution'},), 10:21:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:21:11 INFO - 'cmd': ('bash', 10:21:11 INFO - '-c', 10:21:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:21:11 INFO - 'enabled': True, 10:21:11 INFO - 'halt_on_failure': False, 10:21:11 INFO - 'name': 'check_screen_resolution'},), 10:21:11 INFO - 'run_cmd_checks_enabled': True, 10:21:11 INFO - 'suite': 'dromaeojs-e10s', 10:21:11 INFO - 'system_bits': '32', 10:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:21:11 INFO - 'title': 't-yosemite-r7-0355', 10:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:21:11 INFO - 'use_talos_json': True, 10:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:21:11 INFO - 'work_dir': 'build'} 10:21:11 INFO - [mozharness: 2017-04-21 17:21:11.104843Z] Running clobber step. 10:21:11 INFO - Running pre-action listener: _resource_record_pre_action 10:21:11 INFO - Running main action method: clobber 10:21:11 INFO - rmtree: /builds/slave/test/build 10:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:21:13 INFO - Running post-action listener: _resource_record_post_action 10:21:13 INFO - [mozharness: 2017-04-21 17:21:13.598547Z] Finished clobber step (success) 10:21:13 INFO - [mozharness: 2017-04-21 17:21:13.598671Z] Running read-buildbot-config step. 10:21:13 INFO - Running pre-action listener: _resource_record_pre_action 10:21:13 INFO - Running main action method: read_buildbot_config 10:21:13 INFO - Using buildbot properties: 10:21:13 INFO - { 10:21:13 INFO - "project": "", 10:21:13 INFO - "product": "firefox", 10:21:13 INFO - "script_repo_revision": "production", 10:21:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:21:13 INFO - "repository": "", 10:21:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:21:13 INFO - "buildid": "20170421072927", 10:21:13 INFO - "pgo_build": "False", 10:21:13 INFO - "basedir": "/builds/slave/test", 10:21:13 INFO - "buildnumber": 11, 10:21:13 INFO - "slavename": "t-yosemite-r7-0355", 10:21:13 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:21:13 INFO - "platform": "yosemite_r7", 10:21:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:21:13 INFO - "branch": "mozilla-beta", 10:21:13 INFO - "repo_path": "releases/mozilla-beta", 10:21:13 INFO - "revision": "ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e", 10:21:13 INFO - "stage_platform": "macosx64", 10:21:13 INFO - "builduid": "8c567a83b73d46fd89e6e21d15541005", 10:21:13 INFO - "slavebuilddir": "test" 10:21:13 INFO - } 10:21:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 10:21:13 INFO - Running post-action listener: _resource_record_post_action 10:21:13 INFO - [mozharness: 2017-04-21 17:21:13.601936Z] Finished read-buildbot-config step (success) 10:21:13 INFO - [mozharness: 2017-04-21 17:21:13.602069Z] Running download-and-extract step. 10:21:13 INFO - Running pre-action listener: _resource_record_pre_action 10:21:13 INFO - Running main action method: download_and_extract 10:21:13 INFO - mkdir: /builds/slave/test/build/tests 10:21:13 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')]} 10:21:13 INFO - trying https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 10:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 10:21:14 INFO - Downloaded 1165 bytes. 10:21:14 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 10:21:14 INFO - Using the following test package requirements: 10:21:14 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:21:14 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 10:21:14 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 10:21:14 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:21:14 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 10:21:14 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 10:21:14 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 10:21:14 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 10:21:14 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 10:21:14 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 10:21:14 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 10:21:14 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 10:21:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:21:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:21:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:21:16 INFO - Expected file size: 51223402 10:21:16 INFO - Obtained file size: 51223402 10:21:32 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:21:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 10:21:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 10:21:32 INFO - Fetch https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 10:21:34 INFO - Expected file size: 51223402 10:21:34 INFO - Obtained file size: 51223402 10:21:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 10:21:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 10:21:49 INFO - Fetch https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 10:21:51 INFO - Expected file size: 14404424 10:21:51 INFO - Obtained file size: 14404424 10:21: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')]} 10:21:51 INFO - trying https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:21:51 INFO - Downloading https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 10:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 10:21:53 INFO - Downloaded 59545707 bytes. 10:21:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:21:53 INFO - mkdir: /builds/slave/test/properties 10:21:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:53 INFO - Contents: 10:21:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 10:21:53 INFO - Running post-action listener: _resource_record_post_action 10:21:53 INFO - Running post-action listener: set_extra_try_arguments 10:21:53 INFO - [mozharness: 2017-04-21 17:21:53.844131Z] Finished download-and-extract step (success) 10:21:53 INFO - [mozharness: 2017-04-21 17:21:53.844250Z] Running populate-webroot step. 10:21:53 INFO - Running pre-action listener: _resource_record_pre_action 10:21:53 INFO - Running main action method: populate_webroot 10:21:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:53 INFO - '--tppagecycles', 10:21:53 INFO - '7'], 10:21:53 INFO - 'tests': ['tsvgm']}}, 10:21:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['damp', 'tps']}, 10:21:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'tests': ['damp', 'tps']}, 10:21:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['dromaeo_dom']}, 10:21:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['basic_compositor_video']}, 10:21:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:21:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['a11yr', 10:21:53 INFO - 'ts_paint', 10:21:53 INFO - 'tpaint', 10:21:53 INFO - 'sessionrestore', 10:21:53 INFO - 'sessionrestore_no_auto_restore', 10:21:53 INFO - 'tabpaint']}, 10:21:53 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:53 INFO - 'ts_paint', 10:21:53 INFO - 'tpaint', 10:21:53 INFO - 'sessionrestore', 10:21:53 INFO - 'sessionrestore_no_auto_restore', 10:21:53 INFO - 'tabpaint']}, 10:21:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:53 INFO - 'ts_paint', 10:21:53 INFO - 'tpaint', 10:21:53 INFO - 'sessionrestore', 10:21:53 INFO - 'sessionrestore_no_auto_restore', 10:21:53 INFO - 'tabpaint']}, 10:21:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:53 INFO - 'ts_paint', 10:21:53 INFO - 'tpaint', 10:21:53 INFO - 'sessionrestore', 10:21:53 INFO - 'sessionrestore_no_auto_restore', 10:21:53 INFO - 'tabpaint']}, 10:21:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['a11yr', 10:21:53 INFO - 'ts_paint', 10:21:53 INFO - 'tpaint', 10:21:53 INFO - 'sessionrestore', 10:21:53 INFO - 'sessionrestore_no_auto_restore', 10:21:53 INFO - 'tabpaint']}, 10:21:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['a11yr', 10:21:53 INFO - 'ts_paint', 10:21:53 INFO - 'tpaint', 10:21:53 INFO - 'sessionrestore', 10:21:53 INFO - 'sessionrestore_no_auto_restore', 10:21:53 INFO - 'tabpaint']}, 10:21:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['tsvgx', 10:21:53 INFO - 'tsvgr_opacity', 10:21:53 INFO - 'tart', 10:21:53 INFO - 'tscrollx', 10:21:53 INFO - 'cart', 10:21:53 INFO - 'tsvg_static']}, 10:21:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:53 INFO - 'tsvgr_opacity', 10:21:53 INFO - 'tart', 10:21:53 INFO - 'tscrollx', 10:21:53 INFO - 'cart', 10:21:53 INFO - 'tsvg_static']}, 10:21:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'talos_options': ['--disable-e10s'], 10:21:53 INFO - 'tests': ['tp5o']}, 10:21:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:21:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'talos_options': ['--disable-e10s', 10:21:53 INFO - '--xperf_path', 10:21:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:53 INFO - 'tests': ['tp5n']}, 10:21:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:21:53 INFO - 'talos_options': ['--xperf_path', 10:21:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:53 INFO - 'tests': ['tp5n']}}, 10:21:53 INFO - 'talos.zip': {'path': '', 10:21:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:53 INFO - Running post-action listener: _resource_record_post_action 10:21:53 INFO - [mozharness: 2017-04-21 17:21:53.863188Z] Finished populate-webroot step (success) 10:21:53 INFO - [mozharness: 2017-04-21 17:21:53.863304Z] Running create-virtualenv step. 10:21:53 INFO - Running pre-action listener: _resource_record_pre_action 10:21:53 INFO - Running main action method: create_virtualenv 10:21:53 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:53 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 10:21:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:53 INFO - Using real prefix '/tools/python27' 10:21:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:57 INFO - Installing pip.................done. 10:21:57 INFO - Return code: 0 10:21:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:21:57 INFO - Reading from file tmpfile_stdout 10:21:57 INFO - Output received: 10:21:57 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) 10:21:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:21: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', 'pip>=1.5'] in /builds/slave/test/build 10:21: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 pip>=1.5 10:21:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:21:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:57 INFO - 'HOME': '/Users/cltbld', 10:21:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:57 INFO - 'LOGNAME': 'cltbld', 10:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:57 INFO - 'MOZ_NO_REMOTE': '1', 10:21:57 INFO - 'NO_EM_RESTART': '1', 10:21:57 INFO - 'PAGER': '/bin/cat', 10:21:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:57 INFO - 'PWD': '/builds/slave/test', 10:21:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:57 INFO - 'SHELL': '/bin/bash', 10:21:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:21:57 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:21:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:57 INFO - 'USER': 'cltbld', 10:21:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:57 INFO - 'XPC_FLAGS': '0x0', 10:21:57 INFO - 'XPC_SERVICE_NAME': '0', 10:21:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:58 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 10:21:58 INFO - Cleaning up... 10:21:58 INFO - Return code: 0 10:21:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:21:58 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')]} 10:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:58 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')]} 10:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:58 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:21:58 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 10:21:58 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 10:21:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:21:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:58 INFO - 'HOME': '/Users/cltbld', 10:21:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:58 INFO - 'LOGNAME': 'cltbld', 10:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:58 INFO - 'MOZ_NO_REMOTE': '1', 10:21:58 INFO - 'NO_EM_RESTART': '1', 10:21:58 INFO - 'PAGER': '/bin/cat', 10:21:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:58 INFO - 'PWD': '/builds/slave/test', 10:21:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:58 INFO - 'SHELL': '/bin/bash', 10:21:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:21:58 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:21:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:58 INFO - 'USER': 'cltbld', 10:21:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:58 INFO - 'XPC_FLAGS': '0x0', 10:21:58 INFO - 'XPC_SERVICE_NAME': '0', 10:21:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:58 INFO - Downloading/unpacking psutil>=3.1.1 10:21:58 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 10:21:58 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 10:21:58 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 10:21:58 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 10:21:58 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 10:21:58 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 10:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:02 INFO - Installing collected packages: psutil 10:22:02 INFO - Running setup.py install for psutil 10:22:02 INFO - building 'psutil._psutil_osx' extension 10:22:02 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 10:22:02 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 10:22:02 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 10:22:02 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 10:22:02 INFO - building 'psutil._psutil_posix' extension 10:22:02 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 10:22:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:22:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:22:02 INFO - ^ 10:22:02 INFO - 1 warning generated. 10:22:02 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 10:22:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:03 INFO - Successfully installed psutil 10:22:03 INFO - Cleaning up... 10:22:03 INFO - Return code: 0 10:22:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:22:03 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')]} 10:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:03 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')]} 10:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:03 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:03 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 10:22:03 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 10:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:03 INFO - 'HOME': '/Users/cltbld', 10:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:03 INFO - 'LOGNAME': 'cltbld', 10:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:03 INFO - 'MOZ_NO_REMOTE': '1', 10:22:03 INFO - 'NO_EM_RESTART': '1', 10:22:03 INFO - 'PAGER': '/bin/cat', 10:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:03 INFO - 'PWD': '/builds/slave/test', 10:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:03 INFO - 'SHELL': '/bin/bash', 10:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:03 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:03 INFO - 'USER': 'cltbld', 10:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:03 INFO - 'XPC_FLAGS': '0x0', 10:22:03 INFO - 'XPC_SERVICE_NAME': '0', 10:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:22:06 INFO - Installing collected packages: mozsystemmonitor 10:22:06 INFO - Running setup.py install for mozsystemmonitor 10:22:06 INFO - Successfully installed mozsystemmonitor 10:22:06 INFO - Cleaning up... 10:22:06 INFO - Return code: 0 10:22:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:07 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:07 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 10:22:07 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 10:22:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:07 INFO - 'HOME': '/Users/cltbld', 10:22:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:07 INFO - 'LOGNAME': 'cltbld', 10:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:07 INFO - 'MOZ_NO_REMOTE': '1', 10:22:07 INFO - 'NO_EM_RESTART': '1', 10:22:07 INFO - 'PAGER': '/bin/cat', 10:22:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:07 INFO - 'PWD': '/builds/slave/test', 10:22:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:07 INFO - 'SHELL': '/bin/bash', 10:22:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:07 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:07 INFO - 'USER': 'cltbld', 10:22:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:07 INFO - 'XPC_FLAGS': '0x0', 10:22:07 INFO - 'XPC_SERVICE_NAME': '0', 10:22:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:07 INFO - Downloading/unpacking jsonschema==2.5.1 10:22:07 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 10:22:07 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 10:22:07 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 10:22:07 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 10:22:07 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 10:22:07 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 10:22:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:22:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:22:10 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 10:22:10 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 10:22:10 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 10:22:10 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 10:22:10 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 10:22:10 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 10:22:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:22:10 INFO - warning: no files found matching '*.txt' 10:22:10 INFO - no previously-included directories found matching 'build' 10:22:10 INFO - no previously-included directories found matching 'dist' 10:22:10 INFO - no previously-included directories found matching '.git*' 10:22:10 INFO - Installing collected packages: jsonschema, functools32 10:22:10 INFO - Running setup.py install for functools32 10:22:11 INFO - warning: no files found matching '*.txt' 10:22:11 INFO - no previously-included directories found matching 'build' 10:22:11 INFO - no previously-included directories found matching 'dist' 10:22:11 INFO - no previously-included directories found matching '.git*' 10:22:11 INFO - Successfully installed jsonschema functools32 10:22:11 INFO - Cleaning up... 10:22:11 INFO - Return code: 0 10:22:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:11 INFO - 'HOME': '/Users/cltbld', 10:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:11 INFO - 'LOGNAME': 'cltbld', 10:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:11 INFO - 'MOZ_NO_REMOTE': '1', 10:22:11 INFO - 'NO_EM_RESTART': '1', 10:22:11 INFO - 'PAGER': '/bin/cat', 10:22:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:11 INFO - 'PWD': '/builds/slave/test', 10:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:11 INFO - 'SHELL': '/bin/bash', 10:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:11 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:11 INFO - 'USER': 'cltbld', 10:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:11 INFO - 'XPC_FLAGS': '0x0', 10:22:11 INFO - 'XPC_SERVICE_NAME': '0', 10:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:22:11 INFO - Cleaning up... 10:22:11 INFO - Return code: 0 10:22:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:11 INFO - 'HOME': '/Users/cltbld', 10:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:11 INFO - 'LOGNAME': 'cltbld', 10:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:11 INFO - 'MOZ_NO_REMOTE': '1', 10:22:11 INFO - 'NO_EM_RESTART': '1', 10:22:11 INFO - 'PAGER': '/bin/cat', 10:22:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:11 INFO - 'PWD': '/builds/slave/test', 10:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:11 INFO - 'SHELL': '/bin/bash', 10:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:11 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:11 INFO - 'USER': 'cltbld', 10:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:11 INFO - 'XPC_FLAGS': '0x0', 10:22:11 INFO - 'XPC_SERVICE_NAME': '0', 10:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:14 INFO - Downloading blobuploader-1.2.4.tar.gz 10:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:22:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:22:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:15 INFO - Downloading docopt-0.6.1.tar.gz 10:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:22:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:22:15 INFO - Running setup.py install for blobuploader 10:22:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:22:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:22:15 INFO - Running setup.py install for requests 10:22:16 INFO - Running setup.py install for docopt 10:22:16 INFO - Successfully installed blobuploader requests docopt 10:22:16 INFO - Cleaning up... 10:22:16 INFO - Return code: 0 10:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:16 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')]} 10:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:16 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')]} 10:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:16 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:16 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 10:22:16 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 10:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:16 INFO - 'HOME': '/Users/cltbld', 10:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:16 INFO - 'LOGNAME': 'cltbld', 10:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:16 INFO - 'MOZ_NO_REMOTE': '1', 10:22:16 INFO - 'NO_EM_RESTART': '1', 10:22:16 INFO - 'PAGER': '/bin/cat', 10:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:16 INFO - 'PWD': '/builds/slave/test', 10:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:16 INFO - 'SHELL': '/bin/bash', 10:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:16 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:16 INFO - 'USER': 'cltbld', 10:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:16 INFO - 'XPC_FLAGS': '0x0', 10:22:16 INFO - 'XPC_SERVICE_NAME': '0', 10:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:16 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-hZK2JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:16 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-mYxngP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-laGhYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-jGIDYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-XkdAbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-QK6mPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-6i5r_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-R0zyPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-iuMIj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-b6I9DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:17 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-LbBrrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:18 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-w5LRyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:18 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-8ytdsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:18 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-qGflyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:18 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-xaZl8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:18 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-kJ6i4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:18 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Q77yN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:22:18 INFO - Running setup.py install for manifestparser 10:22:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:22:18 INFO - Running setup.py install for mozcrash 10:22:18 INFO - Running setup.py install for mozdebug 10:22:19 INFO - Running setup.py install for mozdevice 10:22:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Running setup.py install for mozfile 10:22:19 INFO - Running setup.py install for mozhttpd 10:22:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Running setup.py install for mozinfo 10:22:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Running setup.py install for mozInstall 10:22:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:22:19 INFO - Running setup.py install for mozleak 10:22:19 INFO - Running setup.py install for mozlog 10:22:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:22:20 INFO - Running setup.py install for moznetwork 10:22:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:22:20 INFO - Running setup.py install for mozprocess 10:22:20 INFO - Running setup.py install for mozprofile 10:22:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:22:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:22:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:22:20 INFO - Running setup.py install for mozrunner 10:22:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:22:20 INFO - Running setup.py install for mozscreenshot 10:22:20 INFO - Running setup.py install for moztest 10:22:21 INFO - Running setup.py install for mozversion 10:22:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:22:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:22:21 INFO - Cleaning up... 10:22:21 INFO - Return code: 0 10:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:21 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:21 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 10:22:21 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 10:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:21 INFO - 'HOME': '/Users/cltbld', 10:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:21 INFO - 'LOGNAME': 'cltbld', 10:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:21 INFO - 'MOZ_NO_REMOTE': '1', 10:22:21 INFO - 'NO_EM_RESTART': '1', 10:22:21 INFO - 'PAGER': '/bin/cat', 10:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:21 INFO - 'PWD': '/builds/slave/test', 10:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:21 INFO - 'SHELL': '/bin/bash', 10:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:21 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:21 INFO - 'USER': 'cltbld', 10:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:21 INFO - 'XPC_FLAGS': '0x0', 10:22:21 INFO - 'XPC_SERVICE_NAME': '0', 10:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:21 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-g3bm0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:21 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)) 10:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:21 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Lu7lcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:21 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)) 10:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:21 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-BFLoVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:21 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)) 10:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:21 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-ye_Iud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:22:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:21 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-qSQZEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-JihSrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-irQZWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-FId6Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-8z8nU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-19jbIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-uxwOam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-fOEohO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-g8YYYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:22 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)) 10:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:22 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-VOl7_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:23 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)) 10:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:23 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-TQG2K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:23 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)) 10:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:23 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-k0WQBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:23 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)) 10:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:23 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Cow4kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:23 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)) 10:22:23 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)) 10:22:23 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)) 10:22:23 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)) 10:22:23 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)) 10:22:23 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)) 10:22:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:23 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 10:22:23 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 10:22:23 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 10:22:23 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 10:22:23 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 10:22:23 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 10:22:26 INFO - Downloading blessings-1.6.tar.gz 10:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:22:26 INFO - Installing collected packages: blessings 10:22:26 INFO - Running setup.py install for blessings 10:22:26 INFO - Successfully installed blessings 10:22:26 INFO - Cleaning up... 10:22:26 INFO - Return code: 0 10:22:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:26 INFO - Reading from file tmpfile_stdout 10:22:26 INFO - Current package versions: 10:22:26 INFO - blessings == 1.6 10:22:26 INFO - blobuploader == 1.2.4 10:22:26 INFO - docopt == 0.6.1 10:22:26 INFO - functools32 == 3.2.3-2 10:22:26 INFO - jsonschema == 2.5.1 10:22:26 INFO - manifestparser == 1.1 10:22:26 INFO - mozInstall == 1.12 10:22:26 INFO - mozcrash == 1.0 10:22:26 INFO - mozdebug == 0.1 10:22:26 INFO - mozdevice == 0.49 10:22:26 INFO - mozfile == 1.2 10:22:26 INFO - mozhttpd == 0.7 10:22:26 INFO - mozinfo == 0.9 10:22:26 INFO - mozleak == 0.1 10:22:26 INFO - mozlog == 3.4 10:22:26 INFO - moznetwork == 0.27 10:22:26 INFO - mozprocess == 0.25 10:22:26 INFO - mozprofile == 0.28 10:22:26 INFO - mozrunner == 6.13 10:22:26 INFO - mozscreenshot == 0.1 10:22:26 INFO - mozsystemmonitor == 0.3 10:22:26 INFO - moztest == 0.8 10:22:26 INFO - mozversion == 1.4 10:22:26 INFO - psutil == 3.1.1 10:22:26 INFO - requests == 1.2.3 10:22:26 INFO - wsgiref == 0.1.2 10:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:26 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')]} 10:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:26 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')]} 10:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:26 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:26 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 10:22:26 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 10:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:26 INFO - 'HOME': '/Users/cltbld', 10:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:26 INFO - 'LOGNAME': 'cltbld', 10:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:26 INFO - 'MOZ_NO_REMOTE': '1', 10:22:26 INFO - 'NO_EM_RESTART': '1', 10:22:26 INFO - 'PAGER': '/bin/cat', 10:22:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:26 INFO - 'PWD': '/builds/slave/test', 10:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:26 INFO - 'SHELL': '/bin/bash', 10:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:26 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:26 INFO - 'USER': 'cltbld', 10:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:26 INFO - 'XPC_FLAGS': '0x0', 10:22:26 INFO - 'XPC_SERVICE_NAME': '0', 10:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 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)) 10:22:26 INFO - Cleaning up... 10:22:26 INFO - Return code: 0 10:22:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:22:26 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')]} 10:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:26 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')]} 10:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:26 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 0x101eedb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ef0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e52dc3af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, '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.blXOoU9iNZ/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.wDaDMtrV78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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 10:22:26 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 10:22:26 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 10:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:26 INFO - 'HOME': '/Users/cltbld', 10:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:26 INFO - 'LOGNAME': 'cltbld', 10:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:26 INFO - 'MOZ_NO_REMOTE': '1', 10:22:26 INFO - 'NO_EM_RESTART': '1', 10:22:26 INFO - 'PAGER': '/bin/cat', 10:22:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:26 INFO - 'PWD': '/builds/slave/test', 10:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:26 INFO - 'SHELL': '/bin/bash', 10:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:26 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:26 INFO - 'USER': 'cltbld', 10:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:26 INFO - 'XPC_FLAGS': '0x0', 10:22:26 INFO - 'XPC_SERVICE_NAME': '0', 10:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:22:27 INFO - Cleaning up... 10:22:27 INFO - Return code: 0 10:22:27 INFO - Running post-action listener: _resource_record_post_action 10:22:27 INFO - Running post-action listener: _start_resource_monitoring 10:22:27 INFO - Starting resource monitoring. 10:22:27 INFO - [mozharness: 2017-04-21 17:22:27.255555Z] Finished create-virtualenv step (success) 10:22:27 INFO - [mozharness: 2017-04-21 17:22:27.256556Z] Running install step. 10:22:27 INFO - Running pre-action listener: _resource_record_pre_action 10:22:27 INFO - Running main action method: install 10:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:22:27 INFO - Reading from file tmpfile_stdout 10:22:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:22:27 INFO - Reading from file tmpfile_stdout 10:22:27 INFO - Output received: 10:22:27 INFO - Usage: mozinstall [options] installer 10:22:27 INFO - Options: 10:22:27 INFO - -h, --help show this help message and exit 10:22:27 INFO - -d DEST, --destination=DEST 10:22:27 INFO - Directory to install application into. [default: 10:22:27 INFO - "/builds/slave/test"] 10:22:27 INFO - --app=APP Application being installed. [default: firefox] 10:22:27 INFO - mkdir: /builds/slave/test/build/application 10:22:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:22:42 INFO - Reading from file tmpfile_stdout 10:22:42 INFO - Output received: 10:22:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:22:42 INFO - Running post-action listener: _resource_record_post_action 10:22:42 INFO - [mozharness: 2017-04-21 17:22:42.619139Z] Finished install step (success) 10:22:42 INFO - [mozharness: 2017-04-21 17:22:42.619272Z] Running run-tests step. 10:22:42 INFO - Running pre-action listener: _resource_record_pre_action 10:22:42 INFO - Running main action method: run_tests 10:22:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:22:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:22:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:22:42 INFO - 2017-04-21 10:22:42.634 screenresolution[1629:7446] starting screenresolution argv=screenresolution get 10:22:42 INFO - 2017-04-21 10:22:42.636 screenresolution[1629:7446] Display 0: 1600x1200x32@60 10:22:42 INFO - 2017-04-21 10:22:42.642 screenresolution[1630:7448] starting screenresolution argv=screenresolution list 10:22:42 INFO - Available Modes on Display 0 10:22:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:22:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:22:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:22:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:22:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:22:42 INFO - Intel Iris: 10:22:42 INFO - Chipset Model: Intel Iris 10:22:42 INFO - Type: GPU 10:22:42 INFO - Bus: Built-In 10:22:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:22:42 INFO - Vendor: Intel (0x8086) 10:22:42 INFO - Device ID: 0x0a2e 10:22:42 INFO - Revision ID: 0x0009 10:22:42 INFO - Displays: 10:22:42 INFO - Display: 10:22:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:22:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:22:42 INFO - Display Serial Number: 1600x1200 60 10:22:42 INFO - Main Display: Yes 10:22:42 INFO - Mirror: Off 10:22:42 INFO - Online: Yes 10:22:42 INFO - Rotation: Supported 10:22:42 INFO - Return code: 0 10:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:42 INFO - Python 2.7.3 10:22:42 INFO - Return code: 0 10:22:42 INFO - grabbing minidump binary from tooltool 10:22: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')]} 10:22:42 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 0x101ccbd30>, '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 0x101bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:42 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 10:22:42 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 10:22:42 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 10:22:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:43 INFO - Return code: 0 10:22:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:22:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:43 INFO - ENV: RUST_BACKTRACE is now 1 10:22:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:22:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--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 10:22:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0355 --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 10:22:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.blXOoU9iNZ/Render', 10:22:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:43 INFO - 'HOME': '/Users/cltbld', 10:22:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:43 INFO - 'LOGNAME': 'cltbld', 10:22:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:43 INFO - 'MOZ_NO_REMOTE': '1', 10:22:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:43 INFO - 'NO_EM_RESTART': '1', 10:22:43 INFO - 'PAGER': '/bin/cat', 10:22:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:43 INFO - 'PWD': '/builds/slave/test', 10:22:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:43 INFO - 'RUST_BACKTRACE': '1', 10:22:43 INFO - 'SHELL': '/bin/bash', 10:22:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wDaDMtrV78/Listeners', 10:22:43 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 10:22:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:43 INFO - 'USER': 'cltbld', 10:22:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:43 INFO - 'XPC_FLAGS': '0x0', 10:22:43 INFO - 'XPC_SERVICE_NAME': '0', 10:22:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--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 10:22:43 INFO - mozversion application_buildid: 20170421072927 10:22:43 INFO - mozversion application_changeset: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e 10:22:43 INFO - mozversion application_display_name: Firefox 10:22:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:43 INFO - mozversion application_name: Firefox 10:22:43 INFO - mozversion application_remotingname: firefox 10:22:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:22:43 INFO - mozversion application_vendor: Mozilla 10:22:43 INFO - mozversion application_version: 54.0 10:22:43 INFO - mozversion platform_buildid: 20170421072927 10:22:43 INFO - mozversion platform_changeset: ca38cf3eba178b7d1a25a9e1e8ba72dd466fed2e 10:22:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:22:43 INFO - mozversion platform_version: 54.0 10:22:43 INFO - using testdate: 1492795363 10:22:43 INFO - actual date: 1492795363 10:22:43 INFO - starting webserver on 'localhost:49241' 10:22:43 INFO - SUITE-START | Running 2 tests 10:22:43 INFO - TEST-START | dromaeo_css 10:22:43 INFO - operating with platform_type : mac_ 10:22:43 INFO - Initialising browser for dromaeo_css test... 10:22:43 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpj7Mm33/profile http://localhost:49241/getInfo.html) 10:22:45 INFO - PROCESS | 1640 | 2017-04-21 10:22:45.920 plugin-container[1643:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 10:22:45 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:45 INFO - PROCESS | 1640 | 2017-04-21 10:22:45.923 plugin-container[1643:7610] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 10:22:45 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:45 INFO - PROCESS | 1640 | 2017-04-21 10:22:45.923 plugin-container[1643:7610] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:45 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 10:22:45 INFO - PROCESS | 1640 | colorDepth:24 10:22:45 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 10:22:45 INFO - PROCESS | 1640 | __metrics 10:22:46 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 10:22:46 INFO - TEST-INFO | 1640: exit 0 10:22:46 INFO - Browser initialized. 10:22:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:46 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpj7Mm33/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:48 INFO - PROCESS | 1644 | 2017-04-21 10:22:48.861 plugin-container[1645:7750] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864f, name = 'com.apple.tsm.portname' 10:22:48 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:48 INFO - PROCESS | 1644 | 2017-04-21 10:22:48.862 plugin-container[1645:7750] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x421b, name = 'com.apple.CFPasteboardClient' 10:22:48 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:48 INFO - PROCESS | 1644 | 2017-04-21 10:22:48.862 plugin-container[1645:7750] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:58 INFO - PROCESS | 1644 | RSS: Main: 174694400 10:22:58 INFO - PROCESS | 1644 | 10:26:01 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 10:26:03 INFO - PROCESS | 1644 | RSS: Main: 189562880 10:26:03 INFO - PROCESS | 1644 | 10:29:05 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 10:29:05 INFO - PROCESS | 1644 | RSS: Main: 203214848 10:29:05 INFO - PROCESS | 1644 | 10:32:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 10:32:08 INFO - PROCESS | 1644 | RSS: Main: 205193216 10:32:08 INFO - PROCESS | 1644 | 10:35:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:35:10 INFO - PROCESS | 1644 | RSS: Main: 208416768 10:35:10 INFO - PROCESS | 1644 | 10:38:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:38:14 INFO - PROCESS | 1644 | RSS: Main: 211714048 10:38:14 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:41:17 INFO - PROCESS | 1644 | RSS: Main: 209809408 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | __start_tp_report 10:41:17 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 10:41:17 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 10:41:17 INFO - PROCESS | 1644 | |i|pagename|runs| 10:41:17 INFO - PROCESS | 1644 | |0;dojo.html;2741.5476446386347;3655.8354874030665;3667.5232219811437;3687.3362794696945;3701.518802555667;5249.842504724859;5957.689308352161;6196.0705894115845;6225.066240063993;6232.781852635158;6128.601640893339;6133.325334213244;6137.324894261627;6178.629282243069;6182.7836025739;5509.256250406184;5569.721513924308;5570.526505247059;5578.44215578441;5637.943620563803;5594.58040646951;5613;5642.7178641067985;5648.745806438699;5686.545076393879;5427.701476418795;5452.127659574468;5546.833594992157;5619.887602247953;5636.323641163066;5549.334079910416;5556.472135147154;5568.276124103861;5572.721363931787;5608.691521966291;5543.861403464905;5633.183188437694;5638.407967163471;5655.0386434306265;5731.742071606787;6240.5319601030105;6277.435030847246;6278.874422511524;6284.465820405271;6291.62250264981;6253.843653908689;6319.494440444753;6522.510811689095;6546.0835483032415;6576.80269591913;6420.229572451289;6451.741930322782;6460.483161347081;6493.090967264587;6506.772262970773;6236.376362363818;6310.810675679737;6312.810615681537;6313.936860631381;6323.525735569805;6734.6632668367365;6748.966255168692;6759.932400676029;6764.661766911635;6781.25406205317;6257.78097766576;6314.179156709598;6322.936770632326;6343.397377249154;6436.034594810722;6590.934090659128;6594.7032383542855;6605.438537724252;6609.372109649576;6615.966920165464;6457.031445283245;6498.480121590262;6508.446782023487;6509.2839787623325;6526.118973938553;6232.3144454110015;6278.623282603058;6382.266039405435;6400.135981642512;6551.181102362205;4165.937510937339;5221.138512145453;5341;5368.436314186954;5375.623706340597;4659.58063774262;4680.438347398334;4685.718856868599;4690.296455531698;4723.244280915037;6180.289266734293;6303.558750887394;6314.463270621956;6320.146780184708;6335.429811316912;6330.778422755274;6381.298057213703;6465.612063276219;6496.935030649727;6528.445082167974;6322.873542529123;6323.9051414228825;6333.904991425133;6337.429631333202;6349.809505714836;5883.499902508249;5886.793962211302;5894.734736936848;5903.616264942765;5936.851578710481;5801.694618710756;6426.325235850169;6659;6806.353396427331;6874.312568743286;6609.636469994197;6621.569597976116;6637.601743895381;6639.4688424924925;6661.633610151488;6854.211765646815;6926.722931082701;6964.6517674115075;6982.162140543167;6994.825129371807;6286.119943207863;6339.683015849097;6407.135036769976;6516.771912983023;6557.147570815763;5519.558435325084;6619;6626.933730662631;6635.4359879410795;6638.800835974928;5459.918101228405;6443.742250309935;6446.67766611677;6465.256495502889;6480.351964803482;6242.406971337716;6306.590071645328;6335.772196954753;6431.614103153825;6447.871042579029;6207.16203312547;6251.593646413151;6305.180326557518;6317.336679648571;6335.334789847184;6494.383033611799;6504.707288172138;6507.154069970874;6509.804705858832;6525.3800888915475;6118.4059889896;6262.060690896402;6283.874322513616;6369.172007638977;6406.295307516077 10:41:17 INFO - PROCESS | 1644 | |1;ext.html;784.1491981200397;826.2852632472911;845.2266176448552;988.9950550247248;990.173205373513;40208;41034.17931641369;42699.78650106753;42722.93192670185;42756.358654620206;38485.615143848554;38595;38641.647542336024;38680.41979370312;38790.612093879055;8300.128486508906;8436.325093992496;11372;11645.70885727855;11831.940840295787;11416.486258118362;11488.483018264156;11508.3095014299;11518.424078796068;11525.19323647345;11509.884901150965;11514.481848316846;11528.423578821068;11538.826917596201;11554.942225288904;11424.428778561121;11445.59940402086;11500.482478288455;11531.423428828524;11532.365719885403;9435.481048542328;11349;11350.375729334883;11353.943230283796;11371.147163962736;35925.281494370225;36133.63866361329;36247.27505449903;36292;36311.54753809844;3881.86413475527;3930.1157239620857;3938.369860822255;3941.783201923893;3949;26419.73580264192;26655.333616659544;27036.324091897663;27390.178294650992;27529.86235068832;3199.104250809777;3277.147941535218;3283.113559338989;3307.140143562667;3318.867245310185;514379;518963;521485.3925730385;521963;522433;45207.869803255184;45449.772751136035;45452.54547454483;45472.77263613727;45642.31536526955;46887.29669054967;46920;46960.7651961738;46983.76508117506;47156.292655610196;14296.857031429761;14369.06601070927;14385.28073596316;14454.566363009126;14641.853581464049;12552.937235313948;12633.115681902362;12667.11330206895;12688.429020693906;12699.301538415475;12242.265464072007;12258.14193006481;12265.816012759815;12279.815802762965;12323.260604363766;4890.633202509826;5760.625559338713;5792.362840087587;5794.305647873759;5816.82549523515;943.8159558886089;1089.567219106872;1130.864296284451;1145.873953865074;1183.5502509046507;26268.474630507284;27615.854782387767;27654.723452765214;27745.167644970683;28008.71991280061;1272.840894888139;1299.0452017766934;1308.7905935050346;1336.432016393029;1338.0834128621925;13947.930260348836;14375.424983000772;14400.711985760227;14632.707345853023;14666.34001469915;418000;422311;423160;424275;424520.87739561725;57789;58043.70978145082;58217.544561386305;58218.999999999156;58233.70883145557;1455.8325792533994;1461.3935216884875;1476.9113853168844;1492.246415560157;1499.4002399040253;27464.450710985268;28726.42547149087;29023.4304775988;29392.412151756416;29394.677239523844;43591.56408435875;43639;43812;43883.122337552435;43904.90237744082;492518;495801;496614;497626;502593.4870325625;31411;31517.68482315239;31522.369552609278;31617.367652647277;31902.52146217855;39448;39567.2086558273;40154.59845401509;40258;41493.79253103715;27832.721672783013;28463;28757.28106797347;29538;29760.55359169571;29534;30155;30227.848860755556;30497;30509.389812204077;33632.327353453285;34653.48019779756;34780.30439391147;35005;35356.93929182128;29470.852645736635;29474.705252947195;29744.85127574435;29774.25564360908;30430.69569304367;18295.81704182941;23733.694646794593;24230.63654045226;24401.51196976086;24703.135390261254 10:41:17 INFO - PROCESS | 1644 | |2;jquery.html;347.3747254941107;426.3796176563101;435.9553693178991;436.8885934086807;443.94006809080776;20161.19355225793;20744;21984.230551930665;22079.33761987143;22088.558228835413;22486.775132248713;23344.402229734456;23395.947182376793;23605;23904.40238994026;6697.464202863759;6734.93265067348;7018.964905175467;7035.050268213777;7046.5067445278855;6792.592444453324;6961.269066747995;6984.406325462316;6986.510944233905;6987.1964724056625;6603.405693487585;6837.897431538506;6909.550879192861;6954.165500139965;6975.000749677637;6808;6826.829329266759;6867.553609015398;6903.137107861542;6911.7926462206215;6407.871842563122;6722.025306330604;6762.729490820361;6763.323667633246;6771.424428923548;26492.86753566239;26911.51986640734;27459.450810983868;28180.295492612644;28207.717922820713;3062.5099984002454;3063.540468929656;3069.401466713992;3076.26169719268;3106.3476669899346;16599.91700041504;17248.310067597282;17278.049707266095;17325.826741732548;17732.645347093116;2061.185831596511;2070.534129820778;2075.4915045813873;2114.12263910477;2114.8731076135327;129775;132525;133794;136689;146722;20767.273145439838;20862.374128776162;21037.368878933656;21225.787742122382;21428.357149285548;32478;32660.67339326624;33022.66977330196;33160.50259246113;33248.501272480935;10899;10966.232363734462;10990.450477476094;11090.611828585961;11157.553697851996;7724.806879828049;9238;9254.398464099811;9280.95359523198;9364.906350936404;8731.90851143607;9567.234621230285;9845.753856153653;9900.504974751233;9946.950265248628;3546.964530354715;3967;4225.936610950838;4260.765657888845;4277.465316835395;1059.8887116852773;1070.619929924881;1092.415557676639;1105.8838821923744;1147.1072729995408;19564;21785.23751668684;22144.78203698812;22198.334049978526;22362.105515779513;1113.1818113686434;1120.1039168665036;1133.257716195893;1156.1560061155403;1156.5778490850778;10474.790504190027;10629.255952083435;11294.37880916541;11525.193236473366;11542;714745;758285;759588.9798069227;771468.1426592943;783055;140528.5947140536;155902.2204888991;158515;158930;168907;1191.9642410727693;1224.063591352616;1247.8377810884526;1249.287905893632;1252.4364036183754;18782;18948.43154705361;19024.809751902856;19295.710564341265;19423.3201837935;59399.70300148472;61585.69207153936;61969.69015154895;65115.348846512825;65701.67149164224;84197;85506;85643;86764.56617716872;87805.56097219473;9853.704388868346;11563.248388854698;11601.593944211912;11654.708632283922;11670.71622121583;10159.695209143738;11253.381064041556;12715.745685086431;13186.274754888573;13727.107737996997;11465.541378344773;11487.023602993504;11802.822957655813;11827.467763950815;11904.76190476203;8261.958690206751;10612.257141999986;10734.51694673726;10862.402567858844;10976.506057227285;10619.831818499804;11209.495572699085;11687.298762074302;11970.880291197325;12003.459844306852;11675.88324116782;11780.410979451164;11972.820407693718;12058;12060.75878482443;11388.234823602355;11468.967792898678;11674.649760507198;11679;11896.643100706993 10:41:17 INFO - PROCESS | 1644 | |3;mootools.html;1523.2612183091205;1524.603603063204;1546.7679848022794;1636.8705593140733;1652.8842980991333;9252.907470925289;10982.615608453705;11621.767564648702;11639.35983520906;11905.880941190586;9495;11363.545458181663;11493.597724079658;11578.710532236699;11594.246373985685;2480.8139389545813;2527.8736063196857;2529.380301826055;2530.089167899564;2534.0750626021554;2473.2332976777166;2477.0587176872764;2519.4709111086695;2520.09276660403;2536.987315063422;2440.7437219092008;2481.057198264657;2484.354067942339;2530.0891678995545;2536.112360673768;2442.9389265268424;2489.439876027888;2491.6013437849947;2494.3639371960217;2505.1607711416696;2142.2609199826034;2421.7648999010457;2429.866357350345;2435.5250726108416;2442.27952753938;11355.659330220107;11438.828417573743;11549.307041577533;11552.306861588331;11565.363904985223;5497.175423686439;5983.730732117022;6008;6126.938730612681;6194.566380353377;3362.6469220731715;3666.3034023535442;3675.2833197526493;3785.9242815143816;3829.272438236726;1167.7489339791985;1196.7367179220557;1229.0701816886394;1295.391166151907;1319.4985905355904;14221;14427.711445771025;15192.164430956182;16305.103219322933;16462.75305870413;4938.629602779806;5041.294218809369;5044.571211446994;5067.594592432597;5084.161113416319;12255.387230638433;12417.379131043592;12427.130100892851;12449.564265250854;12455.190412623151;5951.642901425842;6138.294096178907;6175.44421002112;6187.752489900354;6190.1952746142715;5555.472230138131;5599.748011339418;5606.887862242814;5611.270534830527;5627.409122042127;3518.2435776308216;3941.2708648900043;4127.979360103181;4139.586041395836;4193.643540299109;998.1316254858319;1040.1522758951583;1094.4035500652005;1098.6045023791428;1105.9336439813637;828.0146625515617;829.3738227638095;851.9190676885686;863.8963324400986;876.2726936642572;6055.757769689251;6608.173978252718;6689.866202675919;6748.426383757435;6804.727810887608;963.7012526116927;1004.7136566078779;1012.1902478017556;1026.650938680852;1046.1369370269558;4193.622573968358;4331.436913201263;4486.102779444124;4540.77296135192;4606.539346065434;10489.842652360221;13722.176669399669;14108.153510789385;14127.57617271463;14150.009499335154;11558.30650160993;13675.452981880811;13970.930145349208;13977.930110349384;13988.58034258974;10047.547860346156;10283.228757843191;10300.433476158883;10320.22598305115;10383.584656613652;5715;6707.932920670731;6752.864942701217;6844.760433384808;6894.482913781587;12361.93819030899;12393.132480726263;12480.313582752673;12500.187487813264;12518.561850335194;11166.888331116585;12515.4368053436;12869.613911582668;13121.868781312065;13178.868211317764;8668.609912553824;8694.260987816106;8802.735917922473;8822.470651760916;8832.470051796912;10355.43045132525;10604.89395106039;10681.252312338062;10687.51906164209;10777.838332425177;8978.32817337453;9163.221126204347;9168.679096231866;9248.537573121452;9277.814443711222;8928.062553431797;8932.821343572961;8951.552422378725;8981.326400519856;9069.63721451161;8246.299064579578;8396.706115285935;8400.285975692135;8401.369897257608;8427.199416055464;6134.26388833325;6165.0444181152;6218.81343559694;6243.843903902439;6388;4934.753262336941;6112.908306375319;6334.714937827716;6358.618482891041;6368.968155159195 10:41:17 INFO - PROCESS | 1644 | |4;prototype.html;337.648845200991;353.6799196726962;370.4942753141962;393.7775157036276;400.3674194772259;4424.102213050453;4837.201861692816;4983.700977941326;4996.625253106014;5322.254884316194;4703.695189357216;4819.469858315582;5146.0702236661255;5158.922616160751;5175.560077393417;3536.45184996326;3673.357162496559;4272.9359059614135;4291.9570804292025;4315.029118448356;3675.6324367563166;3819.3194994202463;3820.4460353248764;3954.782486963216;4277.25148099083;3618.819059047037;4257.850975215868;4283.336082907154;4298.763568003758;4345.804438800245;4135.524414692319;4273.764942928137;4323.384352466744;4333.479982402117;4357.496663651067;3372.6003708460958;3415.7438192135687;3803.6957043436737;3989.2819292527333;4042.8180731867137;3994.422203229708;4248.9787551062045;4434.334849772527;4930.964497455503;4983.426905905831;4979.576735977446;4986.950130498685;4996.500349965011;5007.749612519396;5035.320231768737;4913.813353057891;5210.088234558975;5565.220869078333;5589.860253493654;5607.971960140214;3503.579570451562;3511.20997775501;4014.658754005913;4333.111712099012;4471.485779135409;5593;5699.2590963174525;5718.399568045337;5892.882142357129;5904.1734157218025;3976.8806935791395;4080.897977550585;4347.608715215582;4419.270820314612;4470.619997300266;4608.695652173913;4611.331356953223;4620.3993480847275;4645.46577143626;4670.953290467051;4230.915381692411;4360.411344468456;4512.864614061584;4777.378940737682;4925.87685307863;4352.695311328177;4932.358793356912;5017.247412888023;5207.630528109701;5562.638428502134;1363.9318034098255;1415.5328741515275;1486.0563542150812;1538.023355169453;1565.1687525595082;1007.8135544924213;1078.7087486378634;1185;1203.0796440722854;1227.6317104868504;4746.620270378361;4944.961558072845;4983.975080124576;5073.923891141636;5274.5780337572905;4968.627352948543;5198.92201616976;5351;5507;5689.573282003867;4790.449098353664;4973.960676122772;5050.444451110375;5228.241904923841;5248.08158572256;2722.714115017934;2747.120921305163;2931.897383591564;2967.3620171663197;2975.8425141772473;5554.000279949648;5757.740901659436;5876.9118463223085;5985.049867087701;6015.54883383748;4850.490698476609;5052.888364559791;5405.837505121035;5788.884222315614;5836.445537673914;5232.5552328052545;5787.623804452865;5892.734826932799;5962.791302304398;6016.458518733335;4868.537488938545;4937.8271760488215;5376.838694839161;5689.516391106637;5703;5085.7457127144235;5204.479552044765;5581.2651800616595;5713.714314284186;5730.704844714222;4881.731504767272;5146.665466744649;5609.775608975759;5789.797357092481;5888.617239879394;4244.853889449893;4251.128518653731;4283.9504321441445;4350.477942646902;4526.705764125321;5076.82231121909;5240.973795131;5488.204210389391;5776.277965254343;5786.247787787561;4756.357891684716;4959.156943319716;5419.078756611307;5484.396716361277;5502.8349149525575;4909.803607855646;5058.54473097423;5593.720313984366;5600.775968961359;5611.859703507445;4153.605407486284;4914.361133052823;5118.411382691038;5278.36659600835;5504.458751549572;4923;4927.482614325444;5517.806876759294;5518.696471694096;5547.141707528023;5031.6729412588065;5357.883635963851;5403.702796346239;5423.18652202157;5526.253955716088 10:41:17 INFO - PROCESS | 1644 | |5;yui.html;749.9437542184331;762.8703120469523;798.5528104261614;873.6243415331408;882.7042940614893;16062.196890155505;17212.741808872845;17378.739318910226;17443.38948136814;17445.21496532656;15793.447229346946;15824.920875395606;15948.28232729527;15957;16021.83978160218;988.1255089246033;999.5152351109706;999.5152351109706;1038.937663740178;1040.0639424517956;1020.8774947006369;1024.3853687787343;1027.5067967375664;1027.8149933012055;1031.3554028732042;1057.3233130796295;1069.5561342043043;1076.434871692364;1078.2021304234888;1079.9794194486174;1058.2803693488424;1071.919606029551;1073.291627525837;1073.602766976216;1079.6383211624116;788.2669117720518;793.7936136604525;796.8127490039836;796.8167321516025;798.5288679679018;16836.07401592912;17224.052677102878;17328.566785830328;17353.652926941515;17417.39039133624;13433.925285977197;13815.930920345434;14752.336144873507;15522.61193470161;16302.83697163037;11483.770324593545;11826.408679566073;11846.756090610534;12260.632181034583;12471.75056498874;3949.19041596472;4003.5996400360023;4019.457373254632;4037.394390841368;4205.936910946339;93917.5304123475;122676.38661806723;123511.76488235092;125684;129031.35484322612;10272.33229840058;11968.88031119695;11975.520979160736;12062.819057713965;12495.687607809696;26522.336941576614;26526.46947061048;26676.733232667426;27020.729792701823;27065;8323.292520135856;8459.280961118251;8629.39594228398;8649.697260595849;8867.73396798097;4424.84513042042;4590.67865249436;4656.254999200111;4718.41019872516;4870.099031679079;3729.2355067211156;3766.886993390203;3783.5459744830796;3814.2180852925085;3823.7705737655274;687.4637782529635;695.1901035293927;697.3549466743242;710.5097482736999;712.4442934511089;642.1991114101593;709.4749885085104;720.4092644031844;723.5441671746765;738.4018944654739;10728.302660327054;10819.965328950257;10830.350178989285;11149.777004460027;11239.887601123884;743.2047708951478;747.3535391885979;748.3265061444744;760.9315161635479;766.3979297302589;4950.554450099508;4984.975075124674;5252.107141785906;5258.1849813279005;5273.419923808378;98951.50524247333;109046.45476772723;111142;112866;113133;95220.52389738007;96982.54526182113;97417;99671.50164249132;99697.50151249197;85028.57485712532;85135;85353.57323213469;85822.28355432856;87489.99999999873;9860.654877079267;10048.949755251177;10191.28660993753;10201.38791672502;10208.387496750218;46954;53620.73189634027;53951.730241348545;54983;55629;64611;64659.67670161619;65688;68072.6596367015;68395.65802170958;13191.868081319064;13485.056046076681;13597.184168949894;13633.727325453237;13733.519326823513;15300.311485982935;15474.381024758884;15486.993345432511;15594.532164035098;16289.022658640519;14133.222672753098;14343.784843227568;14837.92581037088;14850;15022.849771502146;13558.728825423634;13675.931620341835;13710;13939.860601393857;14650.63373415673;13576.321183940961;14167.716645666822;14357.353919073876;14482.203478808766;15293.388264469297;10440.269181157246;10703.197260205672;10779.975902289583;10863.619773307897;10867.836982445428;9858.112769850748;10737.355758654505;10889.78220435571;11182.66452006441;11902.166848320881 10:41:17 INFO - PROCESS | 1644 | __end_tp_report 10:41:17 INFO - PROCESS | 1644 | __start_cc_report 10:41:17 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,397 10:41:17 INFO - PROCESS | 1644 | __end_cc_report 10:41:17 INFO - PROCESS | 1644 | __startTimestamp1492796477714__endTimestamp 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | ------- Summary: start ------- 10:41:17 INFO - PROCESS | 1644 | Number of tests: 6 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:6090.42 Median:6314.18 stddev:686.63 (10.9%) stddev-sans-first:636.50 10:41:17 INFO - PROCESS | 1644 | Values: 2741.5 3655.8 3667.5 3687.3 3701.5 5249.8 5957.7 6196.1 6225.1 6232.8 6128.6 6133.3 6137.3 6178.6 6182.8 5509.3 5569.7 5570.5 5578.4 5637.9 5594.6 5613.0 5642.7 5648.7 5686.5 5427.7 5452.1 5546.8 5619.9 5636.3 5549.3 5556.5 5568.3 5572.7 5608.7 5543.9 5633.2 5638.4 5655.0 5731.7 6240.5 6277.4 6278.9 6284.5 6291.6 6253.8 6319.5 6522.5 6546.1 6576.8 6420.2 6451.7 6460.5 6493.1 6506.8 6236.4 6310.8 6312.8 6313.9 6323.5 6734.7 6749.0 6759.9 6764.7 6781.3 6257.8 6314.2 6322.9 6343.4 6436.0 6590.9 6594.7 6605.4 6609.4 6616.0 6457.0 6498.5 6508.4 6509.3 6526.1 6232.3 6278.6 6382.3 6400.1 6551.2 4165.9 5221.1 5341.0 5368.4 5375.6 4659.6 4680.4 4685.7 4690.3 4723.2 6180.3 6303.6 6314.5 6320.1 6335.4 6330.8 6381.3 6465.6 6496.9 6528.4 6322.9 6323.9 6333.9 6337.4 6349.8 5883.5 5886.8 5894.7 5903.6 5936.9 5801.7 6426.3 6659.0 6806.4 6874.3 6609.6 6621.6 6637.6 6639.5 6661.6 6854.2 6926.7 6964.7 6982.2 6994.8 6286.1 6339.7 6407.1 6516.8 6557.1 5519.6 6619.0 6626.9 6635.4 6638.8 5459.9 6443.7 6446.7 6465.3 6480.4 6242.4 6306.6 6335.8 6431.6 6447.9 6207.2 6251.6 6305.2 6317.3 6335.3 6494.4 6504.7 6507.2 6509.8 6525.4 6118.4 6262.1 6283.9 6369.2 6406.3 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:60530.73 Median:30960.19 stddev:128235.37 (414.2%) stddev-sans-first:128516.65 10:41:17 INFO - PROCESS | 1644 | Values: 784.1 826.3 845.2 989.0 990.2 40208.0 41034.2 42699.8 42722.9 42756.4 38485.6 38595.0 38641.6 38680.4 38790.6 8300.1 8436.3 11372.0 11645.7 11831.9 11416.5 11488.5 11508.3 11518.4 11525.2 11509.9 11514.5 11528.4 11538.8 11554.9 11424.4 11445.6 11500.5 11531.4 11532.4 9435.5 11349.0 11350.4 11353.9 11371.1 35925.3 36133.6 36247.3 36292.0 36311.5 3881.9 3930.1 3938.4 3941.8 3949.0 26419.7 26655.3 27036.3 27390.2 27529.9 3199.1 3277.1 3283.1 3307.1 3318.9 514379.0 518963.0 521485.4 521963.0 522433.0 45207.9 45449.8 45452.5 45472.8 45642.3 46887.3 46920.0 46960.8 46983.8 47156.3 14296.9 14369.1 14385.3 14454.6 14641.9 12552.9 12633.1 12667.1 12688.4 12699.3 12242.3 12258.1 12265.8 12279.8 12323.3 4890.6 5760.6 5792.4 5794.3 5816.8 943.8 1089.6 1130.9 1145.9 1183.6 26268.5 27615.9 27654.7 27745.2 28008.7 1272.8 1299.0 1308.8 1336.4 1338.1 13947.9 14375.4 14400.7 14632.7 14666.3 418000.0 422311.0 423160.0 424275.0 424520.9 57789.0 58043.7 58217.5 58219.0 58233.7 1455.8 1461.4 1476.9 1492.2 1499.4 27464.5 28726.4 29023.4 29392.4 29394.7 43591.6 43639.0 43812.0 43883.1 43904.9 492518.0 495801.0 496614.0 497626.0 502593.5 31411.0 31517.7 31522.4 31617.4 31902.5 39448.0 39567.2 40154.6 40258.0 41493.8 27832.7 28463.0 28757.3 29538.0 29760.6 29534.0 30155.0 30227.8 30497.0 30509.4 33632.3 34653.5 34780.3 35005.0 35356.9 29470.9 29474.7 29744.9 29774.3 30430.7 18295.8 23733.7 24230.6 24401.5 24703.1 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:43091.30 Median:21606.80 stddev:125944.12 (582.9%) stddev-sans-first:126256.53 10:41:17 INFO - PROCESS | 1644 | Values: 347.4 426.4 436.0 436.9 443.9 20161.2 20744.0 21984.2 22079.3 22088.6 22486.8 23344.4 23395.9 23605.0 23904.4 6697.5 6734.9 7019.0 7035.1 7046.5 6792.6 6961.3 6984.4 6986.5 6987.2 6603.4 6837.9 6909.6 6954.2 6975.0 6808.0 6826.8 6867.6 6903.1 6911.8 6407.9 6722.0 6762.7 6763.3 6771.4 26492.9 26911.5 27459.5 28180.3 28207.7 3062.5 3063.5 3069.4 3076.3 3106.3 16599.9 17248.3 17278.0 17325.8 17732.6 2061.2 2070.5 2075.5 2114.1 2114.9 129775.0 132525.0 133794.0 136689.0 146722.0 20767.3 20862.4 21037.4 21225.8 21428.4 32478.0 32660.7 33022.7 33160.5 33248.5 10899.0 10966.2 10990.5 11090.6 11157.6 7724.8 9238.0 9254.4 9281.0 9364.9 8731.9 9567.2 9845.8 9900.5 9947.0 3547.0 3967.0 4225.9 4260.8 4277.5 1059.9 1070.6 1092.4 1105.9 1147.1 19564.0 21785.2 22144.8 22198.3 22362.1 1113.2 1120.1 1133.3 1156.2 1156.6 10474.8 10629.3 11294.4 11525.2 11542.0 714745.0 758285.0 759589.0 771468.1 783055.0 140528.6 155902.2 158515.0 158930.0 168907.0 1192.0 1224.1 1247.8 1249.3 1252.4 18782.0 18948.4 19024.8 19295.7 19423.3 59399.7 61585.7 61969.7 65115.3 65701.7 84197.0 85506.0 85643.0 86764.6 87805.6 9853.7 11563.2 11601.6 11654.7 11670.7 10159.7 11253.4 12715.7 13186.3 13727.1 11465.5 11487.0 11802.8 11827.5 11904.8 8262.0 10612.3 10734.5 10862.4 10976.5 10619.8 11209.5 11687.3 11970.9 12003.5 11675.9 11780.4 11972.8 12058.0 12060.8 11388.2 11469.0 11674.6 11679.0 11896.6 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:6880.30 Median:2529.73 stddev:4254.47 (168.2%) stddev-sans-first:4247.36 10:41:17 INFO - PROCESS | 1644 | Values: 1523.3 1524.6 1546.8 1636.9 1652.9 9252.9 10982.6 11621.8 11639.4 11905.9 9495.0 11363.5 11493.6 11578.7 11594.2 2480.8 2527.9 2529.4 2530.1 2534.1 2473.2 2477.1 2519.5 2520.1 2537.0 2440.7 2481.1 2484.4 2530.1 2536.1 2442.9 2489.4 2491.6 2494.4 2505.2 2142.3 2421.8 2429.9 2435.5 2442.3 11355.7 11438.8 11549.3 11552.3 11565.4 5497.2 5983.7 6008.0 6126.9 6194.6 3362.6 3666.3 3675.3 3785.9 3829.3 1167.7 1196.7 1229.1 1295.4 1319.5 14221.0 14427.7 15192.2 16305.1 16462.8 4938.6 5041.3 5044.6 5067.6 5084.2 12255.4 12417.4 12427.1 12449.6 12455.2 5951.6 6138.3 6175.4 6187.8 6190.2 5555.5 5599.7 5606.9 5611.3 5627.4 3518.2 3941.3 4128.0 4139.6 4193.6 998.1 1040.2 1094.4 1098.6 1105.9 828.0 829.4 851.9 863.9 876.3 6055.8 6608.2 6689.9 6748.4 6804.7 963.7 1004.7 1012.2 1026.7 1046.1 4193.6 4331.4 4486.1 4540.8 4606.5 10489.8 13722.2 14108.2 14127.6 14150.0 11558.3 13675.5 13970.9 13977.9 13988.6 10047.5 10283.2 10300.4 10320.2 10383.6 5715.0 6707.9 6752.9 6844.8 6894.5 12361.9 12393.1 12480.3 12500.2 12518.6 11166.9 12515.4 12869.6 13121.9 13178.9 8668.6 8694.3 8802.7 8822.5 8832.5 10355.4 10604.9 10681.3 10687.5 10777.8 8978.3 9163.2 9168.7 9248.5 9277.8 8928.1 8932.8 8951.6 8981.3 9069.6 8246.3 8396.7 8400.3 8401.4 8427.2 6134.3 6165.0 6218.8 6243.8 6388.0 4934.8 6112.9 6334.7 6358.6 6369.0 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4545.06 Median:4931.66 stddev:1287.84 (26.1%) stddev-sans-first:1252.14 10:41:17 INFO - PROCESS | 1644 | Values: 337.6 353.7 370.5 393.8 400.4 4424.1 4837.2 4983.7 4996.6 5322.3 4703.7 4819.5 5146.1 5158.9 5175.6 3536.5 3673.4 4272.9 4292.0 4315.0 3675.6 3819.3 3820.4 3954.8 4277.3 3618.8 4257.9 4283.3 4298.8 4345.8 4135.5 4273.8 4323.4 4333.5 4357.5 3372.6 3415.7 3803.7 3989.3 4042.8 3994.4 4249.0 4434.3 4931.0 4983.4 4979.6 4987.0 4996.5 5007.7 5035.3 4913.8 5210.1 5565.2 5589.9 5608.0 3503.6 3511.2 4014.7 4333.1 4471.5 5593.0 5699.3 5718.4 5892.9 5904.2 3976.9 4080.9 4347.6 4419.3 4470.6 4608.7 4611.3 4620.4 4645.5 4671.0 4230.9 4360.4 4512.9 4777.4 4925.9 4352.7 4932.4 5017.2 5207.6 5562.6 1363.9 1415.5 1486.1 1538.0 1565.2 1007.8 1078.7 1185.0 1203.1 1227.6 4746.6 4945.0 4984.0 5073.9 5274.6 4968.6 5198.9 5351.0 5507.0 5689.6 4790.4 4974.0 5050.4 5228.2 5248.1 2722.7 2747.1 2931.9 2967.4 2975.8 5554.0 5757.7 5876.9 5985.0 6015.5 4850.5 5052.9 5405.8 5788.9 5836.4 5232.6 5787.6 5892.7 5962.8 6016.5 4868.5 4937.8 5376.8 5689.5 5703.0 5085.7 5204.5 5581.3 5713.7 5730.7 4881.7 5146.7 5609.8 5789.8 5888.6 4244.9 4251.1 4284.0 4350.5 4526.7 5076.8 5241.0 5488.2 5776.3 5786.2 4756.4 4959.2 5419.1 5484.4 5502.8 4909.8 5058.5 5593.7 5600.8 5611.9 4153.6 4914.4 5118.4 5278.4 5504.5 4923.0 4927.5 5517.8 5518.7 5547.1 5031.7 5357.9 5403.7 5423.2 5526.3 10:41:17 INFO - PROCESS | 1644 | 10:41:17 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:22092.16 Median:17218.40 stddev:31939.31 (185.5%) stddev-sans-first:31988.71 10:41:17 INFO - PROCESS | 1644 | Values: 749.9 762.9 798.6 873.6 882.7 16062.2 17212.7 17378.7 17443.4 17445.2 15793.4 15824.9 15948.3 15957.0 16021.8 988.1 999.5 999.5 1038.9 1040.1 1020.9 1024.4 1027.5 1027.8 1031.4 1057.3 1069.6 1076.4 1078.2 1080.0 1058.3 1071.9 1073.3 1073.6 1079.6 788.3 793.8 796.8 796.8 798.5 16836.1 17224.1 17328.6 17353.7 17417.4 13433.9 13815.9 14752.3 15522.6 16302.8 11483.8 11826.4 11846.8 12260.6 12471.8 3949.2 4003.6 4019.5 4037.4 4205.9 93917.5 122676.4 123511.8 125684.0 129031.4 10272.3 11968.9 11975.5 12062.8 12495.7 26522.3 26526.5 26676.7 27020.7 27065.0 8323.3 8459.3 8629.4 8649.7 8867.7 4424.8 4590.7 4656.3 4718.4 4870.1 3729.2 3766.9 3783.5 3814.2 3823.8 687.5 695.2 697.4 710.5 712.4 642.2 709.5 720.4 723.5 738.4 10728.3 10820.0 10830.4 11149.8 11239.9 743.2 747.4 748.3 760.9 766.4 4950.6 4985.0 5252.1 5258.2 5273.4 98951.5 109046.5 111142.0 112866.0 113133.0 95220.5 96982.5 97417.0 99671.5 99697.5 85028.6 85135.0 85353.6 85822.3 87490.0 9860.7 10048.9 10191.3 10201.4 10208.4 46954.0 53620.7 53951.7 54983.0 55629.0 64611.0 64659.7 65688.0 68072.7 68395.7 13191.9 13485.1 13597.2 13633.7 13733.5 15300.3 15474.4 15487.0 15594.5 16289.0 14133.2 14343.8 14837.9 14850.0 15022.8 13558.7 13675.9 13710.0 13939.9 14650.6 13576.3 14167.7 14357.4 14482.2 15293.4 10440.3 10703.2 10780.0 10863.6 10867.8 9858.1 10737.4 10889.8 11182.7 11902.2 10:41:17 INFO - PROCESS | 1644 | -------- Summary: end -------- 10:41:17 INFO - PROCESS | 1644 | 10:41:18 INFO - TEST-INFO | 1644: exit 0 10:41:18 INFO - TEST-OK | dromaeo_css | took 1115056ms 10:41:18 INFO - TEST-START | kraken 10:41:18 INFO - operating with platform_type : mac_ 10:41:18 INFO - Initialising browser for kraken test... 10:41:18 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpIVJMAA/profile http://localhost:49241/getInfo.html) 10:41:20 INFO - PROCESS | 1656 | 2017-04-21 10:41:20.977 plugin-container[1658:10194] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:41:20 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:41:20 INFO - PROCESS | 1656 | 2017-04-21 10:41:20.978 plugin-container[1658:10194] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 10:41:20 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:41:20 INFO - PROCESS | 1656 | 2017-04-21 10:41:20.978 plugin-container[1658:10194] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:41:21 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:41:21 INFO - PROCESS | 1656 | colorDepth:24 10:41:21 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:41:21 INFO - PROCESS | 1656 | __metrics 10:41:21 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 10:41:21 INFO - TEST-INFO | 1656: exit 0 10:41:21 INFO - Browser initialized. 10:41:21 INFO - Running cycle 1/1 for kraken test... 10:41:21 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpIVJMAA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:24 INFO - PROCESS | 1659 | 2017-04-21 10:41:24.367 plugin-container[1660:10320] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 10:41:24 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:41:24 INFO - PROCESS | 1659 | 2017-04-21 10:41:24.368 plugin-container[1660:10320] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:41:24 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:41:24 INFO - PROCESS | 1659 | 2017-04-21 10:41:24.368 plugin-container[1660:10320] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:41:34 INFO - PROCESS | 1659 | RSS: Main: 174489600 10:41:34 INFO - PROCESS | 1659 | 10:41:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:38 INFO - PROCESS | 1659 | RSS: Main: 188178432 10:41:38 INFO - PROCESS | 1659 | 10:41:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:41:41 INFO - PROCESS | 1659 | RSS: Main: 196136960 10:41:41 INFO - PROCESS | 1659 | 10:41:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:41:45 INFO - PROCESS | 1659 | RSS: Main: 200015872 10:41:45 INFO - PROCESS | 1659 | 10:41:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:41:48 INFO - PROCESS | 1659 | RSS: Main: 201220096 10:41:48 INFO - PROCESS | 1659 | 10:41:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:50 INFO - PROCESS | 1659 | RSS: Main: 201580544 10:41:50 INFO - PROCESS | 1659 | 10:41:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:54 INFO - PROCESS | 1659 | RSS: Main: 205381632 10:41:54 INFO - PROCESS | 1659 | 10:41:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:58 INFO - PROCESS | 1659 | RSS: Main: 204963840 10:41:58 INFO - PROCESS | 1659 | 10:42:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:42:02 INFO - PROCESS | 1659 | RSS: Main: 205152256 10:42:02 INFO - PROCESS | 1659 | 10:42:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:42:04 INFO - PROCESS | 1659 | RSS: Main: 204689408 10:42:04 INFO - PROCESS | 1659 | 10:42:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:42:06 INFO - PROCESS | 1659 | RSS: Main: 204673024 10:42:06 INFO - PROCESS | 1659 | 10:42:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:42:09 INFO - PROCESS | 1659 | RSS: Main: 204718080 10:42:09 INFO - PROCESS | 1659 | 10:42:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:42:13 INFO - PROCESS | 1659 | RSS: Main: 205111296 10:42:13 INFO - PROCESS | 1659 | 10:42:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:42:17 INFO - PROCESS | 1659 | RSS: Main: 204906496 10:42:17 INFO - PROCESS | 1659 | 10:42:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:42:19 INFO - PROCESS | 1659 | RSS: Main: 206938112 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | __start_tp_report 10:42:19 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 10:42:19 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 10:42:19 INFO - PROCESS | 1659 | |i|pagename|runs| 10:42:19 INFO - PROCESS | 1659 | |0;ai-astar;148;178;120;181;168;120;122;121;124;120 10:42:19 INFO - PROCESS | 1659 | |1;audio-beat-detection;145;131;113;145;142;140;109;117;122;130 10:42:19 INFO - PROCESS | 1659 | |2;audio-dft;202;199;198;200;193;204;200;198;196;197 10:42:19 INFO - PROCESS | 1659 | |3;audio-fft;85;61;60;96;80;82;74;64;71;61 10:42:19 INFO - PROCESS | 1659 | |4;audio-oscillator;83;71;87;68;97;98;66;100;58;68 10:42:19 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;104;89;107;134;131;83;127;85;124;135 10:42:19 INFO - PROCESS | 1659 | |6;imaging-darkroom;137;106;151;114;151;154;97;98;99;97 10:42:19 INFO - PROCESS | 1659 | |7;imaging-desaturate;90;94;101;137;143;91;93;92;91;124 10:42:19 INFO - PROCESS | 1659 | |8;json-parse-financial;64;66;67;62;65;72;68;62;58;105 10:42:19 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;58;63;63;63;62;58;58;57;59;60 10:42:19 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;84;81;85;85;85;88;87;84;88;79 10:42:19 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;137;160;164;145;141;155;153;151;192;148 10:42:19 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;204;150;220;204;170;153;209;220;221;163 10:42:19 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;64;66;66;67;68;66;65;70;76;86 10:42:19 INFO - PROCESS | 1659 | __end_tp_report 10:42:19 INFO - PROCESS | 1659 | __start_cc_report 10:42:19 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1004 10:42:19 INFO - PROCESS | 1659 | __end_cc_report 10:42:19 INFO - PROCESS | 1659 | __startTimestamp1492796539144__endTimestamp 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | ------- Summary: start ------- 10:42:19 INFO - PROCESS | 1659 | Number of tests: 14 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:140.20 Median:136.00 stddev:26.06 (19.2%) stddev-sans-first:27.49 10:42:19 INFO - PROCESS | 1659 | Values: 148.0 178.0 120.0 181.0 168.0 120.0 122.0 121.0 124.0 120.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:135.50 stddev:13.56 (10.0%) stddev-sans-first:13.15 10:42:19 INFO - PROCESS | 1659 | Values: 145.0 131.0 113.0 145.0 142.0 140.0 109.0 117.0 122.0 130.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:198.70 Median:199.50 stddev:3.09 (1.6%) stddev-sans-first:3.04 10:42:19 INFO - PROCESS | 1659 | Values: 202.0 199.0 198.0 200.0 193.0 204.0 200.0 198.0 196.0 197.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:73.40 Median:77.00 stddev:12.22 (15.9%) stddev-sans-first:12.22 10:42:19 INFO - PROCESS | 1659 | Values: 85.0 61.0 60.0 96.0 80.0 82.0 74.0 64.0 71.0 61.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:77.00 stddev:15.34 (19.9%) stddev-sans-first:16.22 10:42:19 INFO - PROCESS | 1659 | Values: 83.0 71.0 87.0 68.0 97.0 98.0 66.0 100.0 58.0 68.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:111.90 Median:134.50 stddev:20.90 (15.5%) stddev-sans-first:21.97 10:42:19 INFO - PROCESS | 1659 | Values: 104.0 89.0 107.0 134.0 131.0 83.0 127.0 85.0 124.0 135.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:120.40 Median:125.50 stddev:24.90 (19.8%) stddev-sans-first:25.68 10:42:19 INFO - PROCESS | 1659 | Values: 137.0 106.0 151.0 114.0 151.0 154.0 97.0 98.0 99.0 97.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:91.00 stddev:20.80 (22.9%) stddev-sans-first:21.28 10:42:19 INFO - PROCESS | 1659 | Values: 90.0 94.0 101.0 137.0 143.0 91.0 93.0 92.0 91.0 124.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:65.50 stddev:13.25 (20.2%) stddev-sans-first:13.93 10:42:19 INFO - PROCESS | 1659 | Values: 64.0 66.0 67.0 62.0 65.0 72.0 68.0 62.0 58.0 105.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:61.00 stddev:2.42 (4.0%) stddev-sans-first:2.45 10:42:19 INFO - PROCESS | 1659 | Values: 58.0 63.0 63.0 63.0 62.0 58.0 58.0 57.0 59.0 60.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:2.88 (3.4%) stddev-sans-first:3.04 10:42:19 INFO - PROCESS | 1659 | Values: 84.0 81.0 85.0 85.0 85.0 88.0 87.0 84.0 88.0 79.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:154.00 stddev:15.50 (10.1%) stddev-sans-first:15.08 10:42:19 INFO - PROCESS | 1659 | Values: 137.0 160.0 164.0 145.0 141.0 155.0 153.0 151.0 192.0 148.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:206.50 stddev:29.04 (14.1%) stddev-sans-first:30.45 10:42:19 INFO - PROCESS | 1659 | Values: 204.0 150.0 220.0 204.0 170.0 153.0 209.0 220.0 221.0 163.0 10:42:19 INFO - PROCESS | 1659 | 10:42:19 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:67.50 stddev:6.75 (10.0%) stddev-sans-first:6.87 10:42:19 INFO - PROCESS | 1659 | Values: 64.0 66.0 66.0 67.0 68.0 66.0 65.0 70.0 76.0 86.0 10:42:19 INFO - PROCESS | 1659 | -------- Summary: end -------- 10:42:19 INFO - PROCESS | 1659 | 10:42:20 INFO - TEST-INFO | 1659: exit 0 10:42:20 INFO - TEST-OK | kraken | took 61810ms 10:42:20 INFO - SUITE-END | took 1176s 10:42:20 INFO - Completed test suite (00:19:37) 10:42:20 INFO - javascript benchmark 10:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7914.969770826624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2741.5476446386347, 3655.8354874030665, 3667.5232219811437, 3687.3362794696945, 3701.518802555667, 5249.842504724859, 5957.689308352161, 6196.0705894115845, 6225.066240063993, 6232.781852635158, 6128.601640893339, 6133.325334213244, 6137.324894261627, 6178.629282243069, 6182.7836025739, 5509.256250406184, 5569.721513924308, 5570.526505247059, 5578.44215578441, 5637.943620563803, 5594.58040646951, 5613.0, 5642.7178641067985, 5648.745806438699, 5686.545076393879, 5427.701476418795, 5452.127659574468, 5546.833594992157, 5619.887602247953, 5636.323641163066, 5549.334079910416, 5556.472135147154, 5568.276124103861, 5572.721363931787, 5608.691521966291, 5543.861403464905, 5633.183188437694, 5638.407967163471, 5655.0386434306265, 5731.742071606787, 6240.5319601030105, 6277.435030847246, 6278.874422511524, 6284.465820405271, 6291.62250264981, 6253.843653908689, 6319.494440444753, 6522.510811689095, 6546.0835483032415, 6576.80269591913, 6420.229572451289, 6451.741930322782, 6460.483161347081, 6493.090967264587, 6506.772262970773, 6236.376362363818, 6310.810675679737, 6312.810615681537, 6313.936860631381, 6323.525735569805, 6734.6632668367365, 6748.966255168692, 6759.932400676029, 6764.661766911635, 6781.25406205317, 6257.78097766576, 6314.179156709598, 6322.936770632326, 6343.397377249154, 6436.034594810722, 6590.934090659128, 6594.7032383542855, 6605.438537724252, 6609.372109649576, 6615.966920165464, 6457.031445283245, 6498.480121590262, 6508.446782023487, 6509.2839787623325, 6526.118973938553, 6232.3144454110015, 6278.623282603058, 6382.266039405435, 6400.135981642512, 6551.181102362205, 4165.937510937339, 5221.138512145453, 5341.0, 5368.436314186954, 5375.623706340597, 4659.58063774262, 4680.438347398334, 4685.718856868599, 4690.296455531698, 4723.244280915037, 6180.289266734293, 6303.558750887394, 6314.463270621956, 6320.146780184708, 6335.429811316912, 6330.778422755274, 6381.298057213703, 6465.612063276219, 6496.935030649727, 6528.445082167974, 6322.873542529123, 6323.9051414228825, 6333.904991425133, 6337.429631333202, 6349.809505714836, 5883.499902508249, 5886.793962211302, 5894.734736936848, 5903.616264942765, 5936.851578710481, 5801.694618710756, 6426.325235850169, 6659.0, 6806.353396427331, 6874.312568743286, 6609.636469994197, 6621.569597976116, 6637.601743895381, 6639.4688424924925, 6661.633610151488, 6854.211765646815, 6926.722931082701, 6964.6517674115075, 6982.162140543167, 6994.825129371807, 6286.119943207863, 6339.683015849097, 6407.135036769976, 6516.771912983023, 6557.147570815763, 5519.558435325084, 6619.0, 6626.933730662631, 6635.4359879410795, 6638.800835974928, 5459.918101228405, 6443.742250309935, 6446.67766611677, 6465.256495502889, 6480.351964803482, 6242.406971337716, 6306.590071645328, 6335.772196954753, 6431.614103153825, 6447.871042579029, 6207.16203312547, 6251.593646413151, 6305.180326557518, 6317.336679648571, 6335.334789847184, 6494.383033611799, 6504.707288172138, 6507.154069970874, 6509.804705858832, 6525.3800888915475, 6118.4059889896, 6262.060690896402, 6283.874322513616, 6369.172007638977, 6406.295307516077], "value": 6046.761169645542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.1491981200397, 826.2852632472911, 845.2266176448552, 988.9950550247248, 990.173205373513, 40208.0, 41034.17931641369, 42699.78650106753, 42722.93192670185, 42756.358654620206, 38485.615143848554, 38595.0, 38641.647542336024, 38680.41979370312, 38790.612093879055, 8300.128486508906, 8436.325093992496, 11372.0, 11645.70885727855, 11831.940840295787, 11416.486258118362, 11488.483018264156, 11508.3095014299, 11518.424078796068, 11525.19323647345, 11509.884901150965, 11514.481848316846, 11528.423578821068, 11538.826917596201, 11554.942225288904, 11424.428778561121, 11445.59940402086, 11500.482478288455, 11531.423428828524, 11532.365719885403, 9435.481048542328, 11349.0, 11350.375729334883, 11353.943230283796, 11371.147163962736, 35925.281494370225, 36133.63866361329, 36247.27505449903, 36292.0, 36311.54753809844, 3881.86413475527, 3930.1157239620857, 3938.369860822255, 3941.783201923893, 3949.0, 26419.73580264192, 26655.333616659544, 27036.324091897663, 27390.178294650992, 27529.86235068832, 3199.104250809777, 3277.147941535218, 3283.113559338989, 3307.140143562667, 3318.867245310185, 514379.0, 518963.0, 521485.3925730385, 521963.0, 522433.0, 45207.869803255184, 45449.772751136035, 45452.54547454483, 45472.77263613727, 45642.31536526955, 46887.29669054967, 46920.0, 46960.7651961738, 46983.76508117506, 47156.292655610196, 14296.857031429761, 14369.06601070927, 14385.28073596316, 14454.566363009126, 14641.853581464049, 12552.937235313948, 12633.115681902362, 12667.11330206895, 12688.429020693906, 12699.301538415475, 12242.265464072007, 12258.14193006481, 12265.816012759815, 12279.815802762965, 12323.260604363766, 4890.633202509826, 5760.625559338713, 5792.362840087587, 5794.305647873759, 5816.82549523515, 943.8159558886089, 1089.567219106872, 1130.864296284451, 1145.873953865074, 1183.5502509046507, 26268.474630507284, 27615.854782387767, 27654.723452765214, 27745.167644970683, 28008.71991280061, 1272.840894888139, 1299.0452017766934, 1308.7905935050346, 1336.432016393029, 1338.0834128621925, 13947.930260348836, 14375.424983000772, 14400.711985760227, 14632.707345853023, 14666.34001469915, 418000.0, 422311.0, 423160.0, 424275.0, 424520.87739561725, 57789.0, 58043.70978145082, 58217.544561386305, 58218.999999999156, 58233.70883145557, 1455.8325792533994, 1461.3935216884875, 1476.9113853168844, 1492.246415560157, 1499.4002399040253, 27464.450710985268, 28726.42547149087, 29023.4304775988, 29392.412151756416, 29394.677239523844, 43591.56408435875, 43639.0, 43812.0, 43883.122337552435, 43904.90237744082, 492518.0, 495801.0, 496614.0, 497626.0, 502593.4870325625, 31411.0, 31517.68482315239, 31522.369552609278, 31617.367652647277, 31902.52146217855, 39448.0, 39567.2086558273, 40154.59845401509, 40258.0, 41493.79253103715, 27832.721672783013, 28463.0, 28757.28106797347, 29538.0, 29760.55359169571, 29534.0, 30155.0, 30227.848860755556, 30497.0, 30509.389812204077, 33632.327353453285, 34653.48019779756, 34780.30439391147, 35005.0, 35356.93929182128, 29470.852645736635, 29474.705252947195, 29744.85127574435, 29774.25564360908, 30430.69569304367, 18295.81704182941, 23733.694646794593, 24230.63654045226, 24401.51196976086, 24703.135390261254], "value": 19167.118744606872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3747254941107, 426.3796176563101, 435.9553693178991, 436.8885934086807, 443.94006809080776, 20161.19355225793, 20744.0, 21984.230551930665, 22079.33761987143, 22088.558228835413, 22486.775132248713, 23344.402229734456, 23395.947182376793, 23605.0, 23904.40238994026, 6697.464202863759, 6734.93265067348, 7018.964905175467, 7035.050268213777, 7046.5067445278855, 6792.592444453324, 6961.269066747995, 6984.406325462316, 6986.510944233905, 6987.1964724056625, 6603.405693487585, 6837.897431538506, 6909.550879192861, 6954.165500139965, 6975.000749677637, 6808.0, 6826.829329266759, 6867.553609015398, 6903.137107861542, 6911.7926462206215, 6407.871842563122, 6722.025306330604, 6762.729490820361, 6763.323667633246, 6771.424428923548, 26492.86753566239, 26911.51986640734, 27459.450810983868, 28180.295492612644, 28207.717922820713, 3062.5099984002454, 3063.540468929656, 3069.401466713992, 3076.26169719268, 3106.3476669899346, 16599.91700041504, 17248.310067597282, 17278.049707266095, 17325.826741732548, 17732.645347093116, 2061.185831596511, 2070.534129820778, 2075.4915045813873, 2114.12263910477, 2114.8731076135327, 129775.0, 132525.0, 133794.0, 136689.0, 146722.0, 20767.273145439838, 20862.374128776162, 21037.368878933656, 21225.787742122382, 21428.357149285548, 32478.0, 32660.67339326624, 33022.66977330196, 33160.50259246113, 33248.501272480935, 10899.0, 10966.232363734462, 10990.450477476094, 11090.611828585961, 11157.553697851996, 7724.806879828049, 9238.0, 9254.398464099811, 9280.95359523198, 9364.906350936404, 8731.90851143607, 9567.234621230285, 9845.753856153653, 9900.504974751233, 9946.950265248628, 3546.964530354715, 3967.0, 4225.936610950838, 4260.765657888845, 4277.465316835395, 1059.8887116852773, 1070.619929924881, 1092.415557676639, 1105.8838821923744, 1147.1072729995408, 19564.0, 21785.23751668684, 22144.78203698812, 22198.334049978526, 22362.105515779513, 1113.1818113686434, 1120.1039168665036, 1133.257716195893, 1156.1560061155403, 1156.5778490850778, 10474.790504190027, 10629.255952083435, 11294.37880916541, 11525.193236473366, 11542.0, 714745.0, 758285.0, 759588.9798069227, 771468.1426592943, 783055.0, 140528.5947140536, 155902.2204888991, 158515.0, 158930.0, 168907.0, 1191.9642410727693, 1224.063591352616, 1247.8377810884526, 1249.287905893632, 1252.4364036183754, 18782.0, 18948.43154705361, 19024.809751902856, 19295.710564341265, 19423.3201837935, 59399.70300148472, 61585.69207153936, 61969.69015154895, 65115.348846512825, 65701.67149164224, 84197.0, 85506.0, 85643.0, 86764.56617716872, 87805.56097219473, 9853.704388868346, 11563.248388854698, 11601.593944211912, 11654.708632283922, 11670.71622121583, 10159.695209143738, 11253.381064041556, 12715.745685086431, 13186.274754888573, 13727.107737996997, 11465.541378344773, 11487.023602993504, 11802.822957655813, 11827.467763950815, 11904.76190476203, 8261.958690206751, 10612.257141999986, 10734.51694673726, 10862.402567858844, 10976.506057227285, 10619.831818499804, 11209.495572699085, 11687.298762074302, 11970.880291197325, 12003.459844306852, 11675.88324116782, 11780.410979451164, 11972.820407693718, 12058.0, 12060.75878482443, 11388.234823602355, 11468.967792898678, 11674.649760507198, 11679.0, 11896.643100706993], "value": 11821.579720490792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.2612183091205, 1524.603603063204, 1546.7679848022794, 1636.8705593140733, 1652.8842980991333, 9252.907470925289, 10982.615608453705, 11621.767564648702, 11639.35983520906, 11905.880941190586, 9495.0, 11363.545458181663, 11493.597724079658, 11578.710532236699, 11594.246373985685, 2480.8139389545813, 2527.8736063196857, 2529.380301826055, 2530.089167899564, 2534.0750626021554, 2473.2332976777166, 2477.0587176872764, 2519.4709111086695, 2520.09276660403, 2536.987315063422, 2440.7437219092008, 2481.057198264657, 2484.354067942339, 2530.0891678995545, 2536.112360673768, 2442.9389265268424, 2489.439876027888, 2491.6013437849947, 2494.3639371960217, 2505.1607711416696, 2142.2609199826034, 2421.7648999010457, 2429.866357350345, 2435.5250726108416, 2442.27952753938, 11355.659330220107, 11438.828417573743, 11549.307041577533, 11552.306861588331, 11565.363904985223, 5497.175423686439, 5983.730732117022, 6008.0, 6126.938730612681, 6194.566380353377, 3362.6469220731715, 3666.3034023535442, 3675.2833197526493, 3785.9242815143816, 3829.272438236726, 1167.7489339791985, 1196.7367179220557, 1229.0701816886394, 1295.391166151907, 1319.4985905355904, 14221.0, 14427.711445771025, 15192.164430956182, 16305.103219322933, 16462.75305870413, 4938.629602779806, 5041.294218809369, 5044.571211446994, 5067.594592432597, 5084.161113416319, 12255.387230638433, 12417.379131043592, 12427.130100892851, 12449.564265250854, 12455.190412623151, 5951.642901425842, 6138.294096178907, 6175.44421002112, 6187.752489900354, 6190.1952746142715, 5555.472230138131, 5599.748011339418, 5606.887862242814, 5611.270534830527, 5627.409122042127, 3518.2435776308216, 3941.2708648900043, 4127.979360103181, 4139.586041395836, 4193.643540299109, 998.1316254858319, 1040.1522758951583, 1094.4035500652005, 1098.6045023791428, 1105.9336439813637, 828.0146625515617, 829.3738227638095, 851.9190676885686, 863.8963324400986, 876.2726936642572, 6055.757769689251, 6608.173978252718, 6689.866202675919, 6748.426383757435, 6804.727810887608, 963.7012526116927, 1004.7136566078779, 1012.1902478017556, 1026.650938680852, 1046.1369370269558, 4193.622573968358, 4331.436913201263, 4486.102779444124, 4540.77296135192, 4606.539346065434, 10489.842652360221, 13722.176669399669, 14108.153510789385, 14127.57617271463, 14150.009499335154, 11558.30650160993, 13675.452981880811, 13970.930145349208, 13977.930110349384, 13988.58034258974, 10047.547860346156, 10283.228757843191, 10300.433476158883, 10320.22598305115, 10383.584656613652, 5715.0, 6707.932920670731, 6752.864942701217, 6844.760433384808, 6894.482913781587, 12361.93819030899, 12393.132480726263, 12480.313582752673, 12500.187487813264, 12518.561850335194, 11166.888331116585, 12515.4368053436, 12869.613911582668, 13121.868781312065, 13178.868211317764, 8668.609912553824, 8694.260987816106, 8802.735917922473, 8822.470651760916, 8832.470051796912, 10355.43045132525, 10604.89395106039, 10681.252312338062, 10687.51906164209, 10777.838332425177, 8978.32817337453, 9163.221126204347, 9168.679096231866, 9248.537573121452, 9277.814443711222, 8928.062553431797, 8932.821343572961, 8951.552422378725, 8981.326400519856, 9069.63721451161, 8246.299064579578, 8396.706115285935, 8400.285975692135, 8401.369897257608, 8427.199416055464, 6134.26388833325, 6165.0444181152, 6218.81343559694, 6243.843903902439, 6388.0, 4934.753262336941, 6112.908306375319, 6334.714937827716, 6358.618482891041, 6368.968155159195], "value": 5259.301736681079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.648845200991, 353.6799196726962, 370.4942753141962, 393.7775157036276, 400.3674194772259, 4424.102213050453, 4837.201861692816, 4983.700977941326, 4996.625253106014, 5322.254884316194, 4703.695189357216, 4819.469858315582, 5146.0702236661255, 5158.922616160751, 5175.560077393417, 3536.45184996326, 3673.357162496559, 4272.9359059614135, 4291.9570804292025, 4315.029118448356, 3675.6324367563166, 3819.3194994202463, 3820.4460353248764, 3954.782486963216, 4277.25148099083, 3618.819059047037, 4257.850975215868, 4283.336082907154, 4298.763568003758, 4345.804438800245, 4135.524414692319, 4273.764942928137, 4323.384352466744, 4333.479982402117, 4357.496663651067, 3372.6003708460958, 3415.7438192135687, 3803.6957043436737, 3989.2819292527333, 4042.8180731867137, 3994.422203229708, 4248.9787551062045, 4434.334849772527, 4930.964497455503, 4983.426905905831, 4979.576735977446, 4986.950130498685, 4996.500349965011, 5007.749612519396, 5035.320231768737, 4913.813353057891, 5210.088234558975, 5565.220869078333, 5589.860253493654, 5607.971960140214, 3503.579570451562, 3511.20997775501, 4014.658754005913, 4333.111712099012, 4471.485779135409, 5593.0, 5699.2590963174525, 5718.399568045337, 5892.882142357129, 5904.1734157218025, 3976.8806935791395, 4080.897977550585, 4347.608715215582, 4419.270820314612, 4470.619997300266, 4608.695652173913, 4611.331356953223, 4620.3993480847275, 4645.46577143626, 4670.953290467051, 4230.915381692411, 4360.411344468456, 4512.864614061584, 4777.378940737682, 4925.87685307863, 4352.695311328177, 4932.358793356912, 5017.247412888023, 5207.630528109701, 5562.638428502134, 1363.9318034098255, 1415.5328741515275, 1486.0563542150812, 1538.023355169453, 1565.1687525595082, 1007.8135544924213, 1078.7087486378634, 1185.0, 1203.0796440722854, 1227.6317104868504, 4746.620270378361, 4944.961558072845, 4983.975080124576, 5073.923891141636, 5274.5780337572905, 4968.627352948543, 5198.92201616976, 5351.0, 5507.0, 5689.573282003867, 4790.449098353664, 4973.960676122772, 5050.444451110375, 5228.241904923841, 5248.08158572256, 2722.714115017934, 2747.120921305163, 2931.897383591564, 2967.3620171663197, 2975.8425141772473, 5554.000279949648, 5757.740901659436, 5876.9118463223085, 5985.049867087701, 6015.54883383748, 4850.490698476609, 5052.888364559791, 5405.837505121035, 5788.884222315614, 5836.445537673914, 5232.5552328052545, 5787.623804452865, 5892.734826932799, 5962.791302304398, 6016.458518733335, 4868.537488938545, 4937.8271760488215, 5376.838694839161, 5689.516391106637, 5703.0, 5085.7457127144235, 5204.479552044765, 5581.2651800616595, 5713.714314284186, 5730.704844714222, 4881.731504767272, 5146.665466744649, 5609.775608975759, 5789.797357092481, 5888.617239879394, 4244.853889449893, 4251.128518653731, 4283.9504321441445, 4350.477942646902, 4526.705764125321, 5076.82231121909, 5240.973795131, 5488.204210389391, 5776.277965254343, 5786.247787787561, 4756.357891684716, 4959.156943319716, 5419.078756611307, 5484.396716361277, 5502.8349149525575, 4909.803607855646, 5058.54473097423, 5593.720313984366, 5600.775968961359, 5611.859703507445, 4153.605407486284, 4914.361133052823, 5118.411382691038, 5278.36659600835, 5504.458751549572, 4923.0, 4927.482614325444, 5517.806876759294, 5518.696471694096, 5547.141707528023, 5031.6729412588065, 5357.883635963851, 5403.702796346239, 5423.18652202157, 5526.253955716088], "value": 4169.538847946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.9437542184331, 762.8703120469523, 798.5528104261614, 873.6243415331408, 882.7042940614893, 16062.196890155505, 17212.741808872845, 17378.739318910226, 17443.38948136814, 17445.21496532656, 15793.447229346946, 15824.920875395606, 15948.28232729527, 15957.0, 16021.83978160218, 988.1255089246033, 999.5152351109706, 999.5152351109706, 1038.937663740178, 1040.0639424517956, 1020.8774947006369, 1024.3853687787343, 1027.5067967375664, 1027.8149933012055, 1031.3554028732042, 1057.3233130796295, 1069.5561342043043, 1076.434871692364, 1078.2021304234888, 1079.9794194486174, 1058.2803693488424, 1071.919606029551, 1073.291627525837, 1073.602766976216, 1079.6383211624116, 788.2669117720518, 793.7936136604525, 796.8127490039836, 796.8167321516025, 798.5288679679018, 16836.07401592912, 17224.052677102878, 17328.566785830328, 17353.652926941515, 17417.39039133624, 13433.925285977197, 13815.930920345434, 14752.336144873507, 15522.61193470161, 16302.83697163037, 11483.770324593545, 11826.408679566073, 11846.756090610534, 12260.632181034583, 12471.75056498874, 3949.19041596472, 4003.5996400360023, 4019.457373254632, 4037.394390841368, 4205.936910946339, 93917.5304123475, 122676.38661806723, 123511.76488235092, 125684.0, 129031.35484322612, 10272.33229840058, 11968.88031119695, 11975.520979160736, 12062.819057713965, 12495.687607809696, 26522.336941576614, 26526.46947061048, 26676.733232667426, 27020.729792701823, 27065.0, 8323.292520135856, 8459.280961118251, 8629.39594228398, 8649.697260595849, 8867.73396798097, 4424.84513042042, 4590.67865249436, 4656.254999200111, 4718.41019872516, 4870.099031679079, 3729.2355067211156, 3766.886993390203, 3783.5459744830796, 3814.2180852925085, 3823.7705737655274, 687.4637782529635, 695.1901035293927, 697.3549466743242, 710.5097482736999, 712.4442934511089, 642.1991114101593, 709.4749885085104, 720.4092644031844, 723.5441671746765, 738.4018944654739, 10728.302660327054, 10819.965328950257, 10830.350178989285, 11149.777004460027, 11239.887601123884, 743.2047708951478, 747.3535391885979, 748.3265061444744, 760.9315161635479, 766.3979297302589, 4950.554450099508, 4984.975075124674, 5252.107141785906, 5258.1849813279005, 5273.419923808378, 98951.50524247333, 109046.45476772723, 111142.0, 112866.0, 113133.0, 95220.52389738007, 96982.54526182113, 97417.0, 99671.50164249132, 99697.50151249197, 85028.57485712532, 85135.0, 85353.57323213469, 85822.28355432856, 87489.99999999873, 9860.654877079267, 10048.949755251177, 10191.28660993753, 10201.38791672502, 10208.387496750218, 46954.0, 53620.73189634027, 53951.730241348545, 54983.0, 55629.0, 64611.0, 64659.67670161619, 65688.0, 68072.6596367015, 68395.65802170958, 13191.868081319064, 13485.056046076681, 13597.184168949894, 13633.727325453237, 13733.519326823513, 15300.311485982935, 15474.381024758884, 15486.993345432511, 15594.532164035098, 16289.022658640519, 14133.222672753098, 14343.784843227568, 14837.92581037088, 14850.0, 15022.849771502146, 13558.728825423634, 13675.931620341835, 13710.0, 13939.860601393857, 14650.63373415673, 13576.321183940961, 14167.716645666822, 14357.353919073876, 14482.203478808766, 15293.388264469297, 10440.269181157246, 10703.197260205672, 10779.975902289583, 10863.619773307897, 10867.836982445428, 9858.112769850748, 10737.355758654505, 10889.78220435571, 11182.66452006441, 11902.166848320881], "value": 8182.433553957255, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 178.0, 120.0, 181.0, 168.0, 120.0, 122.0, 121.0, 124.0, 120.0], "value": 140.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 131.0, 113.0, 145.0, 142.0, 140.0, 109.0, 117.0, 122.0, 130.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 199.0, 198.0, 200.0, 193.0, 204.0, 200.0, 198.0, 196.0, 197.0], "value": 198.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 61.0, 60.0, 96.0, 80.0, 82.0, 74.0, 64.0, 71.0, 61.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 87.0, 68.0, 97.0, 98.0, 66.0, 100.0, 58.0, 68.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 89.0, 107.0, 134.0, 131.0, 83.0, 127.0, 85.0, 124.0, 135.0], "value": 111.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 106.0, 151.0, 114.0, 151.0, 154.0, 97.0, 98.0, 99.0, 97.0], "value": 120.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 101.0, 137.0, 143.0, 91.0, 93.0, 92.0, 91.0, 124.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 67.0, 62.0, 65.0, 72.0, 68.0, 62.0, 58.0, 105.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 63.0, 63.0, 62.0, 58.0, 58.0, 57.0, 59.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 85.0, 85.0, 85.0, 88.0, 87.0, 84.0, 88.0, 79.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 160.0, 164.0, 145.0, 141.0, 155.0, 153.0, 151.0, 192.0, 148.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 150.0, 220.0, 204.0, 170.0, 153.0, 209.0, 220.0, 221.0, 163.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 67.0, 68.0, 66.0, 65.0, 70.0, 76.0, 86.0], "value": 69.4, "unit": "score"}]}]} 10:42:20 INFO - Return code: 0 10:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:42:20 ERROR - # TBPL SUCCESS # 10:42:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:42:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:42:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:42:20 INFO - 2017-04-21 10:42:20.474 screenresolution[1664:10713] starting screenresolution argv=screenresolution get 10:42:20 INFO - 2017-04-21 10:42:20.477 screenresolution[1664:10713] Display 0: 1600x1200x32@60 10:42:20 INFO - 2017-04-21 10:42:20.484 screenresolution[1665:10716] starting screenresolution argv=screenresolution list 10:42:20 INFO - Available Modes on Display 0 10:42:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:42:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:42:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:42:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:42:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:42:20 INFO - Intel Iris: 10:42:20 INFO - Chipset Model: Intel Iris 10:42:20 INFO - Type: GPU 10:42:20 INFO - Bus: Built-In 10:42:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:42:20 INFO - Vendor: Intel (0x8086) 10:42:20 INFO - Device ID: 0x0a2e 10:42:20 INFO - Revision ID: 0x0009 10:42:20 INFO - Displays: 10:42:20 INFO - Display: 10:42:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:42:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:42:20 INFO - Display Serial Number: 1600x1200 60 10:42:20 INFO - Main Display: Yes 10:42:20 INFO - Mirror: Off 10:42:20 INFO - Online: Yes 10:42:20 INFO - Rotation: Supported 10:42:20 INFO - Return code: 0 10:42:20 INFO - Running post-action listener: _resource_record_post_action 10:42:20 INFO - [mozharness: 2017-04-21 17:42:20.731305Z] Finished run-tests step (success) 10:42:20 INFO - Running post-run listener: _resource_record_post_run 10:42:20 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 39483392; Write bytes: 424338432; Read time: 249; Write time: 1416 10:42:20 INFO - TinderboxPrint: CPU usage
54.5% 10:42:20 INFO - TinderboxPrint: I/O read bytes / time
39,483,392 / 249 10:42:20 INFO - TinderboxPrint: I/O write bytes / time
424,338,432 / 1,416 10:42:20 INFO - TinderboxPrint: CPU idle
2,170.9 (45.5%) 10:42:20 INFO - TinderboxPrint: CPU system
956.7 (20.1%) 10:42:20 INFO - TinderboxPrint: CPU user
1,642.0 (34.4%) 10:42:20 INFO - TinderboxPrint: Swap in / out
161,546,240 / 0 10:42:20 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119564800; Write bytes: 115832832; Read time: 10873; Write time: 256 10:42:20 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37365760; Write bytes: 297409536; Read time: 229; Write time: 1123 10:42:21 INFO - Running post-run listener: _upload_blobber_files 10:42:21 INFO - Blob upload gear active. 10:42:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:42:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:42:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:42:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:22 INFO - (blobuploader) - INFO - Done attempting. 10:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:42:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:23 INFO - (blobuploader) - INFO - Done attempting. 10:42:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:42:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:42:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:24 INFO - (blobuploader) - INFO - Done attempting. 10:42:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:42:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:42:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:42:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:42:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:42:26 INFO - (blobuploader) - INFO - Done attempting. 10:42:26 INFO - (blobuploader) - INFO - Iteration through files over. 10:42:26 INFO - Return code: 0 10:42:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:42:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:42:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa6c87889132117a67c965ad41d7099278f217ecb5d1974fe4325b5307a96b50f1bfb1b2a00307433a03f254384d755e062d66c34f98cf5a9cc951d175fd774", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6f165818b41cc4ea989dae7d6a5f7d17ee071a3ecc8d2b326b6b2359c1a12a47f65560ff9bd46b5a09a7e34f2cc481cc5bbecc711c02a8086391923e47a33a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437cbcce433603790d534f350db00a3a9fc0057a19f19edae4bad52b972e9162b4055bb8412a81a6476d49d6c8f0c415c785a72171eb9362cec02a9fe56a5991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e477c76f7088565343ea5fa6bfadc81737f2f8af20f31849e51f1866413eec648ffeb626987680edfac0aa0974152dee00c644d7fda3c1f01fda58972162720"} 10:42:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:42:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:42:26 INFO - Contents: 10:42:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa6c87889132117a67c965ad41d7099278f217ecb5d1974fe4325b5307a96b50f1bfb1b2a00307433a03f254384d755e062d66c34f98cf5a9cc951d175fd774", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6f165818b41cc4ea989dae7d6a5f7d17ee071a3ecc8d2b326b6b2359c1a12a47f65560ff9bd46b5a09a7e34f2cc481cc5bbecc711c02a8086391923e47a33a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437cbcce433603790d534f350db00a3a9fc0057a19f19edae4bad52b972e9162b4055bb8412a81a6476d49d6c8f0c415c785a72171eb9362cec02a9fe56a5991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e477c76f7088565343ea5fa6bfadc81737f2f8af20f31849e51f1866413eec648ffeb626987680edfac0aa0974152dee00c644d7fda3c1f01fda58972162720"} 10:42:26 INFO - Running post-run listener: copy_logs_to_upload_dir 10:42:26 INFO - Copying logs to upload dir... 10:42:26 INFO - mkdir: /builds/slave/test/build/upload/logs 10:42:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.929602 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-04-21 10:42:26.860495) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:42:26.864647) ========= 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.blXOoU9iNZ/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.wDaDMtrV78/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa6c87889132117a67c965ad41d7099278f217ecb5d1974fe4325b5307a96b50f1bfb1b2a00307433a03f254384d755e062d66c34f98cf5a9cc951d175fd774", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6f165818b41cc4ea989dae7d6a5f7d17ee071a3ecc8d2b326b6b2359c1a12a47f65560ff9bd46b5a09a7e34f2cc481cc5bbecc711c02a8086391923e47a33a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437cbcce433603790d534f350db00a3a9fc0057a19f19edae4bad52b972e9162b4055bb8412a81a6476d49d6c8f0c415c785a72171eb9362cec02a9fe56a5991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e477c76f7088565343ea5fa6bfadc81737f2f8af20f31849e51f1866413eec648ffeb626987680edfac0aa0974152dee00c644d7fda3c1f01fda58972162720"} build_url:https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011089 build_url: 'https://queue.taskcluster.net/v1/task/VB45mffqTD-sSUBTWBJxGQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa6c87889132117a67c965ad41d7099278f217ecb5d1974fe4325b5307a96b50f1bfb1b2a00307433a03f254384d755e062d66c34f98cf5a9cc951d175fd774", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d6f165818b41cc4ea989dae7d6a5f7d17ee071a3ecc8d2b326b6b2359c1a12a47f65560ff9bd46b5a09a7e34f2cc481cc5bbecc711c02a8086391923e47a33a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/437cbcce433603790d534f350db00a3a9fc0057a19f19edae4bad52b972e9162b4055bb8412a81a6476d49d6c8f0c415c785a72171eb9362cec02a9fe56a5991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e477c76f7088565343ea5fa6bfadc81737f2f8af20f31849e51f1866413eec648ffeb626987680edfac0aa0974152dee00c644d7fda3c1f01fda58972162720"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:42:26.904492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:42:26.904872) ========= 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.blXOoU9iNZ/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.wDaDMtrV78/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.005018 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:42:26.954029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:42:26.954444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:42:26.954862) ========= ========= Total master_lag: 0.19 =========