builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0283 starttime: 1485619823.1 results: success (0) buildid: 20170128071220 builduid: e3bac20768254833bb52d5fedb1e88b2 revision: 87c8697b2039d816c1531e5a1edd698933b38663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.099973) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.100490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.100821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.128779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.129082) ========= 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.fs39IHWM9W/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.a1zeBWS01o/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-01-28 08:10:23-- 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% 54.0M=0s 2017-01-28 08:10:23 (54.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.510634 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.688280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.689065) ========= 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.fs39IHWM9W/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.a1zeBWS01o/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.026119 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:23.756426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-28 08:10:23.756841) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87c8697b2039d816c1531e5a1edd698933b38663 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87c8697b2039d816c1531e5a1edd698933b38663 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fs39IHWM9W/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.a1zeBWS01o/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-01-28 08:10:23,866 truncating revision to first 12 chars 2017-01-28 08:10:23,866 Setting DEBUG logging. 2017-01-28 08:10:23,866 attempt 1/10 2017-01-28 08:10:23,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/87c8697b2039?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-28 08:10:25,049 unpacking tar archive at: mozilla-aurora-87c8697b2039/testing/mozharness/ program finished with exit code 0 elapsedTime=1.487275 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-28 08:10:25.270258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:25.270854) ========= script_repo_revision: 87c8697b2039d816c1531e5a1edd698933b38663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:25.271610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:25.272139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-28 08:10:25.293965) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-28 08:10:25.294528) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fs39IHWM9W/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.a1zeBWS01o/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:10:25 INFO - MultiFileLogger online at 20170128 08:10:25 in /builds/slave/test 08:10:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:10:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:25 INFO - {'append_to_log': False, 08:10:25 INFO - 'base_work_dir': '/builds/slave/test', 08:10:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:10:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:25 INFO - 'branch': 'Mozilla-Aurora', 08:10:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:25 INFO - 'config_files': ('talos/mac_config.py',), 08:10:25 INFO - 'default_actions': ('clobber', 08:10:25 INFO - 'read-buildbot-config', 08:10:25 INFO - 'download-and-extract', 08:10:25 INFO - 'populate-webroot', 08:10:25 INFO - 'create-virtualenv', 08:10:25 INFO - 'install', 08:10:25 INFO - 'run-tests'), 08:10:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:25 INFO - 'download_minidump_stackwalk': True, 08:10:25 INFO - 'download_symbols': 'ondemand', 08:10:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:25 INFO - 'installer_path': 'installer.exe', 08:10:25 INFO - 'log_level': 'info', 08:10:25 INFO - 'log_name': 'talos', 08:10:25 INFO - 'log_to_console': True, 08:10:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:10:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:10:25 INFO - 'opt_config_files': (), 08:10:25 INFO - 'pip_index': False, 08:10:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:25 INFO - 'cmd': ('bash', 08:10:25 INFO - '-c', 08:10:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:25 INFO - 'enabled': True, 08:10:25 INFO - 'halt_on_failure': False, 08:10:25 INFO - 'name': 'check_screen_resolution'},), 08:10:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:25 INFO - 'cmd': ('bash', 08:10:25 INFO - '-c', 08:10:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:25 INFO - 'enabled': True, 08:10:25 INFO - 'halt_on_failure': False, 08:10:25 INFO - 'name': 'check_screen_resolution'},), 08:10:25 INFO - 'run_cmd_checks_enabled': True, 08:10:25 INFO - 'sps_profile': False, 08:10:25 INFO - 'sps_profile_interval': 0, 08:10:25 INFO - 'suite': 'dromaeojs-e10s', 08:10:25 INFO - 'system_bits': '32', 08:10:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:25 INFO - 'title': 't-yosemite-r7-0283', 08:10:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:25 INFO - 'use_talos_json': True, 08:10:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:25 INFO - 'work_dir': 'build'} 08:10:25 INFO - [mozharness: 2017-01-28 16:10:25.512059Z] Running clobber step. 08:10:25 INFO - Running pre-action listener: _resource_record_pre_action 08:10:25 INFO - Running main action method: clobber 08:10:25 INFO - rmtree: /builds/slave/test/build 08:10:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:28 INFO - Running post-action listener: _resource_record_post_action 08:10:28 INFO - [mozharness: 2017-01-28 16:10:28.051962Z] Finished clobber step (success) 08:10:28 INFO - [mozharness: 2017-01-28 16:10:28.052039Z] Running read-buildbot-config step. 08:10:28 INFO - Running pre-action listener: _resource_record_pre_action 08:10:28 INFO - Running main action method: read_buildbot_config 08:10:28 INFO - Using buildbot properties: 08:10:28 INFO - { 08:10:28 INFO - "project": "", 08:10:28 INFO - "product": "firefox", 08:10:28 INFO - "script_repo_revision": "production", 08:10:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:10:28 INFO - "repository": "", 08:10:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:10:28 INFO - "buildid": "20170128071220", 08:10:28 INFO - "pgo_build": "False", 08:10:28 INFO - "basedir": "/builds/slave/test", 08:10:28 INFO - "buildnumber": 46, 08:10:28 INFO - "slavename": "t-yosemite-r7-0283", 08:10:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:10:28 INFO - "platform": "yosemite_r7", 08:10:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:10:28 INFO - "branch": "mozilla-aurora", 08:10:28 INFO - "repo_path": "releases/mozilla-aurora", 08:10:28 INFO - "revision": "87c8697b2039d816c1531e5a1edd698933b38663", 08:10:28 INFO - "stage_platform": "macosx64", 08:10:28 INFO - "builduid": "e3bac20768254833bb52d5fedb1e88b2", 08:10:28 INFO - "slavebuilddir": "test" 08:10:28 INFO - } 08:10:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:10:28 INFO - Running post-action listener: _resource_record_post_action 08:10:28 INFO - [mozharness: 2017-01-28 16:10:28.055587Z] Finished read-buildbot-config step (success) 08:10:28 INFO - [mozharness: 2017-01-28 16:10:28.055716Z] Running download-and-extract step. 08:10:28 INFO - Running pre-action listener: _resource_record_pre_action 08:10:28 INFO - Running main action method: download_and_extract 08:10:28 INFO - mkdir: /builds/slave/test/build/tests 08:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:28 INFO - trying https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:10:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:10:29 INFO - Downloaded 1199 bytes. 08:10:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:10:29 INFO - Using the following test package requirements: 08:10:29 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:10:29 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:10:29 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:10:29 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'jsshell-mac.zip'], 08:10:29 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:10:29 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:10:29 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:10:29 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:10:29 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:10:29 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:10:29 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:10:29 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:10:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:10:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:10:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:10:30 INFO - Expected file size: 16351679 08:10:30 INFO - Obtained file size: 16351679 08:10:37 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:10:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:10:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:10:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:10:37 INFO - Expected file size: 16351679 08:10:37 INFO - Obtained file size: 16351679 08:10:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:10:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:10:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:10:45 INFO - Expected file size: 14403485 08:10:45 INFO - Obtained file size: 14403485 08:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:46 INFO - trying https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:10:48 INFO - Downloaded 73867127 bytes. 08:10:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:48 INFO - mkdir: /builds/slave/test/properties 08:10:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:48 INFO - Contents: 08:10:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:48 INFO - Running post-action listener: _resource_record_post_action 08:10:48 INFO - Running post-action listener: set_extra_try_arguments 08:10:48 INFO - [mozharness: 2017-01-28 16:10:48.995969Z] Finished download-and-extract step (success) 08:10:48 INFO - [mozharness: 2017-01-28 16:10:48.996097Z] Running populate-webroot step. 08:10:48 INFO - Running pre-action listener: _resource_record_pre_action 08:10:48 INFO - Running main action method: populate_webroot 08:10:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:49 INFO - '--tppagecycles', 08:10:49 INFO - '7'], 08:10:49 INFO - 'tests': ['tsvgm']}}, 08:10:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['damp', 'tps']}, 08:10:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'tests': ['damp', 'tps']}, 08:10:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['dromaeo_dom']}, 08:10:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['basic_compositor_video']}, 08:10:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore', 08:10:49 INFO - 'tabpaint']}, 08:10:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tsvgx', 08:10:49 INFO - 'tsvgr_opacity', 08:10:49 INFO - 'tart', 08:10:49 INFO - 'tscrollx', 08:10:49 INFO - 'cart', 08:10:49 INFO - 'tsvg_static']}, 08:10:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:49 INFO - 'tsvgr_opacity', 08:10:49 INFO - 'tart', 08:10:49 INFO - 'tscrollx', 08:10:49 INFO - 'cart', 08:10:49 INFO - 'tsvg_static']}, 08:10:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s'], 08:10:49 INFO - 'tests': ['tp5o']}, 08:10:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:10:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'talos_options': ['--disable-e10s', 08:10:49 INFO - '--xperf_path', 08:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:49 INFO - 'tests': ['tp5n']}, 08:10:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:10:49 INFO - 'talos_options': ['--xperf_path', 08:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:49 INFO - 'tests': ['tp5n']}}, 08:10:49 INFO - 'talos.zip': {'path': '', 08:10:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:49 INFO - Running post-action listener: _resource_record_post_action 08:10:49 INFO - [mozharness: 2017-01-28 16:10:49.014855Z] Finished populate-webroot step (success) 08:10:49 INFO - [mozharness: 2017-01-28 16:10:49.014973Z] Running create-virtualenv step. 08:10:49 INFO - Running pre-action listener: _resource_record_pre_action 08:10:49 INFO - Running main action method: create_virtualenv 08:10:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:10:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:49 INFO - Using real prefix '/tools/python27' 08:10:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:49 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:52 INFO - Installing pip.................done. 08:10:52 INFO - Return code: 0 08:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:10:52 INFO - Reading from file tmpfile_stdout 08:10:52 INFO - Output received: 08:10:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:10:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:52 INFO - 'HOME': '/Users/cltbld', 08:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PAGER': '/bin/cat', 08:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:10:52 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - 'XPC_FLAGS': '0x0', 08:10:52 INFO - 'XPC_SERVICE_NAME': '0', 08:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:10:53 INFO - Cleaning up... 08:10:53 INFO - Return code: 0 08:10:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:53 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:53 INFO - 'HOME': '/Users/cltbld', 08:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:53 INFO - 'LOGNAME': 'cltbld', 08:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:53 INFO - 'MOZ_NO_REMOTE': '1', 08:10:53 INFO - 'NO_EM_RESTART': '1', 08:10:53 INFO - 'PAGER': '/bin/cat', 08:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:53 INFO - 'PWD': '/builds/slave/test', 08:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:53 INFO - 'SHELL': '/bin/bash', 08:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:10:53 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:53 INFO - 'USER': 'cltbld', 08:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:53 INFO - 'XPC_FLAGS': '0x0', 08:10:53 INFO - 'XPC_SERVICE_NAME': '0', 08:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:53 INFO - Downloading/unpacking psutil>=3.1.1 08:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:57 INFO - Installing collected packages: psutil 08:10:57 INFO - Running setup.py install for psutil 08:10:57 INFO - building 'psutil._psutil_osx' extension 08:10:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:10:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:10:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:10:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:10:58 INFO - building 'psutil._psutil_posix' extension 08:10:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:10:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:10:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:10:58 INFO - ^ 08:10:58 INFO - 1 warning generated. 08:10:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:58 INFO - Successfully installed psutil 08:10:58 INFO - Cleaning up... 08:10:58 INFO - Return code: 0 08:10:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:10: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:10: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 mozsystemmonitor==0.3 08:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:58 INFO - 'HOME': '/Users/cltbld', 08:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:58 INFO - 'LOGNAME': 'cltbld', 08:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:58 INFO - 'MOZ_NO_REMOTE': '1', 08:10:58 INFO - 'NO_EM_RESTART': '1', 08:10:58 INFO - 'PAGER': '/bin/cat', 08:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:58 INFO - 'PWD': '/builds/slave/test', 08:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:58 INFO - 'SHELL': '/bin/bash', 08:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:10:58 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:58 INFO - 'USER': 'cltbld', 08:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:58 INFO - 'XPC_FLAGS': '0x0', 08:10:58 INFO - 'XPC_SERVICE_NAME': '0', 08:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:10: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 08:11:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:01 INFO - Installing collected packages: mozsystemmonitor 08:11:01 INFO - Running setup.py install for mozsystemmonitor 08:11:01 INFO - Successfully installed mozsystemmonitor 08:11:01 INFO - Cleaning up... 08:11:01 INFO - Return code: 0 08:11:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:01 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:01 INFO - 'HOME': '/Users/cltbld', 08:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:01 INFO - 'LOGNAME': 'cltbld', 08:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:01 INFO - 'MOZ_NO_REMOTE': '1', 08:11:01 INFO - 'NO_EM_RESTART': '1', 08:11:01 INFO - 'PAGER': '/bin/cat', 08:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:01 INFO - 'PWD': '/builds/slave/test', 08:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:01 INFO - 'SHELL': '/bin/bash', 08:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:01 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:01 INFO - 'USER': 'cltbld', 08:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:01 INFO - 'XPC_FLAGS': '0x0', 08:11:01 INFO - 'XPC_SERVICE_NAME': '0', 08:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:05 INFO - warning: no files found matching '*.txt' 08:11:05 INFO - no previously-included directories found matching 'build' 08:11:05 INFO - no previously-included directories found matching 'dist' 08:11:05 INFO - no previously-included directories found matching '.git*' 08:11:05 INFO - Installing collected packages: jsonschema, functools32 08:11:05 INFO - Running setup.py install for functools32 08:11:05 INFO - warning: no files found matching '*.txt' 08:11:05 INFO - no previously-included directories found matching 'build' 08:11:05 INFO - no previously-included directories found matching 'dist' 08:11:05 INFO - no previously-included directories found matching '.git*' 08:11:05 INFO - Successfully installed jsonschema functools32 08:11:05 INFO - Cleaning up... 08:11:05 INFO - Return code: 0 08:11:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:05 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:05 INFO - 'HOME': '/Users/cltbld', 08:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:05 INFO - 'LOGNAME': 'cltbld', 08:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:05 INFO - 'MOZ_NO_REMOTE': '1', 08:11:05 INFO - 'NO_EM_RESTART': '1', 08:11:05 INFO - 'PAGER': '/bin/cat', 08:11:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:05 INFO - 'PWD': '/builds/slave/test', 08:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:05 INFO - 'SHELL': '/bin/bash', 08:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:05 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:05 INFO - 'USER': 'cltbld', 08:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:05 INFO - 'XPC_FLAGS': '0x0', 08:11:05 INFO - 'XPC_SERVICE_NAME': '0', 08:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:11:05 INFO - Cleaning up... 08:11:05 INFO - Return code: 0 08:11:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:05 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:05 INFO - 'HOME': '/Users/cltbld', 08:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:05 INFO - 'LOGNAME': 'cltbld', 08:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:05 INFO - 'MOZ_NO_REMOTE': '1', 08:11:05 INFO - 'NO_EM_RESTART': '1', 08:11:05 INFO - 'PAGER': '/bin/cat', 08:11:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:05 INFO - 'PWD': '/builds/slave/test', 08:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:05 INFO - 'SHELL': '/bin/bash', 08:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:05 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:05 INFO - 'USER': 'cltbld', 08:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:05 INFO - 'XPC_FLAGS': '0x0', 08:11:05 INFO - 'XPC_SERVICE_NAME': '0', 08:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:09 INFO - Downloading docopt-0.6.1.tar.gz 08:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:09 INFO - Running setup.py install for blobuploader 08:11:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:10 INFO - Running setup.py install for requests 08:11:10 INFO - Running setup.py install for docopt 08:11:10 INFO - Successfully installed blobuploader requests docopt 08:11:10 INFO - Cleaning up... 08:11:10 INFO - Return code: 0 08:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:10 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:10 INFO - 'HOME': '/Users/cltbld', 08:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:10 INFO - 'LOGNAME': 'cltbld', 08:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:10 INFO - 'MOZ_NO_REMOTE': '1', 08:11:10 INFO - 'NO_EM_RESTART': '1', 08:11:10 INFO - 'PAGER': '/bin/cat', 08:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:10 INFO - 'PWD': '/builds/slave/test', 08:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:10 INFO - 'SHELL': '/bin/bash', 08:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:10 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:10 INFO - 'USER': 'cltbld', 08:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:10 INFO - 'XPC_FLAGS': '0x0', 08:11:10 INFO - 'XPC_SERVICE_NAME': '0', 08:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-DmkddB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-_KmfAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-moD6mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-DoY8Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-d9Te82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-W1Y6oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-LSDLws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:11 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-X3YcXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-c_Q2B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ZTk8kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-q2EjWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-7Hc6S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-PRcgdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-QqK5wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-3dIs08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Nep_Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:12 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Q7Yqfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:12 INFO - Running setup.py install for manifestparser 08:11:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:13 INFO - Running setup.py install for mozcrash 08:11:13 INFO - Running setup.py install for mozdebug 08:11:13 INFO - Running setup.py install for mozdevice 08:11:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:13 INFO - Running setup.py install for mozfile 08:11:13 INFO - Running setup.py install for mozhttpd 08:11:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:13 INFO - Running setup.py install for mozinfo 08:11:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Running setup.py install for mozInstall 08:11:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Running setup.py install for mozleak 08:11:14 INFO - Running setup.py install for mozlog 08:11:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Running setup.py install for moznetwork 08:11:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Running setup.py install for mozprocess 08:11:14 INFO - Running setup.py install for mozprofile 08:11:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:14 INFO - Running setup.py install for mozrunner 08:11:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:15 INFO - Running setup.py install for mozscreenshot 08:11:15 INFO - Running setup.py install for moztest 08:11:15 INFO - Running setup.py install for mozversion 08:11:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:15 INFO - Cleaning up... 08:11:15 INFO - Return code: 0 08:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:15 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:15 INFO - 'HOME': '/Users/cltbld', 08:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:15 INFO - 'LOGNAME': 'cltbld', 08:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:15 INFO - 'MOZ_NO_REMOTE': '1', 08:11:15 INFO - 'NO_EM_RESTART': '1', 08:11:15 INFO - 'PAGER': '/bin/cat', 08:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:15 INFO - 'PWD': '/builds/slave/test', 08:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:15 INFO - 'SHELL': '/bin/bash', 08:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:15 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:15 INFO - 'USER': 'cltbld', 08:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:15 INFO - 'XPC_FLAGS': '0x0', 08:11:15 INFO - 'XPC_SERVICE_NAME': '0', 08:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-NZDdLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:15 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-DrpgqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-rDoZym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-7egV03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-yHlimC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-jGxV1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Q4ufBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-rgWt9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-SssIVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-hVpf9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:16 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-lfOram-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-xRttEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-aEg944-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-63G7YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-SZyWho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-T4rx4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:17 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-wxIst4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:11:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:20 INFO - Downloading blessings-1.6.tar.gz 08:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:20 INFO - Installing collected packages: blessings 08:11:20 INFO - Running setup.py install for blessings 08:11:20 INFO - Successfully installed blessings 08:11:20 INFO - Cleaning up... 08:11:20 INFO - Return code: 0 08:11:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:20 INFO - Reading from file tmpfile_stdout 08:11:20 INFO - Current package versions: 08:11:20 INFO - blessings == 1.6 08:11:20 INFO - blobuploader == 1.2.4 08:11:20 INFO - docopt == 0.6.1 08:11:20 INFO - functools32 == 3.2.3-2 08:11:20 INFO - jsonschema == 2.5.1 08:11:20 INFO - manifestparser == 1.1 08:11:20 INFO - mozInstall == 1.12 08:11:20 INFO - mozcrash == 1.0 08:11:20 INFO - mozdebug == 0.1 08:11:20 INFO - mozdevice == 0.49 08:11:20 INFO - mozfile == 1.2 08:11:20 INFO - mozhttpd == 0.7 08:11:20 INFO - mozinfo == 0.9 08:11:20 INFO - mozleak == 0.1 08:11:20 INFO - mozlog == 3.4 08:11:20 INFO - moznetwork == 0.27 08:11:20 INFO - mozprocess == 0.24 08:11:20 INFO - mozprofile == 0.28 08:11:20 INFO - mozrunner == 6.13 08:11:20 INFO - mozscreenshot == 0.1 08:11:20 INFO - mozsystemmonitor == 0.3 08:11:20 INFO - moztest == 0.8 08:11:20 INFO - mozversion == 1.4 08:11:20 INFO - psutil == 3.1.1 08:11:20 INFO - requests == 1.2.3 08:11:20 INFO - wsgiref == 0.1.2 08:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:20 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:20 INFO - 'HOME': '/Users/cltbld', 08:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:20 INFO - 'LOGNAME': 'cltbld', 08:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:20 INFO - 'MOZ_NO_REMOTE': '1', 08:11:20 INFO - 'NO_EM_RESTART': '1', 08:11:20 INFO - 'PAGER': '/bin/cat', 08:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:20 INFO - 'PWD': '/builds/slave/test', 08:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:20 INFO - 'SHELL': '/bin/bash', 08:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:20 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:20 INFO - 'USER': 'cltbld', 08:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:20 INFO - 'XPC_FLAGS': '0x0', 08:11:20 INFO - 'XPC_SERVICE_NAME': '0', 08:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:11:21 INFO - Cleaning up... 08:11:21 INFO - Return code: 0 08:11:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:21 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 0x108b4fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b52768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe61d65730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, '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.fs39IHWM9W/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.a1zeBWS01o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:21 INFO - 'HOME': '/Users/cltbld', 08:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:21 INFO - 'LOGNAME': 'cltbld', 08:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:21 INFO - 'MOZ_NO_REMOTE': '1', 08:11:21 INFO - 'NO_EM_RESTART': '1', 08:11:21 INFO - 'PAGER': '/bin/cat', 08:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:21 INFO - 'PWD': '/builds/slave/test', 08:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:21 INFO - 'SHELL': '/bin/bash', 08:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:21 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:21 INFO - 'USER': 'cltbld', 08:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:21 INFO - 'XPC_FLAGS': '0x0', 08:11:21 INFO - 'XPC_SERVICE_NAME': '0', 08:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:21 INFO - Cleaning up... 08:11:21 INFO - Return code: 0 08:11:21 INFO - Running post-action listener: _resource_record_post_action 08:11:21 INFO - Running post-action listener: _start_resource_monitoring 08:11:21 INFO - Starting resource monitoring. 08:11:21 INFO - [mozharness: 2017-01-28 16:11:21.491507Z] Finished create-virtualenv step (success) 08:11:21 INFO - [mozharness: 2017-01-28 16:11:21.492459Z] Running install step. 08:11:21 INFO - Running pre-action listener: _resource_record_pre_action 08:11:21 INFO - Running main action method: install 08:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:21 INFO - Reading from file tmpfile_stdout 08:11:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:21 INFO - Reading from file tmpfile_stdout 08:11:21 INFO - Output received: 08:11:21 INFO - Usage: mozinstall [options] installer 08:11:21 INFO - Options: 08:11:21 INFO - -h, --help show this help message and exit 08:11:21 INFO - -d DEST, --destination=DEST 08:11:21 INFO - Directory to install application into. [default: 08:11:21 INFO - "/builds/slave/test"] 08:11:21 INFO - --app=APP Application being installed. [default: firefox] 08:11:21 INFO - mkdir: /builds/slave/test/build/application 08:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:11:41 INFO - Reading from file tmpfile_stdout 08:11:41 INFO - Output received: 08:11:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:11:41 INFO - Running post-action listener: _resource_record_post_action 08:11:41 INFO - [mozharness: 2017-01-28 16:11:41.752698Z] Finished install step (success) 08:11:41 INFO - [mozharness: 2017-01-28 16:11:41.752847Z] Running run-tests step. 08:11:41 INFO - Running pre-action listener: _resource_record_pre_action 08:11:41 INFO - Running main action method: run_tests 08:11:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:41 INFO - 2017-01-28 08:11:41.767 screenresolution[1647:9288] starting screenresolution argv=screenresolution get 08:11:41 INFO - 2017-01-28 08:11:41.770 screenresolution[1647:9288] Display 0: 1600x1200x32@60 08:11:41 INFO - 2017-01-28 08:11:41.776 screenresolution[1648:9291] starting screenresolution argv=screenresolution list 08:11:41 INFO - Available Modes on Display 0 08:11:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:42 INFO - Intel Iris: 08:11:42 INFO - Chipset Model: Intel Iris 08:11:42 INFO - Type: GPU 08:11:42 INFO - Bus: Built-In 08:11:42 INFO - VRAM (Dynamic, Max): 1536 MB 08:11:42 INFO - Vendor: Intel (0x8086) 08:11:42 INFO - Device ID: 0x0a2e 08:11:42 INFO - Revision ID: 0x0009 08:11:42 INFO - Displays: 08:11:42 INFO - Display: 08:11:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:42 INFO - Display Serial Number: 1600x1200 60 08:11:42 INFO - Main Display: Yes 08:11:42 INFO - Mirror: Off 08:11:42 INFO - Online: Yes 08:11:42 INFO - Rotation: Supported 08:11:42 INFO - Return code: 0 08:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:42 INFO - Python 2.7.3 08:11:42 INFO - Return code: 0 08:11:42 INFO - grabbing minidump binary from tooltool 08:11: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')]} 08:11: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 0x10892dd30>, '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 0x108854db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108922be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11: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 08:11: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 08:11: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 08:11:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:42 INFO - Return code: 0 08:11:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fs39IHWM9W/Render', 08:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:42 INFO - 'HOME': '/Users/cltbld', 08:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:42 INFO - 'LOGNAME': 'cltbld', 08:11:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:42 INFO - 'MOZ_NO_REMOTE': '1', 08:11:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:42 INFO - 'NO_EM_RESTART': '1', 08:11:42 INFO - 'PAGER': '/bin/cat', 08:11:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:42 INFO - 'PWD': '/builds/slave/test', 08:11:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:42 INFO - 'SHELL': '/bin/bash', 08:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a1zeBWS01o/Listeners', 08:11:42 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 08:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:42 INFO - 'USER': 'cltbld', 08:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:42 INFO - 'XPC_FLAGS': '0x0', 08:11:42 INFO - 'XPC_SERVICE_NAME': '0', 08:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:11:42 INFO - mozversion application_buildid: 20170128071220 08:11:42 INFO - mozversion application_changeset: 87c8697b2039d816c1531e5a1edd698933b38663 08:11:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:11:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:42 INFO - mozversion application_name: Firefox 08:11:42 INFO - mozversion application_remotingname: firefox-dev 08:11:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:11:42 INFO - mozversion application_vendor: Mozilla 08:11:42 INFO - mozversion application_version: 53.0a2 08:11:42 INFO - mozversion platform_buildid: 20170128071220 08:11:42 INFO - mozversion platform_changeset: 87c8697b2039d816c1531e5a1edd698933b38663 08:11:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:11:42 INFO - mozversion platform_version: 53.0a2 08:11:42 INFO - using testdate: 1485619902 08:11:42 INFO - actual date: 1485619902 08:11:42 INFO - starting webserver on 'localhost:49246' 08:11:42 INFO - SUITE-START | Running 2 tests 08:11:42 INFO - TEST-START | dromaeo_css 08:11:42 INFO - operating with platform_type : mac_ 08:11:42 INFO - Initialising browser for dromaeo_css test... 08:11:42 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmp_b_ivN/profile http://localhost:49246/getInfo.html) 08:11:45 INFO - PROCESS | 1658 | 2017-01-28 08:11:45.479 plugin-container[1660:9474] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 08:11:45 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:45 INFO - PROCESS | 1658 | 2017-01-28 08:11:45.482 plugin-container[1660:9474] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 08:11:45 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:45 INFO - PROCESS | 1658 | 2017-01-28 08:11:45.482 plugin-container[1660:9474] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:11:45 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 08:11:45 INFO - PROCESS | 1658 | colorDepth:24 08:11:45 INFO - PROCESS | 1658 | Browser inner width/height: 1024/663 08:11:45 INFO - PROCESS | 1658 | __metrics 08:11:45 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:11:46 INFO - TEST-INFO | 1658: exit 0 08:11:46 INFO - Browser initialized. 08:11:46 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmp_b_ivN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:48 INFO - PROCESS | 1662 | 2017-01-28 08:11:48.873 plugin-container[1663:9608] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 08:11:48 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:48 INFO - PROCESS | 1662 | 2017-01-28 08:11:48.873 plugin-container[1663:9608] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 08:11:48 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:48 INFO - PROCESS | 1662 | 2017-01-28 08:11:48.873 plugin-container[1663:9608] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:11:58 INFO - PROCESS | 1662 | RSS: Main: 225976320 08:11:58 INFO - PROCESS | 1662 | 08:15:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 08:15:02 INFO - PROCESS | 1662 | RSS: Main: 245301248 08:15:02 INFO - PROCESS | 1662 | 08:16:46 INFO - PROCESS | 1662 | ************************* 08:16:46 INFO - PROCESS | 1662 | A coding exception was thrown and uncaught in a Task. 08:16:46 INFO - PROCESS | 1662 | 08:16:46 ERROR - PROCESS | 1662 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:16:46 INFO - PROCESS | 1662 | Full stack: 08:16:46 INFO - PROCESS | 1662 | ************************* 08:18:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 08:18:05 INFO - PROCESS | 1662 | RSS: Main: 251920384 08:18:05 INFO - PROCESS | 1662 | 08:21:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 08:21:07 INFO - PROCESS | 1662 | RSS: Main: 257757184 08:21:07 INFO - PROCESS | 1662 | 08:24:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 08:24:10 INFO - PROCESS | 1662 | RSS: Main: 254197760 08:24:10 INFO - PROCESS | 1662 | 08:27:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 08:27:13 INFO - PROCESS | 1662 | RSS: Main: 258228224 08:27:13 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 08:30:16 INFO - PROCESS | 1662 | RSS: Main: 259538944 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | __start_tp_report 08:30:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 08:30:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 08:30:16 INFO - PROCESS | 1662 | |i|pagename|runs| 08:30:16 INFO - PROCESS | 1662 | |0;dojo.html;2724.9727502724973;3393.7115345195657;3402.217489977306;3405.744569157314;3426.0749597608633;4361.912761744763;5723.198752174693;5741.36844947056;5760.827175184746;5873.500752436037;5199.324087868572;5497.147942068976;5835.766569337232;5888.116782482619;5928.733207005685;5281.947180528194;5307.071262529062;5308.416074231832;5375.516203541681;5376.4085950545405;5384.40771515133;5395.919061214085;5398.325209348832;5398.973005134989;5406.405295417501;5387.4612538746005;5393.633012685359;5394.217838413448;5395.379531353886;5455.945440545604;5237.031149237403;5246.7901283948595;5295.4969277918535;5325.1479763238085;5367.490088441592;5255.1329030709885;5334.146536554172;5390.407055223922;5390.7870729086035;5396.703181325026;5948.078047902539;6023.096535519707;6028.1861948636815;6028.457438830483;6047.788327408563;6182.783602573888;6227.346128656471;6240;6289.8742025159245;6332.556721029529;6181.721822517998;6200.87598248037;6237.968810155966;6283.8114856554375;6295.811125666238;6025.638461692312;6026.427489388501;6028.09578563219;6043.697815109227;6091.269047714302;5960.807838432244;6127.938720612737;6145.494353883238;6350.491960643138;6399.424051835357;6139.890808645427;6144.880016394337;6173.876522469525;6206.813795586139;6305.243370795534;4674.883127921829;6222.875542489215;6294.087357333161;6335.176427064452;6338.397852204033;6245.718942647592;6272.059191121369;6309.747610095545;6310.242770867433;6311.905321420182;6119.07606531266;6149.661768602769;6172.105044768573;6202.309625772658;6273.247210334789;5069.087564238473;5095.312132862016;5110.642255042111;5115.565176959925;5135.152699804565;4562.475315338778;4571.862844114682;4583.495815460296;4585.839495617637;4597.747123908217;4896.926546101811;5907.172995780594;5918.082697181943;5990.011648078018;6027.126066720389;6285.685715714196;6299.590526615755;6303.495720342362;6318.810435686937;6319.526035547352;5856.4143585641095;6007.789727359522;6023.427774361428;6043.395660434009;6050.42520960508;5515.034868897927;5564.527015203753;5582.190582365615;5601.103823388238;5667;6431.099646049651;6432.614043157426;6475.579087359307;6475.7733479328;6487.124238227968;6317.368263173646;6322.905156422566;6328.746850125944;6329.30377658448;6331.398517140864;6245.250569931455;6295.905561416491;6303.684815759286;6336.524760642878;6358.872822543616;5172.689638621695;5467.644603100785;6130.7241174146375;6276;6316.178896743394;6242.719077641426;6265.436110749872;6265.906011409924;6293.748250070129;6297.118403423616;6113.932424433873;6138.140660307471;6151.96924015377;6156.168917196122;6244.344343843831;6181.381861813783;6249.718762655601;6255.499560035095;6278.15244941927;6301.212348456443;4782.378290822171;5505.752241149078;5841.415858414294;6207.534434917489;6249.7187626557825;6064.969675151596;6144.310314663503;6162.722677479614;6242.094896240111;6258.311585725475;5004.299398084198;6149.108379285068;6170.568060235741;6170.876582468415;6188.319284878749 08:30:16 INFO - PROCESS | 1662 | |1;ext.html;448;453.8547664747282;458.93755954964274;499.3508439029262;521.8147557617045;38590.614093859054;42496.57503424965;42628;42720.57279427205;42749.93125171872;43722;44217.77891110548;44222.89442763932;44245.67262982108;44247.77876110615;8412.411131220786;9269.165775080224;9479.47862867542;9493.572789224501;9508.667196648119;8423.789405264855;11237.157213209;11523.020543253791;11526.481308341145;11726.824097638542;11350.205485615968;11365.943170284138;11382.2032457728;11394;11397.544098236101;11376.488058037408;11438.25651332669;11446.771064578745;11454.370009649467;11476.598319058834;11306.886931130748;11365.772684546346;11371.829422558669;11397.430128493543;11439;40539;40807.387889181686;40977.77066688004;41167.58832411697;41219.38170927409;4022.7988600570147;4098.139390727951;4101.200265948141;4155.833766649331;4247.086876321606;30249;31040.8447957761;31087;31094.689053109632;31536.211594710087;3176.9501278772404;3202.151429871086;3309.834508274577;3313.188268874117;3331.034000139981;481305;482863;483188;485037;485413;62176.37823621796;62198.20108095147;62428;62625.49498020119;62636.06045909315;59011.114833277534;62068.689656552335;64368.356316436235;65110;65295.04114876562;16322.591935201477;16473.01161930288;16817.327306907588;16830.326786928632;16875.91562042182;11626.651200463999;11948.402579870972;12638.368081595883;13083.149595276276;13242.20546767197;13352.53122156562;16013.519594412186;16124.919375403048;16179.352825886832;16227.83772162287;7403.629818509053;7454.068241469817;7495.138059123162;7531.736389226351;7554.2823431773895;887.4896934262824;895.4895709445553;900.7342833864026;911.8723378726984;926.4256161179977;30563;31047.534286985712;31089.067327980196;31098.84450577778;31630.683693163235;1056.7886422715487;1090.8145615245428;1106.2201148190507;1119.8768135505088;1244.9190802597984;11163.776724465628;16188.757168642243;16750.83249167517;17070.23183956725;17139.657206855794;628255;632535;632637;633978;634355;58070;58220.708896455246;58543.70728146332;58594;58605.70697146487;1448.0732331307972;1448.4474888113089;1461.2328527523136;1480.659448326891;1488.6352843553182;29881;31155.37689246248;31459.842700787267;31815;31844.840775795972;43408.34887476627;49267.26099108588;49707.254391184884;49804.25293620526;49927.25109123293;558945;562502;565174;565346;567163;34081;35071.9478415648;37791.62208377991;38020.61979380171;40699.98250043773;46549.30176047294;46617.06765864731;46833;47435.76282118567;48336;38224.61775382211;38294.617053829104;39311.60688393194;39401;39952.4007139899;38078;38247.80876095713;38514.422283665204;38844.6115538841;39332.606673932896;38110.856674299815;38146.85559433221;38450.61549384471;38594;38639.6136038636;27192.048278310165;34226.82886585551;34667.9599612012;34877.9536613902;34965.47551786674;25296.62055069212;25455.49089018172;25674.358141046625;25800.870995644902;25962.480750385264 08:30:16 INFO - PROCESS | 1662 | |2;jquery.html;398.0744768413439;398.91024519483136;403.17349433661025;408.9611486908744;425.9275923093074;19886;20209.595808083828;20911.68632470514;21170.94145292737;21223.57552848944;11945;12223.266604003744;18639.90680046598;21362.359129226108;21624.459388515294;5304.9204261936;5639.295088113986;6131.846703832395;6180.351063138373;6199;3954.9406758898494;6066.484348830355;6174.320824709278;6176.413240742122;6187.102870083835;5618.876224755045;5676.091825307952;5750.769969201227;6123;6142.744345496893;6057.454829065406;6095.024796032636;6141.385861413867;6161.845953851145;6167.444929956303;6051.606645568024;6070.453659170652;6072.848178795522;6076.848078798022;6088.817335479943;11069.225154239206;13593.52422665202;23449.88275058631;23779.643305350262;24759.381015474577;2631.4868600622885;2741.150243424525;2770.515159847019;2900.390917907242;3017.909462716122;10433.35183569902;16225.026498410132;17270.30918763248;17345.739813902674;18309.45071647853;1710.811810700822;1726.7668864703355;1993.800619938009;2003.6693945498976;2087.7077209190725;147902.78145827822;154746;178088;180511.9999999987;181372;24714.50570988606;24883.391908173213;25064;25073.749262507143;25308;37628;42410.57589424066;42461.15077698429;43074.78462607667;43649.127017459476;6690.565113267719;7322.707091716272;8401.285890699237;8617.78455538604;8911;8660.17728315809;8668.8699669505;8674.175953284428;8771.473711577326;8806.471611703319;4074.9796251019147;4803.303520989437;4817.2774083887;4830.734309613005;4893.779779909913;2054.815066644009;2103.2638576498102;2104.1793700456833;2104.936851894415;2106.8103870651717;386.4936932618279;389.92981263372866;401.57633696449943;404.7389433815173;414.17165668662676;11889.762204756029;12088.456019478968;12124.818127728091;12330.32183229913;12442.440090195963;423.46220300219164;431.040933922021;437.56680885923345;874.1651722604897;952.5570609666538;6761.594304341656;6868.896966545506;6937.7224911002995;6976.825579360557;6988;757053;759522;769744;783916;789954;160626;161145.1942740279;162086;164982;167286;1058.4125810175426;1073.6671631794168;1096.9890301097046;1101.4437708956925;1103.900648941599;11986.999175024144;12235.755284894074;12387.256764594153;12526.06054545931;12529.18560293578;61098;62013;62158.68920655368;62772.68613656903;63265.051024233755;91380.54309728408;91441;94067;94848.05151948392;95147.52426237824;8049.637766300648;8082.838343232985;8417.28453081495;8498.447600905922;8725.869111963199;11997.040236781211;12895.742085158432;12945.352732363532;13166.275854828076;13332.666683332995;11071.72675142369;11241.831372529256;11287.604933827277;11440.199186056896;11486.712832179262;10505.527251273557;10981.945090274497;11248.943755281498;11340.829887551858;11479.942600286946;11358.09135269193;11359.602413915472;11508.82736758966;11661.883381166079;11782.351970641697;8315.210055044761;8412.07467178622;8429.494230345954;8534.91465085366;8571.142885711379;8722.869156962777;9993.950030249802;10960.616378426717;11013.669589911995;11278.661640150809 08:30:16 INFO - PROCESS | 1662 | |3;mootools.html;1193.2899924544893;1244.7323825377541;1370.6847425092226;1416.9008169428132;1458.8687018168362;7510.7371242006475;7561.697532098723;7878.80302992424;8282.792930176749;8740.257078148357;8132.308753755938;8309.584520773953;8400.705975290866;8521;8526.658933642648;2282.463621049052;2313.838031337807;2319.199876042771;2325.360525855395;2336.4509340305017;2106.1470104607583;2168.3494951514563;2336.4742932840145;2365.0303375615913;2382.0471811275543;2272.784085511874;2349.788519033287;2356.2460012795914;2356.646503024543;2357.5874222011166;2337.018452250059;2339.789418952294;2350.918577454373;2354.3525530479083;2357.3635118517905;2320.663503791941;2338.4387746940783;2387.271882075966;2395.5208958208427;2403.098837935774;8627.568621568897;8662.480251184948;8705.695300664447;8725.7818554536;8730.956345218297;5199.870003249911;5330.680159190461;5376.327959005124;5376.38171610262;5386.811461598864;3276.7214786743157;3424.931501369959;3589.246258285737;3633.2370202257557;3659.14010207601;1215.7304258513104;1226.2090951336338;1253.486070711004;1273.1469915156868;1273.2233337664018;11060.391678457681;11214.775704485946;11225.214235003554;11238.775224495464;11252.099832013419;4619.353290539327;4825.576454945799;4862.367892173995;4869.878253043702;4886.95113048865;9668.129868311886;9823.705288841345;9846.655367062118;9864.210863130933;9875.160611348116;5238.109521381374;5297;5336.866578335495;5369.328833895763;5378.273933019071;4626.467956185014;4833.806647734122;4842.346283251786;4901.50984901507;4910.165271903714;3914.4911161548816;3984.5218573770753;4013.6588389986596;4089.997950502146;4096.692748043909;1055.8046761349176;1178.3048001678878;1216.0575553945762;1298.1172802494395;1299.883010529038;926.2034650200821;928.7538802217417;931.6087243357806;939.5020639061308;952.2905435450633;5678.488935995698;5684.687342196136;5829.533637309005;6025.18659980897;6033.215681961405;967.6806653804227;1008.7326858382535;1009.8030883977553;1013.8428543575758;1044.2220545693508;3892.82482288292;3961.465202197724;4007.519097708294;4033;4053.61490658387;9988.151007164328;10196.847047294297;10204.030617091365;10345.327553708985;10355.17158627308;9757.365771224848;10154.39073655583;10160.745981350525;10161.847572286422;10175.338602990782;7818.21817818225;8142.4300298978505;8150.918490815135;8155.877661835078;8173.427860049739;5859.091840764689;5862;5866.735996880066;5936.970315148396;6007.939920600738;8069.193080691884;9410.341276110606;9479;9564.378315409476;9598.280128990493;9361.906380936103;9536.475493847905;9607.51962401891;9809.950950245204;9859.260555458226;7301.853962920818;7450.9941157942985;7462.216467270859;7462.626868656437;7476.4392670551015;7985.600719964094;7999.240072193133;8021.318187953856;8087.1104178539135;8135.471194372347;6554.8361290968105;7232.783016509513;7324.743633972786;7367.005454263606;7421.628918553943;6173.32093469709;7185.742495063448;7246.347828695442;7259.382952449101;7265.418766498773;6370.362963703593;6521.771737989147;6538.509611779041;6585.96707016481;6601.3728695773825;4976.054549635558;5091.821786237464;5155.123628983157;5169.4830516948;5180.896382072413;4516.841910533116;5082.898342033212;5153.7165455898785;5253;5337.439568845215 08:30:16 INFO - PROCESS | 1662 | |4;prototype.html;325.84522351882873;361.9095226193452;362.17785626627557;373.29819938515584;377.8299765105703;5131.486851314867;5179.2749015137915;5498.285222921019;5566.721663916808;5616.185653080306;4540.636749060075;4699.143838183915;5378.8533707781;5417.6207665463435;5485.862853428666;3537.4163263061564;4265.8080386382535;4273;4286.863981045026;4303.311470164775;4163.188178305231;4265.914681706364;4300.591443812833;4300.763458009808;4310.80601372939;4189.455370801791;4198.748075115487;4204.537500874917;4215.536291007987;4274.700770946035;4150.792460376984;4214.409982602423;4223;4261.190373828963;4266.5946735060115;3560.928781424383;3761.8307176177136;3766.4915236443276;3785.6592906638534;3788.6400791924725;4584.716279441728;5032.622553308516;5070.949290507085;5075.695458272478;5302.295829127134;4749.4063242094735;4905.321009243068;4913.484084171147;4913.729744864031;4919.262110683426;5034.572061374787;5797.88404231913;5799.739011744439;5814.796482123148;5821.330546987108;3627.764195327295;3833.584841549806;3896.3960586109197;3911.4523966644692;3921.4313924481075;5653.925754106706;5716.828495145152;5809.854753631151;5838.4453476919625;6064.241969753781;3452.37857185709;3508.7719298245534;3775.112848480605;3943.6985794687685;3967.7024223183375;3247.107045562489;3874.082329247041;3906.5045868841844;3921;3958.366661334173;4656.138614356355;4656.41794775653;4666.766661666903;4675.812967481331;4714.95285047152;5092.810091660547;5788.334341550775;5793;5817.534597232211;5826.563007774434;1049.8504137968912;1201.7656556971306;1273.1024627637494;1293.3468598357956;1300.2523548959198;764.6809254036742;815.3558688635911;865.3985480091402;869.9782505437415;880.3617377401333;4250.298700714347;4525.366448697185;4793.281007848851;4891.413030436299;5118.314813334393;4651.325557794101;5021.895183059721;5332.120200166929;5656.434356564393;5709.058919967231;4467.508574056851;4659.7866013643925;4661.813527458931;4758.432633818441;4862.294967229732;2376.9422606939747;2595.351951510804;2775.930601734932;2923.912282631482;2939.5002849515636;4864.030067822538;4905.7301848397965;5439.531326541891;5602.935442265956;5858.912116318259;4456.857915169798;4910.8281210157475;5735.512481439041;5777.913331300034;5877.9118313225335;5067.645264831426;5405.70268635221;5454.4545545445135;5848.912266316009;5947.345791962967;5078.593712502917;5518.565173054954;5590.301212348457;5647.435256474319;5664.518515926027;4609.446866375923;5177.844664660066;5308.867278317918;5486.835394938158;5537.6954267515675;4933.309336692794;5278.815241466684;5619.971900140473;5687.744051517774;5827.358990510956;3704.296023829069;3729.68297694699;3741.017260851753;3744.4196149596855;3753.512043434336;4547.886302842456;5552.000639884698;5620.690862002465;5622.257100298921;5646.237757902631;5463.207834864002;5560.582956278215;5623.437656234344;5702.572307076903;5717.456841600041;4719.480857105647;5691.402402747652;5705.288413475858;5705.4579814917515;5711.000574899293;4527;5255.448177941414;5319.813806516908;5517.586181036358;5589.636673616202;4554.88612784683;4746.5490778376;5641.8589535261945;5704.657720536781;5704.828855134353;5578.967890940189;5584.073494644341;5596.440355964371;5616.410276921028;5618.101103823368 08:30:16 INFO - PROCESS | 1662 | |5;yui.html;700.7477308169061;745.9104907411112;751.8270797716525;801.9839603207936;839.1021606880637;14493.275336233199;15473.071615703038;15647.84352156478;15672.608184795386;15686.76469852953;14208.857911420882;14364.569062928103;14371.71256574868;14380.209088500129;14392.424303027892;658.2890478283442;688.6246995387526;820.5733018830205;857.9699710510133;869;712.8823744082246;868.374770165483;868.7524055644143;871.4945331707626;879.4679219072465;915.9175674189322;927.3045216087934;927.5223260021095;931.0828833598899;931.8555623878276;911.7036962987023;917.2707697380565;923.6767131503954;924.1359329027381;925.3152667026419;588.3116753398534;658.5653468710628;687.8933765266391;689.8413364926045;690.8307464671187;15117.622059448491;15354.692906141927;15356.692866142726;15765.448209312734;16053.197340132947;14639.268036598127;14801.40794368224;14838.777418338734;14889;14926.179060151688;11614.70963225926;12082.516699332016;12110.81833772494;12121.93939030308;12499.750004999849;3349.2129349602824;3714.7956862372557;3772.6981841452616;3795.4686343911876;3803.1721346612017;100866.49566752193;104664.95335046628;105941;108536;108934;10611.787764244671;10983.286086404358;11098.223124381217;11252;11614.477348519167;21662.675059874113;21844.89077554602;22090.226842060452;22437.43906402353;22447.77552224457;7890.487118337404;7978.960105199437;8002.119766825645;8014.318782903402;8066.274035336731;4382.583654552813;4388.71473354231;4418.7127836690515;4421.447319085114;4444.155610434007;3602.765820221677;3673.522442082512;3685.5577330720484;3692.5568931728367;3711.5731690855896;626.6052386996255;670.8356452669127;677.3362105136994;677.3971165662564;686.2348481443155;683.2484267305924;684.9315068493079;702.7259368846154;708.3766285668579;728.7340120855849;9688.224942004763;10608.57565697379;10657.721073471233;10731.83902241467;10822.945885270681;702.6978399288355;723.8298999735058;728.4427413029038;728.5628622826262;741.6884908338511;5177.456367081402;5223.425423203445;5226.634135610547;5231.869203269873;5245.6852588844795;79524.60237698775;105286.47356763168;107349;109003;110339;78979.60510197528;80977.59511202406;87450.56274718713;88669;96714.64784084733;49587.752061240186;60343.39656603466;75850;80663.59668201621;81879;10950.616728414467;11145.888541114486;11186.944065279622;11583.884161158281;11656.708582285512;49363.50636493589;50480;51019.23471147862;51251.97496050133;52912.941741165734;60961.695191525534;70297.29702702907;71532;71584.64207678929;74711.62644186744;13333.599992000256;13370.598882033555;13452.798208027083;13493.730125397633;13500.392482338122;14050.367733452224;14415.567532973608;14793.852061479247;15255;15295.464658736892;13593.86406135926;13959.162450252612;14057.648558786112;14491.565253042425;14674.266286685837;12358.887700107034;12459.563915262923;13769.655758605715;14037.298135093;14502.637434064232;13389.66525836862;13813.24027178515;13888.652783680489;14328.856711433169;14358.784618230944;10643.680689579325;11109.555757751765;11240.084255815087;11398.829017564909;11900.940495297467;10250.436226007343;11143.33140011602;11392.658220253406;11422.771544569228;11436.370999595103 08:30:16 INFO - PROCESS | 1662 | __end_tp_report 08:30:16 INFO - PROCESS | 1662 | __start_cc_report 08:30:16 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,376 08:30:16 INFO - PROCESS | 1662 | __end_cc_report 08:30:16 INFO - PROCESS | 1662 | __startTimestamp1485621016672__endTimestamp 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | ------- Summary: start ------- 08:30:16 INFO - PROCESS | 1662 | Number of tests: 6 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5800.18 Median:6064.97 stddev:667.78 (11.0%) stddev-sans-first:624.73 08:30:16 INFO - PROCESS | 1662 | Values: 2725.0 3393.7 3402.2 3405.7 3426.1 4361.9 5723.2 5741.4 5760.8 5873.5 5199.3 5497.1 5835.8 5888.1 5928.7 5281.9 5307.1 5308.4 5375.5 5376.4 5384.4 5395.9 5398.3 5399.0 5406.4 5387.5 5393.6 5394.2 5395.4 5455.9 5237.0 5246.8 5295.5 5325.1 5367.5 5255.1 5334.1 5390.4 5390.8 5396.7 5948.1 6023.1 6028.2 6028.5 6047.8 6182.8 6227.3 6240.0 6289.9 6332.6 6181.7 6200.9 6238.0 6283.8 6295.8 6025.6 6026.4 6028.1 6043.7 6091.3 5960.8 6127.9 6145.5 6350.5 6399.4 6139.9 6144.9 6173.9 6206.8 6305.2 4674.9 6222.9 6294.1 6335.2 6338.4 6245.7 6272.1 6309.7 6310.2 6311.9 6119.1 6149.7 6172.1 6202.3 6273.2 5069.1 5095.3 5110.6 5115.6 5135.2 4562.5 4571.9 4583.5 4585.8 4597.7 4896.9 5907.2 5918.1 5990.0 6027.1 6285.7 6299.6 6303.5 6318.8 6319.5 5856.4 6007.8 6023.4 6043.4 6050.4 5515.0 5564.5 5582.2 5601.1 5667.0 6431.1 6432.6 6475.6 6475.8 6487.1 6317.4 6322.9 6328.7 6329.3 6331.4 6245.3 6295.9 6303.7 6336.5 6358.9 5172.7 5467.6 6130.7 6276.0 6316.2 6242.7 6265.4 6265.9 6293.7 6297.1 6113.9 6138.1 6152.0 6156.2 6244.3 6181.4 6249.7 6255.5 6278.2 6301.2 4782.4 5505.8 5841.4 6207.5 6249.7 6065.0 6144.3 6162.7 6242.1 6258.3 5004.3 6149.1 6170.6 6170.9 6188.3 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:70141.60 Median:38552.52 stddev:150224.47 (389.7%) stddev-sans-first:150554.76 08:30:16 INFO - PROCESS | 1662 | Values: 448.0 453.9 458.9 499.4 521.8 38590.6 42496.6 42628.0 42720.6 42749.9 43722.0 44217.8 44222.9 44245.7 44247.8 8412.4 9269.2 9479.5 9493.6 9508.7 8423.8 11237.2 11523.0 11526.5 11726.8 11350.2 11365.9 11382.2 11394.0 11397.5 11376.5 11438.3 11446.8 11454.4 11476.6 11306.9 11365.8 11371.8 11397.4 11439.0 40539.0 40807.4 40977.8 41167.6 41219.4 4022.8 4098.1 4101.2 4155.8 4247.1 30249.0 31040.8 31087.0 31094.7 31536.2 3177.0 3202.2 3309.8 3313.2 3331.0 481305.0 482863.0 483188.0 485037.0 485413.0 62176.4 62198.2 62428.0 62625.5 62636.1 59011.1 62068.7 64368.4 65110.0 65295.0 16322.6 16473.0 16817.3 16830.3 16875.9 11626.7 11948.4 12638.4 13083.1 13242.2 13352.5 16013.5 16124.9 16179.4 16227.8 7403.6 7454.1 7495.1 7531.7 7554.3 887.5 895.5 900.7 911.9 926.4 30563.0 31047.5 31089.1 31098.8 31630.7 1056.8 1090.8 1106.2 1119.9 1244.9 11163.8 16188.8 16750.8 17070.2 17139.7 628255.0 632535.0 632637.0 633978.0 634355.0 58070.0 58220.7 58543.7 58594.0 58605.7 1448.1 1448.4 1461.2 1480.7 1488.6 29881.0 31155.4 31459.8 31815.0 31844.8 43408.3 49267.3 49707.3 49804.3 49927.3 558945.0 562502.0 565174.0 565346.0 567163.0 34081.0 35071.9 37791.6 38020.6 40700.0 46549.3 46617.1 46833.0 47435.8 48336.0 38224.6 38294.6 39311.6 39401.0 39952.4 38078.0 38247.8 38514.4 38844.6 39332.6 38110.9 38146.9 38450.6 38594.0 38639.6 27192.0 34226.8 34668.0 34878.0 34965.5 25296.6 25455.5 25674.4 25800.9 25962.5 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:43477.21 Median:2172.44 stddev:129600.81 (5965.7%) stddev-sans-first:129924.00 08:30:16 INFO - PROCESS | 1662 | Values: 398.1 398.9 403.2 409.0 425.9 19886.0 20209.6 20911.7 21170.9 21223.6 11945.0 12223.3 18639.9 21362.4 21624.5 5304.9 5639.3 6131.8 6180.4 6199.0 3954.9 6066.5 6174.3 6176.4 6187.1 5618.9 5676.1 5750.8 6123.0 6142.7 6057.5 6095.0 6141.4 6161.8 6167.4 6051.6 6070.5 6072.8 6076.8 6088.8 11069.2 13593.5 23449.9 23779.6 24759.4 2631.5 2741.2 2770.5 2900.4 3017.9 10433.4 16225.0 17270.3 17345.7 18309.5 1710.8 1726.8 1993.8 2003.7 2087.7 147902.8 154746.0 178088.0 180512.0 181372.0 24714.5 24883.4 25064.0 25073.7 25308.0 37628.0 42410.6 42461.2 43074.8 43649.1 6690.6 7322.7 8401.3 8617.8 8911.0 8660.2 8668.9 8674.2 8771.5 8806.5 4075.0 4803.3 4817.3 4830.7 4893.8 2054.8 2103.3 2104.2 2104.9 2106.8 386.5 389.9 401.6 404.7 414.2 11889.8 12088.5 12124.8 12330.3 12442.4 423.5 431.0 437.6 874.2 952.6 6761.6 6868.9 6937.7 6976.8 6988.0 757053.0 759522.0 769744.0 783916.0 789954.0 160626.0 161145.2 162086.0 164982.0 167286.0 1058.4 1073.7 1097.0 1101.4 1103.9 11987.0 12235.8 12387.3 12526.1 12529.2 61098.0 62013.0 62158.7 62772.7 63265.1 91380.5 91441.0 94067.0 94848.1 95147.5 8049.6 8082.8 8417.3 8498.4 8725.9 11997.0 12895.7 12945.4 13166.3 13332.7 11071.7 11241.8 11287.6 11440.2 11486.7 10505.5 10981.9 11248.9 11340.8 11479.9 11358.1 11359.6 11508.8 11661.9 11782.4 8315.2 8412.1 8429.5 8534.9 8571.1 8722.9 9994.0 10960.6 11013.7 11278.7 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5574.25 Median:5218.99 stddev:3032.57 (58.1%) stddev-sans-first:3023.19 08:30:16 INFO - PROCESS | 1662 | Values: 1193.3 1244.7 1370.7 1416.9 1458.9 7510.7 7561.7 7878.8 8282.8 8740.3 8132.3 8309.6 8400.7 8521.0 8526.7 2282.5 2313.8 2319.2 2325.4 2336.5 2106.1 2168.3 2336.5 2365.0 2382.0 2272.8 2349.8 2356.2 2356.6 2357.6 2337.0 2339.8 2350.9 2354.4 2357.4 2320.7 2338.4 2387.3 2395.5 2403.1 8627.6 8662.5 8705.7 8725.8 8731.0 5199.9 5330.7 5376.3 5376.4 5386.8 3276.7 3424.9 3589.2 3633.2 3659.1 1215.7 1226.2 1253.5 1273.1 1273.2 11060.4 11214.8 11225.2 11238.8 11252.1 4619.4 4825.6 4862.4 4869.9 4887.0 9668.1 9823.7 9846.7 9864.2 9875.2 5238.1 5297.0 5336.9 5369.3 5378.3 4626.5 4833.8 4842.3 4901.5 4910.2 3914.5 3984.5 4013.7 4090.0 4096.7 1055.8 1178.3 1216.1 1298.1 1299.9 926.2 928.8 931.6 939.5 952.3 5678.5 5684.7 5829.5 6025.2 6033.2 967.7 1008.7 1009.8 1013.8 1044.2 3892.8 3961.5 4007.5 4033.0 4053.6 9988.2 10196.8 10204.0 10345.3 10355.2 9757.4 10154.4 10160.7 10161.8 10175.3 7818.2 8142.4 8150.9 8155.9 8173.4 5859.1 5862.0 5866.7 5937.0 6007.9 8069.2 9410.3 9479.0 9564.4 9598.3 9361.9 9536.5 9607.5 9810.0 9859.3 7301.9 7451.0 7462.2 7462.6 7476.4 7985.6 7999.2 8021.3 8087.1 8135.5 6554.8 7232.8 7324.7 7367.0 7421.6 6173.3 7185.7 7246.3 7259.4 7265.4 6370.4 6521.8 6538.5 6586.0 6601.4 4976.1 5091.8 5155.1 5169.5 5180.9 4516.8 5082.9 5153.7 5253.0 5337.4 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4520.35 Median:4913.61 stddev:1369.88 (27.9%) stddev-sans-first:1337.05 08:30:16 INFO - PROCESS | 1662 | Values: 325.8 361.9 362.2 373.3 377.8 5131.5 5179.3 5498.3 5566.7 5616.2 4540.6 4699.1 5378.9 5417.6 5485.9 3537.4 4265.8 4273.0 4286.9 4303.3 4163.2 4265.9 4300.6 4300.8 4310.8 4189.5 4198.7 4204.5 4215.5 4274.7 4150.8 4214.4 4223.0 4261.2 4266.6 3560.9 3761.8 3766.5 3785.7 3788.6 4584.7 5032.6 5070.9 5075.7 5302.3 4749.4 4905.3 4913.5 4913.7 4919.3 5034.6 5797.9 5799.7 5814.8 5821.3 3627.8 3833.6 3896.4 3911.5 3921.4 5653.9 5716.8 5809.9 5838.4 6064.2 3452.4 3508.8 3775.1 3943.7 3967.7 3247.1 3874.1 3906.5 3921.0 3958.4 4656.1 4656.4 4666.8 4675.8 4715.0 5092.8 5788.3 5793.0 5817.5 5826.6 1049.9 1201.8 1273.1 1293.3 1300.3 764.7 815.4 865.4 870.0 880.4 4250.3 4525.4 4793.3 4891.4 5118.3 4651.3 5021.9 5332.1 5656.4 5709.1 4467.5 4659.8 4661.8 4758.4 4862.3 2376.9 2595.4 2775.9 2923.9 2939.5 4864.0 4905.7 5439.5 5602.9 5858.9 4456.9 4910.8 5735.5 5777.9 5877.9 5067.6 5405.7 5454.5 5848.9 5947.3 5078.6 5518.6 5590.3 5647.4 5664.5 4609.4 5177.8 5308.9 5486.8 5537.7 4933.3 5278.8 5620.0 5687.7 5827.4 3704.3 3729.7 3741.0 3744.4 3753.5 4547.9 5552.0 5620.7 5622.3 5646.2 5463.2 5560.6 5623.4 5702.6 5717.5 4719.5 5691.4 5705.3 5705.5 5711.0 4527.0 5255.4 5319.8 5517.6 5589.6 4554.9 4746.5 5641.9 5704.7 5704.8 5579.0 5584.1 5596.4 5616.4 5618.1 08:30:16 INFO - PROCESS | 1662 | 08:30:16 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:20455.94 Median:3679.54 stddev:28970.59 (787.3%) stddev-sans-first:29013.88 08:30:16 INFO - PROCESS | 1662 | Values: 700.7 745.9 751.8 802.0 839.1 14493.3 15473.1 15647.8 15672.6 15686.8 14208.9 14364.6 14371.7 14380.2 14392.4 658.3 688.6 820.6 858.0 869.0 712.9 868.4 868.8 871.5 879.5 915.9 927.3 927.5 931.1 931.9 911.7 917.3 923.7 924.1 925.3 588.3 658.6 687.9 689.8 690.8 15117.6 15354.7 15356.7 15765.4 16053.2 14639.3 14801.4 14838.8 14889.0 14926.2 11614.7 12082.5 12110.8 12121.9 12499.8 3349.2 3714.8 3772.7 3795.5 3803.2 100866.5 104665.0 105941.0 108536.0 108934.0 10611.8 10983.3 11098.2 11252.0 11614.5 21662.7 21844.9 22090.2 22437.4 22447.8 7890.5 7979.0 8002.1 8014.3 8066.3 4382.6 4388.7 4418.7 4421.4 4444.2 3602.8 3673.5 3685.6 3692.6 3711.6 626.6 670.8 677.3 677.4 686.2 683.2 684.9 702.7 708.4 728.7 9688.2 10608.6 10657.7 10731.8 10822.9 702.7 723.8 728.4 728.6 741.7 5177.5 5223.4 5226.6 5231.9 5245.7 79524.6 105286.5 107349.0 109003.0 110339.0 78979.6 80977.6 87450.6 88669.0 96714.6 49587.8 60343.4 75850.0 80663.6 81879.0 10950.6 11145.9 11186.9 11583.9 11656.7 49363.5 50480.0 51019.2 51252.0 52912.9 60961.7 70297.3 71532.0 71584.6 74711.6 13333.6 13370.6 13452.8 13493.7 13500.4 14050.4 14415.6 14793.9 15255.0 15295.5 13593.9 13959.2 14057.6 14491.6 14674.3 12358.9 12459.6 13769.7 14037.3 14502.6 13389.7 13813.2 13888.7 14328.9 14358.8 10643.7 11109.6 11240.1 11398.8 11900.9 10250.4 11143.3 11392.7 11422.8 11436.4 08:30:16 INFO - PROCESS | 1662 | -------- Summary: end -------- 08:30:16 INFO - PROCESS | 1662 | 08:30:17 INFO - TEST-INFO | 1662: exit 0 08:30:17 INFO - TEST-OK | dromaeo_css | took 1114925ms 08:30:17 INFO - TEST-START | kraken 08:30:17 INFO - operating with platform_type : mac_ 08:30:17 INFO - Initialising browser for kraken test... 08:30:17 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpVoVU1U/profile http://localhost:49246/getInfo.html) 08:30:19 INFO - PROCESS | 1670 | 2017-01-28 08:30:19.935 plugin-container[1671:11739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 08:30:19 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:30:19 INFO - PROCESS | 1670 | 2017-01-28 08:30:19.938 plugin-container[1671:11739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 08:30:19 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:30:19 INFO - PROCESS | 1670 | 2017-01-28 08:30:19.938 plugin-container[1671:11739] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:30:20 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 08:30:20 INFO - PROCESS | 1670 | colorDepth:24 08:30:20 INFO - PROCESS | 1670 | Browser inner width/height: 1024/663 08:30:20 INFO - PROCESS | 1670 | __metrics 08:30:20 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:30:20 INFO - TEST-INFO | 1670: exit 0 08:30:20 INFO - Browser initialized. 08:30:20 INFO - Running cycle 1/1 for kraken test... 08:30:20 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpVoVU1U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:23 INFO - PROCESS | 1672 | 2017-01-28 08:30:23.394 plugin-container[1673:11861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 08:30:23 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:30:23 INFO - PROCESS | 1672 | 2017-01-28 08:30:23.394 plugin-container[1673:11861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:30:23 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:30:23 INFO - PROCESS | 1672 | 2017-01-28 08:30:23.394 plugin-container[1673:11861] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:30:33 INFO - PROCESS | 1672 | RSS: Main: 228339712 08:30:33 INFO - PROCESS | 1672 | 08:30:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:37 INFO - PROCESS | 1672 | RSS: Main: 240291840 08:30:37 INFO - PROCESS | 1672 | 08:30:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 08:30:40 INFO - PROCESS | 1672 | RSS: Main: 248492032 08:30:40 INFO - PROCESS | 1672 | 08:30:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 08:30:44 INFO - PROCESS | 1672 | RSS: Main: 249028608 08:30:44 INFO - PROCESS | 1672 | 08:30:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 08:30:47 INFO - PROCESS | 1672 | RSS: Main: 250019840 08:30:47 INFO - PROCESS | 1672 | 08:30:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:49 INFO - PROCESS | 1672 | RSS: Main: 250036224 08:30:49 INFO - PROCESS | 1672 | 08:30:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:52 INFO - PROCESS | 1672 | RSS: Main: 253743104 08:30:52 INFO - PROCESS | 1672 | 08:30:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:56 INFO - PROCESS | 1672 | RSS: Main: 253071360 08:30:56 INFO - PROCESS | 1672 | 08:30:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 08:31:00 INFO - PROCESS | 1672 | RSS: Main: 253222912 08:31:00 INFO - PROCESS | 1672 | 08:31:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:02 INFO - PROCESS | 1672 | RSS: Main: 252715008 08:31:02 INFO - PROCESS | 1672 | 08:31:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:05 INFO - PROCESS | 1672 | RSS: Main: 252751872 08:31:05 INFO - PROCESS | 1672 | 08:31:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:08 INFO - PROCESS | 1672 | RSS: Main: 252760064 08:31:08 INFO - PROCESS | 1672 | 08:31:10 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:11 INFO - PROCESS | 1672 | RSS: Main: 253120512 08:31:11 INFO - PROCESS | 1672 | 08:31:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:15 INFO - PROCESS | 1672 | RSS: Main: 253165568 08:31:15 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 08:31:17 INFO - PROCESS | 1672 | RSS: Main: 254828544 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | __start_tp_report 08:31:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 08:31:17 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 08:31:17 INFO - PROCESS | 1672 | |i|pagename|runs| 08:31:17 INFO - PROCESS | 1672 | |0;ai-astar;113;165;122;120;120;122;132;176;162;120 08:31:17 INFO - PROCESS | 1672 | |1;audio-beat-detection;136;110;114;180;97;99;119;144;162;140 08:31:17 INFO - PROCESS | 1672 | |2;audio-dft;199;195;182;201;196;194;200;236;286;198 08:31:17 INFO - PROCESS | 1672 | |3;audio-fft;81;62;60;88;61;59;58;61;71;60 08:31:17 INFO - PROCESS | 1672 | |4;audio-oscillator;84;71;76;68;68;72;80;70;64;80 08:31:17 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;90;88;89;88;90;87;91;87;89;86 08:31:17 INFO - PROCESS | 1672 | |6;imaging-darkroom;124;155;97;119;118;95;96;103;155;153 08:31:17 INFO - PROCESS | 1672 | |7;imaging-desaturate;93;97;127;145;148;90;93;91;109;143 08:31:17 INFO - PROCESS | 1672 | |8;json-parse-financial;59;61;61;63;63;63;62;63;64;63 08:31:17 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;73;70;76;79;79;71;72;70;107;115 08:31:17 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;82;85;85;87;84;87;85;87;87;91 08:31:17 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;150;152;136;137;137;143;161;152;189;154 08:31:17 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;171;170;168;163;169;169;166;168;168;169 08:31:17 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;66;66;68;75;87;87;87;88;92 08:31:17 INFO - PROCESS | 1672 | __end_tp_report 08:31:17 INFO - PROCESS | 1672 | __start_cc_report 08:31:17 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,937 08:31:17 INFO - PROCESS | 1672 | __end_cc_report 08:31:17 INFO - PROCESS | 1672 | __startTimestamp1485621077308__endTimestamp 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | ------- Summary: start ------- 08:31:17 INFO - PROCESS | 1672 | Number of tests: 14 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:135.20 Median:127.00 stddev:23.13 (18.2%) stddev-sans-first:23.10 08:31:17 INFO - PROCESS | 1672 | Values: 113.0 165.0 122.0 120.0 120.0 122.0 132.0 176.0 162.0 120.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:153.00 stddev:27.25 (17.8%) stddev-sans-first:28.82 08:31:17 INFO - PROCESS | 1672 | Values: 136.0 110.0 114.0 180.0 97.0 99.0 119.0 144.0 162.0 140.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:208.70 Median:199.50 stddev:30.45 (15.3%) stddev-sans-first:32.09 08:31:17 INFO - PROCESS | 1672 | Values: 199.0 195.0 182.0 201.0 196.0 194.0 200.0 236.0 286.0 198.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.50 stddev:10.46 (17.0%) stddev-sans-first:9.61 08:31:17 INFO - PROCESS | 1672 | Values: 81.0 62.0 60.0 88.0 61.0 59.0 58.0 61.0 71.0 60.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:73.30 Median:74.00 stddev:6.43 (8.7%) stddev-sans-first:5.53 08:31:17 INFO - PROCESS | 1672 | Values: 84.0 71.0 76.0 68.0 68.0 72.0 80.0 70.0 64.0 80.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:1.58 (1.8%) stddev-sans-first:1.58 08:31:17 INFO - PROCESS | 1672 | Values: 90.0 88.0 89.0 88.0 90.0 87.0 91.0 87.0 89.0 86.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:121.50 Median:155.00 stddev:24.85 (16.0%) stddev-sans-first:26.34 08:31:17 INFO - PROCESS | 1672 | Values: 124.0 155.0 97.0 119.0 118.0 95.0 96.0 103.0 155.0 153.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:113.60 Median:90.50 stddev:24.55 (27.1%) stddev-sans-first:24.89 08:31:17 INFO - PROCESS | 1672 | Values: 93.0 97.0 127.0 145.0 148.0 90.0 93.0 91.0 109.0 143.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.01 08:31:17 INFO - PROCESS | 1672 | Values: 59.0 61.0 61.0 63.0 63.0 63.0 62.0 63.0 64.0 63.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:72.50 stddev:16.16 (22.3%) stddev-sans-first:16.87 08:31:17 INFO - PROCESS | 1672 | Values: 73.0 70.0 76.0 79.0 79.0 71.0 72.0 70.0 107.0 115.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:87.00 stddev:2.40 (2.8%) stddev-sans-first:2.07 08:31:17 INFO - PROCESS | 1672 | Values: 82.0 85.0 85.0 87.0 84.0 87.0 85.0 87.0 87.0 91.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:152.00 stddev:15.77 (10.4%) stddev-sans-first:16.72 08:31:17 INFO - PROCESS | 1672 | Values: 150.0 152.0 136.0 137.0 137.0 143.0 161.0 152.0 189.0 154.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:169.00 stddev:2.23 (1.3%) stddev-sans-first:2.11 08:31:17 INFO - PROCESS | 1672 | Values: 171.0 170.0 168.0 163.0 169.0 169.0 166.0 168.0 168.0 169.0 08:31:17 INFO - PROCESS | 1672 | 08:31:17 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:87.00 stddev:10.72 (12.3%) stddev-sans-first:10.69 08:31:17 INFO - PROCESS | 1672 | Values: 68.0 66.0 66.0 68.0 75.0 87.0 87.0 87.0 88.0 92.0 08:31:17 INFO - PROCESS | 1672 | -------- Summary: end -------- 08:31:17 INFO - PROCESS | 1672 | 08:31:18 INFO - TEST-INFO | 1672: exit 0 08:31:18 INFO - TEST-OK | kraken | took 60897ms 08:31:18 INFO - SUITE-END | took 1175s 08:31:18 INFO - Completed test suite (00:19:36) 08:31:18 INFO - javascript benchmark 08:31:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.795763254638, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2724.9727502724973, 3393.7115345195657, 3402.217489977306, 3405.744569157314, 3426.0749597608633, 4361.912761744763, 5723.198752174693, 5741.36844947056, 5760.827175184746, 5873.500752436037, 5199.324087868572, 5497.147942068976, 5835.766569337232, 5888.116782482619, 5928.733207005685, 5281.947180528194, 5307.071262529062, 5308.416074231832, 5375.516203541681, 5376.4085950545405, 5384.40771515133, 5395.919061214085, 5398.325209348832, 5398.973005134989, 5406.405295417501, 5387.4612538746005, 5393.633012685359, 5394.217838413448, 5395.379531353886, 5455.945440545604, 5237.031149237403, 5246.7901283948595, 5295.4969277918535, 5325.1479763238085, 5367.490088441592, 5255.1329030709885, 5334.146536554172, 5390.407055223922, 5390.7870729086035, 5396.703181325026, 5948.078047902539, 6023.096535519707, 6028.1861948636815, 6028.457438830483, 6047.788327408563, 6182.783602573888, 6227.346128656471, 6240.0, 6289.8742025159245, 6332.556721029529, 6181.721822517998, 6200.87598248037, 6237.968810155966, 6283.8114856554375, 6295.811125666238, 6025.638461692312, 6026.427489388501, 6028.09578563219, 6043.697815109227, 6091.269047714302, 5960.807838432244, 6127.938720612737, 6145.494353883238, 6350.491960643138, 6399.424051835357, 6139.890808645427, 6144.880016394337, 6173.876522469525, 6206.813795586139, 6305.243370795534, 4674.883127921829, 6222.875542489215, 6294.087357333161, 6335.176427064452, 6338.397852204033, 6245.718942647592, 6272.059191121369, 6309.747610095545, 6310.242770867433, 6311.905321420182, 6119.07606531266, 6149.661768602769, 6172.105044768573, 6202.309625772658, 6273.247210334789, 5069.087564238473, 5095.312132862016, 5110.642255042111, 5115.565176959925, 5135.152699804565, 4562.475315338778, 4571.862844114682, 4583.495815460296, 4585.839495617637, 4597.747123908217, 4896.926546101811, 5907.172995780594, 5918.082697181943, 5990.011648078018, 6027.126066720389, 6285.685715714196, 6299.590526615755, 6303.495720342362, 6318.810435686937, 6319.526035547352, 5856.4143585641095, 6007.789727359522, 6023.427774361428, 6043.395660434009, 6050.42520960508, 5515.034868897927, 5564.527015203753, 5582.190582365615, 5601.103823388238, 5667.0, 6431.099646049651, 6432.614043157426, 6475.579087359307, 6475.7733479328, 6487.124238227968, 6317.368263173646, 6322.905156422566, 6328.746850125944, 6329.30377658448, 6331.398517140864, 6245.250569931455, 6295.905561416491, 6303.684815759286, 6336.524760642878, 6358.872822543616, 5172.689638621695, 5467.644603100785, 6130.7241174146375, 6276.0, 6316.178896743394, 6242.719077641426, 6265.436110749872, 6265.906011409924, 6293.748250070129, 6297.118403423616, 6113.932424433873, 6138.140660307471, 6151.96924015377, 6156.168917196122, 6244.344343843831, 6181.381861813783, 6249.718762655601, 6255.499560035095, 6278.15244941927, 6301.212348456443, 4782.378290822171, 5505.752241149078, 5841.415858414294, 6207.534434917489, 6249.7187626557825, 6064.969675151596, 6144.310314663503, 6162.722677479614, 6242.094896240111, 6258.311585725475, 5004.299398084198, 6149.108379285068, 6170.568060235741, 6170.876582468415, 6188.319284878749], "value": 5759.199394527911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.0, 453.8547664747282, 458.93755954964274, 499.3508439029262, 521.8147557617045, 38590.614093859054, 42496.57503424965, 42628.0, 42720.57279427205, 42749.93125171872, 43722.0, 44217.77891110548, 44222.89442763932, 44245.67262982108, 44247.77876110615, 8412.411131220786, 9269.165775080224, 9479.47862867542, 9493.572789224501, 9508.667196648119, 8423.789405264855, 11237.157213209, 11523.020543253791, 11526.481308341145, 11726.824097638542, 11350.205485615968, 11365.943170284138, 11382.2032457728, 11394.0, 11397.544098236101, 11376.488058037408, 11438.25651332669, 11446.771064578745, 11454.370009649467, 11476.598319058834, 11306.886931130748, 11365.772684546346, 11371.829422558669, 11397.430128493543, 11439.0, 40539.0, 40807.387889181686, 40977.77066688004, 41167.58832411697, 41219.38170927409, 4022.7988600570147, 4098.139390727951, 4101.200265948141, 4155.833766649331, 4247.086876321606, 30249.0, 31040.8447957761, 31087.0, 31094.689053109632, 31536.211594710087, 3176.9501278772404, 3202.151429871086, 3309.834508274577, 3313.188268874117, 3331.034000139981, 481305.0, 482863.0, 483188.0, 485037.0, 485413.0, 62176.37823621796, 62198.20108095147, 62428.0, 62625.49498020119, 62636.06045909315, 59011.114833277534, 62068.689656552335, 64368.356316436235, 65110.0, 65295.04114876562, 16322.591935201477, 16473.01161930288, 16817.327306907588, 16830.326786928632, 16875.91562042182, 11626.651200463999, 11948.402579870972, 12638.368081595883, 13083.149595276276, 13242.20546767197, 13352.53122156562, 16013.519594412186, 16124.919375403048, 16179.352825886832, 16227.83772162287, 7403.629818509053, 7454.068241469817, 7495.138059123162, 7531.736389226351, 7554.2823431773895, 887.4896934262824, 895.4895709445553, 900.7342833864026, 911.8723378726984, 926.4256161179977, 30563.0, 31047.534286985712, 31089.067327980196, 31098.84450577778, 31630.683693163235, 1056.7886422715487, 1090.8145615245428, 1106.2201148190507, 1119.8768135505088, 1244.9190802597984, 11163.776724465628, 16188.757168642243, 16750.83249167517, 17070.23183956725, 17139.657206855794, 628255.0, 632535.0, 632637.0, 633978.0, 634355.0, 58070.0, 58220.708896455246, 58543.70728146332, 58594.0, 58605.70697146487, 1448.0732331307972, 1448.4474888113089, 1461.2328527523136, 1480.659448326891, 1488.6352843553182, 29881.0, 31155.37689246248, 31459.842700787267, 31815.0, 31844.840775795972, 43408.34887476627, 49267.26099108588, 49707.254391184884, 49804.25293620526, 49927.25109123293, 558945.0, 562502.0, 565174.0, 565346.0, 567163.0, 34081.0, 35071.9478415648, 37791.62208377991, 38020.61979380171, 40699.98250043773, 46549.30176047294, 46617.06765864731, 46833.0, 47435.76282118567, 48336.0, 38224.61775382211, 38294.617053829104, 39311.60688393194, 39401.0, 39952.4007139899, 38078.0, 38247.80876095713, 38514.422283665204, 38844.6115538841, 39332.606673932896, 38110.856674299815, 38146.85559433221, 38450.61549384471, 38594.0, 38639.6136038636, 27192.048278310165, 34226.82886585551, 34667.9599612012, 34877.9536613902, 34965.47551786674, 25296.62055069212, 25455.49089018172, 25674.358141046625, 25800.870995644902, 25962.480750385264], "value": 20617.235771451455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.0744768413439, 398.91024519483136, 403.17349433661025, 408.9611486908744, 425.9275923093074, 19886.0, 20209.595808083828, 20911.68632470514, 21170.94145292737, 21223.57552848944, 11945.0, 12223.266604003744, 18639.90680046598, 21362.359129226108, 21624.459388515294, 5304.9204261936, 5639.295088113986, 6131.846703832395, 6180.351063138373, 6199.0, 3954.9406758898494, 6066.484348830355, 6174.320824709278, 6176.413240742122, 6187.102870083835, 5618.876224755045, 5676.091825307952, 5750.769969201227, 6123.0, 6142.744345496893, 6057.454829065406, 6095.024796032636, 6141.385861413867, 6161.845953851145, 6167.444929956303, 6051.606645568024, 6070.453659170652, 6072.848178795522, 6076.848078798022, 6088.817335479943, 11069.225154239206, 13593.52422665202, 23449.88275058631, 23779.643305350262, 24759.381015474577, 2631.4868600622885, 2741.150243424525, 2770.515159847019, 2900.390917907242, 3017.909462716122, 10433.35183569902, 16225.026498410132, 17270.30918763248, 17345.739813902674, 18309.45071647853, 1710.811810700822, 1726.7668864703355, 1993.800619938009, 2003.6693945498976, 2087.7077209190725, 147902.78145827822, 154746.0, 178088.0, 180511.9999999987, 181372.0, 24714.50570988606, 24883.391908173213, 25064.0, 25073.749262507143, 25308.0, 37628.0, 42410.57589424066, 42461.15077698429, 43074.78462607667, 43649.127017459476, 6690.565113267719, 7322.707091716272, 8401.285890699237, 8617.78455538604, 8911.0, 8660.17728315809, 8668.8699669505, 8674.175953284428, 8771.473711577326, 8806.471611703319, 4074.9796251019147, 4803.303520989437, 4817.2774083887, 4830.734309613005, 4893.779779909913, 2054.815066644009, 2103.2638576498102, 2104.1793700456833, 2104.936851894415, 2106.8103870651717, 386.4936932618279, 389.92981263372866, 401.57633696449943, 404.7389433815173, 414.17165668662676, 11889.762204756029, 12088.456019478968, 12124.818127728091, 12330.32183229913, 12442.440090195963, 423.46220300219164, 431.040933922021, 437.56680885923345, 874.1651722604897, 952.5570609666538, 6761.594304341656, 6868.896966545506, 6937.7224911002995, 6976.825579360557, 6988.0, 757053.0, 759522.0, 769744.0, 783916.0, 789954.0, 160626.0, 161145.1942740279, 162086.0, 164982.0, 167286.0, 1058.4125810175426, 1073.6671631794168, 1096.9890301097046, 1101.4437708956925, 1103.900648941599, 11986.999175024144, 12235.755284894074, 12387.256764594153, 12526.06054545931, 12529.18560293578, 61098.0, 62013.0, 62158.68920655368, 62772.68613656903, 63265.051024233755, 91380.54309728408, 91441.0, 94067.0, 94848.05151948392, 95147.52426237824, 8049.637766300648, 8082.838343232985, 8417.28453081495, 8498.447600905922, 8725.869111963199, 11997.040236781211, 12895.742085158432, 12945.352732363532, 13166.275854828076, 13332.666683332995, 11071.72675142369, 11241.831372529256, 11287.604933827277, 11440.199186056896, 11486.712832179262, 10505.527251273557, 10981.945090274497, 11248.943755281498, 11340.829887551858, 11479.942600286946, 11358.09135269193, 11359.602413915472, 11508.82736758966, 11661.883381166079, 11782.351970641697, 8315.210055044761, 8412.07467178622, 8429.494230345954, 8534.91465085366, 8571.142885711379, 8722.869156962777, 9993.950030249802, 10960.616378426717, 11013.669589911995, 11278.661640150809], "value": 9857.70684918679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.2899924544893, 1244.7323825377541, 1370.6847425092226, 1416.9008169428132, 1458.8687018168362, 7510.7371242006475, 7561.697532098723, 7878.80302992424, 8282.792930176749, 8740.257078148357, 8132.308753755938, 8309.584520773953, 8400.705975290866, 8521.0, 8526.658933642648, 2282.463621049052, 2313.838031337807, 2319.199876042771, 2325.360525855395, 2336.4509340305017, 2106.1470104607583, 2168.3494951514563, 2336.4742932840145, 2365.0303375615913, 2382.0471811275543, 2272.784085511874, 2349.788519033287, 2356.2460012795914, 2356.646503024543, 2357.5874222011166, 2337.018452250059, 2339.789418952294, 2350.918577454373, 2354.3525530479083, 2357.3635118517905, 2320.663503791941, 2338.4387746940783, 2387.271882075966, 2395.5208958208427, 2403.098837935774, 8627.568621568897, 8662.480251184948, 8705.695300664447, 8725.7818554536, 8730.956345218297, 5199.870003249911, 5330.680159190461, 5376.327959005124, 5376.38171610262, 5386.811461598864, 3276.7214786743157, 3424.931501369959, 3589.246258285737, 3633.2370202257557, 3659.14010207601, 1215.7304258513104, 1226.2090951336338, 1253.486070711004, 1273.1469915156868, 1273.2233337664018, 11060.391678457681, 11214.775704485946, 11225.214235003554, 11238.775224495464, 11252.099832013419, 4619.353290539327, 4825.576454945799, 4862.367892173995, 4869.878253043702, 4886.95113048865, 9668.129868311886, 9823.705288841345, 9846.655367062118, 9864.210863130933, 9875.160611348116, 5238.109521381374, 5297.0, 5336.866578335495, 5369.328833895763, 5378.273933019071, 4626.467956185014, 4833.806647734122, 4842.346283251786, 4901.50984901507, 4910.165271903714, 3914.4911161548816, 3984.5218573770753, 4013.6588389986596, 4089.997950502146, 4096.692748043909, 1055.8046761349176, 1178.3048001678878, 1216.0575553945762, 1298.1172802494395, 1299.883010529038, 926.2034650200821, 928.7538802217417, 931.6087243357806, 939.5020639061308, 952.2905435450633, 5678.488935995698, 5684.687342196136, 5829.533637309005, 6025.18659980897, 6033.215681961405, 967.6806653804227, 1008.7326858382535, 1009.8030883977553, 1013.8428543575758, 1044.2220545693508, 3892.82482288292, 3961.465202197724, 4007.519097708294, 4033.0, 4053.61490658387, 9988.151007164328, 10196.847047294297, 10204.030617091365, 10345.327553708985, 10355.17158627308, 9757.365771224848, 10154.39073655583, 10160.745981350525, 10161.847572286422, 10175.338602990782, 7818.21817818225, 8142.4300298978505, 8150.918490815135, 8155.877661835078, 8173.427860049739, 5859.091840764689, 5862.0, 5866.735996880066, 5936.970315148396, 6007.939920600738, 8069.193080691884, 9410.341276110606, 9479.0, 9564.378315409476, 9598.280128990493, 9361.906380936103, 9536.475493847905, 9607.51962401891, 9809.950950245204, 9859.260555458226, 7301.853962920818, 7450.9941157942985, 7462.216467270859, 7462.626868656437, 7476.4392670551015, 7985.600719964094, 7999.240072193133, 8021.318187953856, 8087.1104178539135, 8135.471194372347, 6554.8361290968105, 7232.783016509513, 7324.743633972786, 7367.005454263606, 7421.628918553943, 6173.32093469709, 7185.742495063448, 7246.347828695442, 7259.382952449101, 7265.418766498773, 6370.362963703593, 6521.771737989147, 6538.509611779041, 6585.96707016481, 6601.3728695773825, 4976.054549635558, 5091.821786237464, 5155.123628983157, 5169.4830516948, 5180.896382072413, 4516.841910533116, 5082.898342033212, 5153.7165455898785, 5253.0, 5337.439568845215], "value": 4526.7845650627205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.84522351882873, 361.9095226193452, 362.17785626627557, 373.29819938515584, 377.8299765105703, 5131.486851314867, 5179.2749015137915, 5498.285222921019, 5566.721663916808, 5616.185653080306, 4540.636749060075, 4699.143838183915, 5378.8533707781, 5417.6207665463435, 5485.862853428666, 3537.4163263061564, 4265.8080386382535, 4273.0, 4286.863981045026, 4303.311470164775, 4163.188178305231, 4265.914681706364, 4300.591443812833, 4300.763458009808, 4310.80601372939, 4189.455370801791, 4198.748075115487, 4204.537500874917, 4215.536291007987, 4274.700770946035, 4150.792460376984, 4214.409982602423, 4223.0, 4261.190373828963, 4266.5946735060115, 3560.928781424383, 3761.8307176177136, 3766.4915236443276, 3785.6592906638534, 3788.6400791924725, 4584.716279441728, 5032.622553308516, 5070.949290507085, 5075.695458272478, 5302.295829127134, 4749.4063242094735, 4905.321009243068, 4913.484084171147, 4913.729744864031, 4919.262110683426, 5034.572061374787, 5797.88404231913, 5799.739011744439, 5814.796482123148, 5821.330546987108, 3627.764195327295, 3833.584841549806, 3896.3960586109197, 3911.4523966644692, 3921.4313924481075, 5653.925754106706, 5716.828495145152, 5809.854753631151, 5838.4453476919625, 6064.241969753781, 3452.37857185709, 3508.7719298245534, 3775.112848480605, 3943.6985794687685, 3967.7024223183375, 3247.107045562489, 3874.082329247041, 3906.5045868841844, 3921.0, 3958.366661334173, 4656.138614356355, 4656.41794775653, 4666.766661666903, 4675.812967481331, 4714.95285047152, 5092.810091660547, 5788.334341550775, 5793.0, 5817.534597232211, 5826.563007774434, 1049.8504137968912, 1201.7656556971306, 1273.1024627637494, 1293.3468598357956, 1300.2523548959198, 764.6809254036742, 815.3558688635911, 865.3985480091402, 869.9782505437415, 880.3617377401333, 4250.298700714347, 4525.366448697185, 4793.281007848851, 4891.413030436299, 5118.314813334393, 4651.325557794101, 5021.895183059721, 5332.120200166929, 5656.434356564393, 5709.058919967231, 4467.508574056851, 4659.7866013643925, 4661.813527458931, 4758.432633818441, 4862.294967229732, 2376.9422606939747, 2595.351951510804, 2775.930601734932, 2923.912282631482, 2939.5002849515636, 4864.030067822538, 4905.7301848397965, 5439.531326541891, 5602.935442265956, 5858.912116318259, 4456.857915169798, 4910.8281210157475, 5735.512481439041, 5777.913331300034, 5877.9118313225335, 5067.645264831426, 5405.70268635221, 5454.4545545445135, 5848.912266316009, 5947.345791962967, 5078.593712502917, 5518.565173054954, 5590.301212348457, 5647.435256474319, 5664.518515926027, 4609.446866375923, 5177.844664660066, 5308.867278317918, 5486.835394938158, 5537.6954267515675, 4933.309336692794, 5278.815241466684, 5619.971900140473, 5687.744051517774, 5827.358990510956, 3704.296023829069, 3729.68297694699, 3741.017260851753, 3744.4196149596855, 3753.512043434336, 4547.886302842456, 5552.000639884698, 5620.690862002465, 5622.257100298921, 5646.237757902631, 5463.207834864002, 5560.582956278215, 5623.437656234344, 5702.572307076903, 5717.456841600041, 4719.480857105647, 5691.402402747652, 5705.288413475858, 5705.4579814917515, 5711.000574899293, 4527.0, 5255.448177941414, 5319.813806516908, 5517.586181036358, 5589.636673616202, 4554.88612784683, 4746.5490778376, 5641.8589535261945, 5704.657720536781, 5704.828855134353, 5578.967890940189, 5584.073494644341, 5596.440355964371, 5616.410276921028, 5618.101103823368], "value": 4089.8245912609705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7477308169061, 745.9104907411112, 751.8270797716525, 801.9839603207936, 839.1021606880637, 14493.275336233199, 15473.071615703038, 15647.84352156478, 15672.608184795386, 15686.76469852953, 14208.857911420882, 14364.569062928103, 14371.71256574868, 14380.209088500129, 14392.424303027892, 658.2890478283442, 688.6246995387526, 820.5733018830205, 857.9699710510133, 869.0, 712.8823744082246, 868.374770165483, 868.7524055644143, 871.4945331707626, 879.4679219072465, 915.9175674189322, 927.3045216087934, 927.5223260021095, 931.0828833598899, 931.8555623878276, 911.7036962987023, 917.2707697380565, 923.6767131503954, 924.1359329027381, 925.3152667026419, 588.3116753398534, 658.5653468710628, 687.8933765266391, 689.8413364926045, 690.8307464671187, 15117.622059448491, 15354.692906141927, 15356.692866142726, 15765.448209312734, 16053.197340132947, 14639.268036598127, 14801.40794368224, 14838.777418338734, 14889.0, 14926.179060151688, 11614.70963225926, 12082.516699332016, 12110.81833772494, 12121.93939030308, 12499.750004999849, 3349.2129349602824, 3714.7956862372557, 3772.6981841452616, 3795.4686343911876, 3803.1721346612017, 100866.49566752193, 104664.95335046628, 105941.0, 108536.0, 108934.0, 10611.787764244671, 10983.286086404358, 11098.223124381217, 11252.0, 11614.477348519167, 21662.675059874113, 21844.89077554602, 22090.226842060452, 22437.43906402353, 22447.77552224457, 7890.487118337404, 7978.960105199437, 8002.119766825645, 8014.318782903402, 8066.274035336731, 4382.583654552813, 4388.71473354231, 4418.7127836690515, 4421.447319085114, 4444.155610434007, 3602.765820221677, 3673.522442082512, 3685.5577330720484, 3692.5568931728367, 3711.5731690855896, 626.6052386996255, 670.8356452669127, 677.3362105136994, 677.3971165662564, 686.2348481443155, 683.2484267305924, 684.9315068493079, 702.7259368846154, 708.3766285668579, 728.7340120855849, 9688.224942004763, 10608.57565697379, 10657.721073471233, 10731.83902241467, 10822.945885270681, 702.6978399288355, 723.8298999735058, 728.4427413029038, 728.5628622826262, 741.6884908338511, 5177.456367081402, 5223.425423203445, 5226.634135610547, 5231.869203269873, 5245.6852588844795, 79524.60237698775, 105286.47356763168, 107349.0, 109003.0, 110339.0, 78979.60510197528, 80977.59511202406, 87450.56274718713, 88669.0, 96714.64784084733, 49587.752061240186, 60343.39656603466, 75850.0, 80663.59668201621, 81879.0, 10950.616728414467, 11145.888541114486, 11186.944065279622, 11583.884161158281, 11656.708582285512, 49363.50636493589, 50480.0, 51019.23471147862, 51251.97496050133, 52912.941741165734, 60961.695191525534, 70297.29702702907, 71532.0, 71584.64207678929, 74711.62644186744, 13333.599992000256, 13370.598882033555, 13452.798208027083, 13493.730125397633, 13500.392482338122, 14050.367733452224, 14415.567532973608, 14793.852061479247, 15255.0, 15295.464658736892, 13593.86406135926, 13959.162450252612, 14057.648558786112, 14491.565253042425, 14674.266286685837, 12358.887700107034, 12459.563915262923, 13769.655758605715, 14037.298135093, 14502.637434064232, 13389.66525836862, 13813.24027178515, 13888.652783680489, 14328.856711433169, 14358.784618230944, 10643.680689579325, 11109.555757751765, 11240.084255815087, 11398.829017564909, 11900.940495297467, 10250.436226007343, 11143.33140011602, 11392.658220253406, 11422.771544569228, 11436.370999595103], "value": 7655.638144625337, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 165.0, 122.0, 120.0, 120.0, 122.0, 132.0, 176.0, 162.0, 120.0], "value": 135.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 110.0, 114.0, 180.0, 97.0, 99.0, 119.0, 144.0, 162.0, 140.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 195.0, 182.0, 201.0, 196.0, 194.0, 200.0, 236.0, 286.0, 198.0], "value": 208.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 60.0, 88.0, 61.0, 59.0, 58.0, 61.0, 71.0, 60.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 76.0, 68.0, 68.0, 72.0, 80.0, 70.0, 64.0, 80.0], "value": 73.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 88.0, 90.0, 87.0, 91.0, 87.0, 89.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 155.0, 97.0, 119.0, 118.0, 95.0, 96.0, 103.0, 155.0, 153.0], "value": 121.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 127.0, 145.0, 148.0, 90.0, 93.0, 91.0, 109.0, 143.0], "value": 113.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 76.0, 79.0, 79.0, 71.0, 72.0, 70.0, 107.0, 115.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 85.0, 87.0, 84.0, 87.0, 85.0, 87.0, 87.0, 91.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 136.0, 137.0, 137.0, 143.0, 161.0, 152.0, 189.0, 154.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 168.0, 163.0, 169.0, 169.0, 166.0, 168.0, 168.0, 169.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 68.0, 75.0, 87.0, 87.0, 87.0, 88.0, 92.0], "value": 78.4, "unit": "score"}]}]} 08:31:18 INFO - Return code: 0 08:31:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:18 ERROR - # TBPL SUCCESS # 08:31:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:31:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:31:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:31:18 INFO - 2017-01-28 08:31:18.607 screenresolution[1677:12255] starting screenresolution argv=screenresolution get 08:31:18 INFO - 2017-01-28 08:31:18.610 screenresolution[1677:12255] Display 0: 1600x1200x32@60 08:31:18 INFO - 2017-01-28 08:31:18.616 screenresolution[1678:12258] starting screenresolution argv=screenresolution list 08:31:18 INFO - Available Modes on Display 0 08:31:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:31:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:31:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:31:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:31:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:31:18 INFO - Intel Iris: 08:31:18 INFO - Chipset Model: Intel Iris 08:31:18 INFO - Type: GPU 08:31:18 INFO - Bus: Built-In 08:31:18 INFO - VRAM (Dynamic, Max): 1536 MB 08:31:18 INFO - Vendor: Intel (0x8086) 08:31:18 INFO - Device ID: 0x0a2e 08:31:18 INFO - Revision ID: 0x0009 08:31:18 INFO - Displays: 08:31:18 INFO - Display: 08:31:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:31:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:31:18 INFO - Display Serial Number: 1600x1200 60 08:31:18 INFO - Main Display: Yes 08:31:18 INFO - Mirror: Off 08:31:18 INFO - Online: Yes 08:31:18 INFO - Rotation: Supported 08:31:18 INFO - Return code: 0 08:31:18 INFO - Running post-action listener: _resource_record_post_action 08:31:18 INFO - [mozharness: 2017-01-28 16:31:18.850147Z] Finished run-tests step (success) 08:31:18 INFO - Running post-run listener: _resource_record_post_run 08:31:18 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 33329664; Write bytes: 511508480; Read time: 193; Write time: 1606 08:31:18 INFO - TinderboxPrint: CPU usage
54.3% 08:31:18 INFO - TinderboxPrint: I/O read bytes / time
33,329,664 / 193 08:31:18 INFO - TinderboxPrint: I/O write bytes / time
511,508,480 / 1,606 08:31:18 INFO - TinderboxPrint: CPU idle
2,189.1 (45.7%) 08:31:18 INFO - TinderboxPrint: CPU system
961.8 (20.1%) 08:31:18 INFO - TinderboxPrint: CPU user
1,634.6 (34.2%) 08:31:18 INFO - TinderboxPrint: Swap in / out
236,584,960 / 0 08:31:18 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205324800; Write bytes: 201373696; Read time: 15662; Write time: 425 08:31:18 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29880832; Write bytes: 299042816; Read time: 171; Write time: 1147 08:31:19 INFO - Running post-run listener: _upload_blobber_files 08:31:19 INFO - Blob upload gear active. 08:31:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:31:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:31:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:20 INFO - (blobuploader) - INFO - Done attempting. 08:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:21 INFO - (blobuploader) - INFO - Done attempting. 08:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:22 INFO - (blobuploader) - INFO - Done attempting. 08:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:24 INFO - (blobuploader) - INFO - Done attempting. 08:31:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:24 INFO - Return code: 0 08:31:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c295be572ca98753da255b743fe285acee4cea47d9bc81abaa63aa25bfb5c0fb58d0c539e40fc81634ccc8a2671689ba64ec8cd547f567b8bddebf20a1125f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1263711c4a4c8671449d6a41372c68b4a403191e2549f1af973734e3bcdbef7ae46e853a8891e536b4a5bf957f018348327187c23e6da4cca5edc84d005ede51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec24b560e5618103bcac98c3c2ee5acf69ff9b83781028f2122409590dddbcdf2014180f9cef830c78205b1998cc7dfba853759339fc65fbb6483a85785070e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ddf28452b65eb1413924d192bf79b361ef402ba0313bce439ec2f25e184280be0f620bdb629b17a382f735c5c096d4bb70ca5b8c402497c2cc9e27461c0dd34"} 08:31:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:24 INFO - Contents: 08:31:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c295be572ca98753da255b743fe285acee4cea47d9bc81abaa63aa25bfb5c0fb58d0c539e40fc81634ccc8a2671689ba64ec8cd547f567b8bddebf20a1125f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1263711c4a4c8671449d6a41372c68b4a403191e2549f1af973734e3bcdbef7ae46e853a8891e536b4a5bf957f018348327187c23e6da4cca5edc84d005ede51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec24b560e5618103bcac98c3c2ee5acf69ff9b83781028f2122409590dddbcdf2014180f9cef830c78205b1998cc7dfba853759339fc65fbb6483a85785070e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ddf28452b65eb1413924d192bf79b361ef402ba0313bce439ec2f25e184280be0f620bdb629b17a382f735c5c096d4bb70ca5b8c402497c2cc9e27461c0dd34"} 08:31:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:24 INFO - Copying logs to upload dir... 08:31:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.373294 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-28 08:31:24.709424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-28 08:31:24.712841) ========= 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.fs39IHWM9W/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.a1zeBWS01o/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c295be572ca98753da255b743fe285acee4cea47d9bc81abaa63aa25bfb5c0fb58d0c539e40fc81634ccc8a2671689ba64ec8cd547f567b8bddebf20a1125f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1263711c4a4c8671449d6a41372c68b4a403191e2549f1af973734e3bcdbef7ae46e853a8891e536b4a5bf957f018348327187c23e6da4cca5edc84d005ede51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec24b560e5618103bcac98c3c2ee5acf69ff9b83781028f2122409590dddbcdf2014180f9cef830c78205b1998cc7dfba853759339fc65fbb6483a85785070e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ddf28452b65eb1413924d192bf79b361ef402ba0313bce439ec2f25e184280be0f620bdb629b17a382f735c5c096d4bb70ca5b8c402497c2cc9e27461c0dd34"} build_url:https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010498 build_url: 'https://queue.taskcluster.net/v1/task/ZIW9td5yQsaQZFSSJ6jCRg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c295be572ca98753da255b743fe285acee4cea47d9bc81abaa63aa25bfb5c0fb58d0c539e40fc81634ccc8a2671689ba64ec8cd547f567b8bddebf20a1125f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1263711c4a4c8671449d6a41372c68b4a403191e2549f1af973734e3bcdbef7ae46e853a8891e536b4a5bf957f018348327187c23e6da4cca5edc84d005ede51", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec24b560e5618103bcac98c3c2ee5acf69ff9b83781028f2122409590dddbcdf2014180f9cef830c78205b1998cc7dfba853759339fc65fbb6483a85785070e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ddf28452b65eb1413924d192bf79b361ef402ba0313bce439ec2f25e184280be0f620bdb629b17a382f735c5c096d4bb70ca5b8c402497c2cc9e27461c0dd34"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-28 08:31:24.746380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:31:24.746735) ========= 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.fs39IHWM9W/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.a1zeBWS01o/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.005046 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-28 08:31:24.796300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-28 08:31:24.796791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-28 08:31:24.797332) ========= ========= Total master_lag: 0.23 =========