builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0333 starttime: 1486990083.31 results: success (0) buildid: 20170213033940 builduid: 2c8483137e584b5ebf28088ee738b705 revision: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.315494) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.316318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.316807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.430900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.431618) ========= 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.LN3lxeauQ0/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.eAAra4vsLY/Listeners TMPDIR=/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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-02-13 04:48:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-02-13 04:48:03 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132678 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.591599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.591923) ========= 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.LN3lxeauQ0/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.eAAra4vsLY/Listeners TMPDIR=/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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.025450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:03.642519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 04:48:03.643252) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 --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 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LN3lxeauQ0/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.eAAra4vsLY/Listeners TMPDIR=/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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-02-13 04:48:03,745 truncating revision to first 12 chars 2017-02-13 04:48:03,745 Setting DEBUG logging. 2017-02-13 04:48:03,745 attempt 1/10 2017-02-13 04:48:03,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c300355a94d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 04:48:04,642 unpacking tar archive at: mozilla-central-3c300355a94d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164342 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 04:48:04.836747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:04.837117) ========= script_repo_revision: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:04.837571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:04.837875) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 04:48:04.858475) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-13 04:48:04.859137) ========= /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.LN3lxeauQ0/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.eAAra4vsLY/Listeners TMPDIR=/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:48:05 INFO - MultiFileLogger online at 20170213 04:48:05 in /builds/slave/test 04:48:05 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 04:48:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:05 INFO - {'append_to_log': False, 04:48:05 INFO - 'base_work_dir': '/builds/slave/test', 04:48:05 INFO - 'blob_upload_branch': 'Firefox', 04:48:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:05 INFO - 'branch': 'Firefox', 04:48:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:05 INFO - 'config_files': ('talos/mac_config.py',), 04:48:05 INFO - 'default_actions': ('clobber', 04:48:05 INFO - 'read-buildbot-config', 04:48:05 INFO - 'download-and-extract', 04:48:05 INFO - 'populate-webroot', 04:48:05 INFO - 'create-virtualenv', 04:48:05 INFO - 'install', 04:48:05 INFO - 'run-tests'), 04:48:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:05 INFO - 'download_minidump_stackwalk': True, 04:48:05 INFO - 'download_symbols': 'ondemand', 04:48:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:05 INFO - 'installer_path': 'installer.exe', 04:48:05 INFO - 'log_level': 'info', 04:48:05 INFO - 'log_name': 'talos', 04:48:05 INFO - 'log_to_console': True, 04:48:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:05 INFO - 'opt_config_files': (), 04:48:05 INFO - 'pip_index': False, 04:48:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:05 INFO - 'cmd': ('bash', 04:48:05 INFO - '-c', 04:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:05 INFO - 'enabled': True, 04:48:05 INFO - 'halt_on_failure': False, 04:48:05 INFO - 'name': 'check_screen_resolution'},), 04:48:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:05 INFO - 'cmd': ('bash', 04:48:05 INFO - '-c', 04:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:05 INFO - 'enabled': True, 04:48:05 INFO - 'halt_on_failure': False, 04:48:05 INFO - 'name': 'check_screen_resolution'},), 04:48:05 INFO - 'run_cmd_checks_enabled': True, 04:48:05 INFO - 'sps_profile': False, 04:48:05 INFO - 'sps_profile_interval': 0, 04:48:05 INFO - 'suite': 'dromaeojs-e10s', 04:48:05 INFO - 'system_bits': '32', 04:48:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:05 INFO - 'title': 't-yosemite-r7-0333', 04:48:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:05 INFO - 'use_talos_json': True, 04:48:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:05 INFO - 'work_dir': 'build'} 04:48:05 INFO - [mozharness: 2017-02-13 12:48:05.070838Z] Running clobber step. 04:48:05 INFO - Running pre-action listener: _resource_record_pre_action 04:48:05 INFO - Running main action method: clobber 04:48:05 INFO - rmtree: /builds/slave/test/build 04:48:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:07 INFO - Running post-action listener: _resource_record_post_action 04:48:07 INFO - [mozharness: 2017-02-13 12:48:07.561792Z] Finished clobber step (success) 04:48:07 INFO - [mozharness: 2017-02-13 12:48:07.561927Z] Running read-buildbot-config step. 04:48:07 INFO - Running pre-action listener: _resource_record_pre_action 04:48:07 INFO - Running main action method: read_buildbot_config 04:48:07 INFO - Using buildbot properties: 04:48:07 INFO - { 04:48:07 INFO - "project": "", 04:48:07 INFO - "product": "firefox", 04:48:07 INFO - "script_repo_revision": "production", 04:48:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:48:07 INFO - "repository": "", 04:48:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:48:07 INFO - "buildid": "20170213033940", 04:48:07 INFO - "pgo_build": "False", 04:48:07 INFO - "basedir": "/builds/slave/test", 04:48:07 INFO - "buildnumber": 138, 04:48:07 INFO - "slavename": "t-yosemite-r7-0333", 04:48:07 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:48:07 INFO - "platform": "yosemite_r7", 04:48:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:07 INFO - "branch": "mozilla-central", 04:48:07 INFO - "repo_path": "mozilla-central", 04:48:07 INFO - "revision": "3c300355a94d24e0c1c156f9de4a6e9c60beaa28", 04:48:07 INFO - "stage_platform": "macosx64", 04:48:07 INFO - "builduid": "2c8483137e584b5ebf28088ee738b705", 04:48:07 INFO - "slavebuilddir": "test" 04:48:07 INFO - } 04:48:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:48:07 INFO - Running post-action listener: _resource_record_post_action 04:48:07 INFO - [mozharness: 2017-02-13 12:48:07.565202Z] Finished read-buildbot-config step (success) 04:48:07 INFO - [mozharness: 2017-02-13 12:48:07.565316Z] Running download-and-extract step. 04:48:07 INFO - Running pre-action listener: _resource_record_pre_action 04:48:07 INFO - Running main action method: download_and_extract 04:48:07 INFO - mkdir: /builds/slave/test/build/tests 04:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:07 INFO - trying https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:48:07 INFO - Downloading https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:48:08 INFO - Downloaded 1199 bytes. 04:48:08 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:48:08 INFO - Using the following test package requirements: 04:48:08 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:48:08 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:08 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:48:08 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'jsshell-mac.zip'], 04:48:08 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:48:08 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:48:08 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:48:08 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:48:08 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:48:08 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:48:08 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:08 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:48:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:08 INFO - Fetch https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:48:10 INFO - Expected file size: 51504268 04:48:10 INFO - Obtained file size: 51504268 04:48:26 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:48:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:48:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:26 INFO - Fetch https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:48:28 INFO - Expected file size: 51504268 04:48:28 INFO - Obtained file size: 51504268 04:48:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:48:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:48:43 INFO - Fetch https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:48:44 INFO - Expected file size: 14403647 04:48:44 INFO - Obtained file size: 14403647 04:48:44 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')]} 04:48:44 INFO - trying https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:48:44 INFO - Downloading https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:48:46 INFO - Downloaded 70385435 bytes. 04:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:48:46 INFO - mkdir: /builds/slave/test/properties 04:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:48:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:48:46 INFO - Contents: 04:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:48:47 INFO - Running post-action listener: _resource_record_post_action 04:48:47 INFO - Running post-action listener: set_extra_try_arguments 04:48:47 INFO - [mozharness: 2017-02-13 12:48:47.559113Z] Finished download-and-extract step (success) 04:48:47 INFO - [mozharness: 2017-02-13 12:48:47.559264Z] Running populate-webroot step. 04:48:47 INFO - Running pre-action listener: _resource_record_pre_action 04:48:47 INFO - Running main action method: populate_webroot 04:48:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:48:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:48:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:48:47 INFO - '--tppagecycles', 04:48:47 INFO - '7'], 04:48:47 INFO - 'tests': ['tsvgm']}}, 04:48:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:48:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:48:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:48:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:48:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['damp', 'tps']}, 04:48:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'tests': ['damp', 'tps']}, 04:48:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['dromaeo_dom']}, 04:48:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:48:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['basic_compositor_video']}, 04:48:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:48:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['a11yr', 04:48:47 INFO - 'ts_paint', 04:48:47 INFO - 'tpaint', 04:48:47 INFO - 'sessionrestore', 04:48:47 INFO - 'sessionrestore_no_auto_restore', 04:48:47 INFO - 'tabpaint']}, 04:48:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:48:47 INFO - 'ts_paint', 04:48:47 INFO - 'tpaint', 04:48:47 INFO - 'sessionrestore', 04:48:47 INFO - 'sessionrestore_no_auto_restore', 04:48:47 INFO - 'tabpaint']}, 04:48:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:48:47 INFO - 'ts_paint', 04:48:47 INFO - 'tpaint', 04:48:47 INFO - 'sessionrestore', 04:48:47 INFO - 'sessionrestore_no_auto_restore', 04:48:47 INFO - 'tabpaint']}, 04:48:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:48:47 INFO - 'ts_paint', 04:48:47 INFO - 'tpaint', 04:48:47 INFO - 'sessionrestore', 04:48:47 INFO - 'sessionrestore_no_auto_restore', 04:48:47 INFO - 'tabpaint']}, 04:48:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['a11yr', 04:48:47 INFO - 'ts_paint', 04:48:47 INFO - 'tpaint', 04:48:47 INFO - 'sessionrestore', 04:48:47 INFO - 'sessionrestore_no_auto_restore', 04:48:47 INFO - 'tabpaint']}, 04:48:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['a11yr', 04:48:47 INFO - 'ts_paint', 04:48:47 INFO - 'tpaint', 04:48:47 INFO - 'sessionrestore', 04:48:47 INFO - 'sessionrestore_no_auto_restore', 04:48:47 INFO - 'tabpaint']}, 04:48:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['tsvgx', 04:48:47 INFO - 'tsvgr_opacity', 04:48:47 INFO - 'tart', 04:48:47 INFO - 'tscrollx', 04:48:47 INFO - 'cart', 04:48:47 INFO - 'tsvg_static']}, 04:48:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:48:47 INFO - 'tsvgr_opacity', 04:48:47 INFO - 'tart', 04:48:47 INFO - 'tscrollx', 04:48:47 INFO - 'cart', 04:48:47 INFO - 'tsvg_static']}, 04:48:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'talos_options': ['--disable-e10s'], 04:48:47 INFO - 'tests': ['tp5o']}, 04:48:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:48:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'talos_options': ['--disable-e10s', 04:48:47 INFO - '--xperf_path', 04:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:47 INFO - 'tests': ['tp5n']}, 04:48:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:48:47 INFO - 'talos_options': ['--xperf_path', 04:48:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:47 INFO - 'tests': ['tp5n']}}, 04:48:47 INFO - 'talos.zip': {'path': '', 04:48:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:48:47 INFO - Running post-action listener: _resource_record_post_action 04:48:47 INFO - [mozharness: 2017-02-13 12:48:47.577330Z] Finished populate-webroot step (success) 04:48:47 INFO - [mozharness: 2017-02-13 12:48:47.577435Z] Running create-virtualenv step. 04:48:47 INFO - Running pre-action listener: _resource_record_pre_action 04:48:47 INFO - Running main action method: create_virtualenv 04:48:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:48:47 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 04:48:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:48:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:48:47 INFO - Using real prefix '/tools/python27' 04:48:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:48:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:48:51 INFO - Installing pip.................done. 04:48:51 INFO - Return code: 0 04:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:48:51 INFO - Reading from file tmpfile_stdout 04:48:51 INFO - Output received: 04:48:51 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) 04:48:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:51 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 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:48:51 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 04:48:51 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 04:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:51 INFO - 'HOME': '/Users/cltbld', 04:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:51 INFO - 'LOGNAME': 'cltbld', 04:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:51 INFO - 'MOZ_NO_REMOTE': '1', 04:48:51 INFO - 'NO_EM_RESTART': '1', 04:48:51 INFO - 'PAGER': '/bin/cat', 04:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:51 INFO - 'PWD': '/builds/slave/test', 04:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:51 INFO - 'SHELL': '/bin/bash', 04:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:48:51 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:51 INFO - 'USER': 'cltbld', 04:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:51 INFO - 'XPC_FLAGS': '0x0', 04:48:51 INFO - 'XPC_SERVICE_NAME': '0', 04:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:51 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 04:48:51 INFO - Cleaning up... 04:48:51 INFO - Return code: 0 04:48:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:51 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 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:48:51 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 04:48:51 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 04:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:51 INFO - 'HOME': '/Users/cltbld', 04:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:51 INFO - 'LOGNAME': 'cltbld', 04:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:51 INFO - 'MOZ_NO_REMOTE': '1', 04:48:51 INFO - 'NO_EM_RESTART': '1', 04:48:51 INFO - 'PAGER': '/bin/cat', 04:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:51 INFO - 'PWD': '/builds/slave/test', 04:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:51 INFO - 'SHELL': '/bin/bash', 04:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:48:51 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:51 INFO - 'USER': 'cltbld', 04:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:51 INFO - 'XPC_FLAGS': '0x0', 04:48:51 INFO - 'XPC_SERVICE_NAME': '0', 04:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:52 INFO - Downloading/unpacking psutil>=3.1.1 04:48: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 04:48: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 04:48: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 04:48: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 04:48: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 04:48: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 04:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:55 INFO - Installing collected packages: psutil 04:48:55 INFO - Running setup.py install for psutil 04:48:55 INFO - building 'psutil._psutil_osx' extension 04:48:55 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 04:48:56 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 04:48:56 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 04:48:56 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 04:48:56 INFO - building 'psutil._psutil_posix' extension 04:48:56 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 04:48:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:48:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:48:56 INFO - ^ 04:48:56 INFO - 1 warning generated. 04:48:56 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 04:48:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:56 INFO - Successfully installed psutil 04:48:56 INFO - Cleaning up... 04:48:56 INFO - Return code: 0 04:48:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:48:56 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')]} 04:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:56 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')]} 04:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:56 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 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:48:56 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 04:48:56 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 04:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:48:56 INFO - 'HOME': '/Users/cltbld', 04:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:48:56 INFO - 'LOGNAME': 'cltbld', 04:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:56 INFO - 'MOZ_NO_REMOTE': '1', 04:48:56 INFO - 'NO_EM_RESTART': '1', 04:48:56 INFO - 'PAGER': '/bin/cat', 04:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:56 INFO - 'PWD': '/builds/slave/test', 04:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:48:56 INFO - 'SHELL': '/bin/bash', 04:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:48:56 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:48:56 INFO - 'USER': 'cltbld', 04:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:56 INFO - 'XPC_FLAGS': '0x0', 04:48:56 INFO - 'XPC_SERVICE_NAME': '0', 04:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:48:59 INFO - Installing collected packages: mozsystemmonitor 04:48:59 INFO - Running setup.py install for mozsystemmonitor 04:49:00 INFO - Successfully installed mozsystemmonitor 04:49:00 INFO - Cleaning up... 04:49:00 INFO - Return code: 0 04:49:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49:00 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')]} 04:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:00 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')]} 04:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:00 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 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:00 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 04:49:00 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 04:49:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:00 INFO - 'HOME': '/Users/cltbld', 04:49:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:00 INFO - 'LOGNAME': 'cltbld', 04:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:00 INFO - 'MOZ_NO_REMOTE': '1', 04:49:00 INFO - 'NO_EM_RESTART': '1', 04:49:00 INFO - 'PAGER': '/bin/cat', 04:49:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:00 INFO - 'PWD': '/builds/slave/test', 04:49:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:00 INFO - 'SHELL': '/bin/bash', 04:49:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:00 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:00 INFO - 'USER': 'cltbld', 04:49:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:00 INFO - 'XPC_FLAGS': '0x0', 04:49:00 INFO - 'XPC_SERVICE_NAME': '0', 04:49:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:01 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 04:49:01 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 04:49:01 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 04:49:01 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 04:49:01 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 04:49:01 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 04:49:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:04 INFO - warning: no files found matching '*.txt' 04:49:04 INFO - no previously-included directories found matching 'build' 04:49:04 INFO - no previously-included directories found matching 'dist' 04:49:04 INFO - no previously-included directories found matching '.git*' 04:49:04 INFO - Installing collected packages: jsonschema, functools32 04:49:04 INFO - Running setup.py install for functools32 04:49:04 INFO - warning: no files found matching '*.txt' 04:49:04 INFO - no previously-included directories found matching 'build' 04:49:04 INFO - no previously-included directories found matching 'dist' 04:49:04 INFO - no previously-included directories found matching '.git*' 04:49:04 INFO - Successfully installed jsonschema functools32 04:49:04 INFO - Cleaning up... 04:49:04 INFO - Return code: 0 04:49:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:05 INFO - 'HOME': '/Users/cltbld', 04:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:05 INFO - 'LOGNAME': 'cltbld', 04:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:05 INFO - 'MOZ_NO_REMOTE': '1', 04:49:05 INFO - 'NO_EM_RESTART': '1', 04:49:05 INFO - 'PAGER': '/bin/cat', 04:49:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:05 INFO - 'PWD': '/builds/slave/test', 04:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:05 INFO - 'SHELL': '/bin/bash', 04:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:05 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:05 INFO - 'USER': 'cltbld', 04:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:05 INFO - 'XPC_FLAGS': '0x0', 04:49:05 INFO - 'XPC_SERVICE_NAME': '0', 04:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:05 INFO - Cleaning up... 04:49:05 INFO - Return code: 0 04:49:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:05 INFO - 'HOME': '/Users/cltbld', 04:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:05 INFO - 'LOGNAME': 'cltbld', 04:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:05 INFO - 'MOZ_NO_REMOTE': '1', 04:49:05 INFO - 'NO_EM_RESTART': '1', 04:49:05 INFO - 'PAGER': '/bin/cat', 04:49:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:05 INFO - 'PWD': '/builds/slave/test', 04:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:05 INFO - 'SHELL': '/bin/bash', 04:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:05 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:05 INFO - 'USER': 'cltbld', 04:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:05 INFO - 'XPC_FLAGS': '0x0', 04:49:05 INFO - 'XPC_SERVICE_NAME': '0', 04:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:05 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 04:49:05 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 04:49:05 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 04:49:05 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 04:49:05 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 04:49:05 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 04:49:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:09 INFO - Downloading docopt-0.6.1.tar.gz 04:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:09 INFO - Running setup.py install for blobuploader 04:49:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:09 INFO - Running setup.py install for requests 04:49:10 INFO - Running setup.py install for docopt 04:49:10 INFO - Successfully installed blobuploader requests docopt 04:49:10 INFO - Cleaning up... 04:49:10 INFO - Return code: 0 04:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:10 INFO - 'HOME': '/Users/cltbld', 04:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:10 INFO - 'LOGNAME': 'cltbld', 04:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:10 INFO - 'MOZ_NO_REMOTE': '1', 04:49:10 INFO - 'NO_EM_RESTART': '1', 04:49:10 INFO - 'PAGER': '/bin/cat', 04:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:10 INFO - 'PWD': '/builds/slave/test', 04:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:10 INFO - 'SHELL': '/bin/bash', 04:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:10 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:10 INFO - 'USER': 'cltbld', 04:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:10 INFO - 'XPC_FLAGS': '0x0', 04:49:10 INFO - 'XPC_SERVICE_NAME': '0', 04:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:10 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-Oo2x_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:10 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-U37SeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:10 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-MgylTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:10 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-Cuj3Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-4KP5wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-lefPoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-JEN39Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-50b6EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-O_1GL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-YFRaUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-bX26gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-of8JmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:11 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-Sc1hWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:12 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-ejwqJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:12 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-0s7WAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:12 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-Qft4qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:12 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-jvzj0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:12 INFO - Running setup.py install for manifestparser 04:49:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:12 INFO - Running setup.py install for mozcrash 04:49:12 INFO - Running setup.py install for mozdebug 04:49:12 INFO - Running setup.py install for mozdevice 04:49:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Running setup.py install for mozfile 04:49:13 INFO - Running setup.py install for mozhttpd 04:49:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Running setup.py install for mozinfo 04:49:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Running setup.py install for mozInstall 04:49:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Running setup.py install for mozleak 04:49:13 INFO - Running setup.py install for mozlog 04:49:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:13 INFO - Running setup.py install for moznetwork 04:49:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:14 INFO - Running setup.py install for mozprocess 04:49:14 INFO - Running setup.py install for mozprofile 04:49:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:14 INFO - Running setup.py install for mozrunner 04:49:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:14 INFO - Running setup.py install for mozscreenshot 04:49:14 INFO - Running setup.py install for moztest 04:49:14 INFO - Running setup.py install for mozversion 04:49:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:14 INFO - Cleaning up... 04:49:15 INFO - Return code: 0 04:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:15 INFO - 'HOME': '/Users/cltbld', 04:49:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:15 INFO - 'LOGNAME': 'cltbld', 04:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:15 INFO - 'MOZ_NO_REMOTE': '1', 04:49:15 INFO - 'NO_EM_RESTART': '1', 04:49:15 INFO - 'PAGER': '/bin/cat', 04:49:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:15 INFO - 'PWD': '/builds/slave/test', 04:49:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:15 INFO - 'SHELL': '/bin/bash', 04:49:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:15 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:15 INFO - 'USER': 'cltbld', 04:49:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:15 INFO - 'XPC_FLAGS': '0x0', 04:49:15 INFO - 'XPC_SERVICE_NAME': '0', 04:49:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-w4s1ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-WpTPZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:15 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)) 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-c6Vh_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:15 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)) 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-PFPObr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:15 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)) 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-L8gR1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:15 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)) 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-k4hJWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:15 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)) 04:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:15 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-R_m2ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-hQTbbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-wPA7BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-AFX9Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-Nu1eVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-TQd2o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:16 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)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-aebbdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:16 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)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-Rt5iQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:16 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)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-bBaaDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:16 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)) 04:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:16 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-0CA_EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:17 INFO - Running setup.py (path:/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/pip-5dZFKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:19 INFO - Downloading blessings-1.6.tar.gz 04:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:19 INFO - Installing collected packages: blessings 04:49:19 INFO - Running setup.py install for blessings 04:49:20 INFO - Successfully installed blessings 04:49:20 INFO - Cleaning up... 04:49:20 INFO - Return code: 0 04:49:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:20 INFO - Reading from file tmpfile_stdout 04:49:20 INFO - Current package versions: 04:49:20 INFO - blessings == 1.6 04:49:20 INFO - blobuploader == 1.2.4 04:49:20 INFO - docopt == 0.6.1 04:49:20 INFO - functools32 == 3.2.3-2 04:49:20 INFO - jsonschema == 2.5.1 04:49:20 INFO - manifestparser == 1.1 04:49:20 INFO - mozInstall == 1.12 04:49:20 INFO - mozcrash == 1.0 04:49:20 INFO - mozdebug == 0.1 04:49:20 INFO - mozdevice == 0.49 04:49:20 INFO - mozfile == 1.2 04:49:20 INFO - mozhttpd == 0.7 04:49:20 INFO - mozinfo == 0.9 04:49:20 INFO - mozleak == 0.1 04:49:20 INFO - mozlog == 3.4 04:49:20 INFO - moznetwork == 0.27 04:49:20 INFO - mozprocess == 0.24 04:49:20 INFO - mozprofile == 0.28 04:49:20 INFO - mozrunner == 6.13 04:49:20 INFO - mozscreenshot == 0.1 04:49:20 INFO - mozsystemmonitor == 0.3 04:49:20 INFO - moztest == 0.8 04:49:20 INFO - mozversion == 1.4 04:49:20 INFO - psutil == 3.1.1 04:49:20 INFO - requests == 1.2.3 04:49:20 INFO - wsgiref == 0.1.2 04:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:20 INFO - 'HOME': '/Users/cltbld', 04:49:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:20 INFO - 'LOGNAME': 'cltbld', 04:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:20 INFO - 'MOZ_NO_REMOTE': '1', 04:49:20 INFO - 'NO_EM_RESTART': '1', 04:49:20 INFO - 'PAGER': '/bin/cat', 04:49:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:20 INFO - 'PWD': '/builds/slave/test', 04:49:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:20 INFO - 'SHELL': '/bin/bash', 04:49:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:20 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:20 INFO - 'USER': 'cltbld', 04:49:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:20 INFO - 'XPC_FLAGS': '0x0', 04:49:20 INFO - 'XPC_SERVICE_NAME': '0', 04:49:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 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)) 04:49:20 INFO - Cleaning up... 04:49:20 INFO - Return code: 0 04:49:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:20 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 0x106afdb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b00768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecdad51c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, '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.LN3lxeauQ0/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.eAAra4vsLY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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 04:49:20 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 04:49:20 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 04:49:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:20 INFO - 'HOME': '/Users/cltbld', 04:49:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:20 INFO - 'LOGNAME': 'cltbld', 04:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:20 INFO - 'MOZ_NO_REMOTE': '1', 04:49:20 INFO - 'NO_EM_RESTART': '1', 04:49:20 INFO - 'PAGER': '/bin/cat', 04:49:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:20 INFO - 'PWD': '/builds/slave/test', 04:49:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:20 INFO - 'SHELL': '/bin/bash', 04:49:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:20 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:20 INFO - 'USER': 'cltbld', 04:49:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:20 INFO - 'XPC_FLAGS': '0x0', 04:49:20 INFO - 'XPC_SERVICE_NAME': '0', 04:49:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:49:21 INFO - Cleaning up... 04:49:21 INFO - Return code: 0 04:49:21 INFO - Running post-action listener: _resource_record_post_action 04:49:21 INFO - Running post-action listener: _start_resource_monitoring 04:49:21 INFO - Starting resource monitoring. 04:49:21 INFO - [mozharness: 2017-02-13 12:49:21.063076Z] Finished create-virtualenv step (success) 04:49:21 INFO - [mozharness: 2017-02-13 12:49:21.064090Z] Running install step. 04:49:21 INFO - Running pre-action listener: _resource_record_pre_action 04:49:21 INFO - Running main action method: install 04:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:21 INFO - Reading from file tmpfile_stdout 04:49:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:21 INFO - Reading from file tmpfile_stdout 04:49:21 INFO - Output received: 04:49:21 INFO - Usage: mozinstall [options] installer 04:49:21 INFO - Options: 04:49:21 INFO - -h, --help show this help message and exit 04:49:21 INFO - -d DEST, --destination=DEST 04:49:21 INFO - Directory to install application into. [default: 04:49:21 INFO - "/builds/slave/test"] 04:49:21 INFO - --app=APP Application being installed. [default: firefox] 04:49:21 INFO - mkdir: /builds/slave/test/build/application 04:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:49:43 INFO - Reading from file tmpfile_stdout 04:49:43 INFO - Output received: 04:49:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:49:43 INFO - Running post-action listener: _resource_record_post_action 04:49:43 INFO - [mozharness: 2017-02-13 12:49:43.489541Z] Finished install step (success) 04:49:43 INFO - [mozharness: 2017-02-13 12:49:43.489683Z] Running run-tests step. 04:49:43 INFO - Running pre-action listener: _resource_record_pre_action 04:49:43 INFO - Running main action method: run_tests 04:49:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:49:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:49:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:49:43 INFO - 2017-02-13 04:49:43.504 screenresolution[1627:7356] starting screenresolution argv=screenresolution get 04:49:43 INFO - 2017-02-13 04:49:43.507 screenresolution[1627:7356] Display 0: 1600x1200x32@60 04:49:43 INFO - 2017-02-13 04:49:43.513 screenresolution[1628:7358] starting screenresolution argv=screenresolution list 04:49:43 INFO - Available Modes on Display 0 04:49:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:49:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:49:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:49:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:49:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:49:43 INFO - Intel Iris: 04:49:43 INFO - Chipset Model: Intel Iris 04:49:43 INFO - Type: GPU 04:49:43 INFO - Bus: Built-In 04:49:43 INFO - VRAM (Dynamic, Max): 1536 MB 04:49:43 INFO - Vendor: Intel (0x8086) 04:49:43 INFO - Device ID: 0x0a2e 04:49:43 INFO - Revision ID: 0x0009 04:49:43 INFO - Displays: 04:49:43 INFO - Display: 04:49:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:49:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:49:43 INFO - Display Serial Number: 1600x1200 60 04:49:43 INFO - Main Display: Yes 04:49:43 INFO - Mirror: Off 04:49:43 INFO - Online: Yes 04:49:43 INFO - Rotation: Supported 04:49:43 INFO - Return code: 0 04:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:43 INFO - Python 2.7.3 04:49:43 INFO - Return code: 0 04:49:43 INFO - grabbing minidump binary from tooltool 04:49:43 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')]} 04:49:43 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 0x1068dbd30>, '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 0x106802db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068d0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:43 INFO - Return code: 0 04:49:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:49:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:49:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:43 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/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0333', '--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 04:49:43 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/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0333 --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 04:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LN3lxeauQ0/Render', 04:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:43 INFO - 'HOME': '/Users/cltbld', 04:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:43 INFO - 'LOGNAME': 'cltbld', 04:49:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:43 INFO - 'MOZ_NO_REMOTE': '1', 04:49:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:43 INFO - 'NO_EM_RESTART': '1', 04:49:43 INFO - 'PAGER': '/bin/cat', 04:49:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:43 INFO - 'PWD': '/builds/slave/test', 04:49:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:43 INFO - 'SHELL': '/bin/bash', 04:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAAra4vsLY/Listeners', 04:49:43 INFO - 'TMPDIR': '/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/', 04:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:43 INFO - 'USER': 'cltbld', 04:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:43 INFO - 'XPC_FLAGS': '0x0', 04:49:43 INFO - 'XPC_SERVICE_NAME': '0', 04:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:43 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/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0333', '--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 04:49:44 INFO - mozversion application_buildid: 20170213033940 04:49:44 INFO - mozversion application_changeset: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 04:49:44 INFO - mozversion application_display_name: Nightly 04:49:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:44 INFO - mozversion application_name: Firefox 04:49:44 INFO - mozversion application_remotingname: firefox 04:49:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:49:44 INFO - mozversion application_vendor: Mozilla 04:49:44 INFO - mozversion application_version: 54.0a1 04:49:44 INFO - mozversion platform_buildid: 20170213033940 04:49:44 INFO - mozversion platform_changeset: 3c300355a94d24e0c1c156f9de4a6e9c60beaa28 04:49:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:49:44 INFO - mozversion platform_version: 54.0a1 04:49:44 INFO - using testdate: 1486990184 04:49:44 INFO - actual date: 1486990184 04:49:44 INFO - starting webserver on 'localhost:49244' 04:49:44 INFO - SUITE-START | Running 2 tests 04:49:44 INFO - TEST-START | dromaeo_css 04:49:44 INFO - operating with platform_type : mac_ 04:49:44 INFO - Initialising browser for dromaeo_css test... 04:49:44 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/tmpX68vyF/profile http://localhost:49244/getInfo.html) 04:49:46 INFO - PROCESS | 1638 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:49:46 INFO - PROCESS | 1638 | 2017-02-13 04:49:46.932 plugin-container[1640:7521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 04:49:46 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:49:46 INFO - PROCESS | 1638 | 2017-02-13 04:49:46.934 plugin-container[1640:7521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x921b, name = 'com.apple.CFPasteboardClient' 04:49:46 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:49:46 INFO - PROCESS | 1638 | 2017-02-13 04:49:46.934 plugin-container[1640:7521] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:49:47 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 04:49:47 INFO - PROCESS | 1638 | colorDepth:24 04:49:47 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 04:49:47 INFO - PROCESS | 1638 | __metrics 04:49:47 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:49:47 INFO - TEST-INFO | 1638: exit 0 04:49:47 INFO - Browser initialized. 04:49:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:49:47 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/tmpX68vyF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:50 INFO - PROCESS | 1641 | 2017-02-13 04:49:50.424 plugin-container[1642:7643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 04:49:50 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:49:50 INFO - PROCESS | 1641 | 2017-02-13 04:49:50.425 plugin-container[1642:7643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471f, name = 'com.apple.CFPasteboardClient' 04:49:50 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:49:50 INFO - PROCESS | 1641 | 2017-02-13 04:49:50.425 plugin-container[1642:7643] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:00 INFO - PROCESS | 1641 | RSS: Main: 233738240 04:50:00 INFO - PROCESS | 1641 | 04:53:02 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:53:04 INFO - PROCESS | 1641 | RSS: Main: 254394368 04:53:04 INFO - PROCESS | 1641 | 04:54:48 INFO - PROCESS | 1641 | ************************* 04:54:48 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 04:54:48 INFO - PROCESS | 1641 | 04:54:48 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:48 INFO - PROCESS | 1641 | Full stack: 04:54:48 INFO - PROCESS | 1641 | ************************* 04:56:06 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:56:07 INFO - PROCESS | 1641 | RSS: Main: 259080192 04:56:07 INFO - PROCESS | 1641 | 04:59:08 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:59:09 INFO - PROCESS | 1641 | RSS: Main: 270696448 04:59:09 INFO - PROCESS | 1641 | 05:02:11 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 05:02:12 INFO - PROCESS | 1641 | RSS: Main: 263745536 05:02:12 INFO - PROCESS | 1641 | 05:05:14 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 05:05:15 INFO - PROCESS | 1641 | RSS: Main: 267714560 05:05:15 INFO - PROCESS | 1641 | 05:08:18 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 05:08:19 INFO - PROCESS | 1641 | RSS: Main: 269410304 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | __start_tp_report 05:08:19 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 05:08:19 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 05:08:19 INFO - PROCESS | 1641 | |i|pagename|runs| 05:08:19 INFO - PROCESS | 1641 | |0;dojo.html;2482.751724827517;2726.4138210284787;2803.621511096002;3296.637369889313;3297.5383446317533;5359.196120581914;5416.404195538487;5451.972740136299;5457.508824205821;5515.448455154483;4612.700174488656;5466.207399927008;5519.69641669708;5533.47431993961;5542.307211598551;4676.3920690310215;4980.477049909761;4981.825636102719;5018.799248030084;5098.617603679721;5067.9746601267125;5101.234814777776;5134.460881607433;5162.5095615916425;5213;4924.901501969976;5015.297858299841;5018.146915024455;5019.573336266421;5094.2358646203365;5035.748212589356;5056.367954005749;5062.746862656889;5070.670406423607;5080.339555857752;3868.4197370394386;3908.902277443058;4255.659547236213;4463.285874260136;4969.751512424365;4435.62297204738;4625.745583992879;5231.712255825928;5360.3567571891235;5480.534154596864;6034.36639152887;6042.395760423967;6047.274327080779;6062;6063.575549711522;6105.755769769248;6116.938830611682;6124.693765311717;6125.448709616156;6145.539084568675;5421.83734487966;5538.75075621594;5551.195076713854;5557.5831812614215;5641.717914104278;6055.333913269536;6082.422169893853;6102.125716101306;6105.786297479567;6113.476306051762;5571.331440227118;5589.524890384281;5639;5727.7995270166175;5992.101184822224;5817.185594016841;5834.416558344132;5976.910346344808;6031.276246850406;6083.239595050619;6010.398960104042;6015;6033.849153771191;6037.184980027728;6045.6070355426755;5708.971455142698;6030.33666296707;6038.064100064497;6042.788502402394;6053.213082299273;4686.062787442525;4757.452892917289;4778.450478195052;4786.904261914742;4827.396575428072;4285.035866929916;4316.935245971313;4354.194474022316;4364.148990946735;4368.584984426474;5447.478572852334;5459.372172200168;5478.096114141202;5478.890422191534;5488.643238189505;4797.712137271775;5911.76352945886;5913.733881975321;5939.762409503572;6022.488088512438;5460.836174914759;5463.071277882769;5476.2333273341765;5487.012337779158;5488.670679759227;4707.7175369477945;5257.106291930381;5316.388615309212;5336.733163341817;5352.598555108382;6191.628502289697;6206.658633775095;6230.221222347116;6231.345708700612;6250.062490626442;5882.705864706833;5955.612885162451;6044.516438684983;6133.938660613515;6160.907586386297;5094.694318340911;6111.724972376165;6146.5390095742105;6150.7539698411565;6158.076288556752;6029.57792954489;6035.577509574287;6036.8188954331445;6071.969640151771;6091.847703807441;6059.424354686298;6081.452669259788;6097.176881120992;6112.602680825732;6116.847078822887;4513.390692256503;5455.18172274162;5666.206731057738;5706.885862282648;5787.276590426197;5588.608797384144;5679.801206957736;5775.711214439178;5793.739281732248;5896.292444906639;4911.386076740408;5599.12429336177;5764;5783.537317014545;5823.854403639773;5862.413758624103;5874.148248503858;5921.052631578927;5943.108533719977;5951.791687290924;5478.945210547843;5527.778888844401;5631.831045068655;5637.098064309691;5737.311522617312 05:08:19 INFO - PROCESS | 1641 | |1;ext.html;468.12927954005556;505.1891713799352;508.09305389879074;522.7569180331145;541.7887024060619;32033.359332813387;36359.63640363596;38797.83606491806;39163.80418097905;39283.01792455183;38872;39032.804835975854;39720.808375748704;39773.204535909266;39797;8950.82098358034;10454.320469169517;10803.459827008619;10975.50610222542;10975.670729878117;9203.309751768644;10640.042396184343;10695.251332406735;10736.624218152367;10738.677839664822;9262.212711919496;10604.522796474177;10778.353298802058;10789.244752867302;10808.78382432351;9320.580573874191;10595.84106238407;10694.732631684232;10722.356658600509;10783.245172837904;10788.029077383073;10875.184361172865;10886.945565272123;10887.455627218607;10887.564497420093;35516.28967420663;35678.46482302742;35797;35840.820795896114;36032.09919752001;3644.7630903991158;3677.4483827425834;3677.4667673187505;3694.8522059117604;3713.0717320669833;26746.331341716417;26863.597046044324;26923.057692980652;27633.86183069092;27724.168274951782;2586.3404831767966;2994.8652310646075;3068.6777888321853;3085.953710694319;3131.091983324833;390370;391644.99999999715;392759.03620482003;393983;394026;51801.48198518042;52500.73749631227;52969.086700231084;53052.67368315823;53053.204201937;52877.735611321696;53081.93836123256;53207;53225.73387133117;53373.199402009;13959.720805583831;14299.714005720036;14450.205238711762;14479.131252124906;14489.492867749577;10883.67348979532;11020.44897755109;11077.612283570197;11083.279586826831;11094.833577496343;13632.863671363359;16277.918610406872;16452;16487.52687096945;16515.256813443422;7196.96401517989;7220.494565380373;7220.819479512949;7236.312550307713;7326.267373262738;821.6302663801314;830.8130670599066;832.5129799067493;839.8530257204965;855.7903313688187;25941.351466213495;26006.479870402487;26626.500024896446;27411.725882741317;29095.854520727262;999.3753903810118;1040.942748148859;1043.9895601044045;1045.6235755128148;1104.3594715065242;13822;14930.626734331729;14955.850441495664;15178.696426071418;15279.923600381928;577787;580838.0958095182;583491;584653;585729;58053;58558.41441585615;58700.706496467246;58822.70588647029;59029.40970590325;1199.8320235167084;1239.925604463735;1314.822498962647;1352.2697743218748;1360.2586590308504;29472;30348.393032139677;30436.543451847796;30767.384652307275;30935.226619334695;38990;46713.53286467092;46719.532804671515;46971.295430569255;47270.76364618155;495531;497048;498679.50660246465;499776;500274;21400.82295473764;24220.51558968846;24698.753012469646;25812.61281080823;26007.349816253987;40150.79924600358;40190.397144042276;40694.59305406908;41794.79102604467;41817.79091104525;34595.65404346025;34963;35208.823955880056;35275;35395.64604353924;32838.507422388204;33902.830485847415;34003.65996340104;34747.82626086853;34911;33014.65011376861;33286;33627;33692.157696057795;33728.65085396557;21336.573268534234;27780.583291251052;28487.860485580346;31056.75772969056;31273;22725.545489089796;22836.4290892729;23716.407089822893;23921.880390597937;24043.918023689326 05:08:19 INFO - PROCESS | 1641 | |2;jquery.html;387.1637263510817;390.74796756092337;397.4475479084073;401.9115794525204;422.6622739030967;13538.796918046237;18486.537836554093;19603.607927841436;19791.50521236968;19832.305869294578;20747.481312967182;20844.791552084476;20877.373678789623;20953.685694714553;20972.846493442856;5339.679619222859;5752.252207213057;5761.596688231804;5786.9710651446685;5799.971000144993;5559.694216818073;5740.7703691852275;5758.452946970031;5763.481286684198;5812.593118481708;5712.800051998181;5731.942680573183;5742.6841523716175;5746.712664366786;5749.59752817303;5511.22842802008;5687.175359572881;5725.713714314288;5747.252857128588;5749.885002299951;5027.195648696227;5049.671771334852;5059.3422855028975;5078.31442755227;5083.415407228179;24025.519489610284;25677.229683109537;26632.46735065307;26633.73366266351;27337.179884603494;2720.170348043846;2739.328864428208;2829.6321478207906;2840.6591209055046;2892.85535723213;15872.682546349008;15898.60253493672;16085.276162572713;16143.112128832909;16546.83453165465;1924.7305377247196;1954.6481633306;1974.7432833731523;1976.2391479280436;1987.2647120565484;159156;161641.1507654772;162314;165434;166139.1693041539;20893.477663058242;22983.540329193656;23164;23196.188133415588;23410.531789364457;9669.661561845442;12615.432305546272;39415.01462463461;39545.40681889774;39565.230433869925;7758.534487930742;7832.138464768871;7845.293923546908;7959.880601790977;7973.883656288124;7786.26030527099;7804.492707973964;7831.882521762178;7932.841343173104;7945.324647405036;3843.404272337792;4096.836126554905;4101.876943691694;4141.316682747373;4190.790460476964;1884.3875740384156;2084.0830034784644;2085.6026462270315;2096.413004358782;2097.8216851567786;964.9228061755043;976.6581696406344;978.0854900667898;980.6812785844629;1027.7944411117805;20274.493137671383;20369.08339124713;20520.947905209658;20548;20550.58898822015;904.5115637555778;998.2812375089924;1005.8591797148405;1008.4050410257983;1035.7203555040248;8973.551322433983;10091.7477063074;10550.47247637615;10588.523516441779;10634.574617015232;498117;644362;647951;664257;693291;124835;128287;160587;161957.19021404817;165952.17023914802;991.8908920018793;999.7000899730198;1022.5756311130798;1024.5235965276183;1027.5735569738624;17350.39273625417;18105;18211.45365639033;18342.899426033946;18384.264629414673;52055.73972130115;59272.81454370975;59597.702011489666;60173.7965240684;60353.39646603478;63473.36526634859;83841.58079209809;84044.15955840364;84208.57895710727;85129;8096.109427963037;8272.875906861282;8404.697271922862;8471.237588617054;8507.489550626982;11407.486663100015;12588;12637.557685480964;12932.159409638343;13014.15407998477;10968.73859506167;11129.165312601426;11250.099992000456;11273.774524509628;11281.492332844877;10372.948135259276;10427.739306517398;10737.355758654505;11080.61217857371;11186.04918581897;10628.52171652262;10704.518296676513;10898.346099234072;11352.262102963281;11491.8276225855;8118.5940702963435;8152.470089444168;8300;8548.487090774574;8566.443181193203;6812.489063320171;8474.915250847413;8972.37193396456;9708.320417570701;10200.897991019994 05:08:19 INFO - PROCESS | 1641 | |3;mootools.html;1305.8498272698641;1397.6715471864115;1406.212520988246;1422.4594654031466;1425.4369524038004;8054.637541310641;8145.551994640293;8381.161883811616;8486.575671216438;8510.148985101487;8312.75061748147;8395.496270223792;8424.073351931283;8440;8467.576621168948;2207.5253820428643;2239.641657334827;2242.372135801978;2244.1584405847807;2246.9887650561723;2238.787315205053;2276.8520046196945;2279.794818466338;2279.817614590837;2288.0733303012307;2226.14293497004;2235;2249.718785151856;2254.5603607296503;2260.49138943738;2135.444784356063;2192.7916847899423;2211.756706762255;2222.811061059812;2231.062953559501;1941.1167918597005;2019.0813180003063;2182.6944227807962;2253.0649780341137;2258.966115508252;8144;8412.579371031425;8419;8456.78858028548;8512.48925064492;4375.956240437618;5000.174971129759;5159.329287192679;5161.406438259611;5166.07010738067;3353.195233144028;3432.9141771455666;3480.582330120402;3482.251315967054;3486.1110416843544;1117.4245263689124;1123.8819923908036;1144.1590431033185;1227.0858210633046;1628.1370873437097;8213.38399620025;10702.090322322612;10914.672559823219;10993.835092473619;10994.560217591286;4112.91774164515;4350.260455722471;4389.078293558325;4411.669124815588;4424.60178583929;8667.479951202948;8740.694075707319;8749;8755.518446485377;8803.867941980876;5054.241863720398;5058.1654027085115;5063.11395505785;5071.847844564669;5082.847514574569;4562.931556026662;4672.2057250267535;4680.672352935262;4722.1028004679;4752.287156926489;3230.596175478065;3751.437284407361;3756.1924186300075;3810.72340765841;3864.439656249884;1250.1748845761754;1262.5644152767281;1263.1473755215193;1281.333706472629;1294.9482020719254;846.3948276981987;879.2350654930252;880.423322723617;920.2775820980498;929.5445231836487;5418.106012507971;5541.889162216814;5559.722013899289;5595.608307418523;5670.829875103754;543.3724048723731;558.488982580942;558.9776408943678;561.6237121128853;564.3960961770865;3662.304162209172;3693.538307711536;3716.2939041582013;3837.846486140579;3888.9805550972064;8830.955845220733;9473.66842160521;9805;9841.60633574649;9896.208303335716;9576.329656924088;9925.1067403934;9929.751756206153;9934.205263578897;9941.304108712466;7511.32398084175;7770.689172433039;7774.339181169551;7792.142864285038;7817.8827317590285;5499.092649712753;5537.861553461034;5539.446055394428;5575.832725018256;5591.30108736408;8872.24585910205;8950.820983580423;9067.90932090697;9199.77000574991;9207.677731279373;8013.19868013194;8280.089190189196;9184.08159184103;9239.214666753402;9346.252299815862;7127.75052873147;7194.5683259002535;7200.675969581486;7201.819954501179;7206.387457065998;7574.697012119454;7716.112647045662;7784.026996625422;7789.7273595423885;7836.333911617577;6832.863342733217;6855.794326170223;6871.862562748617;6876.896846547406;6993.2657071006815;6727.966360168168;6771.356721111487;7104.893426598708;7238.782836514913;7424.628768561658;5198.4801519847715;6304.684765761602;6341.619502829845;6393.8721225576155;6407.070974708734;4773.498782627774;4839.516048395273;4912.533309335608;5028.120078986236;5030.144875371268;3659.3596120678244;4876.902461950812;4881.194602890625;5000.724960127228;5049.545540901337 05:08:19 INFO - PROCESS | 1641 | |4;prototype.html;298.61180465394983;347.83815120554175;363.4729642019073;365.48649147947145;371.90516418313337;4221.121600887606;4808.398950131229;5367.087595108831;5461.918071228934;5584;4991.975040124803;5055.736065983504;5260;5397.676139431637;5404;4018.8995275118064;4098.262312783698;4099.405586190001;4109.007131541208;4121.608447197512;3734.3091528067257;3849.8075096245216;4114.8148333324925;4118.649914757234;4142.668586513072;4013.8394464221396;4026.4765580474495;4028.96537248689;4033.2336855997414;4033.5764744701823;3730.7015438764834;4015.8996025099314;4062.9593704062877;4070.75575465473;4073.348264277731;3089.258577941278;3517;3522.630123836986;3523.189666376722;3529.523514325559;4581.496035436099;4646.930296045562;5219.895602087937;5241.764120614544;5370.731463426813;3901.726879118463;4118.073433477443;4606.968902210566;4630.953690463086;4631.791569379352;5018.7992480300745;5258.894822103536;5271.389098467562;5686.402927692616;5811.389804070596;3380.8309584520675;3688.391415416453;3806.7906265155407;3839.596842331543;3865.4974853269177;5053.134352220554;5536.754230298151;5738.3687794343;5882.058870580687;6044.516438684895;3291.572095627553;3755.5493340798735;3818.293615681108;3915.5497117831246;3917.6082391761165;3966;3971.821268042945;3972.880813575597;3976.4035394691027;3981.960180398217;4105.398894431174;4289.656827453796;4608.193566125915;4636.559526844944;4637.5130611286;4814.807407703723;5409.56723462122;5498.615096943256;5681.545476361881;5712.828615141552;1197.754335491097;1211.5820042085466;1269.8095285707034;1276.4064709909937;1290.3548225887057;758.2266088589607;758.3932853717005;816.5141740664413;860.3848248502351;876.2639382918379;4627.930581041287;4705.4588722296685;5071.949280507221;5205.6616319939085;5216.895662086737;5253.395859476209;5293.62365784891;5659.745311460994;5665.943340566624;5771.509421699118;4766.976165119221;4792.95207047925;5070.29015937769;5159.2003239497935;5219.269302297681;2641.616965539986;2751.1058905855675;2823.096609085073;2981.567672687448;2988.63897520956;5846.386129456346;5868.647881127146;5937.435943585352;5944.613600116065;5951.226340575784;4979.651424400257;5138.3833939927445;5636.351819540723;5824;5897.2038774765715;5122.564582010496;5299.549538289211;5332.880095180056;5543;5920.585559010914;4891.51084891508;5146.353166986529;5418.783248670166;5554.444555544414;5718.94118117469;5219.451957544555;5281.524662780368;5489.600151961225;5595.63628364155;5652.236948011966;5723.513501352265;5877.970610147093;5912.497437717842;5968.612040217372;5973.91039134422;3839.308924393636;3841.558220804643;3855.5566109897723;3856.3251430998903;3890.0469385000856;5016.2224855147515;5317.308749862493;5440.945590544044;5809.24479817621;5853.94146058534;4818.566329030404;4905.117078925828;5619.438056194348;5657.349404818334;5690.886182276414;5007.624428167829;5448.645838020516;5643.181738647955;5646.237757902631;5664.26364572603;4692.920628255589;4919.975400122977;4937.580305674058;5560.443955604407;5603.299587551556;4633.513481084437;5593.028949445939;5623.634463759842;5634.352049514358;5652.975658022938;4995.925061124159;5136.12685843415;5470.234167216513;5553.6390134641115;5580.572450983835 05:08:19 INFO - PROCESS | 1641 | |5;yui.html;635.0410879571848;648.5103746671268;710.4565007769057;754.4341743692231;789.8578255913935;14381.209033503153;15339.92330038351;15341.463048793294;15404.69190616187;15420.537383878474;12671.746565068715;13268.407791065061;13887.79168312476;14179.220142892136;14182.929085354559;828.5981299069977;842.3177226446567;847.0470720439506;848.1010129263001;858.6522458404326;738.7488253993641;862.5687156421789;870.7735988642935;871.6992637540038;876.5003947749753;911.6353458616541;911.7583840282331;911.8632205169245;912.2291663544295;922.3820040572832;736.8968344431757;868.8088620503479;880.5025160784137;905.0813424374265;908.5548081440113;659.7855696898528;669.581511555278;672.5863593889723;673.2863165045068;673.612672713187;11685.41572921359;14926.253687315699;15174.772378414333;15187.772183417257;15269;13667.726645467135;13677.658058548615;13678.93160534191;13834.23911684857;13865.4453821847;11084.778304433947;11322.178640583932;11353.659390218225;11601.535938562447;11609;3563.518924945151;3564.21587250807;3577.9821100894587;3610.945835812465;3730.4404339349044;100571;101800.49099754453;102987.45518817299;103423.48288258586;104009;10343.27597068213;10344;10432.269741118049;10451.216158788122;10538.304759621167;21471.78528214698;21892.562148757253;21934;21945.561088778137;21949.341519754435;7281.7087316507805;7380.335769780638;7415.036045314183;7441.404687624977;7604.8479030419085;3959.8416063357145;4042.333015052542;4072.6538244249573;4079.143379890197;4082.510098788105;3540;3602.4056030755155;3620.0768803954825;3642.4718415829557;3649.817509124586;555.927729395176;632.8987362022146;643.4787821864305;658.4863806231148;671.2347923367365;561.9241402410622;632.7469012395079;641.1568787045021;657.2704298228962;692.7609974558769;8742.956285218534;9436.764080897896;10546.947265263625;10635.361878287327;10974.506147223394;540.7242306423752;557.3061538384737;568.7810193075613;620.8758248350348;680.210955291859;4537.931931021038;4856.426094170025;4879.39007624047;4912.508749125059;4926.113299606105;69498.3050169502;92844.53577732203;93334;93807;96989;52723.783767661145;81524.91202815161;83481.58259208665;85143;88722;67024;67302.99045514321;75202.4959500818;75969.9999999989;76934.23065769383;10058.597656093674;10393.844092338772;10506.422146781695;10574.206934480098;10637.468126593485;46126;49011.5098849007;49139.508604914925;49913.75043124761;49944.50055499398;62766;63792;67213.3278667207;67317;68123.65938170278;12171.634850954486;12296.778301792956;12318.384080795746;12400.937995309965;13014.869851301366;13747.587572372844;13863.861361386256;13899.374528146056;14166.362513686703;14208.71582568322;12779.552715654907;12830;13134.474621015052;13229.933850330686;13408.927285817306;12902.161359511601;13018.285278096013;13194.472221111047;13271.86728132745;13292.734145317232;12776.936115319364;12789.232646041268;12832.679183020498;12964.286964217059;13275.601731948056;9068.22920051803;9121.543922803701;9349.767525213774;9369.297302702189;9487.905120948702;8779;10617.946910265398;10636.680899573024;10636.84044739314;10667.146628269564 05:08:19 INFO - PROCESS | 1641 | __end_tp_report 05:08:19 INFO - PROCESS | 1641 | __start_cc_report 05:08:19 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,420 05:08:19 INFO - PROCESS | 1641 | __end_cc_report 05:08:19 INFO - PROCESS | 1641 | __startTimestamp1486991299085__endTimestamp 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | ------- Summary: start ------- 05:08:19 INFO - PROCESS | 1641 | Number of tests: 6 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5460.69 Median:5588.61 stddev:706.67 (12.6%) stddev-sans-first:669.11 05:08:19 INFO - PROCESS | 1641 | Values: 2482.8 2726.4 2803.6 3296.6 3297.5 5359.2 5416.4 5452.0 5457.5 5515.4 4612.7 5466.2 5519.7 5533.5 5542.3 4676.4 4980.5 4981.8 5018.8 5098.6 5068.0 5101.2 5134.5 5162.5 5213.0 4924.9 5015.3 5018.1 5019.6 5094.2 5035.7 5056.4 5062.7 5070.7 5080.3 3868.4 3908.9 4255.7 4463.3 4969.8 4435.6 4625.7 5231.7 5360.4 5480.5 6034.4 6042.4 6047.3 6062.0 6063.6 6105.8 6116.9 6124.7 6125.4 6145.5 5421.8 5538.8 5551.2 5557.6 5641.7 6055.3 6082.4 6102.1 6105.8 6113.5 5571.3 5589.5 5639.0 5727.8 5992.1 5817.2 5834.4 5976.9 6031.3 6083.2 6010.4 6015.0 6033.8 6037.2 6045.6 5709.0 6030.3 6038.1 6042.8 6053.2 4686.1 4757.5 4778.5 4786.9 4827.4 4285.0 4316.9 4354.2 4364.1 4368.6 5447.5 5459.4 5478.1 5478.9 5488.6 4797.7 5911.8 5913.7 5939.8 6022.5 5460.8 5463.1 5476.2 5487.0 5488.7 4707.7 5257.1 5316.4 5336.7 5352.6 6191.6 6206.7 6230.2 6231.3 6250.1 5882.7 5955.6 6044.5 6133.9 6160.9 5094.7 6111.7 6146.5 6150.8 6158.1 6029.6 6035.6 6036.8 6072.0 6091.8 6059.4 6081.5 6097.2 6112.6 6116.8 4513.4 5455.2 5666.2 5706.9 5787.3 5588.6 5679.8 5775.7 5793.7 5896.3 4911.4 5599.1 5764.0 5783.5 5823.9 5862.4 5874.1 5921.1 5943.1 5951.8 5478.9 5527.8 5631.8 5637.1 5737.3 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:61824.91 Median:33710.40 stddev:132695.39 (393.6%) stddev-sans-first:132987.67 05:08:19 INFO - PROCESS | 1641 | Values: 468.1 505.2 508.1 522.8 541.8 32033.4 36359.6 38797.8 39163.8 39283.0 38872.0 39032.8 39720.8 39773.2 39797.0 8950.8 10454.3 10803.5 10975.5 10975.7 9203.3 10640.0 10695.3 10736.6 10738.7 9262.2 10604.5 10778.4 10789.2 10808.8 9320.6 10595.8 10694.7 10722.4 10783.2 10788.0 10875.2 10886.9 10887.5 10887.6 35516.3 35678.5 35797.0 35840.8 36032.1 3644.8 3677.4 3677.5 3694.9 3713.1 26746.3 26863.6 26923.1 27633.9 27724.2 2586.3 2994.9 3068.7 3086.0 3131.1 390370.0 391645.0 392759.0 393983.0 394026.0 51801.5 52500.7 52969.1 53052.7 53053.2 52877.7 53081.9 53207.0 53225.7 53373.2 13959.7 14299.7 14450.2 14479.1 14489.5 10883.7 11020.4 11077.6 11083.3 11094.8 13632.9 16277.9 16452.0 16487.5 16515.3 7197.0 7220.5 7220.8 7236.3 7326.3 821.6 830.8 832.5 839.9 855.8 25941.4 26006.5 26626.5 27411.7 29095.9 999.4 1040.9 1044.0 1045.6 1104.4 13822.0 14930.6 14955.9 15178.7 15279.9 577787.0 580838.1 583491.0 584653.0 585729.0 58053.0 58558.4 58700.7 58822.7 59029.4 1199.8 1239.9 1314.8 1352.3 1360.3 29472.0 30348.4 30436.5 30767.4 30935.2 38990.0 46713.5 46719.5 46971.3 47270.8 495531.0 497048.0 498679.5 499776.0 500274.0 21400.8 24220.5 24698.8 25812.6 26007.3 40150.8 40190.4 40694.6 41794.8 41817.8 34595.7 34963.0 35208.8 35275.0 35395.6 32838.5 33902.8 34003.7 34747.8 34911.0 33014.7 33286.0 33627.0 33692.2 33728.7 21336.6 27780.6 28487.9 31056.8 31273.0 22725.5 22836.4 23716.4 23921.9 24043.9 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:38585.64 Median:2835.15 stddev:107187.08 (3780.7%) stddev-sans-first:107449.39 05:08:19 INFO - PROCESS | 1641 | Values: 387.2 390.7 397.4 401.9 422.7 13538.8 18486.5 19603.6 19791.5 19832.3 20747.5 20844.8 20877.4 20953.7 20972.8 5339.7 5752.3 5761.6 5787.0 5800.0 5559.7 5740.8 5758.5 5763.5 5812.6 5712.8 5731.9 5742.7 5746.7 5749.6 5511.2 5687.2 5725.7 5747.3 5749.9 5027.2 5049.7 5059.3 5078.3 5083.4 24025.5 25677.2 26632.5 26633.7 27337.2 2720.2 2739.3 2829.6 2840.7 2892.9 15872.7 15898.6 16085.3 16143.1 16546.8 1924.7 1954.6 1974.7 1976.2 1987.3 159156.0 161641.2 162314.0 165434.0 166139.2 20893.5 22983.5 23164.0 23196.2 23410.5 9669.7 12615.4 39415.0 39545.4 39565.2 7758.5 7832.1 7845.3 7959.9 7973.9 7786.3 7804.5 7831.9 7932.8 7945.3 3843.4 4096.8 4101.9 4141.3 4190.8 1884.4 2084.1 2085.6 2096.4 2097.8 964.9 976.7 978.1 980.7 1027.8 20274.5 20369.1 20520.9 20548.0 20550.6 904.5 998.3 1005.9 1008.4 1035.7 8973.6 10091.7 10550.5 10588.5 10634.6 498117.0 644362.0 647951.0 664257.0 693291.0 124835.0 128287.0 160587.0 161957.2 165952.2 991.9 999.7 1022.6 1024.5 1027.6 17350.4 18105.0 18211.5 18342.9 18384.3 52055.7 59272.8 59597.7 60173.8 60353.4 63473.4 83841.6 84044.2 84208.6 85129.0 8096.1 8272.9 8404.7 8471.2 8507.5 11407.5 12588.0 12637.6 12932.2 13014.2 10968.7 11129.2 11250.1 11273.8 11281.5 10372.9 10427.7 10737.4 11080.6 11186.0 10628.5 10704.5 10898.3 11352.3 11491.8 8118.6 8152.5 8300.0 8548.5 8566.4 6812.5 8474.9 8972.4 9708.3 10200.9 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5315.38 Median:2980.74 stddev:2911.69 (97.7%) stddev-sans-first:2904.26 05:08:19 INFO - PROCESS | 1641 | Values: 1305.8 1397.7 1406.2 1422.5 1425.4 8054.6 8145.6 8381.2 8486.6 8510.1 8312.8 8395.5 8424.1 8440.0 8467.6 2207.5 2239.6 2242.4 2244.2 2247.0 2238.8 2276.9 2279.8 2279.8 2288.1 2226.1 2235.0 2249.7 2254.6 2260.5 2135.4 2192.8 2211.8 2222.8 2231.1 1941.1 2019.1 2182.7 2253.1 2259.0 8144.0 8412.6 8419.0 8456.8 8512.5 4376.0 5000.2 5159.3 5161.4 5166.1 3353.2 3432.9 3480.6 3482.3 3486.1 1117.4 1123.9 1144.2 1227.1 1628.1 8213.4 10702.1 10914.7 10993.8 10994.6 4112.9 4350.3 4389.1 4411.7 4424.6 8667.5 8740.7 8749.0 8755.5 8803.9 5054.2 5058.2 5063.1 5071.8 5082.8 4562.9 4672.2 4680.7 4722.1 4752.3 3230.6 3751.4 3756.2 3810.7 3864.4 1250.2 1262.6 1263.1 1281.3 1294.9 846.4 879.2 880.4 920.3 929.5 5418.1 5541.9 5559.7 5595.6 5670.8 543.4 558.5 559.0 561.6 564.4 3662.3 3693.5 3716.3 3837.8 3889.0 8831.0 9473.7 9805.0 9841.6 9896.2 9576.3 9925.1 9929.8 9934.2 9941.3 7511.3 7770.7 7774.3 7792.1 7817.9 5499.1 5537.9 5539.4 5575.8 5591.3 8872.2 8950.8 9067.9 9199.8 9207.7 8013.2 8280.1 9184.1 9239.2 9346.3 7127.8 7194.6 7200.7 7201.8 7206.4 7574.7 7716.1 7784.0 7789.7 7836.3 6832.9 6855.8 6871.9 6876.9 6993.3 6728.0 6771.4 7104.9 7238.8 7424.6 5198.5 6304.7 6341.6 6393.9 6407.1 4773.5 4839.5 4912.5 5028.1 5030.1 3659.4 4876.9 4881.2 5000.7 5049.5 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4499.07 Median:5017.51 stddev:1377.98 (27.5%) stddev-sans-first:1345.29 05:08:19 INFO - PROCESS | 1641 | Values: 298.6 347.8 363.5 365.5 371.9 4221.1 4808.4 5367.1 5461.9 5584.0 4992.0 5055.7 5260.0 5397.7 5404.0 4018.9 4098.3 4099.4 4109.0 4121.6 3734.3 3849.8 4114.8 4118.6 4142.7 4013.8 4026.5 4029.0 4033.2 4033.6 3730.7 4015.9 4063.0 4070.8 4073.3 3089.3 3517.0 3522.6 3523.2 3529.5 4581.5 4646.9 5219.9 5241.8 5370.7 3901.7 4118.1 4607.0 4631.0 4631.8 5018.8 5258.9 5271.4 5686.4 5811.4 3380.8 3688.4 3806.8 3839.6 3865.5 5053.1 5536.8 5738.4 5882.1 6044.5 3291.6 3755.5 3818.3 3915.5 3917.6 3966.0 3971.8 3972.9 3976.4 3982.0 4105.4 4289.7 4608.2 4636.6 4637.5 4814.8 5409.6 5498.6 5681.5 5712.8 1197.8 1211.6 1269.8 1276.4 1290.4 758.2 758.4 816.5 860.4 876.3 4627.9 4705.5 5071.9 5205.7 5216.9 5253.4 5293.6 5659.7 5665.9 5771.5 4767.0 4793.0 5070.3 5159.2 5219.3 2641.6 2751.1 2823.1 2981.6 2988.6 5846.4 5868.6 5937.4 5944.6 5951.2 4979.7 5138.4 5636.4 5824.0 5897.2 5122.6 5299.5 5332.9 5543.0 5920.6 4891.5 5146.4 5418.8 5554.4 5718.9 5219.5 5281.5 5489.6 5595.6 5652.2 5723.5 5878.0 5912.5 5968.6 5973.9 3839.3 3841.6 3855.6 3856.3 3890.0 5016.2 5317.3 5440.9 5809.2 5853.9 4818.6 4905.1 5619.4 5657.3 5690.9 5007.6 5448.6 5643.2 5646.2 5664.3 4692.9 4920.0 4937.6 5560.4 5603.3 4633.5 5593.0 5623.6 5634.4 5653.0 4995.9 5136.1 5470.2 5553.6 5580.6 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19272.68 Median:4080.83 stddev:27179.45 (666.0%) stddev-sans-first:27219.67 05:08:19 INFO - PROCESS | 1641 | Values: 635.0 648.5 710.5 754.4 789.9 14381.2 15339.9 15341.5 15404.7 15420.5 12671.7 13268.4 13887.8 14179.2 14182.9 828.6 842.3 847.0 848.1 858.7 738.7 862.6 870.8 871.7 876.5 911.6 911.8 911.9 912.2 922.4 736.9 868.8 880.5 905.1 908.6 659.8 669.6 672.6 673.3 673.6 11685.4 14926.3 15174.8 15187.8 15269.0 13667.7 13677.7 13678.9 13834.2 13865.4 11084.8 11322.2 11353.7 11601.5 11609.0 3563.5 3564.2 3578.0 3610.9 3730.4 100571.0 101800.5 102987.5 103423.5 104009.0 10343.3 10344.0 10432.3 10451.2 10538.3 21471.8 21892.6 21934.0 21945.6 21949.3 7281.7 7380.3 7415.0 7441.4 7604.8 3959.8 4042.3 4072.7 4079.1 4082.5 3540.0 3602.4 3620.1 3642.5 3649.8 555.9 632.9 643.5 658.5 671.2 561.9 632.7 641.2 657.3 692.8 8743.0 9436.8 10546.9 10635.4 10974.5 540.7 557.3 568.8 620.9 680.2 4537.9 4856.4 4879.4 4912.5 4926.1 69498.3 92844.5 93334.0 93807.0 96989.0 52723.8 81524.9 83481.6 85143.0 88722.0 67024.0 67303.0 75202.5 75970.0 76934.2 10058.6 10393.8 10506.4 10574.2 10637.5 46126.0 49011.5 49139.5 49913.8 49944.5 62766.0 63792.0 67213.3 67317.0 68123.7 12171.6 12296.8 12318.4 12400.9 13014.9 13747.6 13863.9 13899.4 14166.4 14208.7 12779.6 12830.0 13134.5 13229.9 13408.9 12902.2 13018.3 13194.5 13271.9 13292.7 12776.9 12789.2 12832.7 12964.3 13275.6 9068.2 9121.5 9349.8 9369.3 9487.9 8779.0 10617.9 10636.7 10636.8 10667.1 05:08:19 INFO - PROCESS | 1641 | -------- Summary: end -------- 05:08:19 INFO - PROCESS | 1641 | 05:08:19 INFO - TEST-INFO | 1641: exit 0 05:08:19 INFO - TEST-OK | dromaeo_css | took 1115641ms 05:08:19 INFO - TEST-START | kraken 05:08:19 INFO - operating with platform_type : mac_ 05:08:19 INFO - Initialising browser for kraken test... 05:08:19 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/tmpRQRuWx/profile http://localhost:49244/getInfo.html) 05:08:22 INFO - PROCESS | 1653 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:08:22 INFO - PROCESS | 1653 | 2017-02-13 05:08:22.592 plugin-container[1654:9953] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 05:08:22 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:22 INFO - PROCESS | 1653 | 2017-02-13 05:08:22.595 plugin-container[1654:9953] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 05:08:22 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:22 INFO - PROCESS | 1653 | 2017-02-13 05:08:22.595 plugin-container[1654:9953] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:08:22 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 05:08:22 INFO - PROCESS | 1653 | colorDepth:24 05:08:22 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 05:08:22 INFO - PROCESS | 1653 | __metrics 05:08:22 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:08:23 INFO - TEST-INFO | 1653: exit 0 05:08:23 INFO - Browser initialized. 05:08:23 INFO - Running cycle 1/1 for kraken test... 05:08:23 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/T/tmpRQRuWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:25 INFO - PROCESS | 1655 | 2017-02-13 05:08:25.920 plugin-container[1656:10071] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 05:08:25 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:25 INFO - PROCESS | 1655 | 2017-02-13 05:08:25.920 plugin-container[1656:10071] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 05:08:25 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:25 INFO - PROCESS | 1655 | 2017-02-13 05:08:25.921 plugin-container[1656:10071] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:08:35 INFO - PROCESS | 1655 | RSS: Main: 233328640 05:08:35 INFO - PROCESS | 1655 | 05:08:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:39 INFO - PROCESS | 1655 | RSS: Main: 247975936 05:08:39 INFO - PROCESS | 1655 | 05:08:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 05:08:42 INFO - PROCESS | 1655 | RSS: Main: 255762432 05:08:42 INFO - PROCESS | 1655 | 05:08:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 05:08:46 INFO - PROCESS | 1655 | RSS: Main: 258240512 05:08:46 INFO - PROCESS | 1655 | 05:08:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 05:08:49 INFO - PROCESS | 1655 | RSS: Main: 260493312 05:08:49 INFO - PROCESS | 1655 | 05:08:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:52 INFO - PROCESS | 1655 | RSS: Main: 261222400 05:08:52 INFO - PROCESS | 1655 | 05:08:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 05:08:55 INFO - PROCESS | 1655 | RSS: Main: 266547200 05:08:55 INFO - PROCESS | 1655 | 05:08:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 05:08:59 INFO - PROCESS | 1655 | RSS: Main: 265674752 05:08:59 INFO - PROCESS | 1655 | 05:09:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 05:09:03 INFO - PROCESS | 1655 | RSS: Main: 266620928 05:09:03 INFO - PROCESS | 1655 | 05:09:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:05 INFO - PROCESS | 1655 | RSS: Main: 265486336 05:09:05 INFO - PROCESS | 1655 | 05:09:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:08 INFO - PROCESS | 1655 | RSS: Main: 265297920 05:09:08 INFO - PROCESS | 1655 | 05:09:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:11 INFO - PROCESS | 1655 | RSS: Main: 265347072 05:09:11 INFO - PROCESS | 1655 | 05:09:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:15 INFO - PROCESS | 1655 | RSS: Main: 265744384 05:09:15 INFO - PROCESS | 1655 | 05:09:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:18 INFO - PROCESS | 1655 | RSS: Main: 265543680 05:09:18 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 05:09:20 INFO - PROCESS | 1655 | RSS: Main: 267583488 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | __start_tp_report 05:09:20 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 05:09:20 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 05:09:20 INFO - PROCESS | 1655 | |i|pagename|runs| 05:09:20 INFO - PROCESS | 1655 | |0;ai-astar;106;117;116;118;117;124;156;117;117;119 05:09:20 INFO - PROCESS | 1655 | |1;audio-beat-detection;145;116;116;154;116;118;115;121;134;106 05:09:20 INFO - PROCESS | 1655 | |2;audio-dft;202;212;211;245;203;271;192;201;194;200 05:09:20 INFO - PROCESS | 1655 | |3;audio-fft;82;59;61;90;87;51;79;51;74;79 05:09:20 INFO - PROCESS | 1655 | |4;audio-oscillator;86;72;84;72;74;73;85;73;72;83 05:09:20 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;90;95;90;98;131;102;137;108;89;90 05:09:20 INFO - PROCESS | 1655 | |6;imaging-darkroom;120;97;97;96;102;134;154;113;97;97 05:09:20 INFO - PROCESS | 1655 | |7;imaging-desaturate;114;94;113;149;91;90;136;86;149;147 05:09:20 INFO - PROCESS | 1655 | |8;json-parse-financial;62;61;61;62;62;64;65;65;64;64 05:09:20 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;73;79;76;73;73;73;73;73;75;76 05:09:20 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;89;91;93;95;92;93;92;92;92;92 05:09:20 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;143;156;163;149;154;166;158;143;229;171 05:09:20 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;179;181;178;183;179;177;174;174;173;172 05:09:20 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;71;75;70;71;67;70;68;69;65;67 05:09:20 INFO - PROCESS | 1655 | __end_tp_report 05:09:20 INFO - PROCESS | 1655 | __start_cc_report 05:09:20 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,998 05:09:20 INFO - PROCESS | 1655 | __end_cc_report 05:09:20 INFO - PROCESS | 1655 | __startTimestamp1486991360655__endTimestamp 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | ------- Summary: start ------- 05:09:20 INFO - PROCESS | 1655 | Number of tests: 14 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:120.70 Median:117.50 stddev:13.17 (11.2%) stddev-sans-first:12.85 05:09:20 INFO - PROCESS | 1655 | Values: 106.0 117.0 116.0 118.0 117.0 124.0 156.0 117.0 117.0 119.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:119.50 stddev:15.21 (12.7%) stddev-sans-first:14.13 05:09:20 INFO - PROCESS | 1655 | Values: 145.0 116.0 116.0 154.0 116.0 118.0 115.0 121.0 134.0 106.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:213.10 Median:207.00 stddev:25.23 (12.2%) stddev-sans-first:26.44 05:09:20 INFO - PROCESS | 1655 | Values: 202.0 212.0 211.0 245.0 203.0 271.0 192.0 201.0 194.0 200.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:71.30 Median:79.00 stddev:14.60 (18.5%) stddev-sans-first:14.96 05:09:20 INFO - PROCESS | 1655 | Values: 82.0 59.0 61.0 90.0 87.0 51.0 79.0 51.0 74.0 79.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.50 stddev:6.19 (7.9%) stddev-sans-first:5.73 05:09:20 INFO - PROCESS | 1655 | Values: 86.0 72.0 84.0 72.0 74.0 73.0 85.0 73.0 72.0 83.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:103.00 Median:90.00 stddev:17.51 (19.5%) stddev-sans-first:17.92 05:09:20 INFO - PROCESS | 1655 | Values: 90.0 95.0 90.0 98.0 131.0 102.0 137.0 108.0 89.0 90.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:110.70 Median:96.50 stddev:19.87 (20.6%) stddev-sans-first:20.78 05:09:20 INFO - PROCESS | 1655 | Values: 120.0 97.0 97.0 96.0 102.0 134.0 154.0 113.0 97.0 97.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:116.90 Median:117.50 stddev:26.31 (22.4%) stddev-sans-first:27.88 05:09:20 INFO - PROCESS | 1655 | Values: 114.0 94.0 113.0 149.0 91.0 90.0 136.0 86.0 149.0 147.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:64.00 stddev:1.56 (2.4%) stddev-sans-first:1.62 05:09:20 INFO - PROCESS | 1655 | Values: 62.0 61.0 61.0 62.0 62.0 64.0 65.0 65.0 64.0 64.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:74.00 stddev:2.07 (2.8%) stddev-sans-first:2.13 05:09:20 INFO - PROCESS | 1655 | Values: 73.0 79.0 76.0 73.0 73.0 73.0 73.0 73.0 75.0 76.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:92.00 stddev:1.52 (1.7%) stddev-sans-first:1.13 05:09:20 INFO - PROCESS | 1655 | Values: 89.0 91.0 93.0 95.0 92.0 93.0 92.0 92.0 92.0 92.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:163.20 Median:160.50 stddev:24.90 (15.5%) stddev-sans-first:25.31 05:09:20 INFO - PROCESS | 1655 | Values: 143.0 156.0 163.0 149.0 154.0 166.0 158.0 143.0 229.0 171.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:178.50 stddev:3.65 (2.0%) stddev-sans-first:3.80 05:09:20 INFO - PROCESS | 1655 | Values: 179.0 181.0 178.0 183.0 179.0 177.0 174.0 174.0 173.0 172.0 05:09:20 INFO - PROCESS | 1655 | 05:09:20 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:2.79 (4.0%) stddev-sans-first:2.89 05:09:20 INFO - PROCESS | 1655 | Values: 71.0 75.0 70.0 71.0 67.0 70.0 68.0 69.0 65.0 67.0 05:09:20 INFO - PROCESS | 1655 | -------- Summary: end -------- 05:09:20 INFO - PROCESS | 1655 | 05:09:21 INFO - TEST-INFO | 1655: exit 0 05:09:21 INFO - TEST-OK | kraken | took 61843ms 05:09:21 INFO - SUITE-END | took 1177s 05:09:21 INFO - Completed test suite (00:19:37) 05:09:21 INFO - javascript benchmark 05:09:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7105.688683229061, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2482.751724827517, 2726.4138210284787, 2803.621511096002, 3296.637369889313, 3297.5383446317533, 5359.196120581914, 5416.404195538487, 5451.972740136299, 5457.508824205821, 5515.448455154483, 4612.700174488656, 5466.207399927008, 5519.69641669708, 5533.47431993961, 5542.307211598551, 4676.3920690310215, 4980.477049909761, 4981.825636102719, 5018.799248030084, 5098.617603679721, 5067.9746601267125, 5101.234814777776, 5134.460881607433, 5162.5095615916425, 5213.0, 4924.901501969976, 5015.297858299841, 5018.146915024455, 5019.573336266421, 5094.2358646203365, 5035.748212589356, 5056.367954005749, 5062.746862656889, 5070.670406423607, 5080.339555857752, 3868.4197370394386, 3908.902277443058, 4255.659547236213, 4463.285874260136, 4969.751512424365, 4435.62297204738, 4625.745583992879, 5231.712255825928, 5360.3567571891235, 5480.534154596864, 6034.36639152887, 6042.395760423967, 6047.274327080779, 6062.0, 6063.575549711522, 6105.755769769248, 6116.938830611682, 6124.693765311717, 6125.448709616156, 6145.539084568675, 5421.83734487966, 5538.75075621594, 5551.195076713854, 5557.5831812614215, 5641.717914104278, 6055.333913269536, 6082.422169893853, 6102.125716101306, 6105.786297479567, 6113.476306051762, 5571.331440227118, 5589.524890384281, 5639.0, 5727.7995270166175, 5992.101184822224, 5817.185594016841, 5834.416558344132, 5976.910346344808, 6031.276246850406, 6083.239595050619, 6010.398960104042, 6015.0, 6033.849153771191, 6037.184980027728, 6045.6070355426755, 5708.971455142698, 6030.33666296707, 6038.064100064497, 6042.788502402394, 6053.213082299273, 4686.062787442525, 4757.452892917289, 4778.450478195052, 4786.904261914742, 4827.396575428072, 4285.035866929916, 4316.935245971313, 4354.194474022316, 4364.148990946735, 4368.584984426474, 5447.478572852334, 5459.372172200168, 5478.096114141202, 5478.890422191534, 5488.643238189505, 4797.712137271775, 5911.76352945886, 5913.733881975321, 5939.762409503572, 6022.488088512438, 5460.836174914759, 5463.071277882769, 5476.2333273341765, 5487.012337779158, 5488.670679759227, 4707.7175369477945, 5257.106291930381, 5316.388615309212, 5336.733163341817, 5352.598555108382, 6191.628502289697, 6206.658633775095, 6230.221222347116, 6231.345708700612, 6250.062490626442, 5882.705864706833, 5955.612885162451, 6044.516438684983, 6133.938660613515, 6160.907586386297, 5094.694318340911, 6111.724972376165, 6146.5390095742105, 6150.7539698411565, 6158.076288556752, 6029.57792954489, 6035.577509574287, 6036.8188954331445, 6071.969640151771, 6091.847703807441, 6059.424354686298, 6081.452669259788, 6097.176881120992, 6112.602680825732, 6116.847078822887, 4513.390692256503, 5455.18172274162, 5666.206731057738, 5706.885862282648, 5787.276590426197, 5588.608797384144, 5679.801206957736, 5775.711214439178, 5793.739281732248, 5896.292444906639, 4911.386076740408, 5599.12429336177, 5764.0, 5783.537317014545, 5823.854403639773, 5862.413758624103, 5874.148248503858, 5921.052631578927, 5943.108533719977, 5951.791687290924, 5478.945210547843, 5527.778888844401, 5631.831045068655, 5637.098064309691, 5737.311522617312], "value": 5410.240661368479, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.12927954005556, 505.1891713799352, 508.09305389879074, 522.7569180331145, 541.7887024060619, 32033.359332813387, 36359.63640363596, 38797.83606491806, 39163.80418097905, 39283.01792455183, 38872.0, 39032.804835975854, 39720.808375748704, 39773.204535909266, 39797.0, 8950.82098358034, 10454.320469169517, 10803.459827008619, 10975.50610222542, 10975.670729878117, 9203.309751768644, 10640.042396184343, 10695.251332406735, 10736.624218152367, 10738.677839664822, 9262.212711919496, 10604.522796474177, 10778.353298802058, 10789.244752867302, 10808.78382432351, 9320.580573874191, 10595.84106238407, 10694.732631684232, 10722.356658600509, 10783.245172837904, 10788.029077383073, 10875.184361172865, 10886.945565272123, 10887.455627218607, 10887.564497420093, 35516.28967420663, 35678.46482302742, 35797.0, 35840.820795896114, 36032.09919752001, 3644.7630903991158, 3677.4483827425834, 3677.4667673187505, 3694.8522059117604, 3713.0717320669833, 26746.331341716417, 26863.597046044324, 26923.057692980652, 27633.86183069092, 27724.168274951782, 2586.3404831767966, 2994.8652310646075, 3068.6777888321853, 3085.953710694319, 3131.091983324833, 390370.0, 391644.99999999715, 392759.03620482003, 393983.0, 394026.0, 51801.48198518042, 52500.73749631227, 52969.086700231084, 53052.67368315823, 53053.204201937, 52877.735611321696, 53081.93836123256, 53207.0, 53225.73387133117, 53373.199402009, 13959.720805583831, 14299.714005720036, 14450.205238711762, 14479.131252124906, 14489.492867749577, 10883.67348979532, 11020.44897755109, 11077.612283570197, 11083.279586826831, 11094.833577496343, 13632.863671363359, 16277.918610406872, 16452.0, 16487.52687096945, 16515.256813443422, 7196.96401517989, 7220.494565380373, 7220.819479512949, 7236.312550307713, 7326.267373262738, 821.6302663801314, 830.8130670599066, 832.5129799067493, 839.8530257204965, 855.7903313688187, 25941.351466213495, 26006.479870402487, 26626.500024896446, 27411.725882741317, 29095.854520727262, 999.3753903810118, 1040.942748148859, 1043.9895601044045, 1045.6235755128148, 1104.3594715065242, 13822.0, 14930.626734331729, 14955.850441495664, 15178.696426071418, 15279.923600381928, 577787.0, 580838.0958095182, 583491.0, 584653.0, 585729.0, 58053.0, 58558.41441585615, 58700.706496467246, 58822.70588647029, 59029.40970590325, 1199.8320235167084, 1239.925604463735, 1314.822498962647, 1352.2697743218748, 1360.2586590308504, 29472.0, 30348.393032139677, 30436.543451847796, 30767.384652307275, 30935.226619334695, 38990.0, 46713.53286467092, 46719.532804671515, 46971.295430569255, 47270.76364618155, 495531.0, 497048.0, 498679.50660246465, 499776.0, 500274.0, 21400.82295473764, 24220.51558968846, 24698.753012469646, 25812.61281080823, 26007.349816253987, 40150.79924600358, 40190.397144042276, 40694.59305406908, 41794.79102604467, 41817.79091104525, 34595.65404346025, 34963.0, 35208.823955880056, 35275.0, 35395.64604353924, 32838.507422388204, 33902.830485847415, 34003.65996340104, 34747.82626086853, 34911.0, 33014.65011376861, 33286.0, 33627.0, 33692.157696057795, 33728.65085396557, 21336.573268534234, 27780.583291251052, 28487.860485580346, 31056.75772969056, 31273.0, 22725.545489089796, 22836.4290892729, 23716.407089822893, 23921.880390597937, 24043.918023689326], "value": 18664.991768291737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.1637263510817, 390.74796756092337, 397.4475479084073, 401.9115794525204, 422.6622739030967, 13538.796918046237, 18486.537836554093, 19603.607927841436, 19791.50521236968, 19832.305869294578, 20747.481312967182, 20844.791552084476, 20877.373678789623, 20953.685694714553, 20972.846493442856, 5339.679619222859, 5752.252207213057, 5761.596688231804, 5786.9710651446685, 5799.971000144993, 5559.694216818073, 5740.7703691852275, 5758.452946970031, 5763.481286684198, 5812.593118481708, 5712.800051998181, 5731.942680573183, 5742.6841523716175, 5746.712664366786, 5749.59752817303, 5511.22842802008, 5687.175359572881, 5725.713714314288, 5747.252857128588, 5749.885002299951, 5027.195648696227, 5049.671771334852, 5059.3422855028975, 5078.31442755227, 5083.415407228179, 24025.519489610284, 25677.229683109537, 26632.46735065307, 26633.73366266351, 27337.179884603494, 2720.170348043846, 2739.328864428208, 2829.6321478207906, 2840.6591209055046, 2892.85535723213, 15872.682546349008, 15898.60253493672, 16085.276162572713, 16143.112128832909, 16546.83453165465, 1924.7305377247196, 1954.6481633306, 1974.7432833731523, 1976.2391479280436, 1987.2647120565484, 159156.0, 161641.1507654772, 162314.0, 165434.0, 166139.1693041539, 20893.477663058242, 22983.540329193656, 23164.0, 23196.188133415588, 23410.531789364457, 9669.661561845442, 12615.432305546272, 39415.01462463461, 39545.40681889774, 39565.230433869925, 7758.534487930742, 7832.138464768871, 7845.293923546908, 7959.880601790977, 7973.883656288124, 7786.26030527099, 7804.492707973964, 7831.882521762178, 7932.841343173104, 7945.324647405036, 3843.404272337792, 4096.836126554905, 4101.876943691694, 4141.316682747373, 4190.790460476964, 1884.3875740384156, 2084.0830034784644, 2085.6026462270315, 2096.413004358782, 2097.8216851567786, 964.9228061755043, 976.6581696406344, 978.0854900667898, 980.6812785844629, 1027.7944411117805, 20274.493137671383, 20369.08339124713, 20520.947905209658, 20548.0, 20550.58898822015, 904.5115637555778, 998.2812375089924, 1005.8591797148405, 1008.4050410257983, 1035.7203555040248, 8973.551322433983, 10091.7477063074, 10550.47247637615, 10588.523516441779, 10634.574617015232, 498117.0, 644362.0, 647951.0, 664257.0, 693291.0, 124835.0, 128287.0, 160587.0, 161957.19021404817, 165952.17023914802, 991.8908920018793, 999.7000899730198, 1022.5756311130798, 1024.5235965276183, 1027.5735569738624, 17350.39273625417, 18105.0, 18211.45365639033, 18342.899426033946, 18384.264629414673, 52055.73972130115, 59272.81454370975, 59597.702011489666, 60173.7965240684, 60353.39646603478, 63473.36526634859, 83841.58079209809, 84044.15955840364, 84208.57895710727, 85129.0, 8096.109427963037, 8272.875906861282, 8404.697271922862, 8471.237588617054, 8507.489550626982, 11407.486663100015, 12588.0, 12637.557685480964, 12932.159409638343, 13014.15407998477, 10968.73859506167, 11129.165312601426, 11250.099992000456, 11273.774524509628, 11281.492332844877, 10372.948135259276, 10427.739306517398, 10737.355758654505, 11080.61217857371, 11186.04918581897, 10628.52171652262, 10704.518296676513, 10898.346099234072, 11352.262102963281, 11491.8276225855, 8118.5940702963435, 8152.470089444168, 8300.0, 8548.487090774574, 8566.443181193203, 6812.489063320171, 8474.915250847413, 8972.37193396456, 9708.320417570701, 10200.897991019994], "value": 10148.4856485244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.8498272698641, 1397.6715471864115, 1406.212520988246, 1422.4594654031466, 1425.4369524038004, 8054.637541310641, 8145.551994640293, 8381.161883811616, 8486.575671216438, 8510.148985101487, 8312.75061748147, 8395.496270223792, 8424.073351931283, 8440.0, 8467.576621168948, 2207.5253820428643, 2239.641657334827, 2242.372135801978, 2244.1584405847807, 2246.9887650561723, 2238.787315205053, 2276.8520046196945, 2279.794818466338, 2279.817614590837, 2288.0733303012307, 2226.14293497004, 2235.0, 2249.718785151856, 2254.5603607296503, 2260.49138943738, 2135.444784356063, 2192.7916847899423, 2211.756706762255, 2222.811061059812, 2231.062953559501, 1941.1167918597005, 2019.0813180003063, 2182.6944227807962, 2253.0649780341137, 2258.966115508252, 8144.0, 8412.579371031425, 8419.0, 8456.78858028548, 8512.48925064492, 4375.956240437618, 5000.174971129759, 5159.329287192679, 5161.406438259611, 5166.07010738067, 3353.195233144028, 3432.9141771455666, 3480.582330120402, 3482.251315967054, 3486.1110416843544, 1117.4245263689124, 1123.8819923908036, 1144.1590431033185, 1227.0858210633046, 1628.1370873437097, 8213.38399620025, 10702.090322322612, 10914.672559823219, 10993.835092473619, 10994.560217591286, 4112.91774164515, 4350.260455722471, 4389.078293558325, 4411.669124815588, 4424.60178583929, 8667.479951202948, 8740.694075707319, 8749.0, 8755.518446485377, 8803.867941980876, 5054.241863720398, 5058.1654027085115, 5063.11395505785, 5071.847844564669, 5082.847514574569, 4562.931556026662, 4672.2057250267535, 4680.672352935262, 4722.1028004679, 4752.287156926489, 3230.596175478065, 3751.437284407361, 3756.1924186300075, 3810.72340765841, 3864.439656249884, 1250.1748845761754, 1262.5644152767281, 1263.1473755215193, 1281.333706472629, 1294.9482020719254, 846.3948276981987, 879.2350654930252, 880.423322723617, 920.2775820980498, 929.5445231836487, 5418.106012507971, 5541.889162216814, 5559.722013899289, 5595.608307418523, 5670.829875103754, 543.3724048723731, 558.488982580942, 558.9776408943678, 561.6237121128853, 564.3960961770865, 3662.304162209172, 3693.538307711536, 3716.2939041582013, 3837.846486140579, 3888.9805550972064, 8830.955845220733, 9473.66842160521, 9805.0, 9841.60633574649, 9896.208303335716, 9576.329656924088, 9925.1067403934, 9929.751756206153, 9934.205263578897, 9941.304108712466, 7511.32398084175, 7770.689172433039, 7774.339181169551, 7792.142864285038, 7817.8827317590285, 5499.092649712753, 5537.861553461034, 5539.446055394428, 5575.832725018256, 5591.30108736408, 8872.24585910205, 8950.820983580423, 9067.90932090697, 9199.77000574991, 9207.677731279373, 8013.19868013194, 8280.089190189196, 9184.08159184103, 9239.214666753402, 9346.252299815862, 7127.75052873147, 7194.5683259002535, 7200.675969581486, 7201.819954501179, 7206.387457065998, 7574.697012119454, 7716.112647045662, 7784.026996625422, 7789.7273595423885, 7836.333911617577, 6832.863342733217, 6855.794326170223, 6871.862562748617, 6876.896846547406, 6993.2657071006815, 6727.966360168168, 6771.356721111487, 7104.893426598708, 7238.782836514913, 7424.628768561658, 5198.4801519847715, 6304.684765761602, 6341.619502829845, 6393.8721225576155, 6407.070974708734, 4773.498782627774, 4839.516048395273, 4912.533309335608, 5028.120078986236, 5030.144875371268, 3659.3596120678244, 4876.902461950812, 4881.194602890625, 5000.724960127228, 5049.545540901337], "value": 4276.399129010754, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.61180465394983, 347.83815120554175, 363.4729642019073, 365.48649147947145, 371.90516418313337, 4221.121600887606, 4808.398950131229, 5367.087595108831, 5461.918071228934, 5584.0, 4991.975040124803, 5055.736065983504, 5260.0, 5397.676139431637, 5404.0, 4018.8995275118064, 4098.262312783698, 4099.405586190001, 4109.007131541208, 4121.608447197512, 3734.3091528067257, 3849.8075096245216, 4114.8148333324925, 4118.649914757234, 4142.668586513072, 4013.8394464221396, 4026.4765580474495, 4028.96537248689, 4033.2336855997414, 4033.5764744701823, 3730.7015438764834, 4015.8996025099314, 4062.9593704062877, 4070.75575465473, 4073.348264277731, 3089.258577941278, 3517.0, 3522.630123836986, 3523.189666376722, 3529.523514325559, 4581.496035436099, 4646.930296045562, 5219.895602087937, 5241.764120614544, 5370.731463426813, 3901.726879118463, 4118.073433477443, 4606.968902210566, 4630.953690463086, 4631.791569379352, 5018.7992480300745, 5258.894822103536, 5271.389098467562, 5686.402927692616, 5811.389804070596, 3380.8309584520675, 3688.391415416453, 3806.7906265155407, 3839.596842331543, 3865.4974853269177, 5053.134352220554, 5536.754230298151, 5738.3687794343, 5882.058870580687, 6044.516438684895, 3291.572095627553, 3755.5493340798735, 3818.293615681108, 3915.5497117831246, 3917.6082391761165, 3966.0, 3971.821268042945, 3972.880813575597, 3976.4035394691027, 3981.960180398217, 4105.398894431174, 4289.656827453796, 4608.193566125915, 4636.559526844944, 4637.5130611286, 4814.807407703723, 5409.56723462122, 5498.615096943256, 5681.545476361881, 5712.828615141552, 1197.754335491097, 1211.5820042085466, 1269.8095285707034, 1276.4064709909937, 1290.3548225887057, 758.2266088589607, 758.3932853717005, 816.5141740664413, 860.3848248502351, 876.2639382918379, 4627.930581041287, 4705.4588722296685, 5071.949280507221, 5205.6616319939085, 5216.895662086737, 5253.395859476209, 5293.62365784891, 5659.745311460994, 5665.943340566624, 5771.509421699118, 4766.976165119221, 4792.95207047925, 5070.29015937769, 5159.2003239497935, 5219.269302297681, 2641.616965539986, 2751.1058905855675, 2823.096609085073, 2981.567672687448, 2988.63897520956, 5846.386129456346, 5868.647881127146, 5937.435943585352, 5944.613600116065, 5951.226340575784, 4979.651424400257, 5138.3833939927445, 5636.351819540723, 5824.0, 5897.2038774765715, 5122.564582010496, 5299.549538289211, 5332.880095180056, 5543.0, 5920.585559010914, 4891.51084891508, 5146.353166986529, 5418.783248670166, 5554.444555544414, 5718.94118117469, 5219.451957544555, 5281.524662780368, 5489.600151961225, 5595.63628364155, 5652.236948011966, 5723.513501352265, 5877.970610147093, 5912.497437717842, 5968.612040217372, 5973.91039134422, 3839.308924393636, 3841.558220804643, 3855.5566109897723, 3856.3251430998903, 3890.0469385000856, 5016.2224855147515, 5317.308749862493, 5440.945590544044, 5809.24479817621, 5853.94146058534, 4818.566329030404, 4905.117078925828, 5619.438056194348, 5657.349404818334, 5690.886182276414, 5007.624428167829, 5448.645838020516, 5643.181738647955, 5646.237757902631, 5664.26364572603, 4692.920628255589, 4919.975400122977, 4937.580305674058, 5560.443955604407, 5603.299587551556, 4633.513481084437, 5593.028949445939, 5623.634463759842, 5634.352049514358, 5652.975658022938, 4995.925061124159, 5136.12685843415, 5470.234167216513, 5553.6390134641115, 5580.572450983835], "value": 4063.8165919552744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.0410879571848, 648.5103746671268, 710.4565007769057, 754.4341743692231, 789.8578255913935, 14381.209033503153, 15339.92330038351, 15341.463048793294, 15404.69190616187, 15420.537383878474, 12671.746565068715, 13268.407791065061, 13887.79168312476, 14179.220142892136, 14182.929085354559, 828.5981299069977, 842.3177226446567, 847.0470720439506, 848.1010129263001, 858.6522458404326, 738.7488253993641, 862.5687156421789, 870.7735988642935, 871.6992637540038, 876.5003947749753, 911.6353458616541, 911.7583840282331, 911.8632205169245, 912.2291663544295, 922.3820040572832, 736.8968344431757, 868.8088620503479, 880.5025160784137, 905.0813424374265, 908.5548081440113, 659.7855696898528, 669.581511555278, 672.5863593889723, 673.2863165045068, 673.612672713187, 11685.41572921359, 14926.253687315699, 15174.772378414333, 15187.772183417257, 15269.0, 13667.726645467135, 13677.658058548615, 13678.93160534191, 13834.23911684857, 13865.4453821847, 11084.778304433947, 11322.178640583932, 11353.659390218225, 11601.535938562447, 11609.0, 3563.518924945151, 3564.21587250807, 3577.9821100894587, 3610.945835812465, 3730.4404339349044, 100571.0, 101800.49099754453, 102987.45518817299, 103423.48288258586, 104009.0, 10343.27597068213, 10344.0, 10432.269741118049, 10451.216158788122, 10538.304759621167, 21471.78528214698, 21892.562148757253, 21934.0, 21945.561088778137, 21949.341519754435, 7281.7087316507805, 7380.335769780638, 7415.036045314183, 7441.404687624977, 7604.8479030419085, 3959.8416063357145, 4042.333015052542, 4072.6538244249573, 4079.143379890197, 4082.510098788105, 3540.0, 3602.4056030755155, 3620.0768803954825, 3642.4718415829557, 3649.817509124586, 555.927729395176, 632.8987362022146, 643.4787821864305, 658.4863806231148, 671.2347923367365, 561.9241402410622, 632.7469012395079, 641.1568787045021, 657.2704298228962, 692.7609974558769, 8742.956285218534, 9436.764080897896, 10546.947265263625, 10635.361878287327, 10974.506147223394, 540.7242306423752, 557.3061538384737, 568.7810193075613, 620.8758248350348, 680.210955291859, 4537.931931021038, 4856.426094170025, 4879.39007624047, 4912.508749125059, 4926.113299606105, 69498.3050169502, 92844.53577732203, 93334.0, 93807.0, 96989.0, 52723.783767661145, 81524.91202815161, 83481.58259208665, 85143.0, 88722.0, 67024.0, 67302.99045514321, 75202.4959500818, 75969.9999999989, 76934.23065769383, 10058.597656093674, 10393.844092338772, 10506.422146781695, 10574.206934480098, 10637.468126593485, 46126.0, 49011.5098849007, 49139.508604914925, 49913.75043124761, 49944.50055499398, 62766.0, 63792.0, 67213.3278667207, 67317.0, 68123.65938170278, 12171.634850954486, 12296.778301792956, 12318.384080795746, 12400.937995309965, 13014.869851301366, 13747.587572372844, 13863.861361386256, 13899.374528146056, 14166.362513686703, 14208.71582568322, 12779.552715654907, 12830.0, 13134.474621015052, 13229.933850330686, 13408.927285817306, 12902.161359511601, 13018.285278096013, 13194.472221111047, 13271.86728132745, 13292.734145317232, 12776.936115319364, 12789.232646041268, 12832.679183020498, 12964.286964217059, 13275.601731948056, 9068.22920051803, 9121.543922803701, 9349.767525213774, 9369.297302702189, 9487.905120948702, 8779.0, 10617.946910265398, 10636.680899573024, 10636.84044739314, 10667.146628269564], "value": 7226.54928969568, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 116.0, 118.0, 117.0, 124.0, 156.0, 117.0, 117.0, 119.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 116.0, 154.0, 116.0, 118.0, 115.0, 121.0, 134.0, 106.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 212.0, 211.0, 245.0, 203.0, 271.0, 192.0, 201.0, 194.0, 200.0], "value": 213.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 61.0, 90.0, 87.0, 51.0, 79.0, 51.0, 74.0, 79.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 84.0, 72.0, 74.0, 73.0, 85.0, 73.0, 72.0, 83.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 90.0, 98.0, 131.0, 102.0, 137.0, 108.0, 89.0, 90.0], "value": 103.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 97.0, 97.0, 96.0, 102.0, 134.0, 154.0, 113.0, 97.0, 97.0], "value": 110.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 94.0, 113.0, 149.0, 91.0, 90.0, 136.0, 86.0, 149.0, 147.0], "value": 116.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 62.0, 64.0, 65.0, 65.0, 64.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 76.0, 73.0, 73.0, 73.0, 73.0, 73.0, 75.0, 76.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 93.0, 95.0, 92.0, 93.0, 92.0, 92.0, 92.0, 92.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 156.0, 163.0, 149.0, 154.0, 166.0, 158.0, 143.0, 229.0, 171.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 178.0, 183.0, 179.0, 177.0, 174.0, 174.0, 173.0, 172.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 70.0, 71.0, 67.0, 70.0, 68.0, 69.0, 65.0, 67.0], "value": 69.3, "unit": "score"}]}]} 05:09:21 INFO - Return code: 0 05:09:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:09:21 ERROR - # TBPL SUCCESS # 05:09:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:22 INFO - 2017-02-13 05:09:22.013 screenresolution[1660:10459] starting screenresolution argv=screenresolution get 05:09:22 INFO - 2017-02-13 05:09:22.015 screenresolution[1660:10459] Display 0: 1600x1200x32@60 05:09:22 INFO - 2017-02-13 05:09:22.022 screenresolution[1661:10462] starting screenresolution argv=screenresolution list 05:09:22 INFO - Available Modes on Display 0 05:09:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:22 INFO - Intel Iris: 05:09:22 INFO - Chipset Model: Intel Iris 05:09:22 INFO - Type: GPU 05:09:22 INFO - Bus: Built-In 05:09:22 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:22 INFO - Vendor: Intel (0x8086) 05:09:22 INFO - Device ID: 0x0a2e 05:09:22 INFO - Revision ID: 0x0009 05:09:22 INFO - Displays: 05:09:22 INFO - Display: 05:09:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:22 INFO - Display Serial Number: 1600x1200 60 05:09:22 INFO - Main Display: Yes 05:09:22 INFO - Mirror: Off 05:09:22 INFO - Online: Yes 05:09:22 INFO - Rotation: Supported 05:09:22 INFO - Return code: 0 05:09:22 INFO - Running post-action listener: _resource_record_post_action 05:09:22 INFO - [mozharness: 2017-02-13 13:09:22.259251Z] Finished run-tests step (success) 05:09:22 INFO - Running post-run listener: _resource_record_post_run 05:09:22 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 38697472; Write bytes: 557609984; Read time: 241; Write time: 1659 05:09:22 INFO - TinderboxPrint: CPU usage
54.7% 05:09:22 INFO - TinderboxPrint: I/O read bytes / time
38,697,472 / 241 05:09:22 INFO - TinderboxPrint: I/O write bytes / time
557,609,984 / 1,659 05:09:22 INFO - TinderboxPrint: CPU idle
2,176.5 (45.3%) 05:09:22 INFO - TinderboxPrint: CPU system
966.9 (20.1%) 05:09:22 INFO - TinderboxPrint: CPU user
1,658.2 (34.5%) 05:09:22 INFO - TinderboxPrint: Swap in / out
291,749,888 / 0 05:09:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 244996608; Write bytes: 239949824; Read time: 17995; Write time: 489 05:09:22 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 36633088; Write bytes: 300248064; Read time: 222; Write time: 1124 05:09:22 INFO - Running post-run listener: _upload_blobber_files 05:09:22 INFO - Blob upload gear active. 05:09:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:22 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 05:09:22 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'] 05:09:22 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 05:09:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:09:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:09:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:24 INFO - (blobuploader) - INFO - Done attempting. 05:09:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:09:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:09:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:25 INFO - (blobuploader) - INFO - Done attempting. 05:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:26 INFO - (blobuploader) - INFO - Done attempting. 05:09:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:28 INFO - (blobuploader) - INFO - Done attempting. 05:09:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:28 INFO - Return code: 0 05:09:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88beb5f6279f3ee96134d90f3f0f9fc44a301583aeb477ecfa76d374f021604f946f095304e4f3b0b3e6a45d010155bcd63fe30bb143cb654f366e4b87b29ee0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36da096885e5fd7a693707ba5eac67ce1d2ec14e5a9e95f0c48899d8d1610b415d0c71f0144556f99f0da6ef645ec35581492e6d073a1127db2e686d4268edb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b61a93c48426264821959ffa524054a7f78ba585918f16968a3109ec6df2858d3007c27c0a1d9ce55b07aa5b703785e986e850cd8cf6c5a22b56e592906ddf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904625b095c621d5e659d4b103d27575509a1c8705f2c2144f93eaaec26d28a7cdf894936bd37a5ed236b4e7e256f11f22b6750d2e120fa30ed55a32abf87c9"} 05:09:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:28 INFO - Contents: 05:09:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88beb5f6279f3ee96134d90f3f0f9fc44a301583aeb477ecfa76d374f021604f946f095304e4f3b0b3e6a45d010155bcd63fe30bb143cb654f366e4b87b29ee0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36da096885e5fd7a693707ba5eac67ce1d2ec14e5a9e95f0c48899d8d1610b415d0c71f0144556f99f0da6ef645ec35581492e6d073a1127db2e686d4268edb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b61a93c48426264821959ffa524054a7f78ba585918f16968a3109ec6df2858d3007c27c0a1d9ce55b07aa5b703785e986e850cd8cf6c5a22b56e592906ddf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904625b095c621d5e659d4b103d27575509a1c8705f2c2144f93eaaec26d28a7cdf894936bd37a5ed236b4e7e256f11f22b6750d2e120fa30ed55a32abf87c9"} 05:09:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:28 INFO - Copying logs to upload dir... 05:09:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.044280 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-13 05:09:28.946728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 05:09:28.950698) ========= 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.LN3lxeauQ0/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.eAAra4vsLY/Listeners TMPDIR=/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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/88beb5f6279f3ee96134d90f3f0f9fc44a301583aeb477ecfa76d374f021604f946f095304e4f3b0b3e6a45d010155bcd63fe30bb143cb654f366e4b87b29ee0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36da096885e5fd7a693707ba5eac67ce1d2ec14e5a9e95f0c48899d8d1610b415d0c71f0144556f99f0da6ef645ec35581492e6d073a1127db2e686d4268edb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b61a93c48426264821959ffa524054a7f78ba585918f16968a3109ec6df2858d3007c27c0a1d9ce55b07aa5b703785e986e850cd8cf6c5a22b56e592906ddf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904625b095c621d5e659d4b103d27575509a1c8705f2c2144f93eaaec26d28a7cdf894936bd37a5ed236b4e7e256f11f22b6750d2e120fa30ed55a32abf87c9"} build_url:https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/WWaim669SAGwJYZjol_BlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88beb5f6279f3ee96134d90f3f0f9fc44a301583aeb477ecfa76d374f021604f946f095304e4f3b0b3e6a45d010155bcd63fe30bb143cb654f366e4b87b29ee0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36da096885e5fd7a693707ba5eac67ce1d2ec14e5a9e95f0c48899d8d1610b415d0c71f0144556f99f0da6ef645ec35581492e6d073a1127db2e686d4268edb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b61a93c48426264821959ffa524054a7f78ba585918f16968a3109ec6df2858d3007c27c0a1d9ce55b07aa5b703785e986e850cd8cf6c5a22b56e592906ddf7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1904625b095c621d5e659d4b103d27575509a1c8705f2c2144f93eaaec26d28a7cdf894936bd37a5ed236b4e7e256f11f22b6750d2e120fa30ed55a32abf87c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 05:09:28.985911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 05:09:28.986307) ========= 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.LN3lxeauQ0/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.eAAra4vsLY/Listeners TMPDIR=/var/folders/_6/xqyggwrj3_z5x7zs3gplhbgr00000w/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.005091 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 05:09:29.035285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 05:09:29.035602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 05:09:29.035952) ========= ========= Total master_lag: 0.19 =========