builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0306 starttime: 1485556713.41 results: success (0) buildid: 20170127131420 builduid: bdcd698618ab4a96b8fa3a9bd0ef33ea revision: 555ce1a07b911aa9445aed099f98e63d27c59136 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.412665) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.413102) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.413376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.439433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.439767) ========= 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.GP9licYJIY/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.rzRm3BmifL/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 14:38:33-- 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% 19.0M=0.001s 2017-01-27 14:38:33 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143116 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.606552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.606879) ========= 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.GP9licYJIY/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.rzRm3BmifL/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.025319 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:33.655690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 14:38:33.656054) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 555ce1a07b911aa9445aed099f98e63d27c59136 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 555ce1a07b911aa9445aed099f98e63d27c59136 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GP9licYJIY/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.rzRm3BmifL/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 14:38:33,765 truncating revision to first 12 chars 2017-01-27 14:38:33,765 Setting DEBUG logging. 2017-01-27 14:38:33,765 attempt 1/10 2017-01-27 14:38:33,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/555ce1a07b91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 14:38:34,856 unpacking tar archive at: mozilla-aurora-555ce1a07b91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.369847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 14:38:35.049195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:35.049517) ========= script_repo_revision: 555ce1a07b911aa9445aed099f98e63d27c59136 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:35.049913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:35.050175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 14:38:35.069421) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-27 14:38:35.069827) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GP9licYJIY/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.rzRm3BmifL/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:38:35 INFO - MultiFileLogger online at 20170127 14:38:35 in /builds/slave/test 14:38:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:38:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:35 INFO - {'append_to_log': False, 14:38:35 INFO - 'base_work_dir': '/builds/slave/test', 14:38:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:38:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:35 INFO - 'branch': 'Mozilla-Aurora', 14:38:35 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:35 INFO - 'config_files': ('talos/mac_config.py',), 14:38:35 INFO - 'default_actions': ('clobber', 14:38:35 INFO - 'read-buildbot-config', 14:38:35 INFO - 'download-and-extract', 14:38:35 INFO - 'populate-webroot', 14:38:35 INFO - 'create-virtualenv', 14:38:35 INFO - 'install', 14:38:35 INFO - 'run-tests'), 14:38:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:35 INFO - 'download_minidump_stackwalk': True, 14:38:35 INFO - 'download_symbols': 'ondemand', 14:38:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:38:35 INFO - 'tooltool.py': '/tools/tooltool.py', 14:38:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:38:35 INFO - '/tools/misc-python/virtualenv.py')}, 14:38:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:35 INFO - 'installer_path': 'installer.exe', 14:38:35 INFO - 'log_level': 'info', 14:38:35 INFO - 'log_name': 'talos', 14:38:35 INFO - 'log_to_console': True, 14:38:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:38:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:38:35 INFO - 'opt_config_files': (), 14:38:35 INFO - 'pip_index': False, 14:38:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:38:35 INFO - 'cmd': ('bash', 14:38:35 INFO - '-c', 14:38:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:38:35 INFO - 'enabled': True, 14:38:35 INFO - 'halt_on_failure': False, 14:38:35 INFO - 'name': 'check_screen_resolution'},), 14:38:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:38:35 INFO - 'cmd': ('bash', 14:38:35 INFO - '-c', 14:38:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:38:35 INFO - 'enabled': True, 14:38:35 INFO - 'halt_on_failure': False, 14:38:35 INFO - 'name': 'check_screen_resolution'},), 14:38:35 INFO - 'run_cmd_checks_enabled': True, 14:38:35 INFO - 'sps_profile': False, 14:38:35 INFO - 'sps_profile_interval': 0, 14:38:35 INFO - 'suite': 'dromaeojs-e10s', 14:38:35 INFO - 'system_bits': '32', 14:38:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:35 INFO - 'title': 't-yosemite-r7-0306', 14:38:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:35 INFO - 'use_talos_json': True, 14:38:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:35 INFO - 'work_dir': 'build'} 14:38:35 INFO - [mozharness: 2017-01-27 22:38:35.287749Z] Running clobber step. 14:38:35 INFO - Running pre-action listener: _resource_record_pre_action 14:38:35 INFO - Running main action method: clobber 14:38:35 INFO - rmtree: /builds/slave/test/build 14:38:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:37 INFO - Running post-action listener: _resource_record_post_action 14:38:37 INFO - [mozharness: 2017-01-27 22:38:37.597322Z] Finished clobber step (success) 14:38:37 INFO - [mozharness: 2017-01-27 22:38:37.597490Z] Running read-buildbot-config step. 14:38:37 INFO - Running pre-action listener: _resource_record_pre_action 14:38:37 INFO - Running main action method: read_buildbot_config 14:38:37 INFO - Using buildbot properties: 14:38:37 INFO - { 14:38:37 INFO - "project": "", 14:38:37 INFO - "product": "firefox", 14:38:37 INFO - "script_repo_revision": "production", 14:38:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:38:37 INFO - "repository": "", 14:38:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:38:37 INFO - "buildid": "20170127131420", 14:38:37 INFO - "pgo_build": "False", 14:38:37 INFO - "basedir": "/builds/slave/test", 14:38:37 INFO - "buildnumber": 24, 14:38:37 INFO - "slavename": "t-yosemite-r7-0306", 14:38:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:38:37 INFO - "platform": "yosemite_r7", 14:38:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:38:37 INFO - "branch": "mozilla-aurora", 14:38:37 INFO - "repo_path": "releases/mozilla-aurora", 14:38:37 INFO - "revision": "555ce1a07b911aa9445aed099f98e63d27c59136", 14:38:37 INFO - "stage_platform": "macosx64", 14:38:37 INFO - "builduid": "bdcd698618ab4a96b8fa3a9bd0ef33ea", 14:38:37 INFO - "slavebuilddir": "test" 14:38:37 INFO - } 14:38:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 14:38:37 INFO - Running post-action listener: _resource_record_post_action 14:38:37 INFO - [mozharness: 2017-01-27 22:38:37.600639Z] Finished read-buildbot-config step (success) 14:38:37 INFO - [mozharness: 2017-01-27 22:38:37.600742Z] Running download-and-extract step. 14:38:37 INFO - Running pre-action listener: _resource_record_pre_action 14:38:37 INFO - Running main action method: download_and_extract 14:38:37 INFO - mkdir: /builds/slave/test/build/tests 14:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:37 INFO - trying https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 14:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 14:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 14:38:39 INFO - Downloaded 1199 bytes. 14:38:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 14:38:39 INFO - Using the following test package requirements: 14:38:39 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 14:38:39 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 14:38:39 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 14:38:39 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'jsshell-mac.zip'], 14:38:39 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 14:38:39 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 14:38:39 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 14:38:39 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 14:38:39 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 14:38:39 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:38:39 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 14:38:39 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:38:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 14:38:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:38:39 INFO - Fetch https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 14:38:39 INFO - Expected file size: 16350794 14:38:39 INFO - Obtained file size: 16350794 14:38:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 14:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 14:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:38:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 14:38:47 INFO - Expected file size: 16350794 14:38:47 INFO - Obtained file size: 16350794 14:38:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 14:38:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:38:53 INFO - Fetch https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 14:38:54 INFO - Expected file size: 14403485 14:38:54 INFO - Obtained file size: 14403485 14:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:55 INFO - trying https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:38:55 INFO - Downloading https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 14:38:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 14:38:57 INFO - Downloaded 73898082 bytes. 14:38:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:38:57 INFO - mkdir: /builds/slave/test/properties 14:38:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:38:57 INFO - Writing to file /builds/slave/test/properties/build_url 14:38:57 INFO - Contents: 14:38:57 INFO - build_url:https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:38:57 INFO - Running post-action listener: _resource_record_post_action 14:38:57 INFO - Running post-action listener: set_extra_try_arguments 14:38:57 INFO - [mozharness: 2017-01-27 22:38:57.772618Z] Finished download-and-extract step (success) 14:38:57 INFO - [mozharness: 2017-01-27 22:38:57.772774Z] Running populate-webroot step. 14:38:57 INFO - Running pre-action listener: _resource_record_pre_action 14:38:57 INFO - Running main action method: populate_webroot 14:38:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:38:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:38:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:38:57 INFO - '--tppagecycles', 14:38:57 INFO - '7'], 14:38:57 INFO - 'tests': ['tsvgm']}}, 14:38:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:38:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:38:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:38:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:38:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['damp', 'tps']}, 14:38:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'tests': ['damp', 'tps']}, 14:38:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['dromaeo_dom']}, 14:38:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:38:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['basic_compositor_video']}, 14:38:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:38:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['a11yr', 14:38:57 INFO - 'ts_paint', 14:38:57 INFO - 'tpaint', 14:38:57 INFO - 'sessionrestore', 14:38:57 INFO - 'sessionrestore_no_auto_restore', 14:38:57 INFO - 'tabpaint']}, 14:38:57 INFO - 'other-e10s': {'tests': ['a11yr', 14:38:57 INFO - 'ts_paint', 14:38:57 INFO - 'tpaint', 14:38:57 INFO - 'sessionrestore', 14:38:57 INFO - 'sessionrestore_no_auto_restore', 14:38:57 INFO - 'tabpaint']}, 14:38:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:38:57 INFO - 'ts_paint', 14:38:57 INFO - 'tpaint', 14:38:57 INFO - 'sessionrestore', 14:38:57 INFO - 'sessionrestore_no_auto_restore', 14:38:57 INFO - 'tabpaint']}, 14:38:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:38:57 INFO - 'ts_paint', 14:38:57 INFO - 'tpaint', 14:38:57 INFO - 'sessionrestore', 14:38:57 INFO - 'sessionrestore_no_auto_restore', 14:38:57 INFO - 'tabpaint']}, 14:38:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['a11yr', 14:38:57 INFO - 'ts_paint', 14:38:57 INFO - 'tpaint', 14:38:57 INFO - 'sessionrestore', 14:38:57 INFO - 'sessionrestore_no_auto_restore', 14:38:57 INFO - 'tabpaint']}, 14:38:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['a11yr', 14:38:57 INFO - 'ts_paint', 14:38:57 INFO - 'tpaint', 14:38:57 INFO - 'sessionrestore', 14:38:57 INFO - 'sessionrestore_no_auto_restore', 14:38:57 INFO - 'tabpaint']}, 14:38:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['tsvgx', 14:38:57 INFO - 'tsvgr_opacity', 14:38:57 INFO - 'tart', 14:38:57 INFO - 'tscrollx', 14:38:57 INFO - 'cart', 14:38:57 INFO - 'tsvg_static']}, 14:38:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:38:57 INFO - 'tsvgr_opacity', 14:38:57 INFO - 'tart', 14:38:57 INFO - 'tscrollx', 14:38:57 INFO - 'cart', 14:38:57 INFO - 'tsvg_static']}, 14:38:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'talos_options': ['--disable-e10s'], 14:38:57 INFO - 'tests': ['tp5o']}, 14:38:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:38:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'talos_options': ['--disable-e10s', 14:38:57 INFO - '--xperf_path', 14:38:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:57 INFO - 'tests': ['tp5n']}, 14:38:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:38:57 INFO - 'talos_options': ['--xperf_path', 14:38:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:57 INFO - 'tests': ['tp5n']}}, 14:38:57 INFO - 'talos.zip': {'path': '', 14:38:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:38:57 INFO - Running post-action listener: _resource_record_post_action 14:38:57 INFO - [mozharness: 2017-01-27 22:38:57.791226Z] Finished populate-webroot step (success) 14:38:57 INFO - [mozharness: 2017-01-27 22:38:57.791360Z] Running create-virtualenv step. 14:38:57 INFO - Running pre-action listener: _resource_record_pre_action 14:38:57 INFO - Running main action method: create_virtualenv 14:38:57 INFO - Creating virtualenv /builds/slave/test/build/venv 14:38:57 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 14:38:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:38:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:38:57 INFO - Using real prefix '/tools/python27' 14:38:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:38:58 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:01 INFO - Installing pip.................done. 14:39:01 INFO - Return code: 0 14:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:39:01 INFO - Reading from file tmpfile_stdout 14:39:01 INFO - Output received: 14:39:01 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) 14:39:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:01 INFO - 'HOME': '/Users/cltbld', 14:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:01 INFO - 'LOGNAME': 'cltbld', 14:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:01 INFO - 'MOZ_NO_REMOTE': '1', 14:39:01 INFO - 'NO_EM_RESTART': '1', 14:39:01 INFO - 'PAGER': '/bin/cat', 14:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:01 INFO - 'PWD': '/builds/slave/test', 14:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:01 INFO - 'SHELL': '/bin/bash', 14:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:01 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:01 INFO - 'USER': 'cltbld', 14:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:01 INFO - 'XPC_FLAGS': '0x0', 14:39:01 INFO - 'XPC_SERVICE_NAME': '0', 14:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:02 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 14:39:02 INFO - Cleaning up... 14:39:02 INFO - Return code: 0 14:39:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:39:02 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')]} 14:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:02 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')]} 14:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:02 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:02 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 14:39:02 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 14:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:02 INFO - 'HOME': '/Users/cltbld', 14:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:02 INFO - 'LOGNAME': 'cltbld', 14:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:02 INFO - 'MOZ_NO_REMOTE': '1', 14:39:02 INFO - 'NO_EM_RESTART': '1', 14:39:02 INFO - 'PAGER': '/bin/cat', 14:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:02 INFO - 'PWD': '/builds/slave/test', 14:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:02 INFO - 'SHELL': '/bin/bash', 14:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:02 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:02 INFO - 'USER': 'cltbld', 14:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:02 INFO - 'XPC_FLAGS': '0x0', 14:39:02 INFO - 'XPC_SERVICE_NAME': '0', 14:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:02 INFO - Downloading/unpacking psutil>=3.1.1 14:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:05 INFO - Installing collected packages: psutil 14:39:05 INFO - Running setup.py install for psutil 14:39:06 INFO - building 'psutil._psutil_osx' extension 14:39:06 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 14:39:06 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 14:39:06 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 14:39:06 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 14:39:06 INFO - building 'psutil._psutil_posix' extension 14:39:06 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 14:39:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:39:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:39:06 INFO - ^ 14:39:06 INFO - 1 warning generated. 14:39:06 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 14:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:07 INFO - Successfully installed psutil 14:39:07 INFO - Cleaning up... 14:39:07 INFO - Return code: 0 14:39:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:07 INFO - 'HOME': '/Users/cltbld', 14:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:07 INFO - 'LOGNAME': 'cltbld', 14:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:07 INFO - 'MOZ_NO_REMOTE': '1', 14:39:07 INFO - 'NO_EM_RESTART': '1', 14:39:07 INFO - 'PAGER': '/bin/cat', 14:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:07 INFO - 'PWD': '/builds/slave/test', 14:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:07 INFO - 'SHELL': '/bin/bash', 14:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:07 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:07 INFO - 'USER': 'cltbld', 14:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:07 INFO - 'XPC_FLAGS': '0x0', 14:39:07 INFO - 'XPC_SERVICE_NAME': '0', 14:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:39:10 INFO - Installing collected packages: mozsystemmonitor 14:39:10 INFO - Running setup.py install for mozsystemmonitor 14:39:10 INFO - Successfully installed mozsystemmonitor 14:39:10 INFO - Cleaning up... 14:39:10 INFO - Return code: 0 14:39:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:10 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:10 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 14:39:10 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 14:39:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:10 INFO - 'HOME': '/Users/cltbld', 14:39:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:10 INFO - 'LOGNAME': 'cltbld', 14:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:10 INFO - 'MOZ_NO_REMOTE': '1', 14:39:10 INFO - 'NO_EM_RESTART': '1', 14:39:10 INFO - 'PAGER': '/bin/cat', 14:39:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:10 INFO - 'PWD': '/builds/slave/test', 14:39:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:10 INFO - 'SHELL': '/bin/bash', 14:39:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:10 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:10 INFO - 'USER': 'cltbld', 14:39:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:10 INFO - 'XPC_FLAGS': '0x0', 14:39:10 INFO - 'XPC_SERVICE_NAME': '0', 14:39:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:39:13 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 14:39:13 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 14:39:13 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 14:39:13 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 14:39:13 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 14:39:13 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 14:39:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:13 INFO - warning: no files found matching '*.txt' 14:39:13 INFO - no previously-included directories found matching 'build' 14:39:13 INFO - no previously-included directories found matching 'dist' 14:39:13 INFO - no previously-included directories found matching '.git*' 14:39:13 INFO - Installing collected packages: jsonschema, functools32 14:39:13 INFO - Running setup.py install for functools32 14:39:13 INFO - warning: no files found matching '*.txt' 14:39:13 INFO - no previously-included directories found matching 'build' 14:39:13 INFO - no previously-included directories found matching 'dist' 14:39:13 INFO - no previously-included directories found matching '.git*' 14:39:13 INFO - Successfully installed jsonschema functools32 14:39:13 INFO - Cleaning up... 14:39:13 INFO - Return code: 0 14:39:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:13 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:13 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 14:39:13 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 14:39:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:13 INFO - 'HOME': '/Users/cltbld', 14:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:13 INFO - 'LOGNAME': 'cltbld', 14:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:13 INFO - 'MOZ_NO_REMOTE': '1', 14:39:13 INFO - 'NO_EM_RESTART': '1', 14:39:13 INFO - 'PAGER': '/bin/cat', 14:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:13 INFO - 'PWD': '/builds/slave/test', 14:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:13 INFO - 'SHELL': '/bin/bash', 14:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:13 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:13 INFO - 'USER': 'cltbld', 14:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:13 INFO - 'XPC_FLAGS': '0x0', 14:39:13 INFO - 'XPC_SERVICE_NAME': '0', 14:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:39:14 INFO - Cleaning up... 14:39:14 INFO - Return code: 0 14:39:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:14 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')]} 14:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:14 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')]} 14:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:14 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:14 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 14:39:14 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 14:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:14 INFO - 'HOME': '/Users/cltbld', 14:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:14 INFO - 'LOGNAME': 'cltbld', 14:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:14 INFO - 'MOZ_NO_REMOTE': '1', 14:39:14 INFO - 'NO_EM_RESTART': '1', 14:39:14 INFO - 'PAGER': '/bin/cat', 14:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:14 INFO - 'PWD': '/builds/slave/test', 14:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:14 INFO - 'SHELL': '/bin/bash', 14:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:14 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:14 INFO - 'USER': 'cltbld', 14:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:14 INFO - 'XPC_FLAGS': '0x0', 14:39:14 INFO - 'XPC_SERVICE_NAME': '0', 14:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:18 INFO - Downloading docopt-0.6.1.tar.gz 14:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:18 INFO - Running setup.py install for blobuploader 14:39:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:18 INFO - Running setup.py install for requests 14:39:19 INFO - Running setup.py install for docopt 14:39:19 INFO - Successfully installed blobuploader requests docopt 14:39:19 INFO - Cleaning up... 14:39:19 INFO - Return code: 0 14:39:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:19 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')]} 14:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:19 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')]} 14:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:19 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:19 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 14:39:19 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 14:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:19 INFO - 'HOME': '/Users/cltbld', 14:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:19 INFO - 'LOGNAME': 'cltbld', 14:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:19 INFO - 'MOZ_NO_REMOTE': '1', 14:39:19 INFO - 'NO_EM_RESTART': '1', 14:39:19 INFO - 'PAGER': '/bin/cat', 14:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:19 INFO - 'PWD': '/builds/slave/test', 14:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:19 INFO - 'SHELL': '/bin/bash', 14:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:19 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:19 INFO - 'USER': 'cltbld', 14:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:19 INFO - 'XPC_FLAGS': '0x0', 14:39:19 INFO - 'XPC_SERVICE_NAME': '0', 14:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:19 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-TjfH5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:19 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-fSaBm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:19 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-TruMqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:19 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-ukG6U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-00m24f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-L1CxTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-GpHqlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-lultam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-lmPtsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Nx8ORy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-sxCFcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-WaNDFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-qgIjKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:20 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-xvK1J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-gG9MRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-JanTY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:21 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-DGZ3Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:21 INFO - Running setup.py install for manifestparser 14:39:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:21 INFO - Running setup.py install for mozcrash 14:39:21 INFO - Running setup.py install for mozdebug 14:39:21 INFO - Running setup.py install for mozdevice 14:39:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Running setup.py install for mozfile 14:39:22 INFO - Running setup.py install for mozhttpd 14:39:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Running setup.py install for mozinfo 14:39:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Running setup.py install for mozInstall 14:39:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Running setup.py install for mozleak 14:39:22 INFO - Running setup.py install for mozlog 14:39:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:22 INFO - Running setup.py install for moznetwork 14:39:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:23 INFO - Running setup.py install for mozprocess 14:39:23 INFO - Running setup.py install for mozprofile 14:39:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:23 INFO - Running setup.py install for mozrunner 14:39:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:23 INFO - Running setup.py install for mozscreenshot 14:39:23 INFO - Running setup.py install for moztest 14:39:23 INFO - Running setup.py install for mozversion 14:39:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:23 INFO - Cleaning up... 14:39:24 INFO - Return code: 0 14:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:24 INFO - 'HOME': '/Users/cltbld', 14:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:24 INFO - 'LOGNAME': 'cltbld', 14:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:24 INFO - 'MOZ_NO_REMOTE': '1', 14:39:24 INFO - 'NO_EM_RESTART': '1', 14:39:24 INFO - 'PAGER': '/bin/cat', 14:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:24 INFO - 'PWD': '/builds/slave/test', 14:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:24 INFO - 'SHELL': '/bin/bash', 14:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:24 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:24 INFO - 'USER': 'cltbld', 14:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:24 INFO - 'XPC_FLAGS': '0x0', 14:39:24 INFO - 'XPC_SERVICE_NAME': '0', 14:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-vUPshO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:24 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)) 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-kVgnKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:24 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)) 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-7AX_n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:24 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)) 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-QlbETF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:24 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)) 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-loksc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:24 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)) 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-9ycH1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:24 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)) 14:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-zca6dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-PYjfPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-21hdYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Ra1ThY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-3DNpoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-oe9MKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-wOR5gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-X6Wku7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-BRO_Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-10BIwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:25 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)) 14:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-WFwXPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:26 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)) 14:39:26 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)) 14:39:26 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)) 14:39:26 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)) 14:39:26 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)) 14:39:26 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)) 14:39:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:26 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 14:39:26 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 14:39:26 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 14:39:26 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 14:39:26 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 14:39:26 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 14:39:28 INFO - Downloading blessings-1.6.tar.gz 14:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:28 INFO - Installing collected packages: blessings 14:39:28 INFO - Running setup.py install for blessings 14:39:28 INFO - Successfully installed blessings 14:39:28 INFO - Cleaning up... 14:39:29 INFO - Return code: 0 14:39:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:29 INFO - Reading from file tmpfile_stdout 14:39:29 INFO - Current package versions: 14:39:29 INFO - blessings == 1.6 14:39:29 INFO - blobuploader == 1.2.4 14:39:29 INFO - docopt == 0.6.1 14:39:29 INFO - functools32 == 3.2.3-2 14:39:29 INFO - jsonschema == 2.5.1 14:39:29 INFO - manifestparser == 1.1 14:39:29 INFO - mozInstall == 1.12 14:39:29 INFO - mozcrash == 1.0 14:39:29 INFO - mozdebug == 0.1 14:39:29 INFO - mozdevice == 0.49 14:39:29 INFO - mozfile == 1.2 14:39:29 INFO - mozhttpd == 0.7 14:39:29 INFO - mozinfo == 0.9 14:39:29 INFO - mozleak == 0.1 14:39:29 INFO - mozlog == 3.4 14:39:29 INFO - moznetwork == 0.27 14:39:29 INFO - mozprocess == 0.24 14:39:29 INFO - mozprofile == 0.28 14:39:29 INFO - mozrunner == 6.13 14:39:29 INFO - mozscreenshot == 0.1 14:39:29 INFO - mozsystemmonitor == 0.3 14:39:29 INFO - moztest == 0.8 14:39:29 INFO - mozversion == 1.4 14:39:29 INFO - psutil == 3.1.1 14:39:29 INFO - requests == 1.2.3 14:39:29 INFO - wsgiref == 0.1.2 14:39:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:30 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 14:39:30 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 14:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:30 INFO - 'HOME': '/Users/cltbld', 14:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:30 INFO - 'LOGNAME': 'cltbld', 14:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:30 INFO - 'MOZ_NO_REMOTE': '1', 14:39:30 INFO - 'NO_EM_RESTART': '1', 14:39:30 INFO - 'PAGER': '/bin/cat', 14:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:30 INFO - 'PWD': '/builds/slave/test', 14:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:30 INFO - 'SHELL': '/bin/bash', 14:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:30 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:30 INFO - 'USER': 'cltbld', 14:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:30 INFO - 'XPC_FLAGS': '0x0', 14:39:30 INFO - 'XPC_SERVICE_NAME': '0', 14:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 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)) 14:39:30 INFO - Cleaning up... 14:39:30 INFO - Return code: 0 14:39:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:31 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 0x10e01eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e021768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7114c30f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, '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.GP9licYJIY/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.rzRm3BmifL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 14:39:31 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 14:39:31 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 14:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:31 INFO - 'HOME': '/Users/cltbld', 14:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:31 INFO - 'LOGNAME': 'cltbld', 14:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:31 INFO - 'MOZ_NO_REMOTE': '1', 14:39:31 INFO - 'NO_EM_RESTART': '1', 14:39:31 INFO - 'PAGER': '/bin/cat', 14:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:31 INFO - 'PWD': '/builds/slave/test', 14:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:31 INFO - 'SHELL': '/bin/bash', 14:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:31 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:31 INFO - 'USER': 'cltbld', 14:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:31 INFO - 'XPC_FLAGS': '0x0', 14:39:31 INFO - 'XPC_SERVICE_NAME': '0', 14:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:39:31 INFO - Cleaning up... 14:39:31 INFO - Return code: 0 14:39:31 INFO - Running post-action listener: _resource_record_post_action 14:39:31 INFO - Running post-action listener: _start_resource_monitoring 14:39:31 INFO - Starting resource monitoring. 14:39:31 INFO - [mozharness: 2017-01-27 22:39:31.350282Z] Finished create-virtualenv step (success) 14:39:31 INFO - [mozharness: 2017-01-27 22:39:31.351190Z] Running install step. 14:39:31 INFO - Running pre-action listener: _resource_record_pre_action 14:39:31 INFO - Running main action method: install 14:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:31 INFO - Reading from file tmpfile_stdout 14:39:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:31 INFO - Reading from file tmpfile_stdout 14:39:31 INFO - Output received: 14:39:31 INFO - Usage: mozinstall [options] installer 14:39:31 INFO - Options: 14:39:31 INFO - -h, --help show this help message and exit 14:39:31 INFO - -d DEST, --destination=DEST 14:39:31 INFO - Directory to install application into. [default: 14:39:31 INFO - "/builds/slave/test"] 14:39:31 INFO - --app=APP Application being installed. [default: firefox] 14:39:31 INFO - mkdir: /builds/slave/test/build/application 14:39:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 14:39:52 INFO - Reading from file tmpfile_stdout 14:39:52 INFO - Output received: 14:39:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:39:52 INFO - Running post-action listener: _resource_record_post_action 14:39:52 INFO - [mozharness: 2017-01-27 22:39:52.043968Z] Finished install step (success) 14:39:52 INFO - [mozharness: 2017-01-27 22:39:52.044130Z] Running run-tests step. 14:39:52 INFO - Running pre-action listener: _resource_record_pre_action 14:39:52 INFO - Running main action method: run_tests 14:39:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:39:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:39:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:39:52 INFO - 2017-01-27 14:39:52.058 screenresolution[1628:7460] starting screenresolution argv=screenresolution get 14:39:52 INFO - 2017-01-27 14:39:52.061 screenresolution[1628:7460] Display 0: 1600x1200x32@60 14:39:52 INFO - 2017-01-27 14:39:52.066 screenresolution[1629:7463] starting screenresolution argv=screenresolution list 14:39:52 INFO - Available Modes on Display 0 14:39:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:39:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:39:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:39:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:39:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:39:52 INFO - Intel Iris: 14:39:52 INFO - Chipset Model: Intel Iris 14:39:52 INFO - Type: GPU 14:39:52 INFO - Bus: Built-In 14:39:52 INFO - VRAM (Dynamic, Max): 1536 MB 14:39:52 INFO - Vendor: Intel (0x8086) 14:39:52 INFO - Device ID: 0x0a2e 14:39:52 INFO - Revision ID: 0x0009 14:39:52 INFO - Displays: 14:39:52 INFO - Display: 14:39:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:39:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:39:52 INFO - Display Serial Number: 1600x1200 60 14:39:52 INFO - Main Display: Yes 14:39:52 INFO - Mirror: Off 14:39:52 INFO - Online: Yes 14:39:52 INFO - Rotation: Supported 14:39:52 INFO - Return code: 0 14:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:39:52 INFO - Python 2.7.3 14:39:52 INFO - Return code: 0 14:39:52 INFO - grabbing minidump binary from tooltool 14:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:52 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 0x10ddfcd30>, '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 0x10dd23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddf1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:39:52 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 14:39:52 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 14:39:52 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 14:39:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:39:52 INFO - Return code: 0 14:39:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:39:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:39:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:39:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:39:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 14:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0306 --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 14:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GP9licYJIY/Render', 14:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:52 INFO - 'HOME': '/Users/cltbld', 14:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:52 INFO - 'LOGNAME': 'cltbld', 14:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:52 INFO - 'MOZ_NO_REMOTE': '1', 14:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:39:52 INFO - 'NO_EM_RESTART': '1', 14:39:52 INFO - 'PAGER': '/bin/cat', 14:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:52 INFO - 'PWD': '/builds/slave/test', 14:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:52 INFO - 'SHELL': '/bin/bash', 14:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rzRm3BmifL/Listeners', 14:39:52 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 14:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:52 INFO - 'USER': 'cltbld', 14:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:52 INFO - 'XPC_FLAGS': '0x0', 14:39:52 INFO - 'XPC_SERVICE_NAME': '0', 14:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 14:39:52 INFO - mozversion application_buildid: 20170127131420 14:39:52 INFO - mozversion application_changeset: 555ce1a07b911aa9445aed099f98e63d27c59136 14:39:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:39:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:39:52 INFO - mozversion application_name: Firefox 14:39:52 INFO - mozversion application_remotingname: firefox-dev 14:39:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:39:52 INFO - mozversion application_vendor: Mozilla 14:39:52 INFO - mozversion application_version: 53.0a2 14:39:52 INFO - mozversion platform_buildid: 20170127131420 14:39:52 INFO - mozversion platform_changeset: 555ce1a07b911aa9445aed099f98e63d27c59136 14:39:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:39:52 INFO - mozversion platform_version: 53.0a2 14:39:52 INFO - using testdate: 1485556792 14:39:52 INFO - actual date: 1485556792 14:39:52 INFO - starting webserver on 'localhost:49241' 14:39:52 INFO - SUITE-START | Running 2 tests 14:39:52 INFO - TEST-START | dromaeo_css 14:39:52 INFO - operating with platform_type : mac_ 14:39:52 INFO - Initialising browser for dromaeo_css test... 14:39:52 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpsiOtRP/profile http://localhost:49241/getInfo.html) 14:39:55 INFO - PROCESS | 1639 | 2017-01-27 14:39:55.553 plugin-container[1641:7641] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 14:39:55 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:39:55 INFO - PROCESS | 1639 | 2017-01-27 14:39:55.556 plugin-container[1641:7641] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 14:39:55 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:39:55 INFO - PROCESS | 1639 | 2017-01-27 14:39:55.556 plugin-container[1641:7641] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:39:55 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 14:39:55 INFO - PROCESS | 1639 | colorDepth:24 14:39:55 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 14:39:55 INFO - PROCESS | 1639 | __metrics 14:39:55 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 14:39:56 INFO - TEST-INFO | 1639: exit 0 14:39:56 INFO - Browser initialized. 14:39:56 INFO - Running cycle 1/1 for dromaeo_css test... 14:39:56 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpsiOtRP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:59 INFO - PROCESS | 1642 | 2017-01-27 14:39:59.138 plugin-container[1643:7769] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 14:39:59 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:39:59 INFO - PROCESS | 1642 | 2017-01-27 14:39:59.138 plugin-container[1643:7769] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a13, name = 'com.apple.CFPasteboardClient' 14:39:59 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:39:59 INFO - PROCESS | 1642 | 2017-01-27 14:39:59.138 plugin-container[1643:7769] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:40:08 INFO - PROCESS | 1642 | RSS: Main: 218316800 14:40:08 INFO - PROCESS | 1642 | 14:43:11 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:43:13 INFO - PROCESS | 1642 | RSS: Main: 239685632 14:43:13 INFO - PROCESS | 1642 | 14:44:56 INFO - PROCESS | 1642 | ************************* 14:44:56 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 14:44:56 INFO - PROCESS | 1642 | 14:44:56 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:44:56 INFO - PROCESS | 1642 | Full stack: 14:44:56 INFO - PROCESS | 1642 | ************************* 14:46:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:46:15 INFO - PROCESS | 1642 | RSS: Main: 244649984 14:46:15 INFO - PROCESS | 1642 | 14:49:17 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 14:49:18 INFO - PROCESS | 1642 | RSS: Main: 250961920 14:49:18 INFO - PROCESS | 1642 | 14:52:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 14:52:20 INFO - PROCESS | 1642 | RSS: Main: 249118720 14:52:20 INFO - PROCESS | 1642 | 14:55:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 14:55:24 INFO - PROCESS | 1642 | RSS: Main: 255770624 14:55:24 INFO - PROCESS | 1642 | 14:58:26 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 14:58:27 INFO - PROCESS | 1642 | RSS: Main: 257912832 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | __start_tp_report 14:58:27 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 14:58:27 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 14:58:27 INFO - PROCESS | 1642 | |i|pagename|runs| 14:58:27 INFO - PROCESS | 1642 | |0;dojo.html;3355.731541476682;3381.4251577231867;3387.017764848194;3389.7288216942648;3395.253044330248;5650.237217975572;5671.234383358245;5712.600117991732;5729.713514324283;5785.855353616151;5673.971630141854;5722.027255366587;5724.685142317171;5738.0532212184935;5797.942020579793;4260.786960651971;5194.506521880416;5229.980153869997;5288.6562373445795;5299.5760339172775;5313.681179129246;5317.016351974878;5328.46715328468;5332.466753324676;5352.357717073956;5301.469853014687;5324.281222035033;5324.946750532503;5337.759800808973;5362;5212.21816727492;5217.8173763918085;5242.2136679498;5269.525742683139;5310;5145.253938178943;5236.528712415863;5280.260763493114;5280.570937368815;5339.466053394668;5760.654360738327;5802.680852553108;5822.272215973004;5825.0679891217205;5828.9417105828825;6162.352952939967;6217.813465596039;6224.782132625336;6261.749530018794;6296.590721603081;6169.845753856144;6265.185525881606;6283.120363149163;6286.308506064329;6295.68521573924;5948.464638182584;5960.195373624592;5976.850578735566;5977.3723759005115;6003.579749417542;6197.287311959092;6220.7511699532415;6286.402791734778;6317.273513545909;6334.683265836689;6126.792505495304;6148.016317389196;6184.721687524072;6187.102870083812;6288.779892703734;6277.372262773777;6298.433141017331;6317.557770955989;6319.8104056878365;6324.873502530016;6102.237220347457;6259.0924315973925;6294.937050629526;6303.432691057827;6311.589746666452;6127.372786728385;6224.751009959641;6259.530535209878;6289.308176100625;6308.779192728232;4976.7262800545595;5000.62495312853;5014.824481143142;5018.1218286800395;5018.996200759862;4491.214037543482;4505.144022635689;4517.006258623098;4521.367008618796;4523.2988886722615;4357.215701173755;4794.808207671654;5750.25246717924;5810.244668193192;5930.7924222652;6190.164327815687;6207.006878899445;6245.281792593819;6257.374262573706;6270.31026587075;5918.408159184047;5924.674142922181;5966.492848107872;5982.940170598238;6011.699415029231;5395.163749618815;5503.724813759296;5529.557635389159;5532.474414930575;5551.694656793834;6231.875362492725;6238.064290356483;6279.277883043325;6302.684865756785;6368.490520758421;6214.285357183981;6221.844453888689;6225.782097626561;6227.377262273736;6234.345393733593;6293.811185664437;6325.652089135142;6340.71466784005;6348.174737284124;6390.584612000205;6109.009944784373;6112.989854784201;6122.448979591858;6141.301904043321;6160.568760186744;6070.206121174266;6217.160683307696;6217.689115544295;6227.501799856092;6236.445226221192;6154.353792851686;6161.753529858935;6164.383561643979;6168.475679567287;6170.197874276315;6059.21230240066;6114.266288045463;6115.6967227387295;6162.044883043135;6165.630062196283;5997.340292567901;6063.757449701962;6080.726367313393;6129.877402452015;6138.232720909887;6226.346233645402;6237.251529816451;6237.656928868956;6237.906431403623;6274.121622972696;5140.177571588528;5505.256790333254;5949.910751338647;5971.925053490413;6099.085137229451 14:58:27 INFO - PROCESS | 1642 | |1;ext.html;428.8091799149378;469.4788784449263;482.3512375854479;498.860319110649;503.95716364109035;31544.52683209751;41758.37362439566;41795.791021044926;42056.15887682248;43654;32254;42785.35821962665;43083.78458107713;43232.91917702059;43293.35059974103;7697.499662521946;8335.083140854502;8498.78753031173;9472.479013654247;9479.43123412594;11126.109911207084;11441.656750297463;11448.771024579504;11573;11611;11343.489542970545;11405.714857128554;11414.258073225255;11418.31490110592;11425.542978280859;11294.830577541343;11294.887051129466;11347.829782553268;11354.71613209668;11374.146938979567;11216;11322.660320190325;11358.148138889534;11365;11387.54449822006;40560.391594126115;40900;40955.59044409548;41002.58997410018;41113.588864111276;3945.1320709443876;4002.8799136025964;4011.1576568920564;4089.325261331877;4190.958090419087;29931.251718707208;30458.54312185319;30548;30830.075097747103;31376.529352059737;3174.032997570334;3181.6659250778566;3283.83580820958;3284.9652359506917;3313.3042061167184;327626.3618681915;340384.2980785105;355387;442622;444092;61184.69407652933;61234;61376.38623613796;62009.37990620126;62900.056499152546;63997.680011599645;64606.67696661487;64654;64892.35107648958;64996.35003649903;13612.863871361358;16026.439074632564;16442.260098295606;16461.34154633825;16563.91718041402;11512.654620361403;11845.5854045108;12495.062870284582;12762.744745105047;12929.54746583865;16500.25748841305;16526.504204873872;16540.421085261958;16550;16586.253618587194;6522.282548919615;6989.755358562527;7321.78034658961;7357.77926662201;7367.8894816577795;883.4257732473815;893.7408151636083;898.851689471243;912.3932584831012;923.2198792020732;29429.822807087905;29916.401671966873;29941.550876736866;30377.936772212866;30531.66090051312;990.7869807991317;1040.698197522725;1058.222206678091;1072.2708558180511;1079.0450451350612;14496.782548261785;14521.273936303354;14523.78214326786;14621.976461647795;14629.268536573129;581400;602169;604507;604843;605464;50358;50920.49079509157;51022.48977510177;51082.489175107774;51097.445127743464;1421.275149673674;1424.33056463462;1447.862453066957;1449.0654975607472;1452.6077958951234;27086;27115.457690845677;27448.588271175548;27661.861690691418;28371;45603.31595026011;45880.8529786758;46015.76992115018;46042.30936536022;46060;527239;528381;531952;533625;534069;24129.879350603136;24253.878730606233;25005.74994250034;25008.62487062659;25924.74075259223;42665.57334426616;42778;42811.92970175646;42871;43305.56694433015;34672;36236.81881590575;37043.62956370402;37463.43804842875;37662.246755064196;35662;35678.572857085426;35687.64312356843;35743.46384804282;36306.91079267626;33997.66002339945;34926;35247.647523524436;35853.28293434065;35951.820240898625;30529.54205686961;31683;32206.67793322037;32215.711371544876;32422.351552968335;22219.77780222242;22391.096756775856;23513.764862351156;24219.39451513726;24781.752182477943 14:58:27 INFO - PROCESS | 1642 | |2;jquery.html;396.5182303501247;397.5070912069035;398.33478091587045;402.9637332640062;421.74320524835986;16245.83754162458;17931.924084554936;20029.399118026464;20797;21528.89235553822;21407.250746223886;21607.919604019775;21622.567548649058;22208.88895555524;22472.101115955382;5630.239917611111;5878.941790477712;5901.73112780752;5920.348761636216;5921.230240068785;5639.7180140993;5812.796552120655;5842.64944103353;5843.79546715865;5859;5009.323741294933;5854.092615644582;5861.824145275648;5872.412758724136;5873.676947767871;5594.412586678422;5734.340550836666;5782.508486778629;5836.6789826559525;5841.386654401291;5153.536181743623;5190.351206099238;5191.351081114861;5194.948050519484;5195.6622819516615;26198.607020894702;26526.73473265281;26715.86642066777;26770.19689409321;27099;2726.6864310604337;2794.3712664650493;2832.7376024351365;2850.78619103566;2854.7716182705335;15301.540953771404;15856.048637081813;15956.601084972852;15961.441349552826;16494.092824894626;1830.7070868661083;1834.8165433295583;1850.7131394633852;1854.249029143199;1857.1271502393854;117196;118038.40980795126;119339.4033029838;121762.39118804438;123352;11565.571230041618;11701.356425396514;11808.701042885275;11817.527298908119;11845.282434047014;13197.868021319857;13846.446142154202;14592.880150348436;14823;14859.925700371645;8630.6979255727;8949.373543851998;8990.235829954396;9091.045440228812;9127.132922372364;8940.552972351486;9105.590248438835;9107.635694572144;9234.76913077165;9244.583993720164;7381.594012329266;7486.176520582731;7500.662470188855;7532.924670753332;7549.849003020019;1650.7936507936508;1951.2292644405381;1972.0928372948317;1972.8027197280157;1975.407377786687;1045.5347370420243;1074.1245884604023;1082.2478377527543;1098.3464838421128;1131.179894576442;21778.782212177677;22124.668129978065;22265.66601500979;22548.759818209826;22574.871256437113;1101.2181351240708;1118.1854357341856;1131.5332574986444;1131.7849608574345;1141.1555448967704;11423;11948.581799636971;11961.86016053646;12072.939635301944;12127.696807579881;610619;710125;715912;732282;742037;101220.49389753005;126407;129397;130264;133432;851.3657325292572;1015.3856916565519;1040.4069680282319;1040.9219308551737;1043.9634612788516;19668.803311966698;20035.89802560873;20148.39554813358;20182.79817201809;20318;56592.71703641456;56732;56933;56986.43013569977;57916.71041644765;75710.59302331519;80443.59778201072;81667;83526.58236708777;83770;8091.676332946617;8392.580370981304;8506.191911768372;8516.446430981967;8729.345299102466;12336.50653973867;13558.728825423634;13600.047996640536;13721.725565488434;13780.862191377957;8442.831143376976;9090.999990001226;11007.669769906915;11067.612633557786;11880.168388212742;5177.171652535727;9415.858762118436;9793.167580755431;11633.941830290794;11656.53373865036;11674.591389301333;11697.707557311136;11823.408829558315;11878.703032423913;11896.881031189923;8559.57202139878;8648.264897483532;8682.78293042679;8707.91292087071;8773.956130219309;9806.65676701312;10478.738031549272;11622.302661840316;11834.763304733684;11955.581554645545 14:58:27 INFO - PROCESS | 1642 | |3;mootools.html;1199.3343694249693;1408.2606631518452;1429.113949351401;1443.9747779076854;1455.446930166537;7632.855071739242;7844.1763614820475;8205.75382738518;8682.305415566756;8693.30453563715;8053.315468185197;8311.459755115913;8316.584170791466;8453.91546084539;8470.491770493774;2306.5963456395148;2331.3705299569106;2337.345543247885;2337.614293641547;2339.63735620979;2074.3362124120285;2139.6255655260343;2306.4810417656063;2339.7192336919593;2350.576896158699;2239.1491233331394;2343.379004563792;2345.6129738593113;2354.234873666057;2356.4226764442737;2317.559663663907;2335.6963594732747;2341.660459233419;2358.893849776747;2360.9409764755846;2305.896234669444;2345.9648105278434;2359.893804778772;2411.493586346869;2415.7221919479307;8398.832023359499;8418.03192632849;8452.028016778087;8454;8470.98348198214;5132.563732082777;5288.444713305086;5294.57643388528;5295.629305948585;5296.708681022542;3366.882159124443;3535.010197144778;3548.6451354864566;3592.2995015971896;3593.3352329819068;1210.1296708053692;1218.2325135164879;1253.4108968784656;1258.3959699344275;1269.4604792962955;10621;10646.893531064745;10699;10706.732331691692;10739.194560408001;4655.605581950725;4709.434867815884;4803.1114243864995;4826.734529600835;4834.6374021948495;8066.516009039477;8207.589620518951;9054.547272636342;9806.31355805101;9812.411255324703;5277.445868183785;5329.573634109262;5336.46635336471;5336.893262134813;5360.490753378423;4210.87367378973;4667.8599642010795;4729.527047295312;4806.543378379049;4809.663323567317;3891.0466935600393;3950;3990.541087774885;4060.0864805418546;4073.450084238649;1018.256672628985;1185.851768528934;1227.7544491101814;1266.3541593787236;1302.5766625846638;646.3923911523153;839;911.1435250864166;915.3592485260344;919.1819280840058;5318.175682769177;5458.1266997280245;5461;5512.4211957744665;5554.555635549146;936.166811537732;940.4169414962766;944.9669261575812;956.1633570625703;977.9193990640382;3626.256617393428;3786.8863934082024;3796.286176987829;3816.103215744298;3824.1778017726324;8377.6230069647;9740.415575065519;9911.553980070914;10028.997100289913;10049.748756281151;7736.729214477579;8427.789305267417;10041.748956276006;10062.949685251528;10099.94950025245;6997.615131167733;7419.777406677808;7789.026371703537;7819.960900195462;8021.919780802351;5417.783288668409;5453.918191227214;5493;5550.750216240198;5556.72216389187;7799.298063174341;9273.026332235018;9286.907130928874;9379.718608441757;9393.436393816393;9241.58412871409;9327.440353578808;9329.72010839676;9464.763380915532;9475.147236748726;5847.619904706181;6813.012113243651;6920.169579650475;6943.305669433016;6945.2707465715375;6753.966230168818;7821.061472623094;7899.0521137463875;7983.8802417962615;8002.479838810459;7123.180834204133;7175.21072682015;7202.063731714844;7270.054892863894;7307.488475806643;7046.964765176142;7107.964460177666;7126.5011449198055;7137.536060156281;7236.167840698387;5902.291724993029;6037.27552693662;6314.4632706218645;6459.870802583828;6478.481721462177;4762.642801789949;4885.511448855086;4939.802407903644;4943.802247910187;4996.6252531061045;4584.693362391702;4976.2286845539;5070.847874563621;5087.364079490064;5177.249298851721 14:58:27 INFO - PROCESS | 1642 | |4;prototype.html;350.24696901661423;364.56252497003584;368.30574367317604;373.9364308067628;377.70161572357824;5001.099802035632;5157.638965272423;5394.541463975562;5410.431904650004;5526.861828454291;5217.895642087156;5336.279602253695;5367.865803354908;5368.3021207243;5373.435789242132;3553.9515842826427;3739.7943113128767;4090.059286364138;4247.6195236548165;4271.0566692155;3808.4668146459517;3884.659792371627;4008.8196031178522;4167.541570427251;4273.316269396897;3130.7025832545874;4214.009707718684;4229.344451610005;4233.555476674951;4233.936490952638;3671.687906527948;4205.642520385771;4209.915801683965;4224.38746381776;4254.638675535077;3479.9652003479896;3778.527684039495;3799.449079883429;3803.562590302123;3820.3123437781187;5053.4946505349535;5072.977752025505;5209.843704688866;5213.758084023868;5275.623600895392;4115.300398932189;4911.435184953741;4912;4916.311716359713;4951.306817045616;5086.143557601486;5789.494731369832;5792.88414231713;5830.650160990354;5833.849721150574;3383.6278009418943;3432.180944099606;3626.8367923443507;3858.5562660294145;3880;5955.583109182359;6076.086032899667;6099.9085013724825;6121.520784082454;6143.815685529396;3730.5336832895887;3812.218495208476;3840.116773142137;3999.000499750125;4009.3785463253244;3231.64271006178;3943.3296339622334;4041.2321658884716;4064.288749468831;4070.7354021989067;4500.122476117126;4643.326717625925;4757.476677565465;4757.666963312535;4758.833440829554;5332.760025798849;5701.2588363513305;5812.389699081536;5815.709214539256;5884.58807883444;1183.8930599889131;1228.6744012836605;1255.7300180461245;1317.4532568983957;1319.901007424447;860.7589874835056;865.8354912566592;873.7422460374205;889.3241136736127;890.8641482110361;4513.684042117086;4736.4316282046375;4763.666543341933;5068.315777370008;5158.3552055993005;5182.455842136521;5722.942770572241;5746.569007324384;5763.106718458645;5764.510016648632;4490.932636010462;4516.325603000878;4612.146752850666;4821.31169655214;5168.08780751117;2552.009432642542;2674.0613055534973;2769.1616093504317;2915.9442592971905;2999.4900866852686;4939.838503357854;5265.551518543895;5273.3935597406025;5772.682502462321;5987.742574059496;4657.534246575316;5230.764615592308;5502.477264659931;5667.489925906688;5910.847384759931;5079.974600127123;5488.4785945335125;5615.613364320229;5821.854453638608;5965.62790558174;5111.6198626371415;5364.436734143015;5445.50990410865;5597.188407680945;5667.3765885753355;4766.737829419415;4814.903701926012;4970.719325245321;5432.049391356576;5668.590848889123;4929.580985616263;5353.2505449237915;5559.72201389937;5688.888888888889;5949.6430214187285;3267.4118658641673;3343.7293828345073;3415.948760768541;3671.0822294426393;3786.772793632391;5468.261784659179;5634.2393776841245;5780.450857168562;5877.911831322448;5915.526757859447;4841;5029.334452740054;5615.185798059177;5687.492814404103;5747.568932330176;5319.547838433777;5782.942170578241;5790.4788569027305;5806.6806325650805;5828.300603927556;4832;5135.229715542699;5380;5656.038473459439;5678.574106942078;5806.477417032318;5825.359210486928;5839.357670656309;5841.4450627190345;5853.473187413153;5449.836504904859;5533.7786488540005;5551.861203469945;5672.078879377042;5767.163761254678 14:58:27 INFO - PROCESS | 1642 | |5;yui.html;720.8990741296222;721.9061522002136;768.3315515501514;832.4006715165079;849.3035710717211;11803;15091.471798487055;15330.08019518827;15490.302936367862;15535.611609709764;14315.57053288403;14322.570322890304;14414.49549265776;14455.915806314542;14638.634034149125;853.4836423963505;868.917452841979;871.8169184471269;872.7905302727363;873.3144481581959;670.4468813229081;686.5262968551683;841.1840514700731;862.1077185113378;866.9566521673922;897.2104547997753;920.5489310238003;922.3820040572832;923.372106967262;923.5059243304834;905.9728208153733;912.1061359867301;913.7852604637905;916.2532535983153;917.1424717888796;672.7006482115461;679.2188982669919;681.3493114076095;682.9726810927557;683.8051155420682;12167.939160304142;14900.329485173193;14949.177795221258;14991.850081499155;15547.844521554753;14261.78607320891;14364.712705745827;14516.419343226258;14598.854011459856;14634.634134146625;11507.769844603145;11851.822222666668;11905.642830715093;11955.820662690066;11969.92270695633;3591.4792355108625;3645.0705070206927;3704.3517384457614;3788.753731007503;3794.6964242860504;104870.47564762204;104975.47512262466;105488;106548;108007.45996269968;10410.271281010408;10479.68560943173;10485.37087774736;10502.212334074822;10582.047615714622;20141.09365078575;20142.59714805725;20196;20385.898070509553;20390.592188156155;7657;7790.5325680459355;7793.532388056735;7807.024121984752;7998.760037198894;3424.503447000171;3716.925661486755;3768.0203147181383;4264.637505812041;4357.607815296638;2953.4979053560946;3585.229175727231;3596.1908570571413;3601.243738814826;3628.9818550907075;569.943005699435;591.361329763854;646.6023395611664;649.6621756686496;657.4575974820792;673.195531340044;677.7763338098416;682.5597489619167;696.8780463418882;714.332099486971;9597.32818702698;9743.512824358753;10203.795924081476;10236.385816851012;10349.172066234683;575.807104619957;647.8468326379053;658.5488940075968;670.1455644053871;682.8258794007496;4469.307257375112;5002.624803139779;5011.298418221452;5012.373453318335;5019.598432125421;110858.44570777095;111271.44364278289;112599.43700281446;115104;115765.42117289528;75290.24709752941;76495.61752191315;97559;98458;100613.49693251487;71917;73111.63444182639;74757;75933;77247.84128237968;10582.947085264525;11225.4387280634;11283.266587671775;11375.601853935073;11415.086793056702;47889.76055119702;50203;50539;52418.475815241356;53393.46606533885;51948.74025629848;53909.730451347496;65480;66568;66638.66680666566;12717.173383730398;12820.294883781482;13006.219626822422;13165.210087394787;13215.933920330337;14127.858721413066;14414.91888108417;14562.708745825235;14809.629759256104;15532.534023979299;12598;13036.869631303565;13696.660850254013;14181.14913105217;14188;12870.22778633285;13347.532836351069;13697.931510342385;13878.583642490741;14213.289335532974;10705.982931621484;13703.177809331472;13736.725265494833;13935.512257070954;14007.649808754863;11343.319400835977;11573.826392604286;11790.351530665896;11829.467673954865;11943.223690460092;10637.414942178255;10891.727706807076;11120.555177792798;11144.832827507431;11179.385133817717 14:58:27 INFO - PROCESS | 1642 | __end_tp_report 14:58:27 INFO - PROCESS | 1642 | __start_cc_report 14:58:27 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,372 14:58:27 INFO - PROCESS | 1642 | __end_cc_report 14:58:27 INFO - PROCESS | 1642 | __startTimestamp1485557907094__endTimestamp 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | ------- Summary: start ------- 14:58:27 INFO - PROCESS | 1642 | Number of tests: 6 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5776.96 Median:6070.21 stddev:651.87 (10.7%) stddev-sans-first:625.59 14:58:27 INFO - PROCESS | 1642 | Values: 3355.7 3381.4 3387.0 3389.7 3395.3 5650.2 5671.2 5712.6 5729.7 5785.9 5674.0 5722.0 5724.7 5738.1 5797.9 4260.8 5194.5 5230.0 5288.7 5299.6 5313.7 5317.0 5328.5 5332.5 5352.4 5301.5 5324.3 5324.9 5337.8 5362.0 5212.2 5217.8 5242.2 5269.5 5310.0 5145.3 5236.5 5280.3 5280.6 5339.5 5760.7 5802.7 5822.3 5825.1 5828.9 6162.4 6217.8 6224.8 6261.7 6296.6 6169.8 6265.2 6283.1 6286.3 6295.7 5948.5 5960.2 5976.9 5977.4 6003.6 6197.3 6220.8 6286.4 6317.3 6334.7 6126.8 6148.0 6184.7 6187.1 6288.8 6277.4 6298.4 6317.6 6319.8 6324.9 6102.2 6259.1 6294.9 6303.4 6311.6 6127.4 6224.8 6259.5 6289.3 6308.8 4976.7 5000.6 5014.8 5018.1 5019.0 4491.2 4505.1 4517.0 4521.4 4523.3 4357.2 4794.8 5750.3 5810.2 5930.8 6190.2 6207.0 6245.3 6257.4 6270.3 5918.4 5924.7 5966.5 5982.9 6011.7 5395.2 5503.7 5529.6 5532.5 5551.7 6231.9 6238.1 6279.3 6302.7 6368.5 6214.3 6221.8 6225.8 6227.4 6234.3 6293.8 6325.7 6340.7 6348.2 6390.6 6109.0 6113.0 6122.4 6141.3 6160.6 6070.2 6217.2 6217.7 6227.5 6236.4 6154.4 6161.8 6164.4 6168.5 6170.2 6059.2 6114.3 6115.7 6162.0 6165.6 5997.3 6063.8 6080.7 6129.9 6138.2 6226.3 6237.3 6237.7 6237.9 6274.1 5140.2 5505.3 5949.9 5971.9 6099.1 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:64123.92 Median:35086.82 stddev:137002.73 (390.5%) stddev-sans-first:137303.59 14:58:27 INFO - PROCESS | 1642 | Values: 428.8 469.5 482.4 498.9 504.0 31544.5 41758.4 41795.8 42056.2 43654.0 32254.0 42785.4 43083.8 43232.9 43293.4 7697.5 8335.1 8498.8 9472.5 9479.4 11126.1 11441.7 11448.8 11573.0 11611.0 11343.5 11405.7 11414.3 11418.3 11425.5 11294.8 11294.9 11347.8 11354.7 11374.1 11216.0 11322.7 11358.1 11365.0 11387.5 40560.4 40900.0 40955.6 41002.6 41113.6 3945.1 4002.9 4011.2 4089.3 4191.0 29931.3 30458.5 30548.0 30830.1 31376.5 3174.0 3181.7 3283.8 3285.0 3313.3 327626.4 340384.3 355387.0 442622.0 444092.0 61184.7 61234.0 61376.4 62009.4 62900.1 63997.7 64606.7 64654.0 64892.4 64996.4 13612.9 16026.4 16442.3 16461.3 16563.9 11512.7 11845.6 12495.1 12762.7 12929.5 16500.3 16526.5 16540.4 16550.0 16586.3 6522.3 6989.8 7321.8 7357.8 7367.9 883.4 893.7 898.9 912.4 923.2 29429.8 29916.4 29941.6 30377.9 30531.7 990.8 1040.7 1058.2 1072.3 1079.0 14496.8 14521.3 14523.8 14622.0 14629.3 581400.0 602169.0 604507.0 604843.0 605464.0 50358.0 50920.5 51022.5 51082.5 51097.4 1421.3 1424.3 1447.9 1449.1 1452.6 27086.0 27115.5 27448.6 27661.9 28371.0 45603.3 45880.9 46015.8 46042.3 46060.0 527239.0 528381.0 531952.0 533625.0 534069.0 24129.9 24253.9 25005.7 25008.6 25924.7 42665.6 42778.0 42811.9 42871.0 43305.6 34672.0 36236.8 37043.6 37463.4 37662.2 35662.0 35678.6 35687.6 35743.5 36306.9 33997.7 34926.0 35247.6 35853.3 35951.8 30529.5 31683.0 32206.7 32215.7 32422.4 22219.8 22391.1 23513.8 24219.4 24781.8 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:38490.33 Median:22510.43 stddev:116529.06 (517.7%) stddev-sans-first:116820.84 14:58:27 INFO - PROCESS | 1642 | Values: 396.5 397.5 398.3 403.0 421.7 16245.8 17931.9 20029.4 20797.0 21528.9 21407.3 21607.9 21622.6 22208.9 22472.1 5630.2 5878.9 5901.7 5920.3 5921.2 5639.7 5812.8 5842.6 5843.8 5859.0 5009.3 5854.1 5861.8 5872.4 5873.7 5594.4 5734.3 5782.5 5836.7 5841.4 5153.5 5190.4 5191.4 5194.9 5195.7 26198.6 26526.7 26715.9 26770.2 27099.0 2726.7 2794.4 2832.7 2850.8 2854.8 15301.5 15856.0 15956.6 15961.4 16494.1 1830.7 1834.8 1850.7 1854.2 1857.1 117196.0 118038.4 119339.4 121762.4 123352.0 11565.6 11701.4 11808.7 11817.5 11845.3 13197.9 13846.4 14592.9 14823.0 14859.9 8630.7 8949.4 8990.2 9091.0 9127.1 8940.6 9105.6 9107.6 9234.8 9244.6 7381.6 7486.2 7500.7 7532.9 7549.8 1650.8 1951.2 1972.1 1972.8 1975.4 1045.5 1074.1 1082.2 1098.3 1131.2 21778.8 22124.7 22265.7 22548.8 22574.9 1101.2 1118.2 1131.5 1131.8 1141.2 11423.0 11948.6 11961.9 12072.9 12127.7 610619.0 710125.0 715912.0 732282.0 742037.0 101220.5 126407.0 129397.0 130264.0 133432.0 851.4 1015.4 1040.4 1040.9 1044.0 19668.8 20035.9 20148.4 20182.8 20318.0 56592.7 56732.0 56933.0 56986.4 57916.7 75710.6 80443.6 81667.0 83526.6 83770.0 8091.7 8392.6 8506.2 8516.4 8729.3 12336.5 13558.7 13600.0 13721.7 13780.9 8442.8 9091.0 11007.7 11067.6 11880.2 5177.2 9415.9 9793.2 11633.9 11656.5 11674.6 11697.7 11823.4 11878.7 11896.9 8559.6 8648.3 8682.8 8707.9 8774.0 9806.7 10478.7 11622.3 11834.8 11955.6 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5385.64 Median:5307.44 stddev:2889.13 (54.4%) stddev-sans-first:2880.10 14:58:27 INFO - PROCESS | 1642 | Values: 1199.3 1408.3 1429.1 1444.0 1455.4 7632.9 7844.2 8205.8 8682.3 8693.3 8053.3 8311.5 8316.6 8453.9 8470.5 2306.6 2331.4 2337.3 2337.6 2339.6 2074.3 2139.6 2306.5 2339.7 2350.6 2239.1 2343.4 2345.6 2354.2 2356.4 2317.6 2335.7 2341.7 2358.9 2360.9 2305.9 2346.0 2359.9 2411.5 2415.7 8398.8 8418.0 8452.0 8454.0 8471.0 5132.6 5288.4 5294.6 5295.6 5296.7 3366.9 3535.0 3548.6 3592.3 3593.3 1210.1 1218.2 1253.4 1258.4 1269.5 10621.0 10646.9 10699.0 10706.7 10739.2 4655.6 4709.4 4803.1 4826.7 4834.6 8066.5 8207.6 9054.5 9806.3 9812.4 5277.4 5329.6 5336.5 5336.9 5360.5 4210.9 4667.9 4729.5 4806.5 4809.7 3891.0 3950.0 3990.5 4060.1 4073.5 1018.3 1185.9 1227.8 1266.4 1302.6 646.4 839.0 911.1 915.4 919.2 5318.2 5458.1 5461.0 5512.4 5554.6 936.2 940.4 945.0 956.2 977.9 3626.3 3786.9 3796.3 3816.1 3824.2 8377.6 9740.4 9911.6 10029.0 10049.7 7736.7 8427.8 10041.7 10062.9 10099.9 6997.6 7419.8 7789.0 7820.0 8021.9 5417.8 5453.9 5493.0 5550.8 5556.7 7799.3 9273.0 9286.9 9379.7 9393.4 9241.6 9327.4 9329.7 9464.8 9475.1 5847.6 6813.0 6920.2 6943.3 6945.3 6754.0 7821.1 7899.1 7983.9 8002.5 7123.2 7175.2 7202.1 7270.1 7307.5 7047.0 7108.0 7126.5 7137.5 7236.2 5902.3 6037.3 6314.5 6459.9 6478.5 4762.6 4885.5 4939.8 4943.8 4996.6 4584.7 4976.2 5070.8 5087.4 5177.2 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4556.29 Median:5083.06 stddev:1407.08 (27.7%) stddev-sans-first:1375.16 14:58:27 INFO - PROCESS | 1642 | Values: 350.2 364.6 368.3 373.9 377.7 5001.1 5157.6 5394.5 5410.4 5526.9 5217.9 5336.3 5367.9 5368.3 5373.4 3554.0 3739.8 4090.1 4247.6 4271.1 3808.5 3884.7 4008.8 4167.5 4273.3 3130.7 4214.0 4229.3 4233.6 4233.9 3671.7 4205.6 4209.9 4224.4 4254.6 3480.0 3778.5 3799.4 3803.6 3820.3 5053.5 5073.0 5209.8 5213.8 5275.6 4115.3 4911.4 4912.0 4916.3 4951.3 5086.1 5789.5 5792.9 5830.7 5833.8 3383.6 3432.2 3626.8 3858.6 3880.0 5955.6 6076.1 6099.9 6121.5 6143.8 3730.5 3812.2 3840.1 3999.0 4009.4 3231.6 3943.3 4041.2 4064.3 4070.7 4500.1 4643.3 4757.5 4757.7 4758.8 5332.8 5701.3 5812.4 5815.7 5884.6 1183.9 1228.7 1255.7 1317.5 1319.9 860.8 865.8 873.7 889.3 890.9 4513.7 4736.4 4763.7 5068.3 5158.4 5182.5 5722.9 5746.6 5763.1 5764.5 4490.9 4516.3 4612.1 4821.3 5168.1 2552.0 2674.1 2769.2 2915.9 2999.5 4939.8 5265.6 5273.4 5772.7 5987.7 4657.5 5230.8 5502.5 5667.5 5910.8 5080.0 5488.5 5615.6 5821.9 5965.6 5111.6 5364.4 5445.5 5597.2 5667.4 4766.7 4814.9 4970.7 5432.0 5668.6 4929.6 5353.3 5559.7 5688.9 5949.6 3267.4 3343.7 3415.9 3671.1 3786.8 5468.3 5634.2 5780.5 5877.9 5915.5 4841.0 5029.3 5615.2 5687.5 5747.6 5319.5 5782.9 5790.5 5806.7 5828.3 4832.0 5135.2 5380.0 5656.0 5678.6 5806.5 5825.4 5839.4 5841.4 5853.5 5449.8 5533.8 5551.9 5672.1 5767.2 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20512.36 Median:3504.87 stddev:29907.85 (853.3%) stddev-sans-first:29954.83 14:58:27 INFO - PROCESS | 1642 | Values: 720.9 721.9 768.3 832.4 849.3 11803.0 15091.5 15330.1 15490.3 15535.6 14315.6 14322.6 14414.5 14455.9 14638.6 853.5 868.9 871.8 872.8 873.3 670.4 686.5 841.2 862.1 867.0 897.2 920.5 922.4 923.4 923.5 906.0 912.1 913.8 916.3 917.1 672.7 679.2 681.3 683.0 683.8 12167.9 14900.3 14949.2 14991.9 15547.8 14261.8 14364.7 14516.4 14598.9 14634.6 11507.8 11851.8 11905.6 11955.8 11969.9 3591.5 3645.1 3704.4 3788.8 3794.7 104870.5 104975.5 105488.0 106548.0 108007.5 10410.3 10479.7 10485.4 10502.2 10582.0 20141.1 20142.6 20196.0 20385.9 20390.6 7657.0 7790.5 7793.5 7807.0 7998.8 3424.5 3716.9 3768.0 4264.6 4357.6 2953.5 3585.2 3596.2 3601.2 3629.0 569.9 591.4 646.6 649.7 657.5 673.2 677.8 682.6 696.9 714.3 9597.3 9743.5 10203.8 10236.4 10349.2 575.8 647.8 658.5 670.1 682.8 4469.3 5002.6 5011.3 5012.4 5019.6 110858.4 111271.4 112599.4 115104.0 115765.4 75290.2 76495.6 97559.0 98458.0 100613.5 71917.0 73111.6 74757.0 75933.0 77247.8 10582.9 11225.4 11283.3 11375.6 11415.1 47889.8 50203.0 50539.0 52418.5 53393.5 51948.7 53909.7 65480.0 66568.0 66638.7 12717.2 12820.3 13006.2 13165.2 13215.9 14127.9 14414.9 14562.7 14809.6 15532.5 12598.0 13036.9 13696.7 14181.1 14188.0 12870.2 13347.5 13697.9 13878.6 14213.3 10706.0 13703.2 13736.7 13935.5 14007.6 11343.3 11573.8 11790.4 11829.5 11943.2 10637.4 10891.7 11120.6 11144.8 11179.4 14:58:27 INFO - PROCESS | 1642 | -------- Summary: end -------- 14:58:27 INFO - PROCESS | 1642 | 14:58:27 INFO - TEST-INFO | 1642: exit 0 14:58:27 INFO - TEST-OK | dromaeo_css | took 1115138ms 14:58:27 INFO - TEST-START | kraken 14:58:27 INFO - operating with platform_type : mac_ 14:58:27 INFO - Initialising browser for kraken test... 14:58:27 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmp9DWfeO/profile http://localhost:49241/getInfo.html) 14:58:30 INFO - PROCESS | 1655 | 2017-01-27 14:58:30.451 plugin-container[1656:10379] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 14:58:30 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:58:30 INFO - PROCESS | 1655 | 2017-01-27 14:58:30.453 plugin-container[1656:10379] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 14:58:30 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:58:30 INFO - PROCESS | 1655 | 2017-01-27 14:58:30.453 plugin-container[1656:10379] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:58:30 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 14:58:30 INFO - PROCESS | 1655 | colorDepth:24 14:58:30 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 14:58:30 INFO - PROCESS | 1655 | __metrics 14:58:30 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 14:58:31 INFO - TEST-INFO | 1655: exit 0 14:58:31 INFO - Browser initialized. 14:58:31 INFO - Running cycle 1/1 for kraken test... 14:58:31 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmp9DWfeO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:33 INFO - PROCESS | 1657 | 2017-01-27 14:58:33.708 plugin-container[1658:10506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:58:33 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:58:33 INFO - PROCESS | 1657 | 2017-01-27 14:58:33.709 plugin-container[1658:10506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:58:33 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:58:33 INFO - PROCESS | 1657 | 2017-01-27 14:58:33.709 plugin-container[1658:10506] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:58:43 INFO - PROCESS | 1657 | RSS: Main: 218681344 14:58:43 INFO - PROCESS | 1657 | 14:58:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 14:58:47 INFO - PROCESS | 1657 | RSS: Main: 233066496 14:58:47 INFO - PROCESS | 1657 | 14:58:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 14:58:50 INFO - PROCESS | 1657 | RSS: Main: 242110464 14:58:50 INFO - PROCESS | 1657 | 14:58:53 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 14:58:54 INFO - PROCESS | 1657 | RSS: Main: 245055488 14:58:54 INFO - PROCESS | 1657 | 14:58:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 14:58:57 INFO - PROCESS | 1657 | RSS: Main: 245133312 14:58:57 INFO - PROCESS | 1657 | 14:58:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:58:59 INFO - PROCESS | 1657 | RSS: Main: 245149696 14:58:59 INFO - PROCESS | 1657 | 14:59:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:03 INFO - PROCESS | 1657 | RSS: Main: 249274368 14:59:03 INFO - PROCESS | 1657 | 14:59:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:07 INFO - PROCESS | 1657 | RSS: Main: 248791040 14:59:07 INFO - PROCESS | 1657 | 14:59:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 14:59:10 INFO - PROCESS | 1657 | RSS: Main: 250298368 14:59:10 INFO - PROCESS | 1657 | 14:59:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:13 INFO - PROCESS | 1657 | RSS: Main: 249704448 14:59:13 INFO - PROCESS | 1657 | 14:59:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:15 INFO - PROCESS | 1657 | RSS: Main: 249712640 14:59:15 INFO - PROCESS | 1657 | 14:59:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:18 INFO - PROCESS | 1657 | RSS: Main: 249774080 14:59:18 INFO - PROCESS | 1657 | 14:59:21 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:22 INFO - PROCESS | 1657 | RSS: Main: 250150912 14:59:22 INFO - PROCESS | 1657 | 14:59:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:25 INFO - PROCESS | 1657 | RSS: Main: 250044416 14:59:25 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 14:59:27 INFO - PROCESS | 1657 | RSS: Main: 252084224 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | __start_tp_report 14:59:27 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 14:59:27 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 14:59:27 INFO - PROCESS | 1657 | |i|pagename|runs| 14:59:27 INFO - PROCESS | 1657 | |0;ai-astar;107;121;119;127;118;118;119;117;162;101 14:59:27 INFO - PROCESS | 1657 | |1;audio-beat-detection;143;116;111;144;114;112;114;113;132;113 14:59:27 INFO - PROCESS | 1657 | |2;audio-dft;217;186;266;263;193;197;197;194;197;197 14:59:27 INFO - PROCESS | 1657 | |3;audio-fft;86;50;50;76;50;51;50;62;89;83 14:59:27 INFO - PROCESS | 1657 | |4;audio-oscillator;87;72;85;90;71;62;102;103;104;93 14:59:27 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;92;90;93;89;92;122;117;77;135;132 14:59:27 INFO - PROCESS | 1657 | |6;imaging-darkroom;127;102;156;123;123;176;175;102;101;102 14:59:27 INFO - PROCESS | 1657 | |7;imaging-desaturate;93;95;100;93;116;117;92;94;95;93 14:59:27 INFO - PROCESS | 1657 | |8;json-parse-financial;62;61;61;63;64;63;64;64;65;63 14:59:27 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;71;88;86;103;118;111;72;71;71;71 14:59:27 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;83;90;89;82;84;85;82;90;87;84 14:59:27 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;135;141;152;151;134;143;152;138;205;175 14:59:27 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;174;167;179;229;232;171;174;171;170;169 14:59:27 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;69;68;68;66;72;91;88;85;86;69 14:59:27 INFO - PROCESS | 1657 | __end_tp_report 14:59:27 INFO - PROCESS | 1657 | __start_cc_report 14:59:27 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,930 14:59:27 INFO - PROCESS | 1657 | __end_cc_report 14:59:27 INFO - PROCESS | 1657 | __startTimestamp1485557967925__endTimestamp 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | ------- Summary: start ------- 14:59:27 INFO - PROCESS | 1657 | Number of tests: 14 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:120.90 Median:119.00 stddev:16.18 (13.6%) stddev-sans-first:16.36 14:59:27 INFO - PROCESS | 1657 | Values: 107.0 121.0 119.0 127.0 118.0 118.0 119.0 117.0 162.0 101.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:115.00 stddev:13.19 (11.5%) stddev-sans-first:11.39 14:59:27 INFO - PROCESS | 1657 | Values: 143.0 116.0 111.0 144.0 114.0 112.0 114.0 113.0 132.0 113.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:210.70 Median:197.00 stddev:29.41 (14.9%) stddev-sans-first:31.11 14:59:27 INFO - PROCESS | 1657 | Values: 217.0 186.0 266.0 263.0 193.0 197.0 197.0 194.0 197.0 197.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:64.70 Median:69.00 stddev:16.89 (24.5%) stddev-sans-first:16.05 14:59:27 INFO - PROCESS | 1657 | Values: 86.0 50.0 50.0 76.0 50.0 51.0 50.0 62.0 89.0 83.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:78.50 stddev:14.62 (18.6%) stddev-sans-first:15.51 14:59:27 INFO - PROCESS | 1657 | Values: 87.0 72.0 85.0 90.0 71.0 62.0 102.0 103.0 104.0 93.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:103.90 Median:89.50 stddev:20.54 (22.9%) stddev-sans-first:21.33 14:59:27 INFO - PROCESS | 1657 | Values: 92.0 90.0 93.0 89.0 92.0 122.0 117.0 77.0 135.0 132.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:128.70 Median:125.00 stddev:30.00 (24.0%) stddev-sans-first:31.81 14:59:27 INFO - PROCESS | 1657 | Values: 127.0 102.0 156.0 123.0 123.0 176.0 175.0 102.0 101.0 102.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:93.00 stddev:9.59 (10.3%) stddev-sans-first:9.94 14:59:27 INFO - PROCESS | 1657 | Values: 93.0 95.0 100.0 93.0 116.0 117.0 92.0 94.0 95.0 93.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.50 stddev:1.33 (2.1%) stddev-sans-first:1.36 14:59:27 INFO - PROCESS | 1657 | Values: 62.0 61.0 61.0 63.0 64.0 63.0 64.0 64.0 65.0 63.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:86.20 Median:71.00 stddev:18.37 (25.9%) stddev-sans-first:18.64 14:59:27 INFO - PROCESS | 1657 | Values: 71.0 88.0 86.0 103.0 118.0 111.0 72.0 71.0 71.0 71.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:3.17 (3.7%) stddev-sans-first:3.22 14:59:27 INFO - PROCESS | 1657 | Values: 83.0 90.0 89.0 82.0 84.0 85.0 82.0 90.0 87.0 84.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:152.60 Median:151.50 stddev:21.98 (14.5%) stddev-sans-first:22.37 14:59:27 INFO - PROCESS | 1657 | Values: 135.0 141.0 152.0 151.0 134.0 143.0 152.0 138.0 205.0 175.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:174.00 stddev:24.95 (14.3%) stddev-sans-first:26.22 14:59:27 INFO - PROCESS | 1657 | Values: 174.0 167.0 179.0 229.0 232.0 171.0 174.0 171.0 170.0 169.0 14:59:27 INFO - PROCESS | 1657 | 14:59:27 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:78.50 stddev:9.95 (12.7%) stddev-sans-first:10.21 14:59:27 INFO - PROCESS | 1657 | Values: 69.0 68.0 68.0 66.0 72.0 91.0 88.0 85.0 86.0 69.0 14:59:27 INFO - PROCESS | 1657 | -------- Summary: end -------- 14:59:27 INFO - PROCESS | 1657 | 14:59:28 INFO - TEST-INFO | 1657: exit 0 14:59:28 INFO - TEST-OK | kraken | took 60997ms 14:59:28 INFO - SUITE-END | took 1176s 14:59:29 INFO - Completed test suite (00:19:36) 14:59:29 INFO - javascript benchmark 14:59:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7323.482948921906, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.731541476682, 3381.4251577231867, 3387.017764848194, 3389.7288216942648, 3395.253044330248, 5650.237217975572, 5671.234383358245, 5712.600117991732, 5729.713514324283, 5785.855353616151, 5673.971630141854, 5722.027255366587, 5724.685142317171, 5738.0532212184935, 5797.942020579793, 4260.786960651971, 5194.506521880416, 5229.980153869997, 5288.6562373445795, 5299.5760339172775, 5313.681179129246, 5317.016351974878, 5328.46715328468, 5332.466753324676, 5352.357717073956, 5301.469853014687, 5324.281222035033, 5324.946750532503, 5337.759800808973, 5362.0, 5212.21816727492, 5217.8173763918085, 5242.2136679498, 5269.525742683139, 5310.0, 5145.253938178943, 5236.528712415863, 5280.260763493114, 5280.570937368815, 5339.466053394668, 5760.654360738327, 5802.680852553108, 5822.272215973004, 5825.0679891217205, 5828.9417105828825, 6162.352952939967, 6217.813465596039, 6224.782132625336, 6261.749530018794, 6296.590721603081, 6169.845753856144, 6265.185525881606, 6283.120363149163, 6286.308506064329, 6295.68521573924, 5948.464638182584, 5960.195373624592, 5976.850578735566, 5977.3723759005115, 6003.579749417542, 6197.287311959092, 6220.7511699532415, 6286.402791734778, 6317.273513545909, 6334.683265836689, 6126.792505495304, 6148.016317389196, 6184.721687524072, 6187.102870083812, 6288.779892703734, 6277.372262773777, 6298.433141017331, 6317.557770955989, 6319.8104056878365, 6324.873502530016, 6102.237220347457, 6259.0924315973925, 6294.937050629526, 6303.432691057827, 6311.589746666452, 6127.372786728385, 6224.751009959641, 6259.530535209878, 6289.308176100625, 6308.779192728232, 4976.7262800545595, 5000.62495312853, 5014.824481143142, 5018.1218286800395, 5018.996200759862, 4491.214037543482, 4505.144022635689, 4517.006258623098, 4521.367008618796, 4523.2988886722615, 4357.215701173755, 4794.808207671654, 5750.25246717924, 5810.244668193192, 5930.7924222652, 6190.164327815687, 6207.006878899445, 6245.281792593819, 6257.374262573706, 6270.31026587075, 5918.408159184047, 5924.674142922181, 5966.492848107872, 5982.940170598238, 6011.699415029231, 5395.163749618815, 5503.724813759296, 5529.557635389159, 5532.474414930575, 5551.694656793834, 6231.875362492725, 6238.064290356483, 6279.277883043325, 6302.684865756785, 6368.490520758421, 6214.285357183981, 6221.844453888689, 6225.782097626561, 6227.377262273736, 6234.345393733593, 6293.811185664437, 6325.652089135142, 6340.71466784005, 6348.174737284124, 6390.584612000205, 6109.009944784373, 6112.989854784201, 6122.448979591858, 6141.301904043321, 6160.568760186744, 6070.206121174266, 6217.160683307696, 6217.689115544295, 6227.501799856092, 6236.445226221192, 6154.353792851686, 6161.753529858935, 6164.383561643979, 6168.475679567287, 6170.197874276315, 6059.21230240066, 6114.266288045463, 6115.6967227387295, 6162.044883043135, 6165.630062196283, 5997.340292567901, 6063.757449701962, 6080.726367313393, 6129.877402452015, 6138.232720909887, 6226.346233645402, 6237.251529816451, 6237.656928868956, 6237.906431403623, 6274.121622972696, 5140.177571588528, 5505.256790333254, 5949.910751338647, 5971.925053490413, 6099.085137229451], "value": 5735.644152446239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.8091799149378, 469.4788784449263, 482.3512375854479, 498.860319110649, 503.95716364109035, 31544.52683209751, 41758.37362439566, 41795.791021044926, 42056.15887682248, 43654.0, 32254.0, 42785.35821962665, 43083.78458107713, 43232.91917702059, 43293.35059974103, 7697.499662521946, 8335.083140854502, 8498.78753031173, 9472.479013654247, 9479.43123412594, 11126.109911207084, 11441.656750297463, 11448.771024579504, 11573.0, 11611.0, 11343.489542970545, 11405.714857128554, 11414.258073225255, 11418.31490110592, 11425.542978280859, 11294.830577541343, 11294.887051129466, 11347.829782553268, 11354.71613209668, 11374.146938979567, 11216.0, 11322.660320190325, 11358.148138889534, 11365.0, 11387.54449822006, 40560.391594126115, 40900.0, 40955.59044409548, 41002.58997410018, 41113.588864111276, 3945.1320709443876, 4002.8799136025964, 4011.1576568920564, 4089.325261331877, 4190.958090419087, 29931.251718707208, 30458.54312185319, 30548.0, 30830.075097747103, 31376.529352059737, 3174.032997570334, 3181.6659250778566, 3283.83580820958, 3284.9652359506917, 3313.3042061167184, 327626.3618681915, 340384.2980785105, 355387.0, 442622.0, 444092.0, 61184.69407652933, 61234.0, 61376.38623613796, 62009.37990620126, 62900.056499152546, 63997.680011599645, 64606.67696661487, 64654.0, 64892.35107648958, 64996.35003649903, 13612.863871361358, 16026.439074632564, 16442.260098295606, 16461.34154633825, 16563.91718041402, 11512.654620361403, 11845.5854045108, 12495.062870284582, 12762.744745105047, 12929.54746583865, 16500.25748841305, 16526.504204873872, 16540.421085261958, 16550.0, 16586.253618587194, 6522.282548919615, 6989.755358562527, 7321.78034658961, 7357.77926662201, 7367.8894816577795, 883.4257732473815, 893.7408151636083, 898.851689471243, 912.3932584831012, 923.2198792020732, 29429.822807087905, 29916.401671966873, 29941.550876736866, 30377.936772212866, 30531.66090051312, 990.7869807991317, 1040.698197522725, 1058.222206678091, 1072.2708558180511, 1079.0450451350612, 14496.782548261785, 14521.273936303354, 14523.78214326786, 14621.976461647795, 14629.268536573129, 581400.0, 602169.0, 604507.0, 604843.0, 605464.0, 50358.0, 50920.49079509157, 51022.48977510177, 51082.489175107774, 51097.445127743464, 1421.275149673674, 1424.33056463462, 1447.862453066957, 1449.0654975607472, 1452.6077958951234, 27086.0, 27115.457690845677, 27448.588271175548, 27661.861690691418, 28371.0, 45603.31595026011, 45880.8529786758, 46015.76992115018, 46042.30936536022, 46060.0, 527239.0, 528381.0, 531952.0, 533625.0, 534069.0, 24129.879350603136, 24253.878730606233, 25005.74994250034, 25008.62487062659, 25924.74075259223, 42665.57334426616, 42778.0, 42811.92970175646, 42871.0, 43305.56694433015, 34672.0, 36236.81881590575, 37043.62956370402, 37463.43804842875, 37662.246755064196, 35662.0, 35678.572857085426, 35687.64312356843, 35743.46384804282, 36306.91079267626, 33997.66002339945, 34926.0, 35247.647523524436, 35853.28293434065, 35951.820240898625, 30529.54205686961, 31683.0, 32206.67793322037, 32215.711371544876, 32422.351552968335, 22219.77780222242, 22391.096756775856, 23513.764862351156, 24219.39451513726, 24781.752182477943], "value": 19536.022773625795, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.5182303501247, 397.5070912069035, 398.33478091587045, 402.9637332640062, 421.74320524835986, 16245.83754162458, 17931.924084554936, 20029.399118026464, 20797.0, 21528.89235553822, 21407.250746223886, 21607.919604019775, 21622.567548649058, 22208.88895555524, 22472.101115955382, 5630.239917611111, 5878.941790477712, 5901.73112780752, 5920.348761636216, 5921.230240068785, 5639.7180140993, 5812.796552120655, 5842.64944103353, 5843.79546715865, 5859.0, 5009.323741294933, 5854.092615644582, 5861.824145275648, 5872.412758724136, 5873.676947767871, 5594.412586678422, 5734.340550836666, 5782.508486778629, 5836.6789826559525, 5841.386654401291, 5153.536181743623, 5190.351206099238, 5191.351081114861, 5194.948050519484, 5195.6622819516615, 26198.607020894702, 26526.73473265281, 26715.86642066777, 26770.19689409321, 27099.0, 2726.6864310604337, 2794.3712664650493, 2832.7376024351365, 2850.78619103566, 2854.7716182705335, 15301.540953771404, 15856.048637081813, 15956.601084972852, 15961.441349552826, 16494.092824894626, 1830.7070868661083, 1834.8165433295583, 1850.7131394633852, 1854.249029143199, 1857.1271502393854, 117196.0, 118038.40980795126, 119339.4033029838, 121762.39118804438, 123352.0, 11565.571230041618, 11701.356425396514, 11808.701042885275, 11817.527298908119, 11845.282434047014, 13197.868021319857, 13846.446142154202, 14592.880150348436, 14823.0, 14859.925700371645, 8630.6979255727, 8949.373543851998, 8990.235829954396, 9091.045440228812, 9127.132922372364, 8940.552972351486, 9105.590248438835, 9107.635694572144, 9234.76913077165, 9244.583993720164, 7381.594012329266, 7486.176520582731, 7500.662470188855, 7532.924670753332, 7549.849003020019, 1650.7936507936508, 1951.2292644405381, 1972.0928372948317, 1972.8027197280157, 1975.407377786687, 1045.5347370420243, 1074.1245884604023, 1082.2478377527543, 1098.3464838421128, 1131.179894576442, 21778.782212177677, 22124.668129978065, 22265.66601500979, 22548.759818209826, 22574.871256437113, 1101.2181351240708, 1118.1854357341856, 1131.5332574986444, 1131.7849608574345, 1141.1555448967704, 11423.0, 11948.581799636971, 11961.86016053646, 12072.939635301944, 12127.696807579881, 610619.0, 710125.0, 715912.0, 732282.0, 742037.0, 101220.49389753005, 126407.0, 129397.0, 130264.0, 133432.0, 851.3657325292572, 1015.3856916565519, 1040.4069680282319, 1040.9219308551737, 1043.9634612788516, 19668.803311966698, 20035.89802560873, 20148.39554813358, 20182.79817201809, 20318.0, 56592.71703641456, 56732.0, 56933.0, 56986.43013569977, 57916.71041644765, 75710.59302331519, 80443.59778201072, 81667.0, 83526.58236708777, 83770.0, 8091.676332946617, 8392.580370981304, 8506.191911768372, 8516.446430981967, 8729.345299102466, 12336.50653973867, 13558.728825423634, 13600.047996640536, 13721.725565488434, 13780.862191377957, 8442.831143376976, 9090.999990001226, 11007.669769906915, 11067.612633557786, 11880.168388212742, 5177.171652535727, 9415.858762118436, 9793.167580755431, 11633.941830290794, 11656.53373865036, 11674.591389301333, 11697.707557311136, 11823.408829558315, 11878.703032423913, 11896.881031189923, 8559.57202139878, 8648.264897483532, 8682.78293042679, 8707.91292087071, 8773.956130219309, 9806.65676701312, 10478.738031549272, 11622.302661840316, 11834.763304733684, 11955.581554645545], "value": 10146.489981012432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.3343694249693, 1408.2606631518452, 1429.113949351401, 1443.9747779076854, 1455.446930166537, 7632.855071739242, 7844.1763614820475, 8205.75382738518, 8682.305415566756, 8693.30453563715, 8053.315468185197, 8311.459755115913, 8316.584170791466, 8453.91546084539, 8470.491770493774, 2306.5963456395148, 2331.3705299569106, 2337.345543247885, 2337.614293641547, 2339.63735620979, 2074.3362124120285, 2139.6255655260343, 2306.4810417656063, 2339.7192336919593, 2350.576896158699, 2239.1491233331394, 2343.379004563792, 2345.6129738593113, 2354.234873666057, 2356.4226764442737, 2317.559663663907, 2335.6963594732747, 2341.660459233419, 2358.893849776747, 2360.9409764755846, 2305.896234669444, 2345.9648105278434, 2359.893804778772, 2411.493586346869, 2415.7221919479307, 8398.832023359499, 8418.03192632849, 8452.028016778087, 8454.0, 8470.98348198214, 5132.563732082777, 5288.444713305086, 5294.57643388528, 5295.629305948585, 5296.708681022542, 3366.882159124443, 3535.010197144778, 3548.6451354864566, 3592.2995015971896, 3593.3352329819068, 1210.1296708053692, 1218.2325135164879, 1253.4108968784656, 1258.3959699344275, 1269.4604792962955, 10621.0, 10646.893531064745, 10699.0, 10706.732331691692, 10739.194560408001, 4655.605581950725, 4709.434867815884, 4803.1114243864995, 4826.734529600835, 4834.6374021948495, 8066.516009039477, 8207.589620518951, 9054.547272636342, 9806.31355805101, 9812.411255324703, 5277.445868183785, 5329.573634109262, 5336.46635336471, 5336.893262134813, 5360.490753378423, 4210.87367378973, 4667.8599642010795, 4729.527047295312, 4806.543378379049, 4809.663323567317, 3891.0466935600393, 3950.0, 3990.541087774885, 4060.0864805418546, 4073.450084238649, 1018.256672628985, 1185.851768528934, 1227.7544491101814, 1266.3541593787236, 1302.5766625846638, 646.3923911523153, 839.0, 911.1435250864166, 915.3592485260344, 919.1819280840058, 5318.175682769177, 5458.1266997280245, 5461.0, 5512.4211957744665, 5554.555635549146, 936.166811537732, 940.4169414962766, 944.9669261575812, 956.1633570625703, 977.9193990640382, 3626.256617393428, 3786.8863934082024, 3796.286176987829, 3816.103215744298, 3824.1778017726324, 8377.6230069647, 9740.415575065519, 9911.553980070914, 10028.997100289913, 10049.748756281151, 7736.729214477579, 8427.789305267417, 10041.748956276006, 10062.949685251528, 10099.94950025245, 6997.615131167733, 7419.777406677808, 7789.026371703537, 7819.960900195462, 8021.919780802351, 5417.783288668409, 5453.918191227214, 5493.0, 5550.750216240198, 5556.72216389187, 7799.298063174341, 9273.026332235018, 9286.907130928874, 9379.718608441757, 9393.436393816393, 9241.58412871409, 9327.440353578808, 9329.72010839676, 9464.763380915532, 9475.147236748726, 5847.619904706181, 6813.012113243651, 6920.169579650475, 6943.305669433016, 6945.2707465715375, 6753.966230168818, 7821.061472623094, 7899.0521137463875, 7983.8802417962615, 8002.479838810459, 7123.180834204133, 7175.21072682015, 7202.063731714844, 7270.054892863894, 7307.488475806643, 7046.964765176142, 7107.964460177666, 7126.5011449198055, 7137.536060156281, 7236.167840698387, 5902.291724993029, 6037.27552693662, 6314.4632706218645, 6459.870802583828, 6478.481721462177, 4762.642801789949, 4885.511448855086, 4939.802407903644, 4943.802247910187, 4996.6252531061045, 4584.693362391702, 4976.2286845539, 5070.847874563621, 5087.364079490064, 5177.249298851721], "value": 4397.4013576066445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.24696901661423, 364.56252497003584, 368.30574367317604, 373.9364308067628, 377.70161572357824, 5001.099802035632, 5157.638965272423, 5394.541463975562, 5410.431904650004, 5526.861828454291, 5217.895642087156, 5336.279602253695, 5367.865803354908, 5368.3021207243, 5373.435789242132, 3553.9515842826427, 3739.7943113128767, 4090.059286364138, 4247.6195236548165, 4271.0566692155, 3808.4668146459517, 3884.659792371627, 4008.8196031178522, 4167.541570427251, 4273.316269396897, 3130.7025832545874, 4214.009707718684, 4229.344451610005, 4233.555476674951, 4233.936490952638, 3671.687906527948, 4205.642520385771, 4209.915801683965, 4224.38746381776, 4254.638675535077, 3479.9652003479896, 3778.527684039495, 3799.449079883429, 3803.562590302123, 3820.3123437781187, 5053.4946505349535, 5072.977752025505, 5209.843704688866, 5213.758084023868, 5275.623600895392, 4115.300398932189, 4911.435184953741, 4912.0, 4916.311716359713, 4951.306817045616, 5086.143557601486, 5789.494731369832, 5792.88414231713, 5830.650160990354, 5833.849721150574, 3383.6278009418943, 3432.180944099606, 3626.8367923443507, 3858.5562660294145, 3880.0, 5955.583109182359, 6076.086032899667, 6099.9085013724825, 6121.520784082454, 6143.815685529396, 3730.5336832895887, 3812.218495208476, 3840.116773142137, 3999.000499750125, 4009.3785463253244, 3231.64271006178, 3943.3296339622334, 4041.2321658884716, 4064.288749468831, 4070.7354021989067, 4500.122476117126, 4643.326717625925, 4757.476677565465, 4757.666963312535, 4758.833440829554, 5332.760025798849, 5701.2588363513305, 5812.389699081536, 5815.709214539256, 5884.58807883444, 1183.8930599889131, 1228.6744012836605, 1255.7300180461245, 1317.4532568983957, 1319.901007424447, 860.7589874835056, 865.8354912566592, 873.7422460374205, 889.3241136736127, 890.8641482110361, 4513.684042117086, 4736.4316282046375, 4763.666543341933, 5068.315777370008, 5158.3552055993005, 5182.455842136521, 5722.942770572241, 5746.569007324384, 5763.106718458645, 5764.510016648632, 4490.932636010462, 4516.325603000878, 4612.146752850666, 4821.31169655214, 5168.08780751117, 2552.009432642542, 2674.0613055534973, 2769.1616093504317, 2915.9442592971905, 2999.4900866852686, 4939.838503357854, 5265.551518543895, 5273.3935597406025, 5772.682502462321, 5987.742574059496, 4657.534246575316, 5230.764615592308, 5502.477264659931, 5667.489925906688, 5910.847384759931, 5079.974600127123, 5488.4785945335125, 5615.613364320229, 5821.854453638608, 5965.62790558174, 5111.6198626371415, 5364.436734143015, 5445.50990410865, 5597.188407680945, 5667.3765885753355, 4766.737829419415, 4814.903701926012, 4970.719325245321, 5432.049391356576, 5668.590848889123, 4929.580985616263, 5353.2505449237915, 5559.72201389937, 5688.888888888889, 5949.6430214187285, 3267.4118658641673, 3343.7293828345073, 3415.948760768541, 3671.0822294426393, 3786.772793632391, 5468.261784659179, 5634.2393776841245, 5780.450857168562, 5877.911831322448, 5915.526757859447, 4841.0, 5029.334452740054, 5615.185798059177, 5687.492814404103, 5747.568932330176, 5319.547838433777, 5782.942170578241, 5790.4788569027305, 5806.6806325650805, 5828.300603927556, 4832.0, 5135.229715542699, 5380.0, 5656.038473459439, 5678.574106942078, 5806.477417032318, 5825.359210486928, 5839.357670656309, 5841.4450627190345, 5853.473187413153, 5449.836504904859, 5533.7786488540005, 5551.861203469945, 5672.078879377042, 5767.163761254678], "value": 4119.45105192375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.8990741296222, 721.9061522002136, 768.3315515501514, 832.4006715165079, 849.3035710717211, 11803.0, 15091.471798487055, 15330.08019518827, 15490.302936367862, 15535.611609709764, 14315.57053288403, 14322.570322890304, 14414.49549265776, 14455.915806314542, 14638.634034149125, 853.4836423963505, 868.917452841979, 871.8169184471269, 872.7905302727363, 873.3144481581959, 670.4468813229081, 686.5262968551683, 841.1840514700731, 862.1077185113378, 866.9566521673922, 897.2104547997753, 920.5489310238003, 922.3820040572832, 923.372106967262, 923.5059243304834, 905.9728208153733, 912.1061359867301, 913.7852604637905, 916.2532535983153, 917.1424717888796, 672.7006482115461, 679.2188982669919, 681.3493114076095, 682.9726810927557, 683.8051155420682, 12167.939160304142, 14900.329485173193, 14949.177795221258, 14991.850081499155, 15547.844521554753, 14261.78607320891, 14364.712705745827, 14516.419343226258, 14598.854011459856, 14634.634134146625, 11507.769844603145, 11851.822222666668, 11905.642830715093, 11955.820662690066, 11969.92270695633, 3591.4792355108625, 3645.0705070206927, 3704.3517384457614, 3788.753731007503, 3794.6964242860504, 104870.47564762204, 104975.47512262466, 105488.0, 106548.0, 108007.45996269968, 10410.271281010408, 10479.68560943173, 10485.37087774736, 10502.212334074822, 10582.047615714622, 20141.09365078575, 20142.59714805725, 20196.0, 20385.898070509553, 20390.592188156155, 7657.0, 7790.5325680459355, 7793.532388056735, 7807.024121984752, 7998.760037198894, 3424.503447000171, 3716.925661486755, 3768.0203147181383, 4264.637505812041, 4357.607815296638, 2953.4979053560946, 3585.229175727231, 3596.1908570571413, 3601.243738814826, 3628.9818550907075, 569.943005699435, 591.361329763854, 646.6023395611664, 649.6621756686496, 657.4575974820792, 673.195531340044, 677.7763338098416, 682.5597489619167, 696.8780463418882, 714.332099486971, 9597.32818702698, 9743.512824358753, 10203.795924081476, 10236.385816851012, 10349.172066234683, 575.807104619957, 647.8468326379053, 658.5488940075968, 670.1455644053871, 682.8258794007496, 4469.307257375112, 5002.624803139779, 5011.298418221452, 5012.373453318335, 5019.598432125421, 110858.44570777095, 111271.44364278289, 112599.43700281446, 115104.0, 115765.42117289528, 75290.24709752941, 76495.61752191315, 97559.0, 98458.0, 100613.49693251487, 71917.0, 73111.63444182639, 74757.0, 75933.0, 77247.84128237968, 10582.947085264525, 11225.4387280634, 11283.266587671775, 11375.601853935073, 11415.086793056702, 47889.76055119702, 50203.0, 50539.0, 52418.475815241356, 53393.46606533885, 51948.74025629848, 53909.730451347496, 65480.0, 66568.0, 66638.66680666566, 12717.173383730398, 12820.294883781482, 13006.219626822422, 13165.210087394787, 13215.933920330337, 14127.858721413066, 14414.91888108417, 14562.708745825235, 14809.629759256104, 15532.534023979299, 12598.0, 13036.869631303565, 13696.660850254013, 14181.14913105217, 14188.0, 12870.22778633285, 13347.532836351069, 13697.931510342385, 13878.583642490741, 14213.289335532974, 10705.982931621484, 13703.177809331472, 13736.725265494833, 13935.512257070954, 14007.649808754863, 11343.319400835977, 11573.826392604286, 11790.351530665896, 11829.467673954865, 11943.223690460092, 10637.414942178255, 10891.727706807076, 11120.555177792798, 11144.832827507431, 11179.385133817717], "value": 7490.129293957859, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 121.0, 119.0, 127.0, 118.0, 118.0, 119.0, 117.0, 162.0, 101.0], "value": 120.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 111.0, 144.0, 114.0, 112.0, 114.0, 113.0, 132.0, 113.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 186.0, 266.0, 263.0, 193.0, 197.0, 197.0, 194.0, 197.0, 197.0], "value": 210.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 50.0, 50.0, 76.0, 50.0, 51.0, 50.0, 62.0, 89.0, 83.0], "value": 64.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 85.0, 90.0, 71.0, 62.0, 102.0, 103.0, 104.0, 93.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 93.0, 89.0, 92.0, 122.0, 117.0, 77.0, 135.0, 132.0], "value": 103.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 102.0, 156.0, 123.0, 123.0, 176.0, 175.0, 102.0, 101.0, 102.0], "value": 128.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 100.0, 93.0, 116.0, 117.0, 92.0, 94.0, 95.0, 93.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 64.0, 63.0, 64.0, 64.0, 65.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 88.0, 86.0, 103.0, 118.0, 111.0, 72.0, 71.0, 71.0, 71.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 89.0, 82.0, 84.0, 85.0, 82.0, 90.0, 87.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 152.0, 151.0, 134.0, 143.0, 152.0, 138.0, 205.0, 175.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 167.0, 179.0, 229.0, 232.0, 171.0, 174.0, 171.0, 170.0, 169.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 66.0, 72.0, 91.0, 88.0, 85.0, 86.0, 69.0], "value": 76.2, "unit": "score"}]}]} 14:59:29 INFO - Return code: 0 14:59:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:59:29 ERROR - # TBPL SUCCESS # 14:59:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:59:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:59:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:59:29 INFO - 2017-01-27 14:59:29.224 screenresolution[1662:10908] starting screenresolution argv=screenresolution get 14:59:29 INFO - 2017-01-27 14:59:29.227 screenresolution[1662:10908] Display 0: 1600x1200x32@60 14:59:29 INFO - 2017-01-27 14:59:29.233 screenresolution[1663:10911] starting screenresolution argv=screenresolution list 14:59:29 INFO - Available Modes on Display 0 14:59:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:59:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:59:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:59:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:59:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:59:29 INFO - Intel Iris: 14:59:29 INFO - Chipset Model: Intel Iris 14:59:29 INFO - Type: GPU 14:59:29 INFO - Bus: Built-In 14:59:29 INFO - VRAM (Dynamic, Max): 1536 MB 14:59:29 INFO - Vendor: Intel (0x8086) 14:59:29 INFO - Device ID: 0x0a2e 14:59:29 INFO - Revision ID: 0x0009 14:59:29 INFO - Displays: 14:59:29 INFO - Display: 14:59:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:59:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:59:29 INFO - Display Serial Number: 1600x1200 60 14:59:29 INFO - Main Display: Yes 14:59:29 INFO - Mirror: Off 14:59:29 INFO - Online: Yes 14:59:29 INFO - Rotation: Supported 14:59:29 INFO - Return code: 0 14:59:29 INFO - Running post-action listener: _resource_record_post_action 14:59:29 INFO - [mozharness: 2017-01-27 22:59:29.472728Z] Finished run-tests step (success) 14:59:29 INFO - Running post-run listener: _resource_record_post_run 14:59:29 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 50322944; Write bytes: 523315200; Read time: 396; Write time: 1711 14:59:29 INFO - TinderboxPrint: CPU usage
54.3% 14:59:29 INFO - TinderboxPrint: I/O read bytes / time
50,322,944 / 396 14:59:29 INFO - TinderboxPrint: I/O write bytes / time
523,315,200 / 1,711 14:59:29 INFO - TinderboxPrint: CPU idle
2,190.4 (45.7%) 14:59:29 INFO - TinderboxPrint: CPU system
964.1 (20.1%) 14:59:29 INFO - TinderboxPrint: CPU user
1,635.2 (34.1%) 14:59:29 INFO - TinderboxPrint: Swap in / out
250,880,000 / 0 14:59:29 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201089536; Write bytes: 200194048; Read time: 15627; Write time: 438 14:59:29 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 49393152; Write bytes: 313307136; Read time: 384; Write time: 1239 14:59:29 INFO - Running post-run listener: _upload_blobber_files 14:59:29 INFO - Blob upload gear active. 14:59:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:29 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 14:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:59:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:31 INFO - (blobuploader) - INFO - Done attempting. 14:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:32 INFO - (blobuploader) - INFO - Done attempting. 14:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:59:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:33 INFO - (blobuploader) - INFO - Done attempting. 14:59:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:59:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:35 INFO - (blobuploader) - INFO - Done attempting. 14:59:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:35 INFO - Return code: 0 14:59:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426a7fedff84a789ef8b5b74d71efa3e971a27d9bbb52fa5b7c2053c25a8601060da7ed8844821e0d11102281f79bfc51c3d4827fb5bc5ca8d5b80409105a8c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fce3af3d869046be020d08d36a4438cc0d9ecd3694fd2e585becac427d52f275f26c3369a10260ce9f678fca2a46d4d83aa0f538c8c7a436b8461632cf80f13f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/beb82d07cb3cc8c7887b25e54c0083a9e16cd2730c274044c424c0753fb967104e1a85aaff0a40edadf86367f389d16a282b9134631a84e5abe168932c174866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab33e2137e34c0b5b64079f4aed0b087dcec4941cd4cbdfaac22882cd88a60939180b0c36f98eb8d8c3e8e4bec23970bf886ade5d45095fb1947b9501f47df00"} 14:59:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:35 INFO - Contents: 14:59:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426a7fedff84a789ef8b5b74d71efa3e971a27d9bbb52fa5b7c2053c25a8601060da7ed8844821e0d11102281f79bfc51c3d4827fb5bc5ca8d5b80409105a8c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fce3af3d869046be020d08d36a4438cc0d9ecd3694fd2e585becac427d52f275f26c3369a10260ce9f678fca2a46d4d83aa0f538c8c7a436b8461632cf80f13f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/beb82d07cb3cc8c7887b25e54c0083a9e16cd2730c274044c424c0753fb967104e1a85aaff0a40edadf86367f389d16a282b9134631a84e5abe168932c174866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab33e2137e34c0b5b64079f4aed0b087dcec4941cd4cbdfaac22882cd88a60939180b0c36f98eb8d8c3e8e4bec23970bf886ade5d45095fb1947b9501f47df00"} 14:59:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:35 INFO - Copying logs to upload dir... 14:59:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.329649 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-27 14:59:35.439204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 14:59:35.443230) ========= 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.GP9licYJIY/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.rzRm3BmifL/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426a7fedff84a789ef8b5b74d71efa3e971a27d9bbb52fa5b7c2053c25a8601060da7ed8844821e0d11102281f79bfc51c3d4827fb5bc5ca8d5b80409105a8c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fce3af3d869046be020d08d36a4438cc0d9ecd3694fd2e585becac427d52f275f26c3369a10260ce9f678fca2a46d4d83aa0f538c8c7a436b8461632cf80f13f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/beb82d07cb3cc8c7887b25e54c0083a9e16cd2730c274044c424c0753fb967104e1a85aaff0a40edadf86367f389d16a282b9134631a84e5abe168932c174866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab33e2137e34c0b5b64079f4aed0b087dcec4941cd4cbdfaac22882cd88a60939180b0c36f98eb8d8c3e8e4bec23970bf886ade5d45095fb1947b9501f47df00"} build_url:https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010888 build_url: 'https://queue.taskcluster.net/v1/task/YKkNlgsoTCWjhLwtVs-UUg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426a7fedff84a789ef8b5b74d71efa3e971a27d9bbb52fa5b7c2053c25a8601060da7ed8844821e0d11102281f79bfc51c3d4827fb5bc5ca8d5b80409105a8c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fce3af3d869046be020d08d36a4438cc0d9ecd3694fd2e585becac427d52f275f26c3369a10260ce9f678fca2a46d4d83aa0f538c8c7a436b8461632cf80f13f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/beb82d07cb3cc8c7887b25e54c0083a9e16cd2730c274044c424c0753fb967104e1a85aaff0a40edadf86367f389d16a282b9134631a84e5abe168932c174866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab33e2137e34c0b5b64079f4aed0b087dcec4941cd4cbdfaac22882cd88a60939180b0c36f98eb8d8c3e8e4bec23970bf886ade5d45095fb1947b9501f47df00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 14:59:35.477081) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 14:59:35.477420) ========= 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.GP9licYJIY/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.rzRm3BmifL/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.005148 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 14:59:35.525790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 14:59:35.526105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 14:59:35.526456) ========= ========= Total master_lag: 0.18 =========