builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0088 starttime: 1484235009.31 results: success (0) buildid: 20170112060215 builduid: 37ee7dc7add0497da43b989463a075a2 revision: 1289b60bd5ed221f6713497fcdc8167ae3896916 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.312003) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.312563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.312919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.341640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.342150) ========= 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.ouKhXe0bEP/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.0yfmqotv8S/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-12 07:30:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 171M=0s 2017-01-12 07:30:09 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139880 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.508211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.508787) ========= 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.ouKhXe0bEP/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.0yfmqotv8S/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.026839 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.606885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:09.607456) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1289b60bd5ed221f6713497fcdc8167ae3896916 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1289b60bd5ed221f6713497fcdc8167ae3896916 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ouKhXe0bEP/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.0yfmqotv8S/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-12 07:30:09,704 truncating revision to first 12 chars 2017-01-12 07:30:09,704 Setting DEBUG logging. 2017-01-12 07:30:09,704 attempt 1/10 2017-01-12 07:30:09,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1289b60bd5ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 07:30:10,420 unpacking tar archive at: mozilla-central-1289b60bd5ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973694 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:10.606628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:10.607008) ========= script_repo_revision: 1289b60bd5ed221f6713497fcdc8167ae3896916 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:10.607448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:10.607710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 07:30:10.628593) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-12 07:30:10.629112) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ouKhXe0bEP/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.0yfmqotv8S/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:10 INFO - MultiFileLogger online at 20170112 07:30:10 in /builds/slave/test 07:30:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:30:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:10 INFO - {'append_to_log': False, 07:30:10 INFO - 'base_work_dir': '/builds/slave/test', 07:30:10 INFO - 'blob_upload_branch': 'Firefox', 07:30:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:10 INFO - 'branch': 'Firefox', 07:30:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:10 INFO - 'config_files': ('talos/mac_config.py',), 07:30:10 INFO - 'default_actions': ('clobber', 07:30:10 INFO - 'read-buildbot-config', 07:30:10 INFO - 'download-and-extract', 07:30:10 INFO - 'populate-webroot', 07:30:10 INFO - 'create-virtualenv', 07:30:10 INFO - 'install', 07:30:10 INFO - 'run-tests'), 07:30:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:10 INFO - 'download_minidump_stackwalk': True, 07:30:10 INFO - 'download_symbols': 'ondemand', 07:30:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:10 INFO - 'installer_path': 'installer.exe', 07:30:10 INFO - 'log_level': 'info', 07:30:10 INFO - 'log_name': 'talos', 07:30:10 INFO - 'log_to_console': True, 07:30:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:30:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:30:10 INFO - 'opt_config_files': (), 07:30:10 INFO - 'pip_index': False, 07:30:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:10 INFO - 'cmd': ('bash', 07:30:10 INFO - '-c', 07:30:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:10 INFO - 'enabled': True, 07:30:10 INFO - 'halt_on_failure': False, 07:30:10 INFO - 'name': 'check_screen_resolution'},), 07:30:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:30:10 INFO - 'cmd': ('bash', 07:30:10 INFO - '-c', 07:30:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:30:10 INFO - 'enabled': True, 07:30:10 INFO - 'halt_on_failure': False, 07:30:10 INFO - 'name': 'check_screen_resolution'},), 07:30:10 INFO - 'run_cmd_checks_enabled': True, 07:30:10 INFO - 'sps_profile': False, 07:30:10 INFO - 'sps_profile_interval': 0, 07:30:10 INFO - 'suite': 'dromaeojs-e10s', 07:30:10 INFO - 'system_bits': '32', 07:30:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:10 INFO - 'title': 't-yosemite-r7-0088', 07:30:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:10 INFO - 'use_talos_json': True, 07:30:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:10 INFO - 'work_dir': 'build'} 07:30:10 INFO - [mozharness: 2017-01-12 15:30:10.839722Z] Running clobber step. 07:30:10 INFO - Running pre-action listener: _resource_record_pre_action 07:30:10 INFO - Running main action method: clobber 07:30:10 INFO - rmtree: /builds/slave/test/build 07:30:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:13 INFO - Running post-action listener: _resource_record_post_action 07:30:13 INFO - [mozharness: 2017-01-12 15:30:13.123967Z] Finished clobber step (success) 07:30:13 INFO - [mozharness: 2017-01-12 15:30:13.124096Z] Running read-buildbot-config step. 07:30:13 INFO - Running pre-action listener: _resource_record_pre_action 07:30:13 INFO - Running main action method: read_buildbot_config 07:30:13 INFO - Using buildbot properties: 07:30:13 INFO - { 07:30:13 INFO - "project": "", 07:30:13 INFO - "product": "firefox", 07:30:13 INFO - "script_repo_revision": "production", 07:30:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:30:13 INFO - "repository": "", 07:30:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:30:13 INFO - "buildid": "20170112060215", 07:30:13 INFO - "pgo_build": "False", 07:30:13 INFO - "basedir": "/builds/slave/test", 07:30:13 INFO - "buildnumber": 51, 07:30:13 INFO - "slavename": "t-yosemite-r7-0088", 07:30:13 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:30:13 INFO - "platform": "yosemite_r7", 07:30:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:30:13 INFO - "branch": "mozilla-central", 07:30:13 INFO - "repo_path": "mozilla-central", 07:30:13 INFO - "revision": "1289b60bd5ed221f6713497fcdc8167ae3896916", 07:30:13 INFO - "stage_platform": "macosx64", 07:30:13 INFO - "builduid": "37ee7dc7add0497da43b989463a075a2", 07:30:13 INFO - "slavebuilddir": "test" 07:30:13 INFO - } 07:30:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:30:13 INFO - Running post-action listener: _resource_record_post_action 07:30:13 INFO - [mozharness: 2017-01-12 15:30:13.127581Z] Finished read-buildbot-config step (success) 07:30:13 INFO - [mozharness: 2017-01-12 15:30:13.127679Z] Running download-and-extract step. 07:30:13 INFO - Running pre-action listener: _resource_record_pre_action 07:30:13 INFO - Running main action method: download_and_extract 07:30:13 INFO - mkdir: /builds/slave/test/build/tests 07:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:13 INFO - trying https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:30:13 INFO - Downloading https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:30:14 INFO - Downloaded 1199 bytes. 07:30:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:30:14 INFO - Using the following test package requirements: 07:30:14 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:30:14 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:30:14 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:30:14 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'jsshell-mac.zip'], 07:30:14 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:30:14 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:30:14 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:30:14 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:30:14 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:30:14 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:30:14 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:30:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:30:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:30:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:30:14 INFO - Fetch https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:30:14 INFO - Expected file size: 16314216 07:30:14 INFO - Obtained file size: 16314216 07:30:21 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:30:22 INFO - Expected file size: 16314216 07:30:22 INFO - Obtained file size: 16314216 07:30:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:30:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:30:29 INFO - Fetch https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:30:29 INFO - Expected file size: 14403532 07:30:29 INFO - Obtained file size: 14403532 07:30:30 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')]} 07:30:30 INFO - trying https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:30:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:30:32 INFO - Downloaded 70134992 bytes. 07:30:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:30:32 INFO - mkdir: /builds/slave/test/properties 07:30:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:32 INFO - Contents: 07:30:32 INFO - build_url:https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:30:33 INFO - Running post-action listener: _resource_record_post_action 07:30:33 INFO - Running post-action listener: set_extra_try_arguments 07:30:33 INFO - [mozharness: 2017-01-12 15:30:33.214756Z] Finished download-and-extract step (success) 07:30:33 INFO - [mozharness: 2017-01-12 15:30:33.214861Z] Running populate-webroot step. 07:30:33 INFO - Running pre-action listener: _resource_record_pre_action 07:30:33 INFO - Running main action method: populate_webroot 07:30:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:33 INFO - '--tppagecycles', 07:30:33 INFO - '7'], 07:30:33 INFO - 'tests': ['tsvgm']}}, 07:30:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['damp', 'tps']}, 07:30:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'tests': ['damp', 'tps']}, 07:30:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['dromaeo_dom']}, 07:30:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['basic_compositor_video']}, 07:30:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['a11yr', 07:30:33 INFO - 'ts_paint', 07:30:33 INFO - 'tpaint', 07:30:33 INFO - 'sessionrestore', 07:30:33 INFO - 'sessionrestore_no_auto_restore', 07:30:33 INFO - 'tabpaint']}, 07:30:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:33 INFO - 'ts_paint', 07:30:33 INFO - 'tpaint', 07:30:33 INFO - 'sessionrestore', 07:30:33 INFO - 'sessionrestore_no_auto_restore', 07:30:33 INFO - 'tabpaint']}, 07:30:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:33 INFO - 'ts_paint', 07:30:33 INFO - 'tpaint', 07:30:33 INFO - 'sessionrestore', 07:30:33 INFO - 'sessionrestore_no_auto_restore', 07:30:33 INFO - 'tabpaint']}, 07:30:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:33 INFO - 'ts_paint', 07:30:33 INFO - 'tpaint', 07:30:33 INFO - 'sessionrestore', 07:30:33 INFO - 'sessionrestore_no_auto_restore', 07:30:33 INFO - 'tabpaint']}, 07:30:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['a11yr', 07:30:33 INFO - 'ts_paint', 07:30:33 INFO - 'tpaint', 07:30:33 INFO - 'sessionrestore', 07:30:33 INFO - 'sessionrestore_no_auto_restore', 07:30:33 INFO - 'tabpaint']}, 07:30:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['a11yr', 07:30:33 INFO - 'ts_paint', 07:30:33 INFO - 'tpaint', 07:30:33 INFO - 'sessionrestore', 07:30:33 INFO - 'sessionrestore_no_auto_restore', 07:30:33 INFO - 'tabpaint']}, 07:30:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['tsvgx', 07:30:33 INFO - 'tsvgr_opacity', 07:30:33 INFO - 'tart', 07:30:33 INFO - 'tscrollx', 07:30:33 INFO - 'cart', 07:30:33 INFO - 'tsvg_static']}, 07:30:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:33 INFO - 'tsvgr_opacity', 07:30:33 INFO - 'tart', 07:30:33 INFO - 'tscrollx', 07:30:33 INFO - 'cart', 07:30:33 INFO - 'tsvg_static']}, 07:30:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'talos_options': ['--disable-e10s'], 07:30:33 INFO - 'tests': ['tp5o']}, 07:30:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:30:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'talos_options': ['--disable-e10s', 07:30:33 INFO - '--xperf_path', 07:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:33 INFO - 'tests': ['tp5n']}, 07:30:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:30:33 INFO - 'talos_options': ['--xperf_path', 07:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:33 INFO - 'tests': ['tp5n']}}, 07:30:33 INFO - 'talos.zip': {'path': '', 07:30:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:33 INFO - Running post-action listener: _resource_record_post_action 07:30:33 INFO - [mozharness: 2017-01-12 15:30:33.233585Z] Finished populate-webroot step (success) 07:30:33 INFO - [mozharness: 2017-01-12 15:30:33.233697Z] Running create-virtualenv step. 07:30:33 INFO - Running pre-action listener: _resource_record_pre_action 07:30:33 INFO - Running main action method: create_virtualenv 07:30:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:33 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 07:30:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:33 INFO - Using real prefix '/tools/python27' 07:30:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:36 INFO - Installing pip.................done. 07:30:36 INFO - Return code: 0 07:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:30:37 INFO - Reading from file tmpfile_stdout 07:30:37 INFO - Output received: 07:30:37 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) 07:30:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:37 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')]} 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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')]} 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:37 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 07:30:37 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 07:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:37 INFO - 'HOME': '/Users/cltbld', 07:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:37 INFO - 'LOGNAME': 'cltbld', 07:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:37 INFO - 'MOZ_NO_REMOTE': '1', 07:30:37 INFO - 'NO_EM_RESTART': '1', 07:30:37 INFO - 'PAGER': '/bin/cat', 07:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:37 INFO - 'PWD': '/builds/slave/test', 07:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:37 INFO - 'SHELL': '/bin/bash', 07:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:37 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:37 INFO - 'USER': 'cltbld', 07:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:37 INFO - 'XPC_FLAGS': '0x0', 07:30:37 INFO - 'XPC_SERVICE_NAME': '0', 07:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:37 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 07:30:37 INFO - Cleaning up... 07:30:37 INFO - Return code: 0 07:30:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:37 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')]} 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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')]} 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:37 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 07:30:37 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 07:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:37 INFO - 'HOME': '/Users/cltbld', 07:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:37 INFO - 'LOGNAME': 'cltbld', 07:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:37 INFO - 'MOZ_NO_REMOTE': '1', 07:30:37 INFO - 'NO_EM_RESTART': '1', 07:30:37 INFO - 'PAGER': '/bin/cat', 07:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:37 INFO - 'PWD': '/builds/slave/test', 07:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:37 INFO - 'SHELL': '/bin/bash', 07:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:37 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:37 INFO - 'USER': 'cltbld', 07:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:37 INFO - 'XPC_FLAGS': '0x0', 07:30:37 INFO - 'XPC_SERVICE_NAME': '0', 07:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:37 INFO - Downloading/unpacking psutil>=3.1.1 07:30:37 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 07:30:37 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 07:30:37 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 07:30:37 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 07:30:37 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 07:30:37 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 07:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:41 INFO - Installing collected packages: psutil 07:30:41 INFO - Running setup.py install for psutil 07:30:41 INFO - building 'psutil._psutil_osx' extension 07:30:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:30:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:30:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:30:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:30:42 INFO - building 'psutil._psutil_posix' extension 07:30:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:30:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:30:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:30:42 INFO - ^ 07:30:42 INFO - 1 warning generated. 07:30:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:42 INFO - Successfully installed psutil 07:30:42 INFO - Cleaning up... 07:30:42 INFO - Return code: 0 07:30:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30: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')]} 07:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30: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')]} 07:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:42 INFO - 'HOME': '/Users/cltbld', 07:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:42 INFO - 'LOGNAME': 'cltbld', 07:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:42 INFO - 'MOZ_NO_REMOTE': '1', 07:30:42 INFO - 'NO_EM_RESTART': '1', 07:30:42 INFO - 'PAGER': '/bin/cat', 07:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:42 INFO - 'PWD': '/builds/slave/test', 07:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:42 INFO - 'SHELL': '/bin/bash', 07:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:42 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:42 INFO - 'USER': 'cltbld', 07:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:42 INFO - 'XPC_FLAGS': '0x0', 07:30:42 INFO - 'XPC_SERVICE_NAME': '0', 07:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:45 INFO - Installing collected packages: mozsystemmonitor 07:30:45 INFO - Running setup.py install for mozsystemmonitor 07:30:45 INFO - Successfully installed mozsystemmonitor 07:30:45 INFO - Cleaning up... 07:30:45 INFO - Return code: 0 07:30:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30:45 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')]} 07:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:45 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')]} 07:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:45 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:45 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 07:30:45 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 07:30:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:45 INFO - 'HOME': '/Users/cltbld', 07:30:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:45 INFO - 'LOGNAME': 'cltbld', 07:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:45 INFO - 'MOZ_NO_REMOTE': '1', 07:30:45 INFO - 'NO_EM_RESTART': '1', 07:30:45 INFO - 'PAGER': '/bin/cat', 07:30:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:45 INFO - 'PWD': '/builds/slave/test', 07:30:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:45 INFO - 'SHELL': '/bin/bash', 07:30:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:45 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:45 INFO - 'USER': 'cltbld', 07:30:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:45 INFO - 'XPC_FLAGS': '0x0', 07:30:45 INFO - 'XPC_SERVICE_NAME': '0', 07:30:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:45 INFO - Downloading/unpacking jsonschema==2.5.1 07:30:45 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 07:30:45 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 07:30:45 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 07:30:45 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 07:30:45 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 07:30:45 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 07:30:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 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 07:30:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:49 INFO - warning: no files found matching '*.txt' 07:30:49 INFO - no previously-included directories found matching 'build' 07:30:49 INFO - no previously-included directories found matching 'dist' 07:30:49 INFO - no previously-included directories found matching '.git*' 07:30:49 INFO - Installing collected packages: jsonschema, functools32 07:30:49 INFO - Running setup.py install for functools32 07:30:49 INFO - warning: no files found matching '*.txt' 07:30:49 INFO - no previously-included directories found matching 'build' 07:30:49 INFO - no previously-included directories found matching 'dist' 07:30:49 INFO - no previously-included directories found matching '.git*' 07:30:49 INFO - Successfully installed jsonschema functools32 07:30:49 INFO - Cleaning up... 07:30:49 INFO - Return code: 0 07:30:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:30:49 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')]} 07:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 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')]} 07:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:49 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 07:30:49 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 07:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:49 INFO - 'HOME': '/Users/cltbld', 07:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:49 INFO - 'LOGNAME': 'cltbld', 07:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:49 INFO - 'MOZ_NO_REMOTE': '1', 07:30:49 INFO - 'NO_EM_RESTART': '1', 07:30:49 INFO - 'PAGER': '/bin/cat', 07:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:49 INFO - 'PWD': '/builds/slave/test', 07:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:49 INFO - 'SHELL': '/bin/bash', 07:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:49 INFO - 'USER': 'cltbld', 07:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:49 INFO - 'XPC_FLAGS': '0x0', 07:30:49 INFO - 'XPC_SERVICE_NAME': '0', 07:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:30:49 INFO - Cleaning up... 07:30:49 INFO - Return code: 0 07:30:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:49 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')]} 07:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 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')]} 07:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:49 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:49 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 07:30:49 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 07:30:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:49 INFO - 'HOME': '/Users/cltbld', 07:30:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:49 INFO - 'LOGNAME': 'cltbld', 07:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:49 INFO - 'MOZ_NO_REMOTE': '1', 07:30:49 INFO - 'NO_EM_RESTART': '1', 07:30:49 INFO - 'PAGER': '/bin/cat', 07:30:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:49 INFO - 'PWD': '/builds/slave/test', 07:30:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:49 INFO - 'SHELL': '/bin/bash', 07:30:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:49 INFO - 'USER': 'cltbld', 07:30:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:49 INFO - 'XPC_FLAGS': '0x0', 07:30:49 INFO - 'XPC_SERVICE_NAME': '0', 07:30:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:49 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 07:30:49 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 07:30:49 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 07:30:49 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 07:30:49 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 07:30:49 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 07:30:52 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30:52 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 07:30:52 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 07:30:52 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 07:30:52 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 07:30:52 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 07:30:52 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 07:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:53 INFO - Downloading docopt-0.6.1.tar.gz 07:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:53 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:53 INFO - Running setup.py install for blobuploader 07:30:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:54 INFO - Running setup.py install for requests 07:30:54 INFO - Running setup.py install for docopt 07:30:54 INFO - Successfully installed blobuploader requests docopt 07:30:54 INFO - Cleaning up... 07:30:54 INFO - Return code: 0 07:30:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:54 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')]} 07:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:54 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')]} 07:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:54 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:30:54 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 07:30:54 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 07:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:30:54 INFO - 'HOME': '/Users/cltbld', 07:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:30:54 INFO - 'LOGNAME': 'cltbld', 07:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:54 INFO - 'MOZ_NO_REMOTE': '1', 07:30:54 INFO - 'NO_EM_RESTART': '1', 07:30:54 INFO - 'PAGER': '/bin/cat', 07:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:54 INFO - 'PWD': '/builds/slave/test', 07:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:30:54 INFO - 'SHELL': '/bin/bash', 07:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:30:54 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:30:54 INFO - 'USER': 'cltbld', 07:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:54 INFO - 'XPC_FLAGS': '0x0', 07:30:54 INFO - 'XPC_SERVICE_NAME': '0', 07:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-oaJB2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-7z9iiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-3XgI6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-lYWE5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ndVq06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XGAL2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-YesPH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-9kiwvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-q4mk7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-jcm2fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hsLq0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_Dvqzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-E7RsA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-OlYr8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-7wGpWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-VwWRkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-A34Br8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:56 INFO - Running setup.py install for manifestparser 07:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:56 INFO - Running setup.py install for mozcrash 07:30:57 INFO - Running setup.py install for mozdebug 07:30:57 INFO - Running setup.py install for mozdevice 07:30:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Running setup.py install for mozfile 07:30:57 INFO - Running setup.py install for mozhttpd 07:30:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Running setup.py install for mozinfo 07:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Running setup.py install for mozInstall 07:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:57 INFO - Running setup.py install for mozleak 07:30:58 INFO - Running setup.py install for mozlog 07:30:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:58 INFO - Running setup.py install for moznetwork 07:30:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:58 INFO - Running setup.py install for mozprocess 07:30:58 INFO - Running setup.py install for mozprofile 07:30:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:58 INFO - Running setup.py install for mozrunner 07:30:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:58 INFO - Running setup.py install for mozscreenshot 07:30:59 INFO - Running setup.py install for moztest 07:30:59 INFO - Running setup.py install for mozversion 07:30:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:59 INFO - Cleaning up... 07:30:59 INFO - Return code: 0 07:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:00 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:31:00 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 07:31:00 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 07:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:00 INFO - 'HOME': '/Users/cltbld', 07:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:00 INFO - 'LOGNAME': 'cltbld', 07:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:00 INFO - 'MOZ_NO_REMOTE': '1', 07:31:00 INFO - 'NO_EM_RESTART': '1', 07:31:00 INFO - 'PAGER': '/bin/cat', 07:31:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:00 INFO - 'PWD': '/builds/slave/test', 07:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:00 INFO - 'SHELL': '/bin/bash', 07:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:31:00 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:00 INFO - 'USER': 'cltbld', 07:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:00 INFO - 'XPC_FLAGS': '0x0', 07:31:00 INFO - 'XPC_SERVICE_NAME': '0', 07:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-xfhhCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:31:00 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)) 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-rJRrvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:31:00 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)) 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DJYGao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:31:00 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)) 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Y1M6Qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:31:00 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)) 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-atAGUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:31:00 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)) 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-7fy2mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:31:00 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)) 07:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:31:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Q0OyiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-7ucqEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-sC_wSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ZyPLD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_89dBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-3sgFEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hcW7X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-qoartM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ERodAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:31:01 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)) 07:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:31:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-WdsPwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:31:02 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)) 07:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:31:02 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DgnuYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:31:02 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)) 07:31:02 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)) 07:31:02 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)) 07:31:02 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)) 07:31:02 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)) 07:31:02 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)) 07:31:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31: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 07:31:05 INFO - Downloading blessings-1.6.tar.gz 07:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:31:05 INFO - Installing collected packages: blessings 07:31:05 INFO - Running setup.py install for blessings 07:31:05 INFO - Successfully installed blessings 07:31:05 INFO - Cleaning up... 07:31:05 INFO - Return code: 0 07:31:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:05 INFO - Reading from file tmpfile_stdout 07:31:05 INFO - Current package versions: 07:31:05 INFO - blessings == 1.6 07:31:05 INFO - blobuploader == 1.2.4 07:31:05 INFO - docopt == 0.6.1 07:31:05 INFO - functools32 == 3.2.3-2 07:31:05 INFO - jsonschema == 2.5.1 07:31:05 INFO - manifestparser == 1.1 07:31:05 INFO - mozInstall == 1.12 07:31:05 INFO - mozcrash == 1.0 07:31:05 INFO - mozdebug == 0.1 07:31:05 INFO - mozdevice == 0.49 07:31:05 INFO - mozfile == 1.2 07:31:05 INFO - mozhttpd == 0.7 07:31:05 INFO - mozinfo == 0.9 07:31:05 INFO - mozleak == 0.1 07:31:05 INFO - mozlog == 3.4 07:31:05 INFO - moznetwork == 0.27 07:31:05 INFO - mozprocess == 0.24 07:31:05 INFO - mozprofile == 0.28 07:31:05 INFO - mozrunner == 6.13 07:31:05 INFO - mozscreenshot == 0.1 07:31:05 INFO - mozsystemmonitor == 0.3 07:31:05 INFO - moztest == 0.8 07:31:05 INFO - mozversion == 1.4 07:31:05 INFO - psutil == 3.1.1 07:31:05 INFO - requests == 1.2.3 07:31:05 INFO - wsgiref == 0.1.2 07:31:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:31: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')]} 07:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31: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')]} 07:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:05 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 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:31:05 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 07:31:05 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 07:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:05 INFO - 'HOME': '/Users/cltbld', 07:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:05 INFO - 'LOGNAME': 'cltbld', 07:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:05 INFO - 'MOZ_NO_REMOTE': '1', 07:31:05 INFO - 'NO_EM_RESTART': '1', 07:31:05 INFO - 'PAGER': '/bin/cat', 07:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:05 INFO - 'PWD': '/builds/slave/test', 07:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:05 INFO - 'SHELL': '/bin/bash', 07:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:31:05 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:05 INFO - 'USER': 'cltbld', 07:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:05 INFO - 'XPC_FLAGS': '0x0', 07:31:05 INFO - 'XPC_SERVICE_NAME': '0', 07:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 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)) 07:31:06 INFO - Cleaning up... 07:31:06 INFO - Return code: 0 07:31:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c55fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c562768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0bb4d3390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, '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.ouKhXe0bEP/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.0yfmqotv8S/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 07:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:06 INFO - 'HOME': '/Users/cltbld', 07:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:06 INFO - 'LOGNAME': 'cltbld', 07:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:06 INFO - 'MOZ_NO_REMOTE': '1', 07:31:06 INFO - 'NO_EM_RESTART': '1', 07:31:06 INFO - 'PAGER': '/bin/cat', 07:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:06 INFO - 'PWD': '/builds/slave/test', 07:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:06 INFO - 'SHELL': '/bin/bash', 07:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:31:06 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:06 INFO - 'USER': 'cltbld', 07:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:06 INFO - 'XPC_FLAGS': '0x0', 07:31:06 INFO - 'XPC_SERVICE_NAME': '0', 07:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:31:06 INFO - Cleaning up... 07:31:06 INFO - Return code: 0 07:31:06 INFO - Running post-action listener: _resource_record_post_action 07:31:06 INFO - Running post-action listener: _start_resource_monitoring 07:31:06 INFO - Starting resource monitoring. 07:31:06 INFO - [mozharness: 2017-01-12 15:31:06.442486Z] Finished create-virtualenv step (success) 07:31:06 INFO - [mozharness: 2017-01-12 15:31:06.443410Z] Running install step. 07:31:06 INFO - Running pre-action listener: _resource_record_pre_action 07:31:06 INFO - Running main action method: install 07:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:31:06 INFO - Reading from file tmpfile_stdout 07:31:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:31:06 INFO - Reading from file tmpfile_stdout 07:31:06 INFO - Output received: 07:31:06 INFO - Usage: mozinstall [options] installer 07:31:06 INFO - Options: 07:31:06 INFO - -h, --help show this help message and exit 07:31:06 INFO - -d DEST, --destination=DEST 07:31:06 INFO - Directory to install application into. [default: 07:31:06 INFO - "/builds/slave/test"] 07:31:06 INFO - --app=APP Application being installed. [default: firefox] 07:31:06 INFO - mkdir: /builds/slave/test/build/application 07:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:31:28 INFO - Reading from file tmpfile_stdout 07:31:28 INFO - Output received: 07:31:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:31:28 INFO - Running post-action listener: _resource_record_post_action 07:31:28 INFO - [mozharness: 2017-01-12 15:31:28.795476Z] Finished install step (success) 07:31:28 INFO - [mozharness: 2017-01-12 15:31:28.795637Z] Running run-tests step. 07:31:28 INFO - Running pre-action listener: _resource_record_pre_action 07:31:28 INFO - Running main action method: run_tests 07:31:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:31:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:31:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:31:28 INFO - 2017-01-12 07:31:28.810 screenresolution[1619:7533] starting screenresolution argv=screenresolution get 07:31:28 INFO - 2017-01-12 07:31:28.813 screenresolution[1619:7533] Display 0: 1600x1200x32@60 07:31:28 INFO - 2017-01-12 07:31:28.819 screenresolution[1620:7535] starting screenresolution argv=screenresolution list 07:31:28 INFO - Available Modes on Display 0 07:31:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:31:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:31:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:31:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:31:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:31:29 INFO - Intel Iris: 07:31:29 INFO - Chipset Model: Intel Iris 07:31:29 INFO - Type: GPU 07:31:29 INFO - Bus: Built-In 07:31:29 INFO - VRAM (Dynamic, Max): 1536 MB 07:31:29 INFO - Vendor: Intel (0x8086) 07:31:29 INFO - Device ID: 0x0a2e 07:31:29 INFO - Revision ID: 0x0009 07:31:29 INFO - Displays: 07:31:29 INFO - Display: 07:31:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:31:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:31:29 INFO - Display Serial Number: 1600x1200 60 07:31:29 INFO - Main Display: Yes 07:31:29 INFO - Mirror: Off 07:31:29 INFO - Online: Yes 07:31:29 INFO - Rotation: Supported 07:31:29 INFO - Return code: 0 07:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:31:29 INFO - Python 2.7.3 07:31:29 INFO - Return code: 0 07:31:29 INFO - grabbing minidump binary from tooltool 07:31:29 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')]} 07:31:29 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 0x10c33dd30>, '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 0x10c264db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c332be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:31:29 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 07:31:29 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 07:31:29 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 07:31:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:31:29 INFO - Return code: 0 07:31:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:31:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:31:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:31:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:31:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 07:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 07:31:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ouKhXe0bEP/Render', 07:31:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:31:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:31:29 INFO - 'HOME': '/Users/cltbld', 07:31:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:31:29 INFO - 'LOGNAME': 'cltbld', 07:31:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:31:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:31:29 INFO - 'MOZ_NO_REMOTE': '1', 07:31:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:31:29 INFO - 'NO_EM_RESTART': '1', 07:31:29 INFO - 'PAGER': '/bin/cat', 07:31:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:31:29 INFO - 'PWD': '/builds/slave/test', 07:31:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:31:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:31:29 INFO - 'SHELL': '/bin/bash', 07:31:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0yfmqotv8S/Listeners', 07:31:29 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:31:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:31:29 INFO - 'USER': 'cltbld', 07:31:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:31:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:31:29 INFO - 'XPC_FLAGS': '0x0', 07:31:29 INFO - 'XPC_SERVICE_NAME': '0', 07:31:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:31:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 07:31:29 INFO - mozversion application_buildid: 20170112060215 07:31:29 INFO - mozversion application_changeset: 1289b60bd5ed221f6713497fcdc8167ae3896916 07:31:29 INFO - mozversion application_display_name: Nightly 07:31:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:31:29 INFO - mozversion application_name: Firefox 07:31:29 INFO - mozversion application_remotingname: firefox 07:31:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:31:29 INFO - mozversion application_vendor: Mozilla 07:31:29 INFO - mozversion application_version: 53.0a1 07:31:29 INFO - mozversion platform_buildid: 20170112060215 07:31:29 INFO - mozversion platform_changeset: 1289b60bd5ed221f6713497fcdc8167ae3896916 07:31:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:31:29 INFO - mozversion platform_version: 53.0a1 07:31:29 INFO - using testdate: 1484235089 07:31:29 INFO - actual date: 1484235089 07:31:29 INFO - starting webserver on 'localhost:49241' 07:31:29 INFO - SUITE-START | Running 2 tests 07:31:29 INFO - TEST-START | dromaeo_css 07:31:29 INFO - operating with platform_type : mac_ 07:31:29 INFO - Initialising browser for dromaeo_css test... 07:31:29 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpPFL5S8/profile http://localhost:49241/getInfo.html) 07:31:32 INFO - PROCESS | 1630 | 2017-01-12 07:31:32.245 plugin-container[1632:7690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 07:31:32 INFO - PROCESS | 1630 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:32 INFO - PROCESS | 1630 | 2017-01-12 07:31:32.248 plugin-container[1632:7690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x901f, name = 'com.apple.CFPasteboardClient' 07:31:32 INFO - PROCESS | 1630 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:32 INFO - PROCESS | 1630 | 2017-01-12 07:31:32.248 plugin-container[1632:7690] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:31:32 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 07:31:32 INFO - PROCESS | 1630 | colorDepth:24 07:31:32 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 07:31:32 INFO - PROCESS | 1630 | __metrics 07:31:32 ERROR - PROCESS | 1630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 07:31:33 INFO - TEST-INFO | 1630: exit 0 07:31:33 INFO - Browser initialized. 07:31:33 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:33 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpPFL5S8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:35 INFO - PROCESS | 1633 | 2017-01-12 07:31:35.509 plugin-container[1634:7808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:31:35 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:35 INFO - PROCESS | 1633 | 2017-01-12 07:31:35.510 plugin-container[1634:7808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 07:31:35 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:31:35 INFO - PROCESS | 1633 | 2017-01-12 07:31:35.510 plugin-container[1634:7808] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:31:45 INFO - PROCESS | 1633 | RSS: Main: 233320448 07:31:45 INFO - PROCESS | 1633 | 07:34:47 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 07:34:49 INFO - PROCESS | 1633 | RSS: Main: 249036800 07:34:49 INFO - PROCESS | 1633 | 07:36:33 INFO - PROCESS | 1633 | ************************* 07:36:33 INFO - PROCESS | 1633 | A coding exception was thrown and uncaught in a Task. 07:36:33 INFO - PROCESS | 1633 | 07:36:33 INFO - PROCESS | 1633 | Full message: ReferenceError: fetch is not defined 07:36:33 INFO - PROCESS | 1633 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:36:33 INFO - PROCESS | 1633 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:36:33 INFO - PROCESS | 1633 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:36:33 INFO - PROCESS | 1633 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:36:33 INFO - PROCESS | 1633 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:36:33 INFO - PROCESS | 1633 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:36:33 INFO - PROCESS | 1633 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:36:33 INFO - PROCESS | 1633 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:36:33 INFO - PROCESS | 1633 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:36:33 INFO - PROCESS | 1633 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:36:33 INFO - PROCESS | 1633 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:36:33 INFO - PROCESS | 1633 | 07:36:33 INFO - PROCESS | 1633 | ************************* 07:37:52 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 07:37:52 INFO - PROCESS | 1633 | RSS: Main: 261689344 07:37:52 INFO - PROCESS | 1633 | 07:40:54 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:40:55 INFO - PROCESS | 1633 | RSS: Main: 270979072 07:40:55 INFO - PROCESS | 1633 | 07:43:57 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:43:57 INFO - PROCESS | 1633 | RSS: Main: 267132928 07:43:57 INFO - PROCESS | 1633 | 07:47:00 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:47:01 INFO - PROCESS | 1633 | RSS: Main: 271974400 07:47:01 INFO - PROCESS | 1633 | 07:50:03 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:50:04 INFO - PROCESS | 1633 | RSS: Main: 274989056 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | __start_tp_report 07:50:04 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 07:50:04 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 07:50:04 INFO - PROCESS | 1633 | |i|pagename|runs| 07:50:04 INFO - PROCESS | 1633 | |0;dojo.html;3362.6132994705617;3368.4778859276807;3386.661333866614;3393.7624366294367;3407.710344620707;5609.775608975641;5636.239107720457;5640.887182256358;5649.18086877403;5704.486596206351;5623.353314368849;5683.2895888014;5743.655380677163;5762;5774.740136693848;5050.116229659813;5095.541401273885;5200.791968321262;5254.57963362932;5302.681839089648;5173.430922598511;5239.711815850127;5252.474752524736;5268.9473105269035;5305.018571564254;5312.096943519611;5336.59975501837;5340.519353258206;5345.839624811262;5359.276497672823;5134.871628209287;5170.767315470813;5207.3751149862255;5231.424543300234;5307.495787900143;5154.865929495505;5186.688798672092;5189.351331083614;5201.427842937273;5249.580033597303;4722.504137065593;5631.493165615114;5652.378238393773;5715.942840571624;5787.739551720183;5130.563902068328;6324.7470101195895;6327.335629758855;6356.0783686365685;6370.90443643341;5192.844214673528;6207.596506227081;6222.253329600477;6278.183836101278;6334.619922804646;5849.561282903799;5883.588148829541;5908.615939963888;5922.615030023035;5931.317898441648;6255.43701066897;6265.248170219512;6270.6864656766975;6292.244930608264;6332.303446620868;6043.607165534227;6076.3316035236085;6103.694815259308;6136.723847426876;6145.66198859067;5240.187770895517;6287.622742635456;6288.811335659846;6294.181756371734;6361.681915904186;5979.4917432018765;6006.2191915051635;6320.146780184708;6325.9051114233325;6327.873442531123;6135.018317212141;6188.566800324024;6244.969580019337;6278.183836101369;6327.936720632827;4899.730514821719;4902.583280421133;4960.875978100504;4961.355023846877;5003.399592048978;4398.428204333481;4509.120721459284;4513.864584062483;4518.548145185521;4521.909561808746;5887.911681324784;5894.911576326359;5902.911456328158;5921.6743079131065;5943.791967281124;6205.317415084337;6287.371262873768;6292.968535157386;6300.905486417708;6327.272363678144;5717.256756621696;5795.275590551181;5803.100519419497;5818.970905145447;5865.20819689345;5538.892221555705;5541.113421852565;5555.916661250085;5581.637193582485;5617.775288988477;6270.905936410866;6393.073004414334;6401.615903045739;6403.64779937108;6414.166158399472;6229.5327850410495;6243.313235544178;6265.248170219603;6302.1492098566105;6327.462165715781;6305.621662700252;6382.648954307558;6384.170057892445;6411.070394792822;6417.133686952202;6283.3402492737605;6291;6301.243850737941;6305.842353941188;6313.400226978613;6205.47253483459;6256.562040657111;6260.154879091265;6286.968565157145;6321.178246828067;4767.642426818072;6132.814448934826;6137.376985335611;6162.506999440124;6207.286162091417;4517.367568540472;5722.4277572242445;6070.180525628984;6237.345078766664;6248.625082495065;5890.558208134493;5934.9406505934385;5943.405659434022;5984.1921340618455;6013.789517366871;6140.381550881072;6143.508519318533;6144.463884028993;6149.354317796567;6160.383961603983;6132.967444181115;6136.404534821068;6142.788596105488;6155.384461553809;6190.0405437157315 07:50:04 INFO - PROCESS | 1633 | |1;ext.html;427.70488363029506;453.193315897702;478.23004962011134;511.41187634220665;526.9235960785686;39572.40641390378;41338;41479.58520414795;41511.79244103779;41521.584784152146;41932;42012;42549.36175957363;42640.78679606605;42676.57323426772;7705.190954949734;8133.349332053451;8326.500409975391;9286.489243091628;9303.674371397003;10999.505022274017;11282.887171128306;11323.150763692756;11392.202545821754;11436.085113190924;9537.284703647254;11187.832182517268;11221.943890280538;11288.435578221097;11298.322100673944;11219.326840389604;11225.66323010307;11235.101191904629;11238.887611123866;11270.492827822767;11077.279976801483;11109.166812489015;11130.276532025393;11164.051055660279;11219.775604487946;40596.39105413421;40887.38668919969;40933.771986840446;40954.1809163818;40975.38536921948;4003.7597744135446;4021.718479706422;4030.2544029354663;4031.858884939013;4049.617470103252;28982.985595504055;31160.688393116234;31202;31434.842825785723;31444.21389465259;2371.703537057868;3111.23774675206;3312.38720836646;3313.486409606515;3340.88306909257;349991;351864.4813551883;352606;353014;353344;64963.67518162379;65189.67405163038;65335.673321634036;65524;65549.67225163843;67620.32379676239;68061.3193868055;68077.65961170163;68615.3138468609;68739.3126068733;16399.91800040992;16541.751873721903;16619.584510387096;16627.418040368528;16686.83313166853;11372.431378431045;11575.536978520764;12410.875891240972;12572.4342404592;12715.364231788373;19290;19388.70916936247;19442.90278548598;19486.317978870957;19525;6677;7603.315701586884;7978.281954624112;7990.68037278514;7993.760187194393;785.9115125551153;823.2878560045517;872.9738107856774;890.1810334492283;901.4275934781462;29513.967011154935;29889.701102989126;30177.245568860515;30262.54606180909;30571.388572228876;944.475815922156;1080.2438293194796;1081.789051135021;1102.671281106265;1109.7059279290995;15490.07059576429;15533.611659708371;15566.84433155654;15771.842281577037;15906.204689765465;550037;556891;563401;564349;567268;60801;61001.38998610046;61082;61190.69404652948;61292.69353653203;1367.2480135925202;1453.3605213705935;1476.7415702252279;1486.8959172857797;1496.5360738170984;23402;28037.71962280351;29102.417951640426;29288.26779330534;29318.41363172682;51246;51490.74254628703;51624;51652.483475164765;51945;477161;486690;487170;493697;495148;26106.73893261043;26165;26477.470450591267;26527.469450611265;26568.734312656627;47232.52767472281;47591.286130707376;47721.01499514809;47770.52229477661;48113;38935.41596876106;39305.41041884431;39771.40342894801;40674;40989.59010409858;38730.41904371493;38789.6121038786;39244;40215;40322.395164071975;37034.88895333144;37944.24111517699;38171.80914095523;38193.80903095467;38195.42706859455;33558;33893;34732.13169670779;34930.47604285989;35029.64970350264;24118.517629646958;24231.515369692155;24711.38221544476;24880.37799055038;25736.485270294863 07:50:04 INFO - PROCESS | 1633 | |2;jquery.html;347.65234765234766;388.43482732624017;390.2958694494216;403.81626360006203;422.3221729124755;19240.807591924076;19566.804331956675;20900.954952252403;20909;20933.790662093357;21035.948202589847;21166.788332116674;21372.89313553434;22045.228417005408;22054.88972555139;5496.230527726111;5886.4113588641;5921.585489015771;5956.076808094752;5979.880402391949;5876.711918247477;5882.382349853268;5892.3812999635065;5964.940350596504;5982.970085149568;5807.477327040566;5883.264591926009;5886.234789477383;5899.820035992797;5950.55370847186;5669.639286571234;5801.216835727165;5880.353161152269;5916.88166236675;5920.940790592103;5173.120569503193;5185.585153187736;5187.221916712486;5194.662346947474;5198.6880787152895;22307.107715691352;24336.39159021021;24484.387890302707;26050.478990420084;26401.3399665008;2709.403931135147;2766.170148955305;2791.1766029021487;2792.0786140573564;2796.9440611187865;15631.609209769847;15674.68650626981;15688.215589220608;15751.921240393725;16012.439564615182;1826.4246762269843;1879.7274395212755;1881.294514557041;1888;1898.2596787252983;116419;116913.41543292314;116994;117249;117973.41013294879;8647;10371.585136594602;11623.12826537996;11778.52885884555;12029.939850300692;14154.787678184835;14328.570142895729;14337.283135843167;14338.56984290473;14346.56960291193;7399.926000739923;8399.874001889977;8646.524441155796;8771.692990745294;8774.473531587997;7600.885986710204;8105.513669179868;8597.52713600758;8603.655853765904;8770.561471926378;6465.709043092978;6718.764843230463;7141.571505709674;7253.419726421979;7274.30894065063;1647.4563394080164;1992.7309813175325;1994.6409646263521;1996.4310171601023;1999.1303782854213;1060.2631171336002;1073;1074.231924174219;1080.8000519903842;1119.7256672115384;19763;21696.566068678538;22467.662985055238;22517.549649007255;22738.658920116213;968.2157452463528;992.0179022767409;1094.8412480190327;1102.8897110288906;1104.7956128116325;9842.60629574809;11841.526338946518;12065.758684826429;12083.275003499819;12087.214331068453;692101;701970.4901475562;708636;712023;732795;101842;121728.39135804442;128953.71046289605;132158;135175;1002.5989604158249;1012.4128005756644;1032.7624646331385;1035.5805898611075;1036.6060896859296;19434.319798806973;19916.164397152796;20133.697994530386;21132;21265.468363291042;51823.74088129535;57340.71329643325;61040.38959610525;64605;65596;66831;89357.55321223353;89953.55023225104;90150.54924725334;91256;7511;8123.7969050771835;8426.41015128935;8689.739307820775;8840.646374144962;12860.228386296852;12973;13448.596542103753;13948.721025579229;14157.292135392983;11330.716732081433;11375.886241137483;11477.253978491372;11598.18812683104;11787;10292;11177.776444471228;11506.769864602493;11544.076473882238;11833.230839995373;11279.605213817476;11726.120540959633;11855.525778968744;12096.576619818265;12181.69545761363;5894.823155305347;7680;8532.488050716976;8803.823923521622;8818.927552025141;10434.947825260826;11744.530218791495;12011.75976480448;12056.276623402624;12070.396480175781 07:50:04 INFO - PROCESS | 1633 | |3;mootools.html;1440.87752541034;1464.9633759156027;1465.7434948883943;1486.8810495160387;1498.4755335632526;7067.1872734635535;7662.195469475709;7754.457187996843;7834;8624.913750862497;8043.758687239378;8338.207870252332;8344.91655083449;8434.789130271747;8440.029396619391;2286.3598192506124;2315.386422598013;2322.407786014564;2332.778386053331;2343.8359314847967;2290.6678531612906;2309.815214782813;2319.9768002320016;2324.337563794319;2331.813454923602;2337.614293641547;2339.9532009359805;2340.180936672168;2344.7772461616205;2353.6116540770754;2319.257837491995;2320.3271051395077;2328;2345.0971376020184;2348.295511346598;2324.779145981129;2354.128972280267;2388.8924998375114;2392.4497365606007;2397;8466.83066338676;8537.786555336104;8541.359398045171;8541.530215838126;8550.743477695616;5039.571636410909;5150.819721309774;5294.97352513235;5312.60155488336;5315.149576067811;3329.3840639481773;3388.525606415079;3502.176988407722;3513.841877115536;3581.7313701472494;1157.7742340243656;1223.5472875036205;1232.5562797392931;1240.355015392;1707.5389644795835;10686.465676716132;10871.075958543533;10920;10953.397563134024;10954.068904143078;4333.71830830995;4522.23122069249;4591.977040114845;4602.424696912886;4641.605463535638;8670;8704.738857834274;8764.342674299452;8775.210231079105;8786;5191.766370513336;5205.661631993984;5210.348706411699;5213.244079608436;5228.660137091077;4306.420699568782;4341.001569639001;4762.285657151455;4792;4813.78337974792;3182.2362632968384;3633.800140992271;3692.8892133236045;3769.8869033929027;3775;1136.2727854173336;1143.8284257361297;1154.492023509653;1157.1090260499368;1160.808466603001;914.8170365926841;925.9027802080819;931.5249222896372;945.3429866243033;954.8138113068024;4825.396825396825;5312.548433383128;5624.3813180550105;5668.433156684381;5729.341125770589;565.6832173982583;575.8042265629622;577.5812535911515;579.6203486716207;579.9507041901401;3742;3758.586555478895;3793.146542028077;3813.0276779421624;3873.5158105236846;9658.951705241569;10236.311008683633;10246.436445995541;10260.538275777608;10291.228157888188;10109.09018188352;10147.797044059078;10164.237682173867;10203.540840662188;10230.23273254494;7622;7911;8012.919870801334;8022.638981245858;8053.59732013397;5711.914321285267;5811;5833.912491312549;5862.882742345044;5918.852028699317;9164.95417522908;9286.535673216447;9292.395994260622;9433;9504.572294246636;9469;9570.712878613653;9590.328676992543;9657.661981830603;9703.757406064904;6690.933090669226;6888.0356750056035;7275.854482910418;7393.149787774475;7403.703851845866;7665.3101220890385;7908.802279943047;7936.880946785687;8007.239312265326;8027.799305017421;7078.221395646372;7194.100737407824;7241.5293005954445;7242.456815738736;7358.595277259802;7118.715251390094;7119.132358837527;7126.536775109601;7132.607706576188;7205.567665940061;5419.891602168013;6406.263279722892;6418.876696577987;6514.0880276760345;6519.250286217146;5017.54842064216;5052.343195384577;5094.745262736774;5095.108356037753;5159.226116082617;4602.355670206107;4605;4803.03939212152;4979.3277907482025;5214.921776173436 07:50:04 INFO - PROCESS | 1633 | |4;prototype.html;347.32618719683825;361.46864109758656;362.3531995388233;363.6835952721131;369.73748638466697;5009.922866583684;5021.522955319243;5160.741962901859;5451.836444906659;5596.188552659862;4314.6332561732215;4854.854354369366;5509.504144626982;5564.304461942257;5644.379118296984;3421.9486707699402;3919.7256192066566;4047.615476529725;4161.9583804161875;4194.790260486986;3746;3835.6931445484292;4007.937896457441;4151.854685086023;4168.6665066794585;3617.439296908983;4098.692598055143;4114.670826333886;4118.711690181688;4137.54487006429;3623.873164439245;3669.266146770643;3959.9010024749323;4136.400221967828;4159.480064991876;2979.2849716067985;3467.8156156545874;3495.2310491691787;3515.771474854126;3533.381658209803;5275.446078161776;5285.6300058995885;5317.654352467077;5318.574514038906;5323.574114070865;4144.730592511477;4505.864824055251;4686.172392766824;4702.905941881178;4704.623630109583;4833.951660483385;5516.724163791794;5718.48533631971;5794.913076303858;5970.462658360769;3731.8880433587037;3972.781497017663;4234.216669916075;4243.575642435762;4246.957530424687;5100.132977393852;5492.009126720652;5936.90353655976;5948.643081415129;6099.939000609981;4153.709240353146;4162.4598898407785;4248.299030659907;4254.234237837157;4320.848770293024;3634.9818250908575;3651.3427583034777;4363.38912552243;4382.123575284956;4393.0994146199955;4965.652404331734;5000.099982003274;5001.89996200074;5005.74971251436;5046.829863158803;4926.704397736147;4992.675476094042;5860.619059761188;5883.411658834082;5952.583319167703;1285.5500574798932;1285.884270415667;1321.7575479049663;1422.4523558430078;1429.0853853533747;953.7812687418998;983.5918093991056;983.8622592837008;990.7176454710373;1000.7798284377425;4933.98853235086;5195.67510284875;5254.791397978486;5263.815766448156;5286.54175808251;5688.40271771458;5936.8812623748145;5958.553108516879;5968.8810472282585;5976.551758618121;4430.977845110819;5259.474052594786;5418.458154184629;5419.810306639328;5475.507204351547;2469.900584503158;2475.5915273979954;2611.4515951649987;2716.619673245747;2841.4885320642484;5300.44345343741;5352.437994010651;5813.912791308134;5826.912596311059;6005.609635373774;5546.750396232179;5906.080523829773;5914.526837852962;5952.285725712855;5958.821235362946;5955.225820643375;5958.612690175125;5972.26804226778;5972.761089556456;5995.880082398415;5684.886302274014;5686.4029276926985;5733.971330143323;5768.481226451945;5773.220615216892;4990.975045124751;5381.901058587076;5470.206820010996;5482.4101010706445;5925.52595792327;6209.65846878408;6232.407921247474;6235.469985051322;6238.937610624017;6244.937550624617;3261.439769780711;3964.6630036447227;4002.239574480839;4005.9399109012807;4034.556198818069;5343.62594618373;5384.946150538444;5551.252130195579;5949.851253718692;5985.510866849862;4953.504649535018;4963.131451995814;5170.1986192140275;5402.972985135049;5809.9419005809405;4880.536349046835;5109.718965456936;5289.7619607117;5419.807642318684;5515.433983054576;5588.077967135378;5645.802396916089;5657.434256574475;5705.800296989585;5721.656700597978;5551.861203469945;5586.413426590312;5649.615844118217;5742.425757424224;5866.122840690938;4305.160493703697;5092.7199004053655;5472.2065300531995;5699.772009119754;5728.942710572841 07:50:04 INFO - PROCESS | 1633 | |5;yui.html;705.6859697434644;737.3069314844047;771.3019717155972;802.137701970382;828.3456069704936;15380.615484612876;15896.841031589709;15957.84042159578;15964.28160732767;15974.680506389865;12016.81974770377;14626.926865365685;14765.704685906276;14789.40842366304;14838.332275047622;688.4561196654637;710.3997122431537;862.7972426479772;867.5575456517174;888.1606881496988;869.1091631078164;885.3890815337429;888.1606881496988;889.208604342136;889.4707648948897;929.8837645294338;930.930180236485;937.4890684576922;939.0515579264958;946.7443790176649;927.3879239701832;927.3925578745932;928.0209379105075;932.0353434195642;936.0405584276172;602.4758460139662;664.3389827121996;680.7617333933133;688.0195721097466;705.4074577354995;14869.851301486955;15220.315085821165;15229.314680839278;15541;15728;14157.22135282559;14316.28418579067;14428.350724217435;14489.492867749683;14492.927535362362;9680.806383872354;11763.58827441044;11785.587504437304;11856.881431185664;11916.285022898654;3188.9202769930707;3665.8533658653623;3709.610490898444;3729.3224083503264;3881.961180388188;82004.58997704973;104345.47827260815;106954;107035.46482267539;107964.4601776994;10472.217123637656;10984.231103822816;11081.224314297922;11125.833112503318;11167.32996020225;18734.625307494047;23292.534149316918;23584.764152358257;23621;23702.814859256967;7582.279683430065;7632.771016869503;7659.61701914902;7661.961690191513;7738.056661997205;4137.689673274516;4188.4555007848785;4222.451081359465;4233.957660423418;4328.04782947751;3555.911102222465;3628.256207477461;3641.3809652359164;3643.7813731176216;3645.0158457216403;646.9514786391039;651.3649192037725;657.8881590129594;665.2150462454254;670.7484693240035;647.5208345824151;674.8312921769558;680.6274907831682;697.553565717941;705.9541129826545;9067.274618030673;9896.208303335716;10159.9492002541;10163;10549.525271362807;635.2313700422541;649.5972497051858;694.8645014222178;708.1290013283588;713.1584730018628;5022.447530771612;5024.995000999815;5045.722485263273;5059.215821547666;5068.120979663646;93807.53096234475;95641.52179239059;97449;97616;99935.50032249792;72661;75143.62428187934;85038.72441913377;87521.5623921889;87845;64939.675301624135;71187.64406178039;75563.62218188874;76082;76113;9686.515674216402;9689.757756055873;9690.75773105678;9713.514324283899;9721.416714997124;48479.27281090716;51110.74444627753;51534;52483;54859.80560777524;52603.73698131485;56523;68470.972935405;68811.3118868825;69290.30709692839;9511.66709165176;11757.176997610086;11925.986291165349;11949.163558550817;12082.214656047328;11624.186306958432;12753.61739147827;12998.740025199253;13159.53941612039;13543.59369218925;10574.836767955672;11020.787713351685;11841.28952262867;11898.821517677416;11994;11102.722431938942;13623.637636236297;13625.046246762631;13655.863441365856;13845.16928984264;12574.679658635712;12874.356282185667;13604.65988350299;13751.656208594864;13858.722825543635;11303.265287756598;11376.521052263153;11384.37385943781;11395.829062564235;11451.541938322374;9394.295427843075;11242.325460472397;11253.268537545033;11405.771884562428;11694.532218711496 07:50:04 INFO - PROCESS | 1633 | __end_tp_report 07:50:04 INFO - PROCESS | 1633 | __start_cc_report 07:50:04 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,386 07:50:04 INFO - PROCESS | 1633 | __end_cc_report 07:50:04 INFO - PROCESS | 1633 | __startTimestamp1484236204178__endTimestamp 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | ------- Summary: start ------- 07:50:04 INFO - PROCESS | 1633 | Number of tests: 6 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:5753.52 Median:5943.41 stddev:661.51 (11.1%) stddev-sans-first:636.39 07:50:04 INFO - PROCESS | 1633 | Values: 3362.6 3368.5 3386.7 3393.8 3407.7 5609.8 5636.2 5640.9 5649.2 5704.5 5623.4 5683.3 5743.7 5762.0 5774.7 5050.1 5095.5 5200.8 5254.6 5302.7 5173.4 5239.7 5252.5 5268.9 5305.0 5312.1 5336.6 5340.5 5345.8 5359.3 5134.9 5170.8 5207.4 5231.4 5307.5 5154.9 5186.7 5189.4 5201.4 5249.6 4722.5 5631.5 5652.4 5715.9 5787.7 5130.6 6324.7 6327.3 6356.1 6370.9 5192.8 6207.6 6222.3 6278.2 6334.6 5849.6 5883.6 5908.6 5922.6 5931.3 6255.4 6265.2 6270.7 6292.2 6332.3 6043.6 6076.3 6103.7 6136.7 6145.7 5240.2 6287.6 6288.8 6294.2 6361.7 5979.5 6006.2 6320.1 6325.9 6327.9 6135.0 6188.6 6245.0 6278.2 6327.9 4899.7 4902.6 4960.9 4961.4 5003.4 4398.4 4509.1 4513.9 4518.5 4521.9 5887.9 5894.9 5902.9 5921.7 5943.8 6205.3 6287.4 6293.0 6300.9 6327.3 5717.3 5795.3 5803.1 5819.0 5865.2 5538.9 5541.1 5555.9 5581.6 5617.8 6270.9 6393.1 6401.6 6403.6 6414.2 6229.5 6243.3 6265.2 6302.1 6327.5 6305.6 6382.6 6384.2 6411.1 6417.1 6283.3 6291.0 6301.2 6305.8 6313.4 6205.5 6256.6 6260.2 6287.0 6321.2 4767.6 6132.8 6137.4 6162.5 6207.3 4517.4 5722.4 6070.2 6237.3 6248.6 5890.6 5934.9 5943.4 5984.2 6013.8 6140.4 6143.5 6144.5 6149.4 6160.4 6133.0 6136.4 6142.8 6155.4 6190.0 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:62384.74 Median:38182.81 stddev:126216.01 (330.6%) stddev-sans-first:126484.36 07:50:04 INFO - PROCESS | 1633 | Values: 427.7 453.2 478.2 511.4 526.9 39572.4 41338.0 41479.6 41511.8 41521.6 41932.0 42012.0 42549.4 42640.8 42676.6 7705.2 8133.3 8326.5 9286.5 9303.7 10999.5 11282.9 11323.2 11392.2 11436.1 9537.3 11187.8 11221.9 11288.4 11298.3 11219.3 11225.7 11235.1 11238.9 11270.5 11077.3 11109.2 11130.3 11164.1 11219.8 40596.4 40887.4 40933.8 40954.2 40975.4 4003.8 4021.7 4030.3 4031.9 4049.6 28983.0 31160.7 31202.0 31434.8 31444.2 2371.7 3111.2 3312.4 3313.5 3340.9 349991.0 351864.5 352606.0 353014.0 353344.0 64963.7 65189.7 65335.7 65524.0 65549.7 67620.3 68061.3 68077.7 68615.3 68739.3 16399.9 16541.8 16619.6 16627.4 16686.8 11372.4 11575.5 12410.9 12572.4 12715.4 19290.0 19388.7 19442.9 19486.3 19525.0 6677.0 7603.3 7978.3 7990.7 7993.8 785.9 823.3 873.0 890.2 901.4 29514.0 29889.7 30177.2 30262.5 30571.4 944.5 1080.2 1081.8 1102.7 1109.7 15490.1 15533.6 15566.8 15771.8 15906.2 550037.0 556891.0 563401.0 564349.0 567268.0 60801.0 61001.4 61082.0 61190.7 61292.7 1367.2 1453.4 1476.7 1486.9 1496.5 23402.0 28037.7 29102.4 29288.3 29318.4 51246.0 51490.7 51624.0 51652.5 51945.0 477161.0 486690.0 487170.0 493697.0 495148.0 26106.7 26165.0 26477.5 26527.5 26568.7 47232.5 47591.3 47721.0 47770.5 48113.0 38935.4 39305.4 39771.4 40674.0 40989.6 38730.4 38789.6 39244.0 40215.0 40322.4 37034.9 37944.2 38171.8 38193.8 38195.4 33558.0 33893.0 34732.1 34930.5 35029.6 24118.5 24231.5 24711.4 24880.4 25736.5 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:38777.81 Median:21870.90 stddev:117471.33 (537.1%) stddev-sans-first:117765.43 07:50:04 INFO - PROCESS | 1633 | Values: 347.7 388.4 390.3 403.8 422.3 19240.8 19566.8 20901.0 20909.0 20933.8 21035.9 21166.8 21372.9 22045.2 22054.9 5496.2 5886.4 5921.6 5956.1 5979.9 5876.7 5882.4 5892.4 5964.9 5983.0 5807.5 5883.3 5886.2 5899.8 5950.6 5669.6 5801.2 5880.4 5916.9 5920.9 5173.1 5185.6 5187.2 5194.7 5198.7 22307.1 24336.4 24484.4 26050.5 26401.3 2709.4 2766.2 2791.2 2792.1 2796.9 15631.6 15674.7 15688.2 15751.9 16012.4 1826.4 1879.7 1881.3 1888.0 1898.3 116419.0 116913.4 116994.0 117249.0 117973.4 8647.0 10371.6 11623.1 11778.5 12029.9 14154.8 14328.6 14337.3 14338.6 14346.6 7399.9 8399.9 8646.5 8771.7 8774.5 7600.9 8105.5 8597.5 8603.7 8770.6 6465.7 6718.8 7141.6 7253.4 7274.3 1647.5 1992.7 1994.6 1996.4 1999.1 1060.3 1073.0 1074.2 1080.8 1119.7 19763.0 21696.6 22467.7 22517.5 22738.7 968.2 992.0 1094.8 1102.9 1104.8 9842.6 11841.5 12065.8 12083.3 12087.2 692101.0 701970.5 708636.0 712023.0 732795.0 101842.0 121728.4 128953.7 132158.0 135175.0 1002.6 1012.4 1032.8 1035.6 1036.6 19434.3 19916.2 20133.7 21132.0 21265.5 51823.7 57340.7 61040.4 64605.0 65596.0 66831.0 89357.6 89953.6 90150.5 91256.0 7511.0 8123.8 8426.4 8689.7 8840.6 12860.2 12973.0 13448.6 13948.7 14157.3 11330.7 11375.9 11477.3 11598.2 11787.0 10292.0 11177.8 11506.8 11544.1 11833.2 11279.6 11726.1 11855.5 12096.6 12181.7 5894.8 7680.0 8532.5 8803.8 8818.9 10434.9 11744.5 12011.8 12056.3 12070.4 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:5439.90 Median:5175.50 stddev:2985.69 (57.7%) stddev-sans-first:2978.94 07:50:04 INFO - PROCESS | 1633 | Values: 1440.9 1465.0 1465.7 1486.9 1498.5 7067.2 7662.2 7754.5 7834.0 8624.9 8043.8 8338.2 8344.9 8434.8 8440.0 2286.4 2315.4 2322.4 2332.8 2343.8 2290.7 2309.8 2320.0 2324.3 2331.8 2337.6 2340.0 2340.2 2344.8 2353.6 2319.3 2320.3 2328.0 2345.1 2348.3 2324.8 2354.1 2388.9 2392.4 2397.0 8466.8 8537.8 8541.4 8541.5 8550.7 5039.6 5150.8 5295.0 5312.6 5315.1 3329.4 3388.5 3502.2 3513.8 3581.7 1157.8 1223.5 1232.6 1240.4 1707.5 10686.5 10871.1 10920.0 10953.4 10954.1 4333.7 4522.2 4592.0 4602.4 4641.6 8670.0 8704.7 8764.3 8775.2 8786.0 5191.8 5205.7 5210.3 5213.2 5228.7 4306.4 4341.0 4762.3 4792.0 4813.8 3182.2 3633.8 3692.9 3769.9 3775.0 1136.3 1143.8 1154.5 1157.1 1160.8 914.8 925.9 931.5 945.3 954.8 4825.4 5312.5 5624.4 5668.4 5729.3 565.7 575.8 577.6 579.6 580.0 3742.0 3758.6 3793.1 3813.0 3873.5 9659.0 10236.3 10246.4 10260.5 10291.2 10109.1 10147.8 10164.2 10203.5 10230.2 7622.0 7911.0 8012.9 8022.6 8053.6 5711.9 5811.0 5833.9 5862.9 5918.9 9165.0 9286.5 9292.4 9433.0 9504.6 9469.0 9570.7 9590.3 9657.7 9703.8 6690.9 6888.0 7275.9 7393.1 7403.7 7665.3 7908.8 7936.9 8007.2 8027.8 7078.2 7194.1 7241.5 7242.5 7358.6 7118.7 7119.1 7126.5 7132.6 7205.6 5419.9 6406.3 6418.9 6514.1 6519.3 5017.5 5052.3 5094.7 5095.1 5159.2 4602.4 4605.0 4803.0 4979.3 5214.9 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4634.83 Median:5225.23 stddev:1426.54 (27.3%) stddev-sans-first:1393.77 07:50:04 INFO - PROCESS | 1633 | Values: 347.3 361.5 362.4 363.7 369.7 5009.9 5021.5 5160.7 5451.8 5596.2 4314.6 4854.9 5509.5 5564.3 5644.4 3421.9 3919.7 4047.6 4162.0 4194.8 3746.0 3835.7 4007.9 4151.9 4168.7 3617.4 4098.7 4114.7 4118.7 4137.5 3623.9 3669.3 3959.9 4136.4 4159.5 2979.3 3467.8 3495.2 3515.8 3533.4 5275.4 5285.6 5317.7 5318.6 5323.6 4144.7 4505.9 4686.2 4702.9 4704.6 4834.0 5516.7 5718.5 5794.9 5970.5 3731.9 3972.8 4234.2 4243.6 4247.0 5100.1 5492.0 5936.9 5948.6 6099.9 4153.7 4162.5 4248.3 4254.2 4320.8 3635.0 3651.3 4363.4 4382.1 4393.1 4965.7 5000.1 5001.9 5005.7 5046.8 4926.7 4992.7 5860.6 5883.4 5952.6 1285.6 1285.9 1321.8 1422.5 1429.1 953.8 983.6 983.9 990.7 1000.8 4934.0 5195.7 5254.8 5263.8 5286.5 5688.4 5936.9 5958.6 5968.9 5976.6 4431.0 5259.5 5418.5 5419.8 5475.5 2469.9 2475.6 2611.5 2716.6 2841.5 5300.4 5352.4 5813.9 5826.9 6005.6 5546.8 5906.1 5914.5 5952.3 5958.8 5955.2 5958.6 5972.3 5972.8 5995.9 5684.9 5686.4 5734.0 5768.5 5773.2 4991.0 5381.9 5470.2 5482.4 5925.5 6209.7 6232.4 6235.5 6238.9 6244.9 3261.4 3964.7 4002.2 4005.9 4034.6 5343.6 5384.9 5551.3 5949.9 5985.5 4953.5 4963.1 5170.2 5403.0 5809.9 4880.5 5109.7 5289.8 5419.8 5515.4 5588.1 5645.8 5657.4 5705.8 5721.7 5551.9 5586.4 5649.6 5742.4 5866.1 4305.2 5092.7 5472.2 5699.8 5728.9 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:19665.65 Median:5023.72 stddev:27795.21 (553.3%) stddev-sans-first:27836.73 07:50:04 INFO - PROCESS | 1633 | Values: 705.7 737.3 771.3 802.1 828.3 15380.6 15896.8 15957.8 15964.3 15974.7 12016.8 14626.9 14765.7 14789.4 14838.3 688.5 710.4 862.8 867.6 888.2 869.1 885.4 888.2 889.2 889.5 929.9 930.9 937.5 939.1 946.7 927.4 927.4 928.0 932.0 936.0 602.5 664.3 680.8 688.0 705.4 14869.9 15220.3 15229.3 15541.0 15728.0 14157.2 14316.3 14428.4 14489.5 14492.9 9680.8 11763.6 11785.6 11856.9 11916.3 3188.9 3665.9 3709.6 3729.3 3882.0 82004.6 104345.5 106954.0 107035.5 107964.5 10472.2 10984.2 11081.2 11125.8 11167.3 18734.6 23292.5 23584.8 23621.0 23702.8 7582.3 7632.8 7659.6 7662.0 7738.1 4137.7 4188.5 4222.5 4234.0 4328.0 3555.9 3628.3 3641.4 3643.8 3645.0 647.0 651.4 657.9 665.2 670.7 647.5 674.8 680.6 697.6 706.0 9067.3 9896.2 10159.9 10163.0 10549.5 635.2 649.6 694.9 708.1 713.2 5022.4 5025.0 5045.7 5059.2 5068.1 93807.5 95641.5 97449.0 97616.0 99935.5 72661.0 75143.6 85038.7 87521.6 87845.0 64939.7 71187.6 75563.6 76082.0 76113.0 9686.5 9689.8 9690.8 9713.5 9721.4 48479.3 51110.7 51534.0 52483.0 54859.8 52603.7 56523.0 68471.0 68811.3 69290.3 9511.7 11757.2 11926.0 11949.2 12082.2 11624.2 12753.6 12998.7 13159.5 13543.6 10574.8 11020.8 11841.3 11898.8 11994.0 11102.7 13623.6 13625.0 13655.9 13845.2 12574.7 12874.4 13604.7 13751.7 13858.7 11303.3 11376.5 11384.4 11395.8 11451.5 9394.3 11242.3 11253.3 11405.8 11694.5 07:50:04 INFO - PROCESS | 1633 | -------- Summary: end -------- 07:50:04 INFO - PROCESS | 1633 | 07:50:04 INFO - TEST-INFO | 1633: exit 0 07:50:04 INFO - TEST-OK | dromaeo_css | took 1115434ms 07:50:04 INFO - TEST-START | kraken 07:50:04 INFO - operating with platform_type : mac_ 07:50:04 INFO - Initialising browser for kraken test... 07:50:04 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpEPY2qd/profile http://localhost:49241/getInfo.html) 07:50:07 INFO - PROCESS | 1645 | 2017-01-12 07:50:07.577 plugin-container[1646:10317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 07:50:07 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:50:07 INFO - PROCESS | 1645 | 2017-01-12 07:50:07.580 plugin-container[1646:10317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 07:50:07 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:50:07 INFO - PROCESS | 1645 | 2017-01-12 07:50:07.580 plugin-container[1646:10317] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:50:07 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 07:50:07 INFO - PROCESS | 1645 | colorDepth:24 07:50:07 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 07:50:07 INFO - PROCESS | 1645 | __metrics 07:50:07 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3242: TypeError: this.tabs is undefined 07:50:08 INFO - TEST-INFO | 1645: exit 0 07:50:08 INFO - Browser initialized. 07:50:08 INFO - Running cycle 1/1 for kraken test... 07:50:08 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpEPY2qd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:10 INFO - PROCESS | 1647 | 2017-01-12 07:50:10.948 plugin-container[1648:10436] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:50:10 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:50:10 INFO - PROCESS | 1647 | 2017-01-12 07:50:10.949 plugin-container[1648:10436] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4427, name = 'com.apple.CFPasteboardClient' 07:50:10 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:50:10 INFO - PROCESS | 1647 | 2017-01-12 07:50:10.949 plugin-container[1648:10436] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:50:20 INFO - PROCESS | 1647 | RSS: Main: 233304064 07:50:20 INFO - PROCESS | 1647 | 07:50:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:50:24 INFO - PROCESS | 1647 | RSS: Main: 246046720 07:50:24 INFO - PROCESS | 1647 | 07:50:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:50:28 INFO - PROCESS | 1647 | RSS: Main: 254169088 07:50:28 INFO - PROCESS | 1647 | 07:50:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:50:32 INFO - PROCESS | 1647 | RSS: Main: 256811008 07:50:32 INFO - PROCESS | 1647 | 07:50:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:50:34 INFO - PROCESS | 1647 | RSS: Main: 259006464 07:50:34 INFO - PROCESS | 1647 | 07:50:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:37 INFO - PROCESS | 1647 | RSS: Main: 259670016 07:50:37 INFO - PROCESS | 1647 | 07:50:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:40 INFO - PROCESS | 1647 | RSS: Main: 265961472 07:50:40 INFO - PROCESS | 1647 | 07:50:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:44 INFO - PROCESS | 1647 | RSS: Main: 264245248 07:50:44 INFO - PROCESS | 1647 | 07:50:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:50:47 INFO - PROCESS | 1647 | RSS: Main: 264196096 07:50:47 INFO - PROCESS | 1647 | 07:50:49 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:50 INFO - PROCESS | 1647 | RSS: Main: 263557120 07:50:50 INFO - PROCESS | 1647 | 07:50:52 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:52 INFO - PROCESS | 1647 | RSS: Main: 263548928 07:50:52 INFO - PROCESS | 1647 | 07:50:55 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:55 INFO - PROCESS | 1647 | RSS: Main: 263606272 07:50:55 INFO - PROCESS | 1647 | 07:50:58 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:59 INFO - PROCESS | 1647 | RSS: Main: 263868416 07:50:59 INFO - PROCESS | 1647 | 07:51:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:51:03 INFO - PROCESS | 1647 | RSS: Main: 264019968 07:51:03 INFO - PROCESS | 1647 | 07:51:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:51:05 INFO - PROCESS | 1647 | RSS: Main: 265912320 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | __start_tp_report 07:51:05 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 07:51:05 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 07:51:05 INFO - PROCESS | 1647 | |i|pagename|runs| 07:51:05 INFO - PROCESS | 1647 | |0;ai-astar;142;176;98;164;174;176;119;118;117;118 07:51:05 INFO - PROCESS | 1647 | |1;audio-beat-detection;140;110;116;149;113;115;111;138;163;117 07:51:05 INFO - PROCESS | 1647 | |2;audio-dft;209;260;284;230;198;197;198;199;197;196 07:51:05 INFO - PROCESS | 1647 | |3;audio-fft;84;57;58;95;73;84;59;60;63;61 07:51:05 INFO - PROCESS | 1647 | |4;audio-oscillator;84;68;85;74;71;72;82;73;72;82 07:51:05 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;90;86;89;87;90;93;137;88;88;87 07:51:05 INFO - PROCESS | 1647 | |6;imaging-darkroom;95;95;95;125;95;95;93;108;95;94 07:51:05 INFO - PROCESS | 1647 | |7;imaging-desaturate;92;95;92;92;96;90;92;92;92;93 07:51:05 INFO - PROCESS | 1647 | |8;json-parse-financial;60;61;60;69;78;94;96;96;98;81 07:51:05 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;70;70;73;87;77;77;71;73;75;104 07:51:05 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;92;88;89;101;91;78;100;114;82;95 07:51:05 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;147;140;140;140;141;143;142;140;193;155 07:51:05 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;173;227;180;176;176;176;174;178;175;204 07:51:05 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;68;82;80;95;89;70;67;82;67;69 07:51:05 INFO - PROCESS | 1647 | __end_tp_report 07:51:05 INFO - PROCESS | 1647 | __start_cc_report 07:51:05 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,938 07:51:05 INFO - PROCESS | 1647 | __end_cc_report 07:51:05 INFO - PROCESS | 1647 | __startTimestamp1484236265219__endTimestamp 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | ------- Summary: start ------- 07:51:05 INFO - PROCESS | 1647 | Number of tests: 14 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:140.20 Median:169.00 stddev:29.87 (17.7%) stddev-sans-first:31.67 07:51:05 INFO - PROCESS | 1647 | Values: 142.0 176.0 98.0 164.0 174.0 176.0 119.0 118.0 117.0 118.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:127.50 stddev:18.78 (14.7%) stddev-sans-first:19.34 07:51:05 INFO - PROCESS | 1647 | Values: 140.0 110.0 116.0 149.0 113.0 115.0 111.0 138.0 163.0 117.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:216.80 Median:204.00 stddev:31.37 (15.4%) stddev-sans-first:33.15 07:51:05 INFO - PROCESS | 1647 | Values: 209.0 260.0 284.0 230.0 198.0 197.0 198.0 199.0 197.0 196.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:69.40 Median:68.00 stddev:13.69 (20.1%) stddev-sans-first:13.46 07:51:05 INFO - PROCESS | 1647 | Values: 84.0 57.0 58.0 95.0 73.0 84.0 59.0 60.0 63.0 61.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:78.00 stddev:6.24 (8.0%) stddev-sans-first:5.96 07:51:05 INFO - PROCESS | 1647 | Values: 84.0 68.0 85.0 74.0 71.0 72.0 82.0 73.0 72.0 82.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:88.50 stddev:15.41 (17.4%) stddev-sans-first:16.30 07:51:05 INFO - PROCESS | 1647 | Values: 90.0 86.0 89.0 87.0 90.0 93.0 137.0 88.0 88.0 87.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:99.00 Median:95.00 stddev:10.08 (10.6%) stddev-sans-first:10.58 07:51:05 INFO - PROCESS | 1647 | Values: 95.0 95.0 95.0 125.0 95.0 95.0 93.0 108.0 95.0 94.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:92.00 stddev:1.71 (1.9%) stddev-sans-first:1.80 07:51:05 INFO - PROCESS | 1647 | Values: 92.0 95.0 92.0 92.0 96.0 90.0 92.0 92.0 92.0 93.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:79.30 Median:87.50 stddev:16.04 (18.3%) stddev-sans-first:15.41 07:51:05 INFO - PROCESS | 1647 | Values: 60.0 61.0 60.0 69.0 78.0 94.0 96.0 96.0 98.0 81.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:74.00 stddev:10.51 (14.2%) stddev-sans-first:10.77 07:51:05 INFO - PROCESS | 1647 | Values: 70.0 70.0 73.0 87.0 77.0 77.0 71.0 73.0 75.0 104.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:88.50 stddev:10.27 (11.6%) stddev-sans-first:10.89 07:51:05 INFO - PROCESS | 1647 | Values: 92.0 88.0 89.0 101.0 91.0 78.0 100.0 114.0 82.0 95.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:142.50 stddev:16.47 (11.6%) stddev-sans-first:17.46 07:51:05 INFO - PROCESS | 1647 | Values: 147.0 140.0 140.0 140.0 141.0 143.0 142.0 140.0 193.0 155.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:177.00 stddev:17.62 (10.0%) stddev-sans-first:18.24 07:51:05 INFO - PROCESS | 1647 | Values: 173.0 227.0 180.0 176.0 176.0 176.0 174.0 178.0 175.0 204.0 07:51:05 INFO - PROCESS | 1647 | 07:51:05 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:81.00 stddev:10.12 (12.5%) stddev-sans-first:10.20 07:51:05 INFO - PROCESS | 1647 | Values: 68.0 82.0 80.0 95.0 89.0 70.0 67.0 82.0 67.0 69.0 07:51:05 INFO - PROCESS | 1647 | -------- Summary: end -------- 07:51:05 INFO - PROCESS | 1647 | 07:51:06 INFO - TEST-INFO | 1647: exit 0 07:51:06 INFO - TEST-OK | kraken | took 61276ms 07:51:06 INFO - SUITE-END | took 1176s 07:51:06 INFO - Completed test suite (00:19:36) 07:51:06 INFO - javascript benchmark 07:51:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7353.451906989236, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3362.6132994705617, 3368.4778859276807, 3386.661333866614, 3393.7624366294367, 3407.710344620707, 5609.775608975641, 5636.239107720457, 5640.887182256358, 5649.18086877403, 5704.486596206351, 5623.353314368849, 5683.2895888014, 5743.655380677163, 5762.0, 5774.740136693848, 5050.116229659813, 5095.541401273885, 5200.791968321262, 5254.57963362932, 5302.681839089648, 5173.430922598511, 5239.711815850127, 5252.474752524736, 5268.9473105269035, 5305.018571564254, 5312.096943519611, 5336.59975501837, 5340.519353258206, 5345.839624811262, 5359.276497672823, 5134.871628209287, 5170.767315470813, 5207.3751149862255, 5231.424543300234, 5307.495787900143, 5154.865929495505, 5186.688798672092, 5189.351331083614, 5201.427842937273, 5249.580033597303, 4722.504137065593, 5631.493165615114, 5652.378238393773, 5715.942840571624, 5787.739551720183, 5130.563902068328, 6324.7470101195895, 6327.335629758855, 6356.0783686365685, 6370.90443643341, 5192.844214673528, 6207.596506227081, 6222.253329600477, 6278.183836101278, 6334.619922804646, 5849.561282903799, 5883.588148829541, 5908.615939963888, 5922.615030023035, 5931.317898441648, 6255.43701066897, 6265.248170219512, 6270.6864656766975, 6292.244930608264, 6332.303446620868, 6043.607165534227, 6076.3316035236085, 6103.694815259308, 6136.723847426876, 6145.66198859067, 5240.187770895517, 6287.622742635456, 6288.811335659846, 6294.181756371734, 6361.681915904186, 5979.4917432018765, 6006.2191915051635, 6320.146780184708, 6325.9051114233325, 6327.873442531123, 6135.018317212141, 6188.566800324024, 6244.969580019337, 6278.183836101369, 6327.936720632827, 4899.730514821719, 4902.583280421133, 4960.875978100504, 4961.355023846877, 5003.399592048978, 4398.428204333481, 4509.120721459284, 4513.864584062483, 4518.548145185521, 4521.909561808746, 5887.911681324784, 5894.911576326359, 5902.911456328158, 5921.6743079131065, 5943.791967281124, 6205.317415084337, 6287.371262873768, 6292.968535157386, 6300.905486417708, 6327.272363678144, 5717.256756621696, 5795.275590551181, 5803.100519419497, 5818.970905145447, 5865.20819689345, 5538.892221555705, 5541.113421852565, 5555.916661250085, 5581.637193582485, 5617.775288988477, 6270.905936410866, 6393.073004414334, 6401.615903045739, 6403.64779937108, 6414.166158399472, 6229.5327850410495, 6243.313235544178, 6265.248170219603, 6302.1492098566105, 6327.462165715781, 6305.621662700252, 6382.648954307558, 6384.170057892445, 6411.070394792822, 6417.133686952202, 6283.3402492737605, 6291.0, 6301.243850737941, 6305.842353941188, 6313.400226978613, 6205.47253483459, 6256.562040657111, 6260.154879091265, 6286.968565157145, 6321.178246828067, 4767.642426818072, 6132.814448934826, 6137.376985335611, 6162.506999440124, 6207.286162091417, 4517.367568540472, 5722.4277572242445, 6070.180525628984, 6237.345078766664, 6248.625082495065, 5890.558208134493, 5934.9406505934385, 5943.405659434022, 5984.1921340618455, 6013.789517366871, 6140.381550881072, 6143.508519318533, 6144.463884028993, 6149.354317796567, 6160.383961603983, 6132.967444181115, 6136.404534821068, 6142.788596105488, 6155.384461553809, 6190.0405437157315], "value": 5713.373233534371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.70488363029506, 453.193315897702, 478.23004962011134, 511.41187634220665, 526.9235960785686, 39572.40641390378, 41338.0, 41479.58520414795, 41511.79244103779, 41521.584784152146, 41932.0, 42012.0, 42549.36175957363, 42640.78679606605, 42676.57323426772, 7705.190954949734, 8133.349332053451, 8326.500409975391, 9286.489243091628, 9303.674371397003, 10999.505022274017, 11282.887171128306, 11323.150763692756, 11392.202545821754, 11436.085113190924, 9537.284703647254, 11187.832182517268, 11221.943890280538, 11288.435578221097, 11298.322100673944, 11219.326840389604, 11225.66323010307, 11235.101191904629, 11238.887611123866, 11270.492827822767, 11077.279976801483, 11109.166812489015, 11130.276532025393, 11164.051055660279, 11219.775604487946, 40596.39105413421, 40887.38668919969, 40933.771986840446, 40954.1809163818, 40975.38536921948, 4003.7597744135446, 4021.718479706422, 4030.2544029354663, 4031.858884939013, 4049.617470103252, 28982.985595504055, 31160.688393116234, 31202.0, 31434.842825785723, 31444.21389465259, 2371.703537057868, 3111.23774675206, 3312.38720836646, 3313.486409606515, 3340.88306909257, 349991.0, 351864.4813551883, 352606.0, 353014.0, 353344.0, 64963.67518162379, 65189.67405163038, 65335.673321634036, 65524.0, 65549.67225163843, 67620.32379676239, 68061.3193868055, 68077.65961170163, 68615.3138468609, 68739.3126068733, 16399.91800040992, 16541.751873721903, 16619.584510387096, 16627.418040368528, 16686.83313166853, 11372.431378431045, 11575.536978520764, 12410.875891240972, 12572.4342404592, 12715.364231788373, 19290.0, 19388.70916936247, 19442.90278548598, 19486.317978870957, 19525.0, 6677.0, 7603.315701586884, 7978.281954624112, 7990.68037278514, 7993.760187194393, 785.9115125551153, 823.2878560045517, 872.9738107856774, 890.1810334492283, 901.4275934781462, 29513.967011154935, 29889.701102989126, 30177.245568860515, 30262.54606180909, 30571.388572228876, 944.475815922156, 1080.2438293194796, 1081.789051135021, 1102.671281106265, 1109.7059279290995, 15490.07059576429, 15533.611659708371, 15566.84433155654, 15771.842281577037, 15906.204689765465, 550037.0, 556891.0, 563401.0, 564349.0, 567268.0, 60801.0, 61001.38998610046, 61082.0, 61190.69404652948, 61292.69353653203, 1367.2480135925202, 1453.3605213705935, 1476.7415702252279, 1486.8959172857797, 1496.5360738170984, 23402.0, 28037.71962280351, 29102.417951640426, 29288.26779330534, 29318.41363172682, 51246.0, 51490.74254628703, 51624.0, 51652.483475164765, 51945.0, 477161.0, 486690.0, 487170.0, 493697.0, 495148.0, 26106.73893261043, 26165.0, 26477.470450591267, 26527.469450611265, 26568.734312656627, 47232.52767472281, 47591.286130707376, 47721.01499514809, 47770.52229477661, 48113.0, 38935.41596876106, 39305.41041884431, 39771.40342894801, 40674.0, 40989.59010409858, 38730.41904371493, 38789.6121038786, 39244.0, 40215.0, 40322.395164071975, 37034.88895333144, 37944.24111517699, 38171.80914095523, 38193.80903095467, 38195.42706859455, 33558.0, 33893.0, 34732.13169670779, 34930.47604285989, 35029.64970350264, 24118.517629646958, 24231.515369692155, 24711.38221544476, 24880.37799055038, 25736.485270294863], "value": 20068.58515503811, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.65234765234766, 388.43482732624017, 390.2958694494216, 403.81626360006203, 422.3221729124755, 19240.807591924076, 19566.804331956675, 20900.954952252403, 20909.0, 20933.790662093357, 21035.948202589847, 21166.788332116674, 21372.89313553434, 22045.228417005408, 22054.88972555139, 5496.230527726111, 5886.4113588641, 5921.585489015771, 5956.076808094752, 5979.880402391949, 5876.711918247477, 5882.382349853268, 5892.3812999635065, 5964.940350596504, 5982.970085149568, 5807.477327040566, 5883.264591926009, 5886.234789477383, 5899.820035992797, 5950.55370847186, 5669.639286571234, 5801.216835727165, 5880.353161152269, 5916.88166236675, 5920.940790592103, 5173.120569503193, 5185.585153187736, 5187.221916712486, 5194.662346947474, 5198.6880787152895, 22307.107715691352, 24336.39159021021, 24484.387890302707, 26050.478990420084, 26401.3399665008, 2709.403931135147, 2766.170148955305, 2791.1766029021487, 2792.0786140573564, 2796.9440611187865, 15631.609209769847, 15674.68650626981, 15688.215589220608, 15751.921240393725, 16012.439564615182, 1826.4246762269843, 1879.7274395212755, 1881.294514557041, 1888.0, 1898.2596787252983, 116419.0, 116913.41543292314, 116994.0, 117249.0, 117973.41013294879, 8647.0, 10371.585136594602, 11623.12826537996, 11778.52885884555, 12029.939850300692, 14154.787678184835, 14328.570142895729, 14337.283135843167, 14338.56984290473, 14346.56960291193, 7399.926000739923, 8399.874001889977, 8646.524441155796, 8771.692990745294, 8774.473531587997, 7600.885986710204, 8105.513669179868, 8597.52713600758, 8603.655853765904, 8770.561471926378, 6465.709043092978, 6718.764843230463, 7141.571505709674, 7253.419726421979, 7274.30894065063, 1647.4563394080164, 1992.7309813175325, 1994.6409646263521, 1996.4310171601023, 1999.1303782854213, 1060.2631171336002, 1073.0, 1074.231924174219, 1080.8000519903842, 1119.7256672115384, 19763.0, 21696.566068678538, 22467.662985055238, 22517.549649007255, 22738.658920116213, 968.2157452463528, 992.0179022767409, 1094.8412480190327, 1102.8897110288906, 1104.7956128116325, 9842.60629574809, 11841.526338946518, 12065.758684826429, 12083.275003499819, 12087.214331068453, 692101.0, 701970.4901475562, 708636.0, 712023.0, 732795.0, 101842.0, 121728.39135804442, 128953.71046289605, 132158.0, 135175.0, 1002.5989604158249, 1012.4128005756644, 1032.7624646331385, 1035.5805898611075, 1036.6060896859296, 19434.319798806973, 19916.164397152796, 20133.697994530386, 21132.0, 21265.468363291042, 51823.74088129535, 57340.71329643325, 61040.38959610525, 64605.0, 65596.0, 66831.0, 89357.55321223353, 89953.55023225104, 90150.54924725334, 91256.0, 7511.0, 8123.7969050771835, 8426.41015128935, 8689.739307820775, 8840.646374144962, 12860.228386296852, 12973.0, 13448.596542103753, 13948.721025579229, 14157.292135392983, 11330.716732081433, 11375.886241137483, 11477.253978491372, 11598.18812683104, 11787.0, 10292.0, 11177.776444471228, 11506.769864602493, 11544.076473882238, 11833.230839995373, 11279.605213817476, 11726.120540959633, 11855.525778968744, 12096.576619818265, 12181.69545761363, 5894.823155305347, 7680.0, 8532.488050716976, 8803.823923521622, 8818.927552025141, 10434.947825260826, 11744.530218791495, 12011.75976480448, 12056.276623402624, 12070.396480175781], "value": 10129.947352804451, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.87752541034, 1464.9633759156027, 1465.7434948883943, 1486.8810495160387, 1498.4755335632526, 7067.1872734635535, 7662.195469475709, 7754.457187996843, 7834.0, 8624.913750862497, 8043.758687239378, 8338.207870252332, 8344.91655083449, 8434.789130271747, 8440.029396619391, 2286.3598192506124, 2315.386422598013, 2322.407786014564, 2332.778386053331, 2343.8359314847967, 2290.6678531612906, 2309.815214782813, 2319.9768002320016, 2324.337563794319, 2331.813454923602, 2337.614293641547, 2339.9532009359805, 2340.180936672168, 2344.7772461616205, 2353.6116540770754, 2319.257837491995, 2320.3271051395077, 2328.0, 2345.0971376020184, 2348.295511346598, 2324.779145981129, 2354.128972280267, 2388.8924998375114, 2392.4497365606007, 2397.0, 8466.83066338676, 8537.786555336104, 8541.359398045171, 8541.530215838126, 8550.743477695616, 5039.571636410909, 5150.819721309774, 5294.97352513235, 5312.60155488336, 5315.149576067811, 3329.3840639481773, 3388.525606415079, 3502.176988407722, 3513.841877115536, 3581.7313701472494, 1157.7742340243656, 1223.5472875036205, 1232.5562797392931, 1240.355015392, 1707.5389644795835, 10686.465676716132, 10871.075958543533, 10920.0, 10953.397563134024, 10954.068904143078, 4333.71830830995, 4522.23122069249, 4591.977040114845, 4602.424696912886, 4641.605463535638, 8670.0, 8704.738857834274, 8764.342674299452, 8775.210231079105, 8786.0, 5191.766370513336, 5205.661631993984, 5210.348706411699, 5213.244079608436, 5228.660137091077, 4306.420699568782, 4341.001569639001, 4762.285657151455, 4792.0, 4813.78337974792, 3182.2362632968384, 3633.800140992271, 3692.8892133236045, 3769.8869033929027, 3775.0, 1136.2727854173336, 1143.8284257361297, 1154.492023509653, 1157.1090260499368, 1160.808466603001, 914.8170365926841, 925.9027802080819, 931.5249222896372, 945.3429866243033, 954.8138113068024, 4825.396825396825, 5312.548433383128, 5624.3813180550105, 5668.433156684381, 5729.341125770589, 565.6832173982583, 575.8042265629622, 577.5812535911515, 579.6203486716207, 579.9507041901401, 3742.0, 3758.586555478895, 3793.146542028077, 3813.0276779421624, 3873.5158105236846, 9658.951705241569, 10236.311008683633, 10246.436445995541, 10260.538275777608, 10291.228157888188, 10109.09018188352, 10147.797044059078, 10164.237682173867, 10203.540840662188, 10230.23273254494, 7622.0, 7911.0, 8012.919870801334, 8022.638981245858, 8053.59732013397, 5711.914321285267, 5811.0, 5833.912491312549, 5862.882742345044, 5918.852028699317, 9164.95417522908, 9286.535673216447, 9292.395994260622, 9433.0, 9504.572294246636, 9469.0, 9570.712878613653, 9590.328676992543, 9657.661981830603, 9703.757406064904, 6690.933090669226, 6888.0356750056035, 7275.854482910418, 7393.149787774475, 7403.703851845866, 7665.3101220890385, 7908.802279943047, 7936.880946785687, 8007.239312265326, 8027.799305017421, 7078.221395646372, 7194.100737407824, 7241.5293005954445, 7242.456815738736, 7358.595277259802, 7118.715251390094, 7119.132358837527, 7126.536775109601, 7132.607706576188, 7205.567665940061, 5419.891602168013, 6406.263279722892, 6418.876696577987, 6514.0880276760345, 6519.250286217146, 5017.54842064216, 5052.343195384577, 5094.745262736774, 5095.108356037753, 5159.226116082617, 4602.355670206107, 4605.0, 4803.03939212152, 4979.3277907482025, 5214.921776173436], "value": 4378.953769978421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.32618719683825, 361.46864109758656, 362.3531995388233, 363.6835952721131, 369.73748638466697, 5009.922866583684, 5021.522955319243, 5160.741962901859, 5451.836444906659, 5596.188552659862, 4314.6332561732215, 4854.854354369366, 5509.504144626982, 5564.304461942257, 5644.379118296984, 3421.9486707699402, 3919.7256192066566, 4047.615476529725, 4161.9583804161875, 4194.790260486986, 3746.0, 3835.6931445484292, 4007.937896457441, 4151.854685086023, 4168.6665066794585, 3617.439296908983, 4098.692598055143, 4114.670826333886, 4118.711690181688, 4137.54487006429, 3623.873164439245, 3669.266146770643, 3959.9010024749323, 4136.400221967828, 4159.480064991876, 2979.2849716067985, 3467.8156156545874, 3495.2310491691787, 3515.771474854126, 3533.381658209803, 5275.446078161776, 5285.6300058995885, 5317.654352467077, 5318.574514038906, 5323.574114070865, 4144.730592511477, 4505.864824055251, 4686.172392766824, 4702.905941881178, 4704.623630109583, 4833.951660483385, 5516.724163791794, 5718.48533631971, 5794.913076303858, 5970.462658360769, 3731.8880433587037, 3972.781497017663, 4234.216669916075, 4243.575642435762, 4246.957530424687, 5100.132977393852, 5492.009126720652, 5936.90353655976, 5948.643081415129, 6099.939000609981, 4153.709240353146, 4162.4598898407785, 4248.299030659907, 4254.234237837157, 4320.848770293024, 3634.9818250908575, 3651.3427583034777, 4363.38912552243, 4382.123575284956, 4393.0994146199955, 4965.652404331734, 5000.099982003274, 5001.89996200074, 5005.74971251436, 5046.829863158803, 4926.704397736147, 4992.675476094042, 5860.619059761188, 5883.411658834082, 5952.583319167703, 1285.5500574798932, 1285.884270415667, 1321.7575479049663, 1422.4523558430078, 1429.0853853533747, 953.7812687418998, 983.5918093991056, 983.8622592837008, 990.7176454710373, 1000.7798284377425, 4933.98853235086, 5195.67510284875, 5254.791397978486, 5263.815766448156, 5286.54175808251, 5688.40271771458, 5936.8812623748145, 5958.553108516879, 5968.8810472282585, 5976.551758618121, 4430.977845110819, 5259.474052594786, 5418.458154184629, 5419.810306639328, 5475.507204351547, 2469.900584503158, 2475.5915273979954, 2611.4515951649987, 2716.619673245747, 2841.4885320642484, 5300.44345343741, 5352.437994010651, 5813.912791308134, 5826.912596311059, 6005.609635373774, 5546.750396232179, 5906.080523829773, 5914.526837852962, 5952.285725712855, 5958.821235362946, 5955.225820643375, 5958.612690175125, 5972.26804226778, 5972.761089556456, 5995.880082398415, 5684.886302274014, 5686.4029276926985, 5733.971330143323, 5768.481226451945, 5773.220615216892, 4990.975045124751, 5381.901058587076, 5470.206820010996, 5482.4101010706445, 5925.52595792327, 6209.65846878408, 6232.407921247474, 6235.469985051322, 6238.937610624017, 6244.937550624617, 3261.439769780711, 3964.6630036447227, 4002.239574480839, 4005.9399109012807, 4034.556198818069, 5343.62594618373, 5384.946150538444, 5551.252130195579, 5949.851253718692, 5985.510866849862, 4953.504649535018, 4963.131451995814, 5170.1986192140275, 5402.972985135049, 5809.9419005809405, 4880.536349046835, 5109.718965456936, 5289.7619607117, 5419.807642318684, 5515.433983054576, 5588.077967135378, 5645.802396916089, 5657.434256574475, 5705.800296989585, 5721.656700597978, 5551.861203469945, 5586.413426590312, 5649.615844118217, 5742.425757424224, 5866.122840690938, 4305.160493703697, 5092.7199004053655, 5472.2065300531995, 5699.772009119754, 5728.942710572841], "value": 4197.422640224405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6859697434644, 737.3069314844047, 771.3019717155972, 802.137701970382, 828.3456069704936, 15380.615484612876, 15896.841031589709, 15957.84042159578, 15964.28160732767, 15974.680506389865, 12016.81974770377, 14626.926865365685, 14765.704685906276, 14789.40842366304, 14838.332275047622, 688.4561196654637, 710.3997122431537, 862.7972426479772, 867.5575456517174, 888.1606881496988, 869.1091631078164, 885.3890815337429, 888.1606881496988, 889.208604342136, 889.4707648948897, 929.8837645294338, 930.930180236485, 937.4890684576922, 939.0515579264958, 946.7443790176649, 927.3879239701832, 927.3925578745932, 928.0209379105075, 932.0353434195642, 936.0405584276172, 602.4758460139662, 664.3389827121996, 680.7617333933133, 688.0195721097466, 705.4074577354995, 14869.851301486955, 15220.315085821165, 15229.314680839278, 15541.0, 15728.0, 14157.22135282559, 14316.28418579067, 14428.350724217435, 14489.492867749683, 14492.927535362362, 9680.806383872354, 11763.58827441044, 11785.587504437304, 11856.881431185664, 11916.285022898654, 3188.9202769930707, 3665.8533658653623, 3709.610490898444, 3729.3224083503264, 3881.961180388188, 82004.58997704973, 104345.47827260815, 106954.0, 107035.46482267539, 107964.4601776994, 10472.217123637656, 10984.231103822816, 11081.224314297922, 11125.833112503318, 11167.32996020225, 18734.625307494047, 23292.534149316918, 23584.764152358257, 23621.0, 23702.814859256967, 7582.279683430065, 7632.771016869503, 7659.61701914902, 7661.961690191513, 7738.056661997205, 4137.689673274516, 4188.4555007848785, 4222.451081359465, 4233.957660423418, 4328.04782947751, 3555.911102222465, 3628.256207477461, 3641.3809652359164, 3643.7813731176216, 3645.0158457216403, 646.9514786391039, 651.3649192037725, 657.8881590129594, 665.2150462454254, 670.7484693240035, 647.5208345824151, 674.8312921769558, 680.6274907831682, 697.553565717941, 705.9541129826545, 9067.274618030673, 9896.208303335716, 10159.9492002541, 10163.0, 10549.525271362807, 635.2313700422541, 649.5972497051858, 694.8645014222178, 708.1290013283588, 713.1584730018628, 5022.447530771612, 5024.995000999815, 5045.722485263273, 5059.215821547666, 5068.120979663646, 93807.53096234475, 95641.52179239059, 97449.0, 97616.0, 99935.50032249792, 72661.0, 75143.62428187934, 85038.72441913377, 87521.5623921889, 87845.0, 64939.675301624135, 71187.64406178039, 75563.62218188874, 76082.0, 76113.0, 9686.515674216402, 9689.757756055873, 9690.75773105678, 9713.514324283899, 9721.416714997124, 48479.27281090716, 51110.74444627753, 51534.0, 52483.0, 54859.80560777524, 52603.73698131485, 56523.0, 68470.972935405, 68811.3118868825, 69290.30709692839, 9511.66709165176, 11757.176997610086, 11925.986291165349, 11949.163558550817, 12082.214656047328, 11624.186306958432, 12753.61739147827, 12998.740025199253, 13159.53941612039, 13543.59369218925, 10574.836767955672, 11020.787713351685, 11841.28952262867, 11898.821517677416, 11994.0, 11102.722431938942, 13623.637636236297, 13625.046246762631, 13655.863441365856, 13845.16928984264, 12574.679658635712, 12874.356282185667, 13604.65988350299, 13751.656208594864, 13858.722825543635, 11303.265287756598, 11376.521052263153, 11384.37385943781, 11395.829062564235, 11451.541938322374, 9394.295427843075, 11242.325460472397, 11253.268537545033, 11405.771884562428, 11694.532218711496], "value": 7405.092554243684, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 176.0, 98.0, 164.0, 174.0, 176.0, 119.0, 118.0, 117.0, 118.0], "value": 140.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 116.0, 149.0, 113.0, 115.0, 111.0, 138.0, 163.0, 117.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 260.0, 284.0, 230.0, 198.0, 197.0, 198.0, 199.0, 197.0, 196.0], "value": 216.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 58.0, 95.0, 73.0, 84.0, 59.0, 60.0, 63.0, 61.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 85.0, 74.0, 71.0, 72.0, 82.0, 73.0, 72.0, 82.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 87.0, 90.0, 93.0, 137.0, 88.0, 88.0, 87.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 125.0, 95.0, 95.0, 93.0, 108.0, 95.0, 94.0], "value": 99.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 92.0, 92.0, 96.0, 90.0, 92.0, 92.0, 92.0, 93.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 69.0, 78.0, 94.0, 96.0, 96.0, 98.0, 81.0], "value": 79.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 87.0, 77.0, 77.0, 71.0, 73.0, 75.0, 104.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 89.0, 101.0, 91.0, 78.0, 100.0, 114.0, 82.0, 95.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 140.0, 140.0, 141.0, 143.0, 142.0, 140.0, 193.0, 155.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 227.0, 180.0, 176.0, 176.0, 176.0, 174.0, 178.0, 175.0, 204.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 80.0, 95.0, 89.0, 70.0, 67.0, 82.0, 67.0, 69.0], "value": 76.9, "unit": "score"}]}]} 07:51:06 INFO - Return code: 0 07:51:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:51:06 ERROR - # TBPL SUCCESS # 07:51:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:06 INFO - 2017-01-12 07:51:06.561 screenresolution[1652:10826] starting screenresolution argv=screenresolution get 07:51:06 INFO - 2017-01-12 07:51:06.564 screenresolution[1652:10826] Display 0: 1600x1200x32@60 07:51:06 INFO - 2017-01-12 07:51:06.570 screenresolution[1653:10829] starting screenresolution argv=screenresolution list 07:51:06 INFO - Available Modes on Display 0 07:51:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:06 INFO - Intel Iris: 07:51:06 INFO - Chipset Model: Intel Iris 07:51:06 INFO - Type: GPU 07:51:06 INFO - Bus: Built-In 07:51:06 INFO - VRAM (Dynamic, Max): 1536 MB 07:51:06 INFO - Vendor: Intel (0x8086) 07:51:06 INFO - Device ID: 0x0a2e 07:51:06 INFO - Revision ID: 0x0009 07:51:06 INFO - Displays: 07:51:06 INFO - Display: 07:51:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:06 INFO - Display Serial Number: 1600x1200 60 07:51:06 INFO - Main Display: Yes 07:51:06 INFO - Mirror: Off 07:51:06 INFO - Online: Yes 07:51:06 INFO - Rotation: Supported 07:51:06 INFO - Return code: 0 07:51:06 INFO - Running post-action listener: _resource_record_post_action 07:51:06 INFO - [mozharness: 2017-01-12 15:51:06.806209Z] Finished run-tests step (success) 07:51:06 INFO - Running post-run listener: _resource_record_post_run 07:51:06 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39758336; Write bytes: 554548224; Read time: 385; Write time: 1794 07:51:06 INFO - TinderboxPrint: CPU usage
54.5% 07:51:06 INFO - TinderboxPrint: I/O read bytes / time
39,758,336 / 385 07:51:06 INFO - TinderboxPrint: I/O write bytes / time
554,548,224 / 1,794 07:51:06 INFO - TinderboxPrint: CPU idle
2,184.7 (45.5%) 07:51:06 INFO - TinderboxPrint: CPU system
966.1 (20.1%) 07:51:06 INFO - TinderboxPrint: CPU user
1,646.8 (34.3%) 07:51:06 INFO - TinderboxPrint: Swap in / out
291,303,424 / 0 07:51:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247665152; Write bytes: 242931712; Read time: 18067; Write time: 502 07:51:06 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37652992; Write bytes: 298214400; Read time: 358; Write time: 1249 07:51:07 INFO - Running post-run listener: _upload_blobber_files 07:51:07 INFO - Blob upload gear active. 07:51:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:51:07 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 07:51:07 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:51:07 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:51:07 INFO - (blobuploader) - INFO - Open directory for files ... 07:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:09 INFO - (blobuploader) - INFO - Done attempting. 07:51:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:51:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:51:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:10 INFO - (blobuploader) - INFO - Done attempting. 07:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:11 INFO - (blobuploader) - INFO - Done attempting. 07:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:51:13 INFO - (blobuploader) - INFO - Done attempting. 07:51:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:51:13 INFO - Return code: 0 07:51:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:51:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:51:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78f0bd1ce936eb5efab63e93c95823b7d8f973d02a658cf281ab23b7b20a4b5863cccb796b707e37ac1c378e89bf0955a23ad537a374f732645e96eee8713db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2cfb644099b73ee681401d63405a35a2d940cdd0df35e1c3cce20ac5668537466858c68921079f7062a7f48aedf9ce53902f1b528fb9ae907b5ac47dd6cf955", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5d1fd894d2b647cde21a6d8169196e0dc924c6c2af3eac764d614c99b67e39d99bec1ef04179a8d985121822843a38d1c6b52b3d945d2a77240f2366fb6fbce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f773e8214d3690be0b3b6ba253af89e403613adb5fe0897217038c39d94bb98187d946b5772acaabb546daae3288f80add6709497876f89de45184d88c950e59"} 07:51:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:51:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:51:13 INFO - Contents: 07:51:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78f0bd1ce936eb5efab63e93c95823b7d8f973d02a658cf281ab23b7b20a4b5863cccb796b707e37ac1c378e89bf0955a23ad537a374f732645e96eee8713db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2cfb644099b73ee681401d63405a35a2d940cdd0df35e1c3cce20ac5668537466858c68921079f7062a7f48aedf9ce53902f1b528fb9ae907b5ac47dd6cf955", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5d1fd894d2b647cde21a6d8169196e0dc924c6c2af3eac764d614c99b67e39d99bec1ef04179a8d985121822843a38d1c6b52b3d945d2a77240f2366fb6fbce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f773e8214d3690be0b3b6ba253af89e403613adb5fe0897217038c39d94bb98187d946b5772acaabb546daae3288f80add6709497876f89de45184d88c950e59"} 07:51:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:51:13 INFO - Copying logs to upload dir... 07:51:13 INFO - mkdir: /builds/slave/test/build/upload/logs 07:51:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.000204 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-12 07:51:13.669993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 07:51:13.673306) ========= 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.ouKhXe0bEP/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.0yfmqotv8S/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Firefox/sha512/78f0bd1ce936eb5efab63e93c95823b7d8f973d02a658cf281ab23b7b20a4b5863cccb796b707e37ac1c378e89bf0955a23ad537a374f732645e96eee8713db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2cfb644099b73ee681401d63405a35a2d940cdd0df35e1c3cce20ac5668537466858c68921079f7062a7f48aedf9ce53902f1b528fb9ae907b5ac47dd6cf955", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5d1fd894d2b647cde21a6d8169196e0dc924c6c2af3eac764d614c99b67e39d99bec1ef04179a8d985121822843a38d1c6b52b3d945d2a77240f2366fb6fbce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f773e8214d3690be0b3b6ba253af89e403613adb5fe0897217038c39d94bb98187d946b5772acaabb546daae3288f80add6709497876f89de45184d88c950e59"} build_url:https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/IM2Y4zTwTXe3VLOu837Qgw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78f0bd1ce936eb5efab63e93c95823b7d8f973d02a658cf281ab23b7b20a4b5863cccb796b707e37ac1c378e89bf0955a23ad537a374f732645e96eee8713db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2cfb644099b73ee681401d63405a35a2d940cdd0df35e1c3cce20ac5668537466858c68921079f7062a7f48aedf9ce53902f1b528fb9ae907b5ac47dd6cf955", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5d1fd894d2b647cde21a6d8169196e0dc924c6c2af3eac764d614c99b67e39d99bec1ef04179a8d985121822843a38d1c6b52b3d945d2a77240f2366fb6fbce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f773e8214d3690be0b3b6ba253af89e403613adb5fe0897217038c39d94bb98187d946b5772acaabb546daae3288f80add6709497876f89de45184d88c950e59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 07:51:13.708404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:51:13.708763) ========= 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.ouKhXe0bEP/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.0yfmqotv8S/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.004923 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 07:51:13.757792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 07:51:13.758113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 07:51:13.758436) ========= ========= Total master_lag: 0.23 =========