builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0339 starttime: 1482380372.43 results: success (0) buildid: 20161221190653 builduid: 23ac1708019340188cfe92e225d73e1c revision: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.428681) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.429108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.429490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.455859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.456143) ========= 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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 --2016-12-21 20:19:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 179M=0s 2016-12-21 20:19:32 (179 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.292108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.772651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.772991) ========= 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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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.025768 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:32.821389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 20:19:32.821753) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 62eb5ff8893e7803da94b2e52bd108285aa1f5fe --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 62eb5ff8893e7803da94b2e52bd108285aa1f5fe --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Cp8XEV0pr1/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.Hn953XEsbt/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 2016-12-21 20:19:32,920 truncating revision to first 12 chars 2016-12-21 20:19:32,920 Setting DEBUG logging. 2016-12-21 20:19:32,920 attempt 1/10 2016-12-21 20:19:32,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/62eb5ff8893e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 20:19:33,981 unpacking tar archive at: mozilla-aurora-62eb5ff8893e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.339382 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 20:19:34.186683) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:34.187131) ========= script_repo_revision: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:34.187693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:34.188098) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 20:19:34.209057) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-21 20:19:34.209490) ========= /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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:19:34 INFO - MultiFileLogger online at 20161221 20:19:34 in /builds/slave/test 20:19:34 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 20:19:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:34 INFO - {'append_to_log': False, 20:19:34 INFO - 'base_work_dir': '/builds/slave/test', 20:19:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:19:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:34 INFO - 'branch': 'Mozilla-Aurora', 20:19:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:34 INFO - 'config_files': ('talos/mac_config.py',), 20:19:34 INFO - 'default_actions': ('clobber', 20:19:34 INFO - 'read-buildbot-config', 20:19:34 INFO - 'download-and-extract', 20:19:34 INFO - 'populate-webroot', 20:19:34 INFO - 'create-virtualenv', 20:19:34 INFO - 'install', 20:19:34 INFO - 'run-tests'), 20:19:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:34 INFO - 'download_minidump_stackwalk': True, 20:19:34 INFO - 'download_symbols': 'ondemand', 20:19:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:34 INFO - 'installer_path': 'installer.exe', 20:19:34 INFO - 'log_level': 'info', 20:19:34 INFO - 'log_name': 'talos', 20:19:34 INFO - 'log_to_console': True, 20:19:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:19:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:19:34 INFO - 'opt_config_files': (), 20:19:34 INFO - 'pip_index': False, 20:19:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:19:34 INFO - 'cmd': ('bash', 20:19:34 INFO - '-c', 20:19:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:19:34 INFO - 'enabled': True, 20:19:34 INFO - 'halt_on_failure': False, 20:19:34 INFO - 'name': 'check_screen_resolution'},), 20:19:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:19:34 INFO - 'cmd': ('bash', 20:19:34 INFO - '-c', 20:19:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:19:34 INFO - 'enabled': True, 20:19:34 INFO - 'halt_on_failure': False, 20:19:34 INFO - 'name': 'check_screen_resolution'},), 20:19:34 INFO - 'run_cmd_checks_enabled': True, 20:19:34 INFO - 'sps_profile': False, 20:19:34 INFO - 'sps_profile_interval': 0, 20:19:34 INFO - 'suite': 'dromaeojs-e10s', 20:19:34 INFO - 'system_bits': '32', 20:19:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:34 INFO - 'title': 't-yosemite-r7-0339', 20:19:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:34 INFO - 'use_talos_json': True, 20:19:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:34 INFO - 'work_dir': 'build'} 20:19:34 INFO - [mozharness: 2016-12-22 04:19:34.415335Z] Running clobber step. 20:19:34 INFO - Running pre-action listener: _resource_record_pre_action 20:19:34 INFO - Running main action method: clobber 20:19:34 INFO - rmtree: /builds/slave/test/build 20:19:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:36 INFO - Running post-action listener: _resource_record_post_action 20:19:36 INFO - [mozharness: 2016-12-22 04:19:36.805193Z] Finished clobber step (success) 20:19:36 INFO - [mozharness: 2016-12-22 04:19:36.805388Z] Running read-buildbot-config step. 20:19:36 INFO - Running pre-action listener: _resource_record_pre_action 20:19:36 INFO - Running main action method: read_buildbot_config 20:19:36 INFO - Using buildbot properties: 20:19:36 INFO - { 20:19:36 INFO - "project": "", 20:19:36 INFO - "product": "firefox", 20:19:36 INFO - "script_repo_revision": "production", 20:19:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 20:19:36 INFO - "repository": "", 20:19:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 20:19:36 INFO - "buildid": "20161221190653", 20:19:36 INFO - "pgo_build": "False", 20:19:36 INFO - "basedir": "/builds/slave/test", 20:19:36 INFO - "buildnumber": 62, 20:19:36 INFO - "slavename": "t-yosemite-r7-0339", 20:19:36 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 20:19:36 INFO - "platform": "yosemite_r7", 20:19:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:19:36 INFO - "branch": "mozilla-aurora", 20:19:36 INFO - "repo_path": "releases/mozilla-aurora", 20:19:36 INFO - "revision": "62eb5ff8893e7803da94b2e52bd108285aa1f5fe", 20:19:36 INFO - "stage_platform": "macosx64", 20:19:36 INFO - "builduid": "23ac1708019340188cfe92e225d73e1c", 20:19:36 INFO - "slavebuilddir": "test" 20:19:36 INFO - } 20:19:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 20:19:36 INFO - Running post-action listener: _resource_record_post_action 20:19:36 INFO - [mozharness: 2016-12-22 04:19:36.808854Z] Finished read-buildbot-config step (success) 20:19:36 INFO - [mozharness: 2016-12-22 04:19:36.808992Z] Running download-and-extract step. 20:19:36 INFO - Running pre-action listener: _resource_record_pre_action 20:19:36 INFO - Running main action method: download_and_extract 20:19:36 INFO - mkdir: /builds/slave/test/build/tests 20:19:36 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')]} 20:19:36 INFO - trying https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 20:19:36 INFO - Downloading https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 20:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 20:19:38 INFO - Downloaded 1199 bytes. 20:19:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 20:19:38 INFO - Using the following test package requirements: 20:19:38 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 20:19:38 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 20:19:38 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 20:19:38 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'jsshell-mac.zip'], 20:19:38 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 20:19:38 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 20:19:38 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 20:19:38 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 20:19:38 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 20:19:38 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 20:19:38 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 20:19:38 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:19:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 20:19:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:19:38 INFO - Fetch https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 20:19:38 INFO - Http code: 200 20:19:38 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 20:19:38 INFO - x-amz-cf-id: kJS1V4YAklA9eumKD5hdafSJq7QUZwdDek2yF0Ad5jmETFBNEOVjig== 20:19:38 INFO - x-amz-version-id: gZE8PqL08MBmB_d2zdA8XUzyaW_Uo9Kd 20:19:39 INFO - Expected file size: 16269584 20:19:39 INFO - Obtained file size: 16269584 20:19:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 20:19:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 20:19:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:19:45 INFO - Fetch https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 20:19:46 INFO - Http code: 200 20:19:46 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 20:19:46 INFO - x-amz-cf-id: O8kxO4b3B7455xTwbbvNSPVOsW3inu1D8BDtMPig8rG-ccz9KW8hHA== 20:19:46 INFO - x-amz-version-id: gZE8PqL08MBmB_d2zdA8XUzyaW_Uo9Kd 20:19:46 INFO - Expected file size: 16269584 20:19:46 INFO - Obtained file size: 16269584 20:19:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 20:19:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:19:53 INFO - Fetch https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 20:19:53 INFO - Http code: 200 20:19:53 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 20:19:53 INFO - x-amz-cf-id: XrCRVlgHkWiMgrskqQkFj5YMead3LNg0B4Gy9rRCng5J4FLa6fia-w== 20:19:53 INFO - x-amz-version-id: LaXIzO9iSI0DdeitfsxL1VeufkFJGqxV 20:19:54 INFO - Expected file size: 14409038 20:19:54 INFO - Obtained file size: 14409038 20:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:54 INFO - trying https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 20:19:54 INFO - Downloading https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 20:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 20:19:57 INFO - Downloaded 109765071 bytes. 20:19:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 20:19:57 INFO - mkdir: /builds/slave/test/properties 20:19:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:19:57 INFO - Writing to file /builds/slave/test/properties/build_url 20:19:57 INFO - Contents: 20:19:57 INFO - build_url:https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 20:19:58 INFO - Running post-action listener: _resource_record_post_action 20:19:58 INFO - Running post-action listener: set_extra_try_arguments 20:19:58 INFO - [mozharness: 2016-12-22 04:19:58.726155Z] Finished download-and-extract step (success) 20:19:58 INFO - [mozharness: 2016-12-22 04:19:58.726287Z] Running populate-webroot step. 20:19:58 INFO - Running pre-action listener: _resource_record_pre_action 20:19:58 INFO - Running main action method: populate_webroot 20:19:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:19:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:19:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:19:58 INFO - '--tppagecycles', 20:19:58 INFO - '7'], 20:19:58 INFO - 'tests': ['tsvgm']}}, 20:19:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:19:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:19:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:19:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:19:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['damp', 'tps']}, 20:19:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'tests': ['damp', 'tps']}, 20:19:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['dromaeo_dom']}, 20:19:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:19:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['basic_compositor_video']}, 20:19:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:19:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['a11yr', 20:19:58 INFO - 'ts_paint', 20:19:58 INFO - 'tpaint', 20:19:58 INFO - 'sessionrestore', 20:19:58 INFO - 'sessionrestore_no_auto_restore', 20:19:58 INFO - 'tabpaint']}, 20:19:58 INFO - 'other-e10s': {'tests': ['a11yr', 20:19:58 INFO - 'ts_paint', 20:19:58 INFO - 'tpaint', 20:19:58 INFO - 'sessionrestore', 20:19:58 INFO - 'sessionrestore_no_auto_restore', 20:19:58 INFO - 'tabpaint']}, 20:19:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:19:58 INFO - 'ts_paint', 20:19:58 INFO - 'tpaint', 20:19:58 INFO - 'sessionrestore', 20:19:58 INFO - 'sessionrestore_no_auto_restore', 20:19:58 INFO - 'tabpaint']}, 20:19:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:19:58 INFO - 'ts_paint', 20:19:58 INFO - 'tpaint', 20:19:58 INFO - 'sessionrestore', 20:19:58 INFO - 'sessionrestore_no_auto_restore', 20:19:58 INFO - 'tabpaint']}, 20:19:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['a11yr', 20:19:58 INFO - 'ts_paint', 20:19:58 INFO - 'tpaint', 20:19:58 INFO - 'sessionrestore', 20:19:58 INFO - 'sessionrestore_no_auto_restore', 20:19:58 INFO - 'tabpaint']}, 20:19:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['a11yr', 20:19:58 INFO - 'ts_paint', 20:19:58 INFO - 'tpaint', 20:19:58 INFO - 'sessionrestore', 20:19:58 INFO - 'sessionrestore_no_auto_restore', 20:19:58 INFO - 'tabpaint']}, 20:19:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['tsvgx', 20:19:58 INFO - 'tsvgr_opacity', 20:19:58 INFO - 'tart', 20:19:58 INFO - 'tscrollx', 20:19:58 INFO - 'cart']}, 20:19:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:19:58 INFO - 'tsvgr_opacity', 20:19:58 INFO - 'tart', 20:19:58 INFO - 'tscrollx', 20:19:58 INFO - 'cart']}, 20:19:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'talos_options': ['--disable-e10s'], 20:19:58 INFO - 'tests': ['tp5o']}, 20:19:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'tests': ['tp5o']}, 20:19:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'talos_options': ['--disable-e10s', 20:19:58 INFO - '--xperf_path', 20:19:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:58 INFO - 'tests': ['tp5n']}, 20:19:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:58 INFO - 'talos_options': ['--xperf_path', 20:19:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:58 INFO - 'tests': ['tp5n']}}, 20:19:58 INFO - 'talos.zip': {'path': '', 20:19:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:19:58 INFO - Running post-action listener: _resource_record_post_action 20:19:58 INFO - [mozharness: 2016-12-22 04:19:58.744855Z] Finished populate-webroot step (success) 20:19:58 INFO - [mozharness: 2016-12-22 04:19:58.744994Z] Running create-virtualenv step. 20:19:58 INFO - Running pre-action listener: _resource_record_pre_action 20:19:58 INFO - Running main action method: create_virtualenv 20:19:58 INFO - Creating virtualenv /builds/slave/test/build/venv 20:19:58 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 20:19:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:19:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:19:58 INFO - Using real prefix '/tools/python27' 20:19:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:19:59 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:02 INFO - Installing pip.................done. 20:20:02 INFO - Return code: 0 20:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:20:02 INFO - Reading from file tmpfile_stdout 20:20:02 INFO - Output received: 20:20:02 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) 20:20:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20: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', 'pip>=1.5'] in /builds/slave/test/build 20:20: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 pip>=1.5 20:20:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:02 INFO - 'HOME': '/Users/cltbld', 20:20:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:02 INFO - 'LOGNAME': 'cltbld', 20:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:02 INFO - 'MOZ_NO_REMOTE': '1', 20:20:02 INFO - 'NO_EM_RESTART': '1', 20:20:02 INFO - 'PAGER': '/bin/cat', 20:20:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:02 INFO - 'PWD': '/builds/slave/test', 20:20:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:02 INFO - 'SHELL': '/bin/bash', 20:20:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:02 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:02 INFO - 'USER': 'cltbld', 20:20:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:02 INFO - 'XPC_FLAGS': '0x0', 20:20:02 INFO - 'XPC_SERVICE_NAME': '0', 20:20:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20: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 20:20:02 INFO - Cleaning up... 20:20:03 INFO - Return code: 0 20:20:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:20:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:03 INFO - 'HOME': '/Users/cltbld', 20:20:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:03 INFO - 'LOGNAME': 'cltbld', 20:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:03 INFO - 'MOZ_NO_REMOTE': '1', 20:20:03 INFO - 'NO_EM_RESTART': '1', 20:20:03 INFO - 'PAGER': '/bin/cat', 20:20:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:03 INFO - 'PWD': '/builds/slave/test', 20:20:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:03 INFO - 'SHELL': '/bin/bash', 20:20:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:03 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:03 INFO - 'USER': 'cltbld', 20:20:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:03 INFO - 'XPC_FLAGS': '0x0', 20:20:03 INFO - 'XPC_SERVICE_NAME': '0', 20:20:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:03 INFO - Downloading/unpacking psutil>=3.1.1 20:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:06 INFO - Installing collected packages: psutil 20:20:06 INFO - Running setup.py install for psutil 20:20:06 INFO - building 'psutil._psutil_osx' extension 20:20: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 20:20:07 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 20:20:07 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 20:20:07 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 20:20:07 INFO - building 'psutil._psutil_posix' extension 20:20:07 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 20:20:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:20:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:20:07 INFO - ^ 20:20:07 INFO - 1 warning generated. 20:20:07 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 20:20:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:07 INFO - Successfully installed psutil 20:20:07 INFO - Cleaning up... 20:20:07 INFO - Return code: 0 20:20:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20: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 20:20: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 20:20:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:07 INFO - 'HOME': '/Users/cltbld', 20:20:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:07 INFO - 'LOGNAME': 'cltbld', 20:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:07 INFO - 'MOZ_NO_REMOTE': '1', 20:20:07 INFO - 'NO_EM_RESTART': '1', 20:20:07 INFO - 'PAGER': '/bin/cat', 20:20:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:07 INFO - 'PWD': '/builds/slave/test', 20:20:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:07 INFO - 'SHELL': '/bin/bash', 20:20:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:07 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:07 INFO - 'USER': 'cltbld', 20:20:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:07 INFO - 'XPC_FLAGS': '0x0', 20:20:07 INFO - 'XPC_SERVICE_NAME': '0', 20:20:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:10 INFO - Installing collected packages: mozsystemmonitor 20:20:10 INFO - Running setup.py install for mozsystemmonitor 20:20:11 INFO - Successfully installed mozsystemmonitor 20:20:11 INFO - Cleaning up... 20:20:11 INFO - Return code: 0 20:20:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:20:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:11 INFO - 'HOME': '/Users/cltbld', 20:20:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:11 INFO - 'LOGNAME': 'cltbld', 20:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:11 INFO - 'MOZ_NO_REMOTE': '1', 20:20:11 INFO - 'NO_EM_RESTART': '1', 20:20:11 INFO - 'PAGER': '/bin/cat', 20:20:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:11 INFO - 'PWD': '/builds/slave/test', 20:20:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:11 INFO - 'SHELL': '/bin/bash', 20:20:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:11 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:11 INFO - 'USER': 'cltbld', 20:20:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:11 INFO - 'XPC_FLAGS': '0x0', 20:20:11 INFO - 'XPC_SERVICE_NAME': '0', 20:20:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:11 INFO - Downloading/unpacking jsonschema==2.5.1 20:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:14 INFO - warning: no files found matching '*.txt' 20:20:14 INFO - no previously-included directories found matching 'build' 20:20:14 INFO - no previously-included directories found matching 'dist' 20:20:14 INFO - no previously-included directories found matching '.git*' 20:20:14 INFO - Installing collected packages: jsonschema, functools32 20:20:14 INFO - Running setup.py install for functools32 20:20:14 INFO - warning: no files found matching '*.txt' 20:20:14 INFO - no previously-included directories found matching 'build' 20:20:14 INFO - no previously-included directories found matching 'dist' 20:20:14 INFO - no previously-included directories found matching '.git*' 20:20:14 INFO - Successfully installed jsonschema functools32 20:20:14 INFO - Cleaning up... 20:20:14 INFO - Return code: 0 20:20:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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', '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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:20: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 functools32==3.2.3-2 20:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:14 INFO - 'HOME': '/Users/cltbld', 20:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:14 INFO - 'LOGNAME': 'cltbld', 20:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:14 INFO - 'MOZ_NO_REMOTE': '1', 20:20:14 INFO - 'NO_EM_RESTART': '1', 20:20:14 INFO - 'PAGER': '/bin/cat', 20:20:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:14 INFO - 'PWD': '/builds/slave/test', 20:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:14 INFO - 'SHELL': '/bin/bash', 20:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:14 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:14 INFO - 'USER': 'cltbld', 20:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:14 INFO - 'XPC_FLAGS': '0x0', 20:20:14 INFO - 'XPC_SERVICE_NAME': '0', 20:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:20:15 INFO - Cleaning up... 20:20:15 INFO - Return code: 0 20:20:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:15 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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20:15 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 20:20:15 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 20:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:15 INFO - 'HOME': '/Users/cltbld', 20:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:15 INFO - 'LOGNAME': 'cltbld', 20:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:15 INFO - 'MOZ_NO_REMOTE': '1', 20:20:15 INFO - 'NO_EM_RESTART': '1', 20:20:15 INFO - 'PAGER': '/bin/cat', 20:20:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:15 INFO - 'PWD': '/builds/slave/test', 20:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:15 INFO - 'SHELL': '/bin/bash', 20:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:15 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:15 INFO - 'USER': 'cltbld', 20:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:15 INFO - 'XPC_FLAGS': '0x0', 20:20:15 INFO - 'XPC_SERVICE_NAME': '0', 20:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 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 20:20:18 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 20:20:19 INFO - Downloading docopt-0.6.1.tar.gz 20:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:19 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:19 INFO - Running setup.py install for blobuploader 20:20:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:19 INFO - Running setup.py install for requests 20:20:19 INFO - Running setup.py install for docopt 20:20:20 INFO - Successfully installed blobuploader requests docopt 20:20:20 INFO - Cleaning up... 20:20:20 INFO - Return code: 0 20:20:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:20 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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20:20 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 20:20:20 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 20:20:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:20 INFO - 'HOME': '/Users/cltbld', 20:20:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:20 INFO - 'LOGNAME': 'cltbld', 20:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:20 INFO - 'MOZ_NO_REMOTE': '1', 20:20:20 INFO - 'NO_EM_RESTART': '1', 20:20:20 INFO - 'PAGER': '/bin/cat', 20:20:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:20 INFO - 'PWD': '/builds/slave/test', 20:20:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:20 INFO - 'SHELL': '/bin/bash', 20:20:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:20 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:20 INFO - 'USER': 'cltbld', 20:20:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:20 INFO - 'XPC_FLAGS': '0x0', 20:20:20 INFO - 'XPC_SERVICE_NAME': '0', 20:20:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:20 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-iZ3bgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:20 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-2Fxsr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:20 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-kIUCMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:20 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-PwJiBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:20 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-pRZrmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:20 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-vPyuWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-3yDd_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-aI5Rc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-h1wmuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-WoRoYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-3zQ5w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-6xptRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-RcjEPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-i6wAXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:21 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-oZoVbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:22 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-nGTAZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:22 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-gnOSP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:22 INFO - Running setup.py install for manifestparser 20:20:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:22 INFO - Running setup.py install for mozcrash 20:20:22 INFO - Running setup.py install for mozdebug 20:20:22 INFO - Running setup.py install for mozdevice 20:20:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:20:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:22 INFO - Running setup.py install for mozfile 20:20:22 INFO - Running setup.py install for mozhttpd 20:20:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Running setup.py install for mozinfo 20:20:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Running setup.py install for mozInstall 20:20:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Running setup.py install for mozleak 20:20:23 INFO - Running setup.py install for mozlog 20:20:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Running setup.py install for moznetwork 20:20:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:23 INFO - Running setup.py install for mozprocess 20:20:24 INFO - Running setup.py install for mozprofile 20:20:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozrunner 20:20:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Running setup.py install for mozscreenshot 20:20:24 INFO - Running setup.py install for moztest 20:20:24 INFO - Running setup.py install for mozversion 20:20:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:24 INFO - Cleaning up... 20:20:24 INFO - Return code: 0 20:20:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20: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 20:20: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 20:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:24 INFO - 'HOME': '/Users/cltbld', 20:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:24 INFO - 'LOGNAME': 'cltbld', 20:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:24 INFO - 'MOZ_NO_REMOTE': '1', 20:20:24 INFO - 'NO_EM_RESTART': '1', 20:20:24 INFO - 'PAGER': '/bin/cat', 20:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:24 INFO - 'PWD': '/builds/slave/test', 20:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:24 INFO - 'SHELL': '/bin/bash', 20:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:24 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:24 INFO - 'USER': 'cltbld', 20:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:24 INFO - 'XPC_FLAGS': '0x0', 20:20:24 INFO - 'XPC_SERVICE_NAME': '0', 20:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-Q0ItMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-tI25sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-4I0Plu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-QtQIke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-HSmijZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-aDj_Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:25 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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-UZ8Yxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20: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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-PdZ7dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20: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)) 20:20:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:25 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-Dh1r6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-IXgKi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-MTiYZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-k5pooh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-dU6pXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-RqJVdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-XGeAai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:26 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-uBr4V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 20:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:26 INFO - Running setup.py (path:/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/pip-pw3lLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20: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)) 20:20: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)) 20:20: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)) 20:20: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)) 20:20: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:20: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:20:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:29 INFO - Downloading blessings-1.6.tar.gz 20:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:20:29 INFO - Installing collected packages: blessings 20:20:29 INFO - Running setup.py install for blessings 20:20:29 INFO - Successfully installed blessings 20:20:29 INFO - Cleaning up... 20:20:29 INFO - Return code: 0 20:20:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:30 INFO - Reading from file tmpfile_stdout 20:20:30 INFO - Current package versions: 20:20:30 INFO - blessings == 1.6 20:20:30 INFO - blobuploader == 1.2.4 20:20:30 INFO - docopt == 0.6.1 20:20:30 INFO - functools32 == 3.2.3-2 20:20:30 INFO - jsonschema == 2.5.1 20:20:30 INFO - manifestparser == 1.1 20:20:30 INFO - mozInstall == 1.12 20:20:30 INFO - mozcrash == 1.0 20:20:30 INFO - mozdebug == 0.1 20:20:30 INFO - mozdevice == 0.48 20:20:30 INFO - mozfile == 1.2 20:20:30 INFO - mozhttpd == 0.7 20:20:30 INFO - mozinfo == 0.9 20:20:30 INFO - mozleak == 0.1 20:20:30 INFO - mozlog == 3.4 20:20:30 INFO - moznetwork == 0.27 20:20:30 INFO - mozprocess == 0.23 20:20:30 INFO - mozprofile == 0.28 20:20:30 INFO - mozrunner == 6.13 20:20:30 INFO - mozscreenshot == 0.1 20:20:30 INFO - mozsystemmonitor == 0.3 20:20:30 INFO - moztest == 0.7 20:20:30 INFO - mozversion == 1.4 20:20:30 INFO - psutil == 3.1.1 20:20:30 INFO - requests == 1.2.3 20:20:30 INFO - wsgiref == 0.1.2 20:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20: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 20:20: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 20:20:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:30 INFO - 'HOME': '/Users/cltbld', 20:20:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:30 INFO - 'LOGNAME': 'cltbld', 20:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:30 INFO - 'MOZ_NO_REMOTE': '1', 20:20:30 INFO - 'NO_EM_RESTART': '1', 20:20:30 INFO - 'PAGER': '/bin/cat', 20:20:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:30 INFO - 'PWD': '/builds/slave/test', 20:20:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:30 INFO - 'SHELL': '/bin/bash', 20:20:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:30 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:30 INFO - 'USER': 'cltbld', 20:20:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:30 INFO - 'XPC_FLAGS': '0x0', 20:20:30 INFO - 'XPC_SERVICE_NAME': '0', 20:20:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 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)) 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:20:31 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')]} 20:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:31 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')]} 20:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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 0x10ca12490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c988570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc155cc50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, '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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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 20:20: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 20:20: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 20:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:31 INFO - 'HOME': '/Users/cltbld', 20:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:31 INFO - 'LOGNAME': 'cltbld', 20:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:31 INFO - 'MOZ_NO_REMOTE': '1', 20:20:31 INFO - 'NO_EM_RESTART': '1', 20:20:31 INFO - 'PAGER': '/bin/cat', 20:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:31 INFO - 'PWD': '/builds/slave/test', 20:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:31 INFO - 'SHELL': '/bin/bash', 20:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:20:31 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:31 INFO - 'USER': 'cltbld', 20:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:31 INFO - 'XPC_FLAGS': '0x0', 20:20:31 INFO - 'XPC_SERVICE_NAME': '0', 20:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:20:31 INFO - Cleaning up... 20:20:31 INFO - Return code: 0 20:20:31 INFO - Running post-action listener: _resource_record_post_action 20:20:31 INFO - Running post-action listener: _start_resource_monitoring 20:20:31 INFO - Starting resource monitoring. 20:20:31 INFO - [mozharness: 2016-12-22 04:20:31.896340Z] Finished create-virtualenv step (success) 20:20:31 INFO - [mozharness: 2016-12-22 04:20:31.897332Z] Running install step. 20:20:31 INFO - Running pre-action listener: _resource_record_pre_action 20:20:31 INFO - Running main action method: install 20:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:32 INFO - Reading from file tmpfile_stdout 20:20:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:20:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:20:32 INFO - Reading from file tmpfile_stdout 20:20:32 INFO - Output received: 20:20:32 INFO - Usage: mozinstall [options] installer 20:20:32 INFO - Options: 20:20:32 INFO - -h, --help show this help message and exit 20:20:32 INFO - -d DEST, --destination=DEST 20:20:32 INFO - Directory to install application into. [default: 20:20:32 INFO - "/builds/slave/test"] 20:20:32 INFO - --app=APP Application being installed. [default: firefox] 20:20:32 INFO - mkdir: /builds/slave/test/build/application 20:20:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 20:21:03 INFO - Reading from file tmpfile_stdout 20:21:03 INFO - Output received: 20:21:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:21:03 INFO - Running post-action listener: _resource_record_post_action 20:21:03 INFO - [mozharness: 2016-12-22 04:21:03.730443Z] Finished install step (success) 20:21:03 INFO - [mozharness: 2016-12-22 04:21:03.730608Z] Running run-tests step. 20:21:03 INFO - Running pre-action listener: _resource_record_pre_action 20:21:03 INFO - Running main action method: run_tests 20:21:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:21:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:21:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:21:03 INFO - 2016-12-21 20:21:03.746 screenresolution[1642:7508] starting screenresolution argv=screenresolution get 20:21:03 INFO - 2016-12-21 20:21:03.749 screenresolution[1642:7508] Display 0: 1600x1200x32@60 20:21:03 INFO - 2016-12-21 20:21:03.755 screenresolution[1643:7515] starting screenresolution argv=screenresolution list 20:21:03 INFO - Available Modes on Display 0 20:21:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:21:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:21:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:21:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:21:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:21:03 INFO - Intel Iris: 20:21:03 INFO - Chipset Model: Intel Iris 20:21:03 INFO - Type: GPU 20:21:03 INFO - Bus: Built-In 20:21:03 INFO - VRAM (Dynamic, Max): 1536 MB 20:21:03 INFO - Vendor: Intel (0x8086) 20:21:03 INFO - Device ID: 0x0a2e 20:21:03 INFO - Revision ID: 0x0009 20:21:03 INFO - Displays: 20:21:03 INFO - Display: 20:21:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:21:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:21:03 INFO - Display Serial Number: 1600x1200 60 20:21:03 INFO - Main Display: Yes 20:21:03 INFO - Mirror: Off 20:21:03 INFO - Online: Yes 20:21:03 INFO - Rotation: Supported 20:21:03 INFO - Return code: 0 20:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:21:03 INFO - Python 2.7.3 20:21:03 INFO - Return code: 0 20:21:03 INFO - grabbing minidump binary from tooltool 20:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:21:03 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 0x10c826d30>, '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 0x10c68cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c81eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:21:03 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 20:21:03 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 20:21:03 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 20:21:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:21:04 INFO - Return code: 0 20:21:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:21:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:21:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:21:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:21:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:21:04 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/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0339', '--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 20:21:04 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/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0339 --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 20:21:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Cp8XEV0pr1/Render', 20:21:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:21:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:21:04 INFO - 'HOME': '/Users/cltbld', 20:21:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:21:04 INFO - 'LOGNAME': 'cltbld', 20:21:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:21:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:04 INFO - 'MOZ_NO_REMOTE': '1', 20:21:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:21:04 INFO - 'NO_EM_RESTART': '1', 20:21:04 INFO - 'PAGER': '/bin/cat', 20:21:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:04 INFO - 'PWD': '/builds/slave/test', 20:21:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:21:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:21:04 INFO - 'SHELL': '/bin/bash', 20:21:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hn953XEsbt/Listeners', 20:21:04 INFO - 'TMPDIR': '/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/', 20:21:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:21:04 INFO - 'USER': 'cltbld', 20:21:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:21:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:04 INFO - 'XPC_FLAGS': '0x0', 20:21:04 INFO - 'XPC_SERVICE_NAME': '0', 20:21:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:21:04 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/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0339', '--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 20:21:04 INFO - mozversion application_buildid: 20161221190653 20:21:04 INFO - mozversion application_changeset: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe 20:21:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:21:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:21:04 INFO - mozversion application_name: Firefox 20:21:04 INFO - mozversion application_remotingname: firefox-dev 20:21:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:21:04 INFO - mozversion application_vendor: Mozilla 20:21:04 INFO - mozversion application_version: 52.0a2 20:21:04 INFO - mozversion platform_buildid: 20161221190653 20:21:04 INFO - mozversion platform_changeset: 62eb5ff8893e7803da94b2e52bd108285aa1f5fe 20:21:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:21:04 INFO - mozversion platform_version: 52.0a2 20:21:04 INFO - using testdate: 1482380464 20:21:04 INFO - actual date: 1482380464 20:21:04 INFO - starting webserver on 'localhost:49243' 20:21:04 INFO - SUITE-START | Running 2 tests 20:21:04 INFO - TEST-START | dromaeo_css 20:21:04 INFO - operating with platform_type : mac_ 20:21:04 INFO - Initialising browser for dromaeo_css test... 20:21:04 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpihE17A/profile http://localhost:49243/getInfo.html) 20:21:07 INFO - PROCESS | 1653 | 2016-12-21 20:21:07.519 plugin-container[1655:7691] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 20:21:07 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:21:07 INFO - PROCESS | 1653 | 2016-12-21 20:21:07.522 plugin-container[1655:7691] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 20:21:07 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:21:07 INFO - PROCESS | 1653 | 2016-12-21 20:21:07.522 plugin-container[1655:7691] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:21:07 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 20:21:07 INFO - PROCESS | 1653 | colorDepth:24 20:21:07 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 20:21:07 INFO - PROCESS | 1653 | __metrics 20:21:07 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 20:21:08 INFO - TEST-INFO | 1653: exit 0 20:21:08 INFO - Browser initialized. 20:21:08 INFO - Running cycle 1/1 for dromaeo_css test... 20:21:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpihE17A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:11 INFO - PROCESS | 1656 | 2016-12-21 20:21:11.497 plugin-container[1657:7818] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 20:21:11 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:21:11 INFO - PROCESS | 1656 | 2016-12-21 20:21:11.500 plugin-container[1657:7818] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x420f, name = 'com.apple.CFPasteboardClient' 20:21:11 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:21:11 INFO - PROCESS | 1656 | 2016-12-21 20:21:11.500 plugin-container[1657:7818] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:21:21 INFO - PROCESS | 1656 | RSS: Main: 229253120 20:21:21 INFO - PROCESS | 1656 | 20:22:10 INFO - PROCESS | 1656 | 1482380530772 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:24:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 20:24:26 INFO - PROCESS | 1656 | RSS: Main: 232210432 20:24:26 INFO - PROCESS | 1656 | 20:27:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 20:27:29 INFO - PROCESS | 1656 | RSS: Main: 243490816 20:27:29 INFO - PROCESS | 1656 | 20:30:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 20:30:32 INFO - PROCESS | 1656 | RSS: Main: 246411264 20:30:32 INFO - PROCESS | 1656 | 20:33:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 20:33:34 INFO - PROCESS | 1656 | RSS: Main: 245559296 20:33:34 INFO - PROCESS | 1656 | 20:36:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 20:36:38 INFO - PROCESS | 1656 | RSS: Main: 248995840 20:36:38 INFO - PROCESS | 1656 | 20:39:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 20:39:41 INFO - PROCESS | 1656 | RSS: Main: 250515456 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | __start_tp_report 20:39:41 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 20:39:41 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 20:39:41 INFO - PROCESS | 1656 | |i|pagename|runs| 20:39:41 INFO - PROCESS | 1656 | |0;dojo.html;2617.6911544227887;3324.0858763839956;3362.3611513812375;3372.4941258811177;3374.342003309354;5553.278073850399;5622.072358060915;5643.661380317184;5658.236138121347;5680.630759000662;4486.923138446774;4894.97552512237;5529.142982837657;5699.259096317483;5721.113227449741;5107.208382700678;5119.59043276537;5232.215167724853;5242.18746094356;5288.65623734456;4255.425517555122;5246.370435547739;5262.236975638531;5266.131088370415;5267.157254839227;5084.949150508484;5105.974470127663;5124.743762811863;5238.895222095556;5256.132738098209;5094.847154585368;5184.429712731597;5218.112920803473;5220.112580861262;5280.735963201863;4333.674974376934;5093.439721630618;5178.14560597501;5214.739263036833;5236.293100431431;5744.655320680772;5773.711314434261;5800.245968024172;5800.941990580082;5811.418858114197;6117.480014198798;6125.143885071339;6126.79250549526;6135.601185922946;6144.494598823272;6193.2877719062435;6253.843653908643;6260.843478913018;6262.185915830958;6282.528810339243;4814.735189564538;5830.62100963436;5836.795712150097;5857.912131318034;5860.296764388258;5225.294585230945;5626.831195064073;5683.914741278884;6225.595336303126;6282.308946015934;6018.097285407224;6103.267607887082;6109.694515274218;6122.081687746873;6122.093225952662;6157.876842463125;6188.44304012641;6208;6228.252609686867;6232.750689972441;5383.600263931406;5457.536109430664;5997.190379298826;6131.662758548234;6185.8144255672405;6139.553468857682;6227.09707092469;6235.594686345373;6239.282482514569;6247.156633854463;3627.891163265106;4833.32333473314;4932.950670493321;4949.455559888409;4960.156773348539;4332.891677708082;4334.761588112684;4405.493368262627;4445.222086134913;4452.48796388413;5601.411851755588;5771.509421699118;5830.4461076197695;5838.12428135783;5933.554983376264;6254.499640028786;6267.749290028439;6283.43449089575;6285.465735412449;6315.336889626615;5647.887042259132;5714.828555143353;5748.367679555246;5852.063669812809;5888.116782482576;5364;5408.91886621701;5424.403315635277;5445.401005889349;5448.264484294569;6274.466670333073;6277.748890044439;6281.057841323838;6291.150694656163;6327.90508142369;6078.665673388006;6158.661273629993;6242.687865606792;6243.875122497434;6257.405546473078;6131.101423540661;6176.474999625082;6212.316645169119;6248.968755156195;6275.874482510233;6084.756609735561;6109.419605137505;6111.174991376285;6111.96944015277;6119.082137679384;6027.427394397525;6055.212822333068;6156.659857961449;6174.166487524307;6178.196834411498;5907.409259074058;6002.639841609517;6022.698865056817;6041.18444010053;6050.42520960508;4360.694751367374;4828.806847726051;5925.881482370414;6107.603005804608;6109.920916985209;4261.91321213101;5858.7070646468355;5970.97014514942;5986.730597123053;5988.071848863433;5891.116332550152;5953.880922381441;5962.07587823888;6051.273847138372;6103.938960610337;5773.97113014449;5937.139114828239;5943.078822782476;5944.791932282349;5945.524358051259 20:39:41 INFO - PROCESS | 1656 | |1;ext.html;491.70006296159335;515.6905856486107;531.8351311093561;545.4518209199754;550.2818821438021;39497.60502394975;40967;41113.99999999996;43208.56791432085;43244.56755432445;41321.58678413215;41964.74105776824;41976.58023419765;42061.36907946376;42068.789656051675;8014.358851291882;9309.115634014775;9372.109649583314;9399.06009399058;9410.247180225566;9260.629574817;9299.209567186797;9374.765630859214;9390.201832844183;9448.007959164292;8045.316148127416;9320.766980825465;9405.858912116324;9416.717498475056;9426;9292.535373231345;9390.577424015935;9396.248300135972;9407.529623518865;9420.481873496956;9270.026647202014;9291.814163716756;9324.953375233148;9326.020767819417;9356.766080847965;38725.61274387248;39159;39187.412188817194;39225.60774392248;39276.803615981735;3228.741700663965;3266.4936934775146;3339.8163101029436;3665.21197942441;3822.445745366906;28927;29524.409511809645;29982.55026174609;30142.698573014208;30231.69768302333;3183.1405520509566;3190.266238765097;3200.4079245339453;3226.7418606511424;3289.703926646613;416725;419540;420571;422162.88918555516;422785;59449.10826337608;59706;59712;59747;59840.70079649574;62205.68897155485;62383.6880815593;62895.6855215721;62929.05606415907;63114;15956.042637441791;16209.946353486986;16226.756598651029;16231.837681623269;16260.674786504203;12425.254484730945;12482.687932801753;12503.812442813365;12507.312097834525;12545.059120565811;16179.43371981975;17230.741538876926;17330.046847423262;17331.913340433217;17377.13114344303;7071.7878463646175;7094.219635840053;7205.135383753878;7256.092988376453;7277.19950805411;779.4349096904699;974.2206235011962;1016.3444578246989;1068.4978060311641;1092.9781404371868;25990.74009259921;26924.05765798227;29601.407971840872;30001.24996875052;30632.562109797458;947.5215016416803;959.0122174160625;1013.3210748798323;1092.6339676208559;1116.558959211107;13303.211102762278;13983.44066237339;15439.30523126462;15479.148646824307;15543.834212434112;666339;668097;670976;671363;671909;56821;56916;57237;57389;57440;1347.7102422979106;1349.406261245049;1385.1204485152202;1386.2098603795941;1389.5275606293706;28533.42933141284;29075;29418.264543386587;29773;29874.551881721356;49921.500784993135;50636.493635063176;50637.74681126571;50764.49235507598;50783.74608126936;517919;519739;519990;521156;521480;26296.73703262943;26518.60222096709;26824.463510730067;26869.462610747283;26870.462590747684;44615.55384446114;45274.54725452703;45801.54198457973;45914.770426147654;46605;28920;37434;37797.62202377941;38216.42675359816;38730;36966.44550331801;37118.44322335113;37431.064223394635;37791.811040944616;37843.864684059525;27511.58732618972;33498.66501334956;33521.83239083789;33727.83136084304;33767.83116084404;30200.09399718012;33719.662803371655;33802.49296260607;33832.323353533284;33865.98402047942;17696.646067078844;25053.74946250587;25072.874635626704;25559.105431309814;25658.101966431084 20:39:41 INFO - PROCESS | 1656 | |2;jquery.html;355.1759916992577;377.61106060757413;388.19643338289734;388.35726872026805;404.45398711739136;18163.636727265446;19515.5121121972;20194.596108077847;20206.39380818574;20403.183872645113;18790.15444305006;19414;19441.51396215095;19632.60734785307;19980.900095499503;4966.85762274677;5382.4886635769535;5598.580106492009;5831.183634291203;5848.970755146218;5595.160725891128;5731;5756.366799652035;5758;5767.1349297605275;4790.329353890458;5535.0571929281405;5623.26897503326;5694.117411801178;5715.571332150084;5604.467575580334;5612.719364031823;5623.49388555028;5635.6055076144685;5655.632383895054;4931.80272789088;5002.499750025005;5013.0725815723845;5211.921821172686;5275.841724748264;12290.446929888176;12602.81095783564;12850.357482125857;12931.806022909665;12958.157719748186;1835.3943198744516;1937.447827369193;2045.877247365148;2171.9782802172094;2250.6398976163737;7407.037085178946;8301.252887240116;9773.804523909483;10147.594096236142;10217.489125543767;1517.9544613661608;1716.7339062445217;1789.4899953513316;1818.4726429335476;1846.9261229550802;94587.52706236494;112784.05255816007;115526;116508.83491165064;117314.82685173124;9223.907760922439;9761.170300524393;9899.505024748734;10166.440845753554;10179.389236645677;12053.457594408274;12057.457414416373;12096.455659495345;12121.151519393734;12121.696957575954;7792.922070779219;7892.092409372881;7933.484323518953;8043.235892590194;8059.838803223903;8253.669853205805;8267.196094643588;8271.8345633087;8365.912431384002;8475.533845638549;3382.3911695894976;3735.122246272124;3804.7336686432236;3873.3996230584303;3968.1666849961252;1895.2229585869727;1939.776925653568;1947.1529884500287;1947.464447276982;1951;741.8961345411647;747.3348719639525;769.3729610367533;834.2575108153748;898.8876390451194;19443.805561944482;20660.896695516425;20778.961051947343;20844.687329690067;20863.687044694343;911.7082533589321;928.6563971330515;950.7432993091827;960.8222478841436;975.8877729061248;8551.486910785372;10798.946005269923;10835.67492975212;10842.295250808673;10894.67315980522;626077;628647;629133;633024;650740;94881.0511894886;129951.05073423906;130702;132113;150973.207582817;954.3128947158035;970.7670159161751;993.6571882700457;995.6963126246419;1001.5793366785967;18396.172172252547;18807;18829.340973066424;18839.6232075355;18959.336423225122;50532.73668158326;54295.45704543062;55891.72054139703;56303.43696562982;58671.11993320189;60770;61858;79784;83575;85396;7850.607469626381;8123.47197432165;8162.347012239125;8178.386621003329;8286.171382861665;12430.564930227398;12788.296643684687;12872.678183045498;12958.611241662766;13198;10926.836097458703;11022.669319920415;11056.11551075928;11394.829077564009;11519.19365644397;10830;10973.341599504056;11068.391238481961;11310.547578096784;11459.541618335174;11196.38419886914;11262.436878155895;11342.319460832376;11709.765804683688;11822.82265765997;6667.566608170453;6717.899231511434;7106.857862842818;8009.239122283374;8111.310538604284;8932.838730964933;10652.786944261226;11045.392503412068;11144.108471322113;11188.160887933274 20:39:41 INFO - PROCESS | 1656 | |3;mootools.html;1263.6840789802548;1374.0656353679497;1524.954251372459;1577.3532851530867;1879.8496120310385;7447.851042979137;7654.655540500677;7656.119546252183;8139.91860081399;8264.504129752218;6088.482478989291;8208.425410221273;8254.91745082549;8333.708320208794;8356.874646880302;2284.942876428094;2327.9534409311805;2330.0912644068826;2335.135999680112;2338.707661542307;2318.547883162784;2344.179537161997;2363.243761996162;2370.134900761227;2382.356763673807;2302.6430903209944;2319.420144963759;2334.4630734930975;2335.8248131390214;2337.1352599538195;2293.9885300573555;2296.4603318220206;2319.095552734435;2319.257837492003;2326.325365643961;2259.1302348595746;2317.698699169114;2324.732655744577;2328.7205535335697;2330.196082351586;8223.42436029478;8279.710210142677;8293.792655183608;8310;8316.667333306661;4177.665786737054;5182.870428239286;5189;5203.089459344599;5217.243499692523;3279.8032118072992;3423.4180189367867;3512.701420379271;3593.2633810068874;3599.748017638766;1048.5386429970865;1053.1406157648669;1086.8315411111291;1088.3252383522188;1106.2145876427746;10785.784284314348;10810.621628243052;10886.891131088667;10892.128629709605;10919.290246134055;4481.977590112028;4611.077784443125;4667.393238878992;4677.579017888406;4740.28895665646;8472.110428404929;9295.11696388842;9390.34267601275;9397.389169703947;9450.57472413743;4975.353204083446;5189.896202075937;5213.983273261753;5215.035218484517;5217.087009773274;4252.4046633471335;4259.253705980533;4707.411573553306;4721.622270218374;4777.546133117348;3798.506194194737;3809.4285857121654;3863.9613603864163;3885.3589157788647;3904.2581909437117;1262.5770366927181;1267.7084270617809;1270.4346565778326;1282.5639282643947;1282.7755142849965;802.7792357101844;881.9338549608805;888.5868071346855;900.5857305639348;911.5305617606938;5394.460553944574;5408.729563521887;5442.755076021588;5570.693611851387;5622.297212848394;820.5938060660012;882.7042940614966;948.2224575847877;956.2350119904049;962.9374090684083;3692.3538380783793;3778.4899038629983;3879.18537107205;3884.2425726983533;3905.7070719696135;9583.185429238454;9846.01539846024;9999.650012249682;10017.198624110053;10030.498475076363;9764.707058788248;9999.000099989942;10013.349132306523;10032.39805611651;10042.949785251172;7616.466847320635;7858.410619203582;7860.5676687782725;7867.370610351159;7867.567283799446;4737.407824021997;5398.46015398457;5417.539509141767;5488.396276409671;5605.439456054362;7673.386129109769;9296.535173241176;9370.765730856783;9436.622535098793;9445;9293.442393456415;9406.43561386319;9475.763105922408;9527;9644.710658680251;6230.221222347207;6398.584092034003;6559.852025895545;6591.934080659132;6801.1158549388265;7824.452288339761;8029.638666259915;8033.799155021171;8038.477498962548;8075.384923015303;6441.613503189824;7063.894041589278;7170.462215333767;7176.712931482891;7280.526765760209;6925.445964322741;6926.515143939876;6963.547369420971;6999.825004374931;7021.719131234898;6659.53383263167;6666.500012499179;6719.395254427125;6732.899006514808;6735.393814556714;4831.492693267156;4858.951410485991;4875.19559272716;4890.6087512998165;4956.950430495649;4052.4326594276235;4745.217039188633;4788.018456216537;4946.985867897;5041.546260836542 20:39:41 INFO - PROCESS | 1656 | |4;prototype.html;306.3795813477708;307.77839955232224;315.1160993413474;315.3975906019503;320.9614846218454;4319.02821865081;5210.150396609206;5297.735113244332;5340.7863685452585;5457.5633949284065;5090.3603923195;5265.63093595665;5279.340082489689;5292.920606190901;5339.919901201485;3602.441621548664;4074.449949256857;4081.795910204493;4092.9590704092875;4096.562545285566;3958.3270843956598;4079.4084857695616;4091.1204091120403;4099.549049604541;4118.396403147246;4011.9197616047663;4012.899677508071;4014.799260037001;4062.756234625917;4070;3790.5451345838537;4057.2088442753675;4060.654844338235;4068.4304197412384;4087.591240875918;2992.925176870574;3546.7871927684164;3566.1084728817796;3576.0523461282783;3604.8377822998027;4446.866594002185;4532.864014079583;4893.608511319121;5058.848234552969;5162.432132465426;4056.9594304057173;4242.703010789246;4429.051217464305;4609.539046095397;4625.306204069417;4597.701149425287;5486.945130548684;5537.262347915142;5547.113981246355;5617.578681598897;3763.9435408468894;3862.4592557042038;3871.9419208711893;3904.25819094374;3940.4680368150507;5204.4535323791215;5497.76300332426;5825.796097136622;5855.4144585541535;5867.591777973298;3184.5541624172633;3260.02199340197;3379.5268662387284;3405.9441573112413;4048.817803198863;3172.873085076571;3352.865885364607;3873.69010479161;4016.5581786003518;4070.409790580349;3918.843246270117;4600.125976064537;4601.688518772134;4614.123316569841;4654.488006319302;4885;5594.342687223536;5627.352854421794;5635.5773317001385;5640;1118.5246270335238;1149.2185313986402;1250.9687257818628;1277.399622177575;1296.8767967043116;883.6553744039829;902.2466240688967;911.9407238529475;914.3782228084833;916.8258030974093;3804.9048773780323;4702.858914232578;4874.073925954058;4973.52751488608;5001.4998500149695;5412.945870541323;5425.430329815392;5427.701476418835;5458.426865179178;5478.918011155815;4229.555896630871;4492.101579684077;4638.281066434708;4828.647978566007;4834.854954351375;2731.808773385844;2810.1148138336766;2835.716428357189;2840.2615320016944;2875.3386721054276;5387.326584176978;5620.241267428926;5623.718814059363;5658.943410565842;5690.374058853523;4509.030558429953;4684.859454216379;4715.693479923794;4843.176659967743;5640.971795140998;4594.839180628662;4986.675866068694;5188.896222075613;5449.692073902314;5678.829635110953;5203.895922081613;5436.9126174766;5463.360991702552;5466.945330546802;5513.558915286848;4798.568128868279;4968.801247950041;5307.256984022163;5338.97330513345;5362.854858056809;4934.925976110433;5055.216441451581;5592.916106258328;5639.520640745419;5680.829575112753;3516.6744903769018;3766.5856755756295;3781.773093614392;3804.505414296124;3823.9808800955816;4512.9774351128035;4539.72761634303;5231.927454871666;5564.415736347787;5793.827314756966;4795.451365989213;5327.973360133329;5483.890322193454;5737.569682273763;5738.942610573841;4987.800487980585;5223.242629818579;5692.6299790513485;5708.51578589578;5723.3418156912485;4837.40365679318;4890.413150421972;5510.6969116698965;5533.806316778893;5580.665160090408;5680.914786278292;5686.658800471985;5687.260656114679;5689.748255383809;5702.7718891243885;5078.441371449064;5302.920456193083;5358.446050645269;5572.972135139298;5585 20:39:41 INFO - PROCESS | 1656 | |5;yui.html;676.2763842688325;703.388052394417;724.0876495615523;730.5945200413768;753.1827966656177;13113.7377252455;15044.849551504481;15065.171415572166;15087.698246035086;15093.698126037472;13438.328083595805;13446.93276533616;13489.39297731602;13546.254955977418;13606.523771667993;646.4311405962758;668.0080081079593;791.6318911706055;809.5183365897311;830;781.0861292288008;789.8973133492638;793.694427645355;794.1105961323326;795.6340083561569;830.2030051150903;832.6169961817571;832.8792325112855;835.2649668291895;835.9884539706932;807.5921659561942;812.6140083460339;819.9139090395512;823.9258466738022;824.4229039672193;609.8322961185665;619.3311223878246;619.358963472808;620.3331418724844;620.6059152438189;13610.183388996691;13653.590392288248;13666.974976876774;13841.930790346085;14253.50112746049;13341.066125371228;13492.190468571818;13496.5276215332;13520.256385898772;13828.239446830421;10811.567537298499;10878.836817447745;11010.284331518425;11216.383098929555;11295.378754168518;3670.72469564781;4257.233697934371;4377.802998865059;4383.978080109611;4511.323301504801;77011.61494192493;78207;78845.60577197134;84121.15878841195;86594.56702716446;10246.38521688701;10403.167746580406;10496.265261431627;10496.68509944703;10527.894571070081;19326.710099348522;19373.8062619372;19561.902190488956;19734.013299334976;19744.60510789776;6441.25925518562;6457.1605691260775;6465.321141280192;6580.769673061515;6599.604023758494;4089.8568550100604;4134.64855487287;4165.708400411942;4169.124483858423;4246.129543443587;3361.09250502363;3447.517347571342;3460.463628137643;3476.3394954958476;3482.91292717679;590.5718354193261;652.425865238587;653.3629711031801;655.8524332025352;669.1167658690579;539.4928766959046;576.3919065386058;592.3070008090544;597.202734349648;636.3858876184412;6668.933310666928;7731.690732370642;8035.959820200862;8684.913150868411;8755.124487551195;564.3932772269826;570.3099249907575;583.107844997155;633.56917296239;641.1142941815649;3219.7555500124718;3798.6135060702645;4355.978220108879;4469.039156581351;4472.865814025585;118196.40901795436;121251;123025;123996.38001809933;127359;63955;81785.77321340184;86135.569322153;89118.55440722755;103327;78139.21860781433;80703.59648201721;81639;85309.57345213235;86493.13506864976;9335.86262377471;9705.181655747525;9780.462074585967;9793.87370452407;9817.969113243007;50601.73495662638;51000.48999510106;54776.72611637076;56325.71837140788;57070.7146464265;53285.7335713319;72470;73304.63347683227;73713.26286737063;73935;12182.817257740964;12228.75542489163;12263.816042759545;12272.938635306766;12736.554220602606;13842.961777866902;13906.652333691738;14219.50231741884;14239.216843073316;14250.643733906321;12112.757744844877;12825.358732063547;13047.28239946774;13202.867971320547;13268;13093.869061309266;13130.934345328595;13173.60479185626;13190.34048297562;13208.33958302062;10668.413237272025;12461.127721059802;12585.811212831632;12751.107422480338;12924.224546527239;10357.326773759682;10381.377117372982;11161.218714689894;11173.441327933408;11516.769664606494;10336.586536538754;10695.5187016586;10804.513796879317;10930.56277748881;10938.835917461085 20:39:41 INFO - PROCESS | 1656 | __end_tp_report 20:39:41 INFO - PROCESS | 1656 | __start_cc_report 20:39:41 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,359 20:39:41 INFO - PROCESS | 1656 | __end_cc_report 20:39:41 INFO - PROCESS | 1656 | __startTimestamp1482381581045__endTimestamp 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | ------- Summary: start ------- 20:39:41 INFO - PROCESS | 1656 | Number of tests: 6 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5634.18 Median:5860.30 stddev:703.00 (12.0%) stddev-sans-first:664.13 20:39:41 INFO - PROCESS | 1656 | Values: 2617.7 3324.1 3362.4 3372.5 3374.3 5553.3 5622.1 5643.7 5658.2 5680.6 4486.9 4895.0 5529.1 5699.3 5721.1 5107.2 5119.6 5232.2 5242.2 5288.7 4255.4 5246.4 5262.2 5266.1 5267.2 5084.9 5106.0 5124.7 5238.9 5256.1 5094.8 5184.4 5218.1 5220.1 5280.7 4333.7 5093.4 5178.1 5214.7 5236.3 5744.7 5773.7 5800.2 5800.9 5811.4 6117.5 6125.1 6126.8 6135.6 6144.5 6193.3 6253.8 6260.8 6262.2 6282.5 4814.7 5830.6 5836.8 5857.9 5860.3 5225.3 5626.8 5683.9 6225.6 6282.3 6018.1 6103.3 6109.7 6122.1 6122.1 6157.9 6188.4 6208.0 6228.3 6232.8 5383.6 5457.5 5997.2 6131.7 6185.8 6139.6 6227.1 6235.6 6239.3 6247.2 3627.9 4833.3 4933.0 4949.5 4960.2 4332.9 4334.8 4405.5 4445.2 4452.5 5601.4 5771.5 5830.4 5838.1 5933.6 6254.5 6267.7 6283.4 6285.5 6315.3 5647.9 5714.8 5748.4 5852.1 5888.1 5364.0 5408.9 5424.4 5445.4 5448.3 6274.5 6277.7 6281.1 6291.2 6327.9 6078.7 6158.7 6242.7 6243.9 6257.4 6131.1 6176.5 6212.3 6249.0 6275.9 6084.8 6109.4 6111.2 6112.0 6119.1 6027.4 6055.2 6156.7 6174.2 6178.2 5907.4 6002.6 6022.7 6041.2 6050.4 4360.7 4828.8 5925.9 6107.6 6109.9 4261.9 5858.7 5971.0 5986.7 5988.1 5891.1 5953.9 5962.1 6051.3 6103.9 5774.0 5937.1 5943.1 5944.8 5945.5 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:66955.73 Median:39387.20 stddev:146172.55 (371.1%) stddev-sans-first:146497.43 20:39:41 INFO - PROCESS | 1656 | Values: 491.7 515.7 531.8 545.5 550.3 39497.6 40967.0 41114.0 43208.6 43244.6 41321.6 41964.7 41976.6 42061.4 42068.8 8014.4 9309.1 9372.1 9399.1 9410.2 9260.6 9299.2 9374.8 9390.2 9448.0 8045.3 9320.8 9405.9 9416.7 9426.0 9292.5 9390.6 9396.2 9407.5 9420.5 9270.0 9291.8 9325.0 9326.0 9356.8 38725.6 39159.0 39187.4 39225.6 39276.8 3228.7 3266.5 3339.8 3665.2 3822.4 28927.0 29524.4 29982.6 30142.7 30231.7 3183.1 3190.3 3200.4 3226.7 3289.7 416725.0 419540.0 420571.0 422162.9 422785.0 59449.1 59706.0 59712.0 59747.0 59840.7 62205.7 62383.7 62895.7 62929.1 63114.0 15956.0 16209.9 16226.8 16231.8 16260.7 12425.3 12482.7 12503.8 12507.3 12545.1 16179.4 17230.7 17330.0 17331.9 17377.1 7071.8 7094.2 7205.1 7256.1 7277.2 779.4 974.2 1016.3 1068.5 1093.0 25990.7 26924.1 29601.4 30001.2 30632.6 947.5 959.0 1013.3 1092.6 1116.6 13303.2 13983.4 15439.3 15479.1 15543.8 666339.0 668097.0 670976.0 671363.0 671909.0 56821.0 56916.0 57237.0 57389.0 57440.0 1347.7 1349.4 1385.1 1386.2 1389.5 28533.4 29075.0 29418.3 29773.0 29874.6 49921.5 50636.5 50637.7 50764.5 50783.7 517919.0 519739.0 519990.0 521156.0 521480.0 26296.7 26518.6 26824.5 26869.5 26870.5 44615.6 45274.5 45801.5 45914.8 46605.0 28920.0 37434.0 37797.6 38216.4 38730.0 36966.4 37118.4 37431.1 37791.8 37843.9 27511.6 33498.7 33521.8 33727.8 33767.8 30200.1 33719.7 33802.5 33832.3 33866.0 17696.6 25053.7 25072.9 25559.1 25658.1 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:35100.29 Median:3839.07 stddev:105452.29 (2746.8%) stddev-sans-first:105715.84 20:39:41 INFO - PROCESS | 1656 | Values: 355.2 377.6 388.2 388.4 404.5 18163.6 19515.5 20194.6 20206.4 20403.2 18790.2 19414.0 19441.5 19632.6 19980.9 4966.9 5382.5 5598.6 5831.2 5849.0 5595.2 5731.0 5756.4 5758.0 5767.1 4790.3 5535.1 5623.3 5694.1 5715.6 5604.5 5612.7 5623.5 5635.6 5655.6 4931.8 5002.5 5013.1 5211.9 5275.8 12290.4 12602.8 12850.4 12931.8 12958.2 1835.4 1937.4 2045.9 2172.0 2250.6 7407.0 8301.3 9773.8 10147.6 10217.5 1518.0 1716.7 1789.5 1818.5 1846.9 94587.5 112784.1 115526.0 116508.8 117314.8 9223.9 9761.2 9899.5 10166.4 10179.4 12053.5 12057.5 12096.5 12121.2 12121.7 7792.9 7892.1 7933.5 8043.2 8059.8 8253.7 8267.2 8271.8 8365.9 8475.5 3382.4 3735.1 3804.7 3873.4 3968.2 1895.2 1939.8 1947.2 1947.5 1951.0 741.9 747.3 769.4 834.3 898.9 19443.8 20660.9 20779.0 20844.7 20863.7 911.7 928.7 950.7 960.8 975.9 8551.5 10798.9 10835.7 10842.3 10894.7 626077.0 628647.0 629133.0 633024.0 650740.0 94881.1 129951.1 130702.0 132113.0 150973.2 954.3 970.8 993.7 995.7 1001.6 18396.2 18807.0 18829.3 18839.6 18959.3 50532.7 54295.5 55891.7 56303.4 58671.1 60770.0 61858.0 79784.0 83575.0 85396.0 7850.6 8123.5 8162.3 8178.4 8286.2 12430.6 12788.3 12872.7 12958.6 13198.0 10926.8 11022.7 11056.1 11394.8 11519.2 10830.0 10973.3 11068.4 11310.5 11459.5 11196.4 11262.4 11342.3 11709.8 11822.8 6667.6 6717.9 7106.9 8009.2 8111.3 8932.8 10652.8 11045.4 11144.1 11188.2 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5378.85 Median:5196.49 stddev:2931.66 (56.4%) stddev-sans-first:2923.57 20:39:41 INFO - PROCESS | 1656 | Values: 1263.7 1374.1 1525.0 1577.4 1879.8 7447.9 7654.7 7656.1 8139.9 8264.5 6088.5 8208.4 8254.9 8333.7 8356.9 2284.9 2328.0 2330.1 2335.1 2338.7 2318.5 2344.2 2363.2 2370.1 2382.4 2302.6 2319.4 2334.5 2335.8 2337.1 2294.0 2296.5 2319.1 2319.3 2326.3 2259.1 2317.7 2324.7 2328.7 2330.2 8223.4 8279.7 8293.8 8310.0 8316.7 4177.7 5182.9 5189.0 5203.1 5217.2 3279.8 3423.4 3512.7 3593.3 3599.7 1048.5 1053.1 1086.8 1088.3 1106.2 10785.8 10810.6 10886.9 10892.1 10919.3 4482.0 4611.1 4667.4 4677.6 4740.3 8472.1 9295.1 9390.3 9397.4 9450.6 4975.4 5189.9 5214.0 5215.0 5217.1 4252.4 4259.3 4707.4 4721.6 4777.5 3798.5 3809.4 3864.0 3885.4 3904.3 1262.6 1267.7 1270.4 1282.6 1282.8 802.8 881.9 888.6 900.6 911.5 5394.5 5408.7 5442.8 5570.7 5622.3 820.6 882.7 948.2 956.2 962.9 3692.4 3778.5 3879.2 3884.2 3905.7 9583.2 9846.0 9999.7 10017.2 10030.5 9764.7 9999.0 10013.3 10032.4 10042.9 7616.5 7858.4 7860.6 7867.4 7867.6 4737.4 5398.5 5417.5 5488.4 5605.4 7673.4 9296.5 9370.8 9436.6 9445.0 9293.4 9406.4 9475.8 9527.0 9644.7 6230.2 6398.6 6559.9 6591.9 6801.1 7824.5 8029.6 8033.8 8038.5 8075.4 6441.6 7063.9 7170.5 7176.7 7280.5 6925.4 6926.5 6963.5 6999.8 7021.7 6659.5 6666.5 6719.4 6732.9 6735.4 4831.5 4859.0 4875.2 4890.6 4957.0 4052.4 4745.2 4788.0 4947.0 5041.5 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4411.36 Median:4858.63 stddev:1344.11 (27.7%) stddev-sans-first:1312.10 20:39:41 INFO - PROCESS | 1656 | Values: 306.4 307.8 315.1 315.4 321.0 4319.0 5210.2 5297.7 5340.8 5457.6 5090.4 5265.6 5279.3 5292.9 5339.9 3602.4 4074.4 4081.8 4093.0 4096.6 3958.3 4079.4 4091.1 4099.5 4118.4 4011.9 4012.9 4014.8 4062.8 4070.0 3790.5 4057.2 4060.7 4068.4 4087.6 2992.9 3546.8 3566.1 3576.1 3604.8 4446.9 4532.9 4893.6 5058.8 5162.4 4057.0 4242.7 4429.1 4609.5 4625.3 4597.7 5486.9 5537.3 5547.1 5617.6 3763.9 3862.5 3871.9 3904.3 3940.5 5204.5 5497.8 5825.8 5855.4 5867.6 3184.6 3260.0 3379.5 3405.9 4048.8 3172.9 3352.9 3873.7 4016.6 4070.4 3918.8 4600.1 4601.7 4614.1 4654.5 4885.0 5594.3 5627.4 5635.6 5640.0 1118.5 1149.2 1251.0 1277.4 1296.9 883.7 902.2 911.9 914.4 916.8 3804.9 4702.9 4874.1 4973.5 5001.5 5412.9 5425.4 5427.7 5458.4 5478.9 4229.6 4492.1 4638.3 4828.6 4834.9 2731.8 2810.1 2835.7 2840.3 2875.3 5387.3 5620.2 5623.7 5658.9 5690.4 4509.0 4684.9 4715.7 4843.2 5641.0 4594.8 4986.7 5188.9 5449.7 5678.8 5203.9 5436.9 5463.4 5466.9 5513.6 4798.6 4968.8 5307.3 5339.0 5362.9 4934.9 5055.2 5592.9 5639.5 5680.8 3516.7 3766.6 3781.8 3804.5 3824.0 4513.0 4539.7 5231.9 5564.4 5793.8 4795.5 5328.0 5483.9 5737.6 5738.9 4987.8 5223.2 5692.6 5708.5 5723.3 4837.4 4890.4 5510.7 5533.8 5580.7 5680.9 5686.7 5687.3 5689.7 5702.8 5078.4 5302.9 5358.4 5573.0 5585.0 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20104.09 Median:4366.89 stddev:29800.24 (682.4%) stddev-sans-first:29848.14 20:39:41 INFO - PROCESS | 1656 | Values: 676.3 703.4 724.1 730.6 753.2 13113.7 15044.8 15065.2 15087.7 15093.7 13438.3 13446.9 13489.4 13546.3 13606.5 646.4 668.0 791.6 809.5 830.0 781.1 789.9 793.7 794.1 795.6 830.2 832.6 832.9 835.3 836.0 807.6 812.6 819.9 823.9 824.4 609.8 619.3 619.4 620.3 620.6 13610.2 13653.6 13667.0 13841.9 14253.5 13341.1 13492.2 13496.5 13520.3 13828.2 10811.6 10878.8 11010.3 11216.4 11295.4 3670.7 4257.2 4377.8 4384.0 4511.3 77011.6 78207.0 78845.6 84121.2 86594.6 10246.4 10403.2 10496.3 10496.7 10527.9 19326.7 19373.8 19561.9 19734.0 19744.6 6441.3 6457.2 6465.3 6580.8 6599.6 4089.9 4134.6 4165.7 4169.1 4246.1 3361.1 3447.5 3460.5 3476.3 3482.9 590.6 652.4 653.4 655.9 669.1 539.5 576.4 592.3 597.2 636.4 6668.9 7731.7 8036.0 8684.9 8755.1 564.4 570.3 583.1 633.6 641.1 3219.8 3798.6 4356.0 4469.0 4472.9 118196.4 121251.0 123025.0 123996.4 127359.0 63955.0 81785.8 86135.6 89118.6 103327.0 78139.2 80703.6 81639.0 85309.6 86493.1 9335.9 9705.2 9780.5 9793.9 9818.0 50601.7 51000.5 54776.7 56325.7 57070.7 53285.7 72470.0 73304.6 73713.3 73935.0 12182.8 12228.8 12263.8 12272.9 12736.6 13843.0 13906.7 14219.5 14239.2 14250.6 12112.8 12825.4 13047.3 13202.9 13268.0 13093.9 13130.9 13173.6 13190.3 13208.3 10668.4 12461.1 12585.8 12751.1 12924.2 10357.3 10381.4 11161.2 11173.4 11516.8 10336.6 10695.5 10804.5 10930.6 10938.8 20:39:41 INFO - PROCESS | 1656 | -------- Summary: end -------- 20:39:41 INFO - PROCESS | 1656 | 20:39:41 INFO - TEST-INFO | 1656: exit 0 20:39:41 INFO - TEST-OK | dromaeo_css | took 1117321ms 20:39:41 INFO - TEST-START | kraken 20:39:41 INFO - operating with platform_type : mac_ 20:39:41 INFO - Initialising browser for kraken test... 20:39:41 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpJ02UYt/profile http://localhost:49243/getInfo.html) 20:39:44 INFO - PROCESS | 1670 | 2016-12-21 20:39:44.717 plugin-container[1671:10242] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 20:39:44 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:39:44 INFO - PROCESS | 1670 | 2016-12-21 20:39:44.720 plugin-container[1671:10242] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 20:39:44 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:39:44 INFO - PROCESS | 1670 | 2016-12-21 20:39:44.720 plugin-container[1671:10242] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:39:44 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 20:39:44 INFO - PROCESS | 1670 | colorDepth:24 20:39:44 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 20:39:44 INFO - PROCESS | 1670 | __metrics 20:39:44 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 20:39:45 INFO - TEST-INFO | 1670: exit 0 20:39:45 INFO - Browser initialized. 20:39:45 INFO - Running cycle 1/1 for kraken test... 20:39:45 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/T/tmpJ02UYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:48 INFO - PROCESS | 1672 | 2016-12-21 20:39:48.625 plugin-container[1673:10367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 20:39:48 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:39:48 INFO - PROCESS | 1672 | 2016-12-21 20:39:48.628 plugin-container[1673:10367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 20:39:48 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:39:48 INFO - PROCESS | 1672 | 2016-12-21 20:39:48.628 plugin-container[1673:10367] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:39:58 INFO - PROCESS | 1672 | RSS: Main: 229158912 20:39:58 INFO - PROCESS | 1672 | 20:40:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 20:40:01 INFO - PROCESS | 1672 | RSS: Main: 241065984 20:40:01 INFO - PROCESS | 1672 | 20:40:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 20:40:04 INFO - PROCESS | 1672 | RSS: Main: 248737792 20:40:04 INFO - PROCESS | 1672 | 20:40:08 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 20:40:08 INFO - PROCESS | 1672 | RSS: Main: 252538880 20:40:08 INFO - PROCESS | 1672 | 20:40:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 20:40:11 INFO - PROCESS | 1672 | RSS: Main: 254128128 20:40:11 INFO - PROCESS | 1672 | 20:40:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:40:14 INFO - PROCESS | 1672 | RSS: Main: 254124032 20:40:14 INFO - PROCESS | 1672 | 20:40:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 20:40:17 INFO - PROCESS | 1672 | RSS: Main: 258793472 20:40:17 INFO - PROCESS | 1672 | 20:40:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:21 INFO - PROCESS | 1672 | RSS: Main: 257912832 20:40:21 INFO - PROCESS | 1672 | 20:40:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 20:40:25 INFO - PROCESS | 1672 | RSS: Main: 257986560 20:40:25 INFO - PROCESS | 1672 | 20:40:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:27 INFO - PROCESS | 1672 | RSS: Main: 256999424 20:40:27 INFO - PROCESS | 1672 | 20:40:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:30 INFO - PROCESS | 1672 | RSS: Main: 257077248 20:40:30 INFO - PROCESS | 1672 | 20:40:32 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:33 INFO - PROCESS | 1672 | RSS: Main: 257073152 20:40:33 INFO - PROCESS | 1672 | 20:40:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:36 INFO - PROCESS | 1672 | RSS: Main: 257290240 20:40:36 INFO - PROCESS | 1672 | 20:40:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:40 INFO - PROCESS | 1672 | RSS: Main: 257445888 20:40:40 INFO - PROCESS | 1672 | 20:40:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 20:40:42 INFO - PROCESS | 1672 | RSS: Main: 259223552 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | __start_tp_report 20:40:42 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 20:40:42 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 20:40:42 INFO - PROCESS | 1672 | |i|pagename|runs| 20:40:42 INFO - PROCESS | 1672 | |0;ai-astar;105;121;117;118;118;120;118;119;119;117 20:40:42 INFO - PROCESS | 1672 | |1;audio-beat-detection;139;109;121;179;99;133;149;100;135;132 20:40:42 INFO - PROCESS | 1672 | |2;audio-dft;234;247;204;197;205;194;194;193;208;247 20:40:42 INFO - PROCESS | 1672 | |3;audio-fft;91;50;61;101;88;86;51;74;104;86 20:40:42 INFO - PROCESS | 1672 | |4;audio-oscillator;86;71;89;72;71;63;102;100;102;119 20:40:42 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;90;74;135;130;89;91;135;88;89;90 20:40:42 INFO - PROCESS | 1672 | |6;imaging-darkroom;94;116;153;122;96;96;96;100;154;100 20:40:42 INFO - PROCESS | 1672 | |7;imaging-desaturate;139;86;78;135;122;140;88;140;133;123 20:40:42 INFO - PROCESS | 1672 | |8;json-parse-financial;57;55;56;79;91;59;59;60;58;67 20:40:42 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;69;71;78;84;78;71;70;64;74;73 20:40:42 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;86;85;84;81;85;87;85;88;85;85 20:40:42 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;142;142;142;140;144;143;144;150;194;144 20:40:42 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;167;171;163;178;168;166;169;173;167;167 20:40:42 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;69;70;67;68;72;81;87;92;77;68 20:40:42 INFO - PROCESS | 1672 | __end_tp_report 20:40:42 INFO - PROCESS | 1672 | __start_cc_report 20:40:42 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,975 20:40:42 INFO - PROCESS | 1672 | __end_cc_report 20:40:42 INFO - PROCESS | 1672 | __startTimestamp1482381642073__endTimestamp 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | ------- Summary: start ------- 20:40:42 INFO - PROCESS | 1672 | Number of tests: 14 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:117.20 Median:118.50 stddev:4.47 (3.8%) stddev-sans-first:1.33 20:40:42 INFO - PROCESS | 1672 | Values: 105.0 121.0 117.0 118.0 118.0 120.0 118.0 119.0 119.0 117.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:137.00 stddev:24.18 (17.7%) stddev-sans-first:25.41 20:40:42 INFO - PROCESS | 1672 | Values: 139.0 109.0 121.0 179.0 99.0 133.0 149.0 100.0 135.0 132.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:212.30 Median:206.50 stddev:21.85 (10.6%) stddev-sans-first:21.72 20:40:42 INFO - PROCESS | 1672 | Values: 234.0 247.0 204.0 197.0 205.0 194.0 194.0 193.0 208.0 247.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:79.20 Median:80.00 stddev:19.45 (24.3%) stddev-sans-first:20.16 20:40:42 INFO - PROCESS | 1672 | Values: 91.0 50.0 61.0 101.0 88.0 86.0 51.0 74.0 104.0 86.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:71.00 stddev:18.13 (25.5%) stddev-sans-first:19.22 20:40:42 INFO - PROCESS | 1672 | Values: 86.0 71.0 89.0 72.0 71.0 63.0 102.0 100.0 102.0 119.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:101.10 Median:89.00 stddev:22.81 (25.6%) stddev-sans-first:23.83 20:40:42 INFO - PROCESS | 1672 | Values: 90.0 74.0 135.0 130.0 89.0 91.0 135.0 88.0 89.0 90.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:124.00 stddev:23.42 (18.9%) stddev-sans-first:23.84 20:40:42 INFO - PROCESS | 1672 | Values: 94.0 116.0 153.0 122.0 96.0 96.0 96.0 100.0 154.0 100.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:118.40 Median:140.00 stddev:24.69 (17.6%) stddev-sans-first:25.04 20:40:42 INFO - PROCESS | 1672 | Values: 139.0 86.0 78.0 135.0 122.0 140.0 88.0 140.0 133.0 123.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:59.50 stddev:11.83 (19.9%) stddev-sans-first:12.26 20:40:42 INFO - PROCESS | 1672 | Values: 57.0 55.0 56.0 79.0 91.0 59.0 59.0 60.0 58.0 67.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.50 stddev:5.63 (7.7%) stddev-sans-first:5.77 20:40:42 INFO - PROCESS | 1672 | Values: 69.0 71.0 78.0 84.0 78.0 71.0 70.0 64.0 74.0 73.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.85 (2.2%) stddev-sans-first:1.94 20:40:42 INFO - PROCESS | 1672 | Values: 86.0 85.0 84.0 81.0 85.0 87.0 85.0 88.0 85.0 85.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:144.00 stddev:16.20 (11.3%) stddev-sans-first:17.01 20:40:42 INFO - PROCESS | 1672 | Values: 142.0 142.0 142.0 140.0 144.0 143.0 144.0 150.0 194.0 144.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:168.50 stddev:4.20 (2.5%) stddev-sans-first:4.40 20:40:42 INFO - PROCESS | 1672 | Values: 167.0 171.0 163.0 178.0 168.0 166.0 169.0 173.0 167.0 167.0 20:40:42 INFO - PROCESS | 1672 | 20:40:42 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:74.50 stddev:8.85 (11.9%) stddev-sans-first:9.11 20:40:42 INFO - PROCESS | 1672 | Values: 69.0 70.0 67.0 68.0 72.0 81.0 87.0 92.0 77.0 68.0 20:40:42 INFO - PROCESS | 1672 | -------- Summary: end -------- 20:40:42 INFO - PROCESS | 1672 | 20:40:43 INFO - TEST-INFO | 1672: exit 0 20:40:43 INFO - TEST-OK | kraken | took 61411ms 20:40:43 INFO - SUITE-END | took 1178s 20:40:43 INFO - Completed test suite (00:19:38) 20:40:43 INFO - javascript benchmark 20:40:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7034.529203624055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.6911544227887, 3324.0858763839956, 3362.3611513812375, 3372.4941258811177, 3374.342003309354, 5553.278073850399, 5622.072358060915, 5643.661380317184, 5658.236138121347, 5680.630759000662, 4486.923138446774, 4894.97552512237, 5529.142982837657, 5699.259096317483, 5721.113227449741, 5107.208382700678, 5119.59043276537, 5232.215167724853, 5242.18746094356, 5288.65623734456, 4255.425517555122, 5246.370435547739, 5262.236975638531, 5266.131088370415, 5267.157254839227, 5084.949150508484, 5105.974470127663, 5124.743762811863, 5238.895222095556, 5256.132738098209, 5094.847154585368, 5184.429712731597, 5218.112920803473, 5220.112580861262, 5280.735963201863, 4333.674974376934, 5093.439721630618, 5178.14560597501, 5214.739263036833, 5236.293100431431, 5744.655320680772, 5773.711314434261, 5800.245968024172, 5800.941990580082, 5811.418858114197, 6117.480014198798, 6125.143885071339, 6126.79250549526, 6135.601185922946, 6144.494598823272, 6193.2877719062435, 6253.843653908643, 6260.843478913018, 6262.185915830958, 6282.528810339243, 4814.735189564538, 5830.62100963436, 5836.795712150097, 5857.912131318034, 5860.296764388258, 5225.294585230945, 5626.831195064073, 5683.914741278884, 6225.595336303126, 6282.308946015934, 6018.097285407224, 6103.267607887082, 6109.694515274218, 6122.081687746873, 6122.093225952662, 6157.876842463125, 6188.44304012641, 6208.0, 6228.252609686867, 6232.750689972441, 5383.600263931406, 5457.536109430664, 5997.190379298826, 6131.662758548234, 6185.8144255672405, 6139.553468857682, 6227.09707092469, 6235.594686345373, 6239.282482514569, 6247.156633854463, 3627.891163265106, 4833.32333473314, 4932.950670493321, 4949.455559888409, 4960.156773348539, 4332.891677708082, 4334.761588112684, 4405.493368262627, 4445.222086134913, 4452.48796388413, 5601.411851755588, 5771.509421699118, 5830.4461076197695, 5838.12428135783, 5933.554983376264, 6254.499640028786, 6267.749290028439, 6283.43449089575, 6285.465735412449, 6315.336889626615, 5647.887042259132, 5714.828555143353, 5748.367679555246, 5852.063669812809, 5888.116782482576, 5364.0, 5408.91886621701, 5424.403315635277, 5445.401005889349, 5448.264484294569, 6274.466670333073, 6277.748890044439, 6281.057841323838, 6291.150694656163, 6327.90508142369, 6078.665673388006, 6158.661273629993, 6242.687865606792, 6243.875122497434, 6257.405546473078, 6131.101423540661, 6176.474999625082, 6212.316645169119, 6248.968755156195, 6275.874482510233, 6084.756609735561, 6109.419605137505, 6111.174991376285, 6111.96944015277, 6119.082137679384, 6027.427394397525, 6055.212822333068, 6156.659857961449, 6174.166487524307, 6178.196834411498, 5907.409259074058, 6002.639841609517, 6022.698865056817, 6041.18444010053, 6050.42520960508, 4360.694751367374, 4828.806847726051, 5925.881482370414, 6107.603005804608, 6109.920916985209, 4261.91321213101, 5858.7070646468355, 5970.97014514942, 5986.730597123053, 5988.071848863433, 5891.116332550152, 5953.880922381441, 5962.07587823888, 6051.273847138372, 6103.938960610337, 5773.97113014449, 5937.139114828239, 5943.078822782476, 5944.791932282349, 5945.524358051259], "value": 5589.703726513116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.70006296159335, 515.6905856486107, 531.8351311093561, 545.4518209199754, 550.2818821438021, 39497.60502394975, 40967.0, 41113.99999999996, 43208.56791432085, 43244.56755432445, 41321.58678413215, 41964.74105776824, 41976.58023419765, 42061.36907946376, 42068.789656051675, 8014.358851291882, 9309.115634014775, 9372.109649583314, 9399.06009399058, 9410.247180225566, 9260.629574817, 9299.209567186797, 9374.765630859214, 9390.201832844183, 9448.007959164292, 8045.316148127416, 9320.766980825465, 9405.858912116324, 9416.717498475056, 9426.0, 9292.535373231345, 9390.577424015935, 9396.248300135972, 9407.529623518865, 9420.481873496956, 9270.026647202014, 9291.814163716756, 9324.953375233148, 9326.020767819417, 9356.766080847965, 38725.61274387248, 39159.0, 39187.412188817194, 39225.60774392248, 39276.803615981735, 3228.741700663965, 3266.4936934775146, 3339.8163101029436, 3665.21197942441, 3822.445745366906, 28927.0, 29524.409511809645, 29982.55026174609, 30142.698573014208, 30231.69768302333, 3183.1405520509566, 3190.266238765097, 3200.4079245339453, 3226.7418606511424, 3289.703926646613, 416725.0, 419540.0, 420571.0, 422162.88918555516, 422785.0, 59449.10826337608, 59706.0, 59712.0, 59747.0, 59840.70079649574, 62205.68897155485, 62383.6880815593, 62895.6855215721, 62929.05606415907, 63114.0, 15956.042637441791, 16209.946353486986, 16226.756598651029, 16231.837681623269, 16260.674786504203, 12425.254484730945, 12482.687932801753, 12503.812442813365, 12507.312097834525, 12545.059120565811, 16179.43371981975, 17230.741538876926, 17330.046847423262, 17331.913340433217, 17377.13114344303, 7071.7878463646175, 7094.219635840053, 7205.135383753878, 7256.092988376453, 7277.19950805411, 779.4349096904699, 974.2206235011962, 1016.3444578246989, 1068.4978060311641, 1092.9781404371868, 25990.74009259921, 26924.05765798227, 29601.407971840872, 30001.24996875052, 30632.562109797458, 947.5215016416803, 959.0122174160625, 1013.3210748798323, 1092.6339676208559, 1116.558959211107, 13303.211102762278, 13983.44066237339, 15439.30523126462, 15479.148646824307, 15543.834212434112, 666339.0, 668097.0, 670976.0, 671363.0, 671909.0, 56821.0, 56916.0, 57237.0, 57389.0, 57440.0, 1347.7102422979106, 1349.406261245049, 1385.1204485152202, 1386.2098603795941, 1389.5275606293706, 28533.42933141284, 29075.0, 29418.264543386587, 29773.0, 29874.551881721356, 49921.500784993135, 50636.493635063176, 50637.74681126571, 50764.49235507598, 50783.74608126936, 517919.0, 519739.0, 519990.0, 521156.0, 521480.0, 26296.73703262943, 26518.60222096709, 26824.463510730067, 26869.462610747283, 26870.462590747684, 44615.55384446114, 45274.54725452703, 45801.54198457973, 45914.770426147654, 46605.0, 28920.0, 37434.0, 37797.62202377941, 38216.42675359816, 38730.0, 36966.44550331801, 37118.44322335113, 37431.064223394635, 37791.811040944616, 37843.864684059525, 27511.58732618972, 33498.66501334956, 33521.83239083789, 33727.83136084304, 33767.83116084404, 30200.09399718012, 33719.662803371655, 33802.49296260607, 33832.323353533284, 33865.98402047942, 17696.646067078844, 25053.74946250587, 25072.874635626704, 25559.105431309814, 25658.101966431084], "value": 19403.766064681342, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.1759916992577, 377.61106060757413, 388.19643338289734, 388.35726872026805, 404.45398711739136, 18163.636727265446, 19515.5121121972, 20194.596108077847, 20206.39380818574, 20403.183872645113, 18790.15444305006, 19414.0, 19441.51396215095, 19632.60734785307, 19980.900095499503, 4966.85762274677, 5382.4886635769535, 5598.580106492009, 5831.183634291203, 5848.970755146218, 5595.160725891128, 5731.0, 5756.366799652035, 5758.0, 5767.1349297605275, 4790.329353890458, 5535.0571929281405, 5623.26897503326, 5694.117411801178, 5715.571332150084, 5604.467575580334, 5612.719364031823, 5623.49388555028, 5635.6055076144685, 5655.632383895054, 4931.80272789088, 5002.499750025005, 5013.0725815723845, 5211.921821172686, 5275.841724748264, 12290.446929888176, 12602.81095783564, 12850.357482125857, 12931.806022909665, 12958.157719748186, 1835.3943198744516, 1937.447827369193, 2045.877247365148, 2171.9782802172094, 2250.6398976163737, 7407.037085178946, 8301.252887240116, 9773.804523909483, 10147.594096236142, 10217.489125543767, 1517.9544613661608, 1716.7339062445217, 1789.4899953513316, 1818.4726429335476, 1846.9261229550802, 94587.52706236494, 112784.05255816007, 115526.0, 116508.83491165064, 117314.82685173124, 9223.907760922439, 9761.170300524393, 9899.505024748734, 10166.440845753554, 10179.389236645677, 12053.457594408274, 12057.457414416373, 12096.455659495345, 12121.151519393734, 12121.696957575954, 7792.922070779219, 7892.092409372881, 7933.484323518953, 8043.235892590194, 8059.838803223903, 8253.669853205805, 8267.196094643588, 8271.8345633087, 8365.912431384002, 8475.533845638549, 3382.3911695894976, 3735.122246272124, 3804.7336686432236, 3873.3996230584303, 3968.1666849961252, 1895.2229585869727, 1939.776925653568, 1947.1529884500287, 1947.464447276982, 1951.0, 741.8961345411647, 747.3348719639525, 769.3729610367533, 834.2575108153748, 898.8876390451194, 19443.805561944482, 20660.896695516425, 20778.961051947343, 20844.687329690067, 20863.687044694343, 911.7082533589321, 928.6563971330515, 950.7432993091827, 960.8222478841436, 975.8877729061248, 8551.486910785372, 10798.946005269923, 10835.67492975212, 10842.295250808673, 10894.67315980522, 626077.0, 628647.0, 629133.0, 633024.0, 650740.0, 94881.0511894886, 129951.05073423906, 130702.0, 132113.0, 150973.207582817, 954.3128947158035, 970.7670159161751, 993.6571882700457, 995.6963126246419, 1001.5793366785967, 18396.172172252547, 18807.0, 18829.340973066424, 18839.6232075355, 18959.336423225122, 50532.73668158326, 54295.45704543062, 55891.72054139703, 56303.43696562982, 58671.11993320189, 60770.0, 61858.0, 79784.0, 83575.0, 85396.0, 7850.607469626381, 8123.47197432165, 8162.347012239125, 8178.386621003329, 8286.171382861665, 12430.564930227398, 12788.296643684687, 12872.678183045498, 12958.611241662766, 13198.0, 10926.836097458703, 11022.669319920415, 11056.11551075928, 11394.829077564009, 11519.19365644397, 10830.0, 10973.341599504056, 11068.391238481961, 11310.547578096784, 11459.541618335174, 11196.38419886914, 11262.436878155895, 11342.319460832376, 11709.765804683688, 11822.82265765997, 6667.566608170453, 6717.899231511434, 7106.857862842818, 8009.239122283374, 8111.310538604284, 8932.838730964933, 10652.786944261226, 11045.392503412068, 11144.108471322113, 11188.160887933274], "value": 8993.69701063575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.6840789802548, 1374.0656353679497, 1524.954251372459, 1577.3532851530867, 1879.8496120310385, 7447.851042979137, 7654.655540500677, 7656.119546252183, 8139.91860081399, 8264.504129752218, 6088.482478989291, 8208.425410221273, 8254.91745082549, 8333.708320208794, 8356.874646880302, 2284.942876428094, 2327.9534409311805, 2330.0912644068826, 2335.135999680112, 2338.707661542307, 2318.547883162784, 2344.179537161997, 2363.243761996162, 2370.134900761227, 2382.356763673807, 2302.6430903209944, 2319.420144963759, 2334.4630734930975, 2335.8248131390214, 2337.1352599538195, 2293.9885300573555, 2296.4603318220206, 2319.095552734435, 2319.257837492003, 2326.325365643961, 2259.1302348595746, 2317.698699169114, 2324.732655744577, 2328.7205535335697, 2330.196082351586, 8223.42436029478, 8279.710210142677, 8293.792655183608, 8310.0, 8316.667333306661, 4177.665786737054, 5182.870428239286, 5189.0, 5203.089459344599, 5217.243499692523, 3279.8032118072992, 3423.4180189367867, 3512.701420379271, 3593.2633810068874, 3599.748017638766, 1048.5386429970865, 1053.1406157648669, 1086.8315411111291, 1088.3252383522188, 1106.2145876427746, 10785.784284314348, 10810.621628243052, 10886.891131088667, 10892.128629709605, 10919.290246134055, 4481.977590112028, 4611.077784443125, 4667.393238878992, 4677.579017888406, 4740.28895665646, 8472.110428404929, 9295.11696388842, 9390.34267601275, 9397.389169703947, 9450.57472413743, 4975.353204083446, 5189.896202075937, 5213.983273261753, 5215.035218484517, 5217.087009773274, 4252.4046633471335, 4259.253705980533, 4707.411573553306, 4721.622270218374, 4777.546133117348, 3798.506194194737, 3809.4285857121654, 3863.9613603864163, 3885.3589157788647, 3904.2581909437117, 1262.5770366927181, 1267.7084270617809, 1270.4346565778326, 1282.5639282643947, 1282.7755142849965, 802.7792357101844, 881.9338549608805, 888.5868071346855, 900.5857305639348, 911.5305617606938, 5394.460553944574, 5408.729563521887, 5442.755076021588, 5570.693611851387, 5622.297212848394, 820.5938060660012, 882.7042940614966, 948.2224575847877, 956.2350119904049, 962.9374090684083, 3692.3538380783793, 3778.4899038629983, 3879.18537107205, 3884.2425726983533, 3905.7070719696135, 9583.185429238454, 9846.01539846024, 9999.650012249682, 10017.198624110053, 10030.498475076363, 9764.707058788248, 9999.000099989942, 10013.349132306523, 10032.39805611651, 10042.949785251172, 7616.466847320635, 7858.410619203582, 7860.5676687782725, 7867.370610351159, 7867.567283799446, 4737.407824021997, 5398.46015398457, 5417.539509141767, 5488.396276409671, 5605.439456054362, 7673.386129109769, 9296.535173241176, 9370.765730856783, 9436.622535098793, 9445.0, 9293.442393456415, 9406.43561386319, 9475.763105922408, 9527.0, 9644.710658680251, 6230.221222347207, 6398.584092034003, 6559.852025895545, 6591.934080659132, 6801.1158549388265, 7824.452288339761, 8029.638666259915, 8033.799155021171, 8038.477498962548, 8075.384923015303, 6441.613503189824, 7063.894041589278, 7170.462215333767, 7176.712931482891, 7280.526765760209, 6925.445964322741, 6926.515143939876, 6963.547369420971, 6999.825004374931, 7021.719131234898, 6659.53383263167, 6666.500012499179, 6719.395254427125, 6732.899006514808, 6735.393814556714, 4831.492693267156, 4858.951410485991, 4875.19559272716, 4890.6087512998165, 4956.950430495649, 4052.4326594276235, 4745.217039188633, 4788.018456216537, 4946.985867897, 5041.546260836542], "value": 4379.37989458447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.3795813477708, 307.77839955232224, 315.1160993413474, 315.3975906019503, 320.9614846218454, 4319.02821865081, 5210.150396609206, 5297.735113244332, 5340.7863685452585, 5457.5633949284065, 5090.3603923195, 5265.63093595665, 5279.340082489689, 5292.920606190901, 5339.919901201485, 3602.441621548664, 4074.449949256857, 4081.795910204493, 4092.9590704092875, 4096.562545285566, 3958.3270843956598, 4079.4084857695616, 4091.1204091120403, 4099.549049604541, 4118.396403147246, 4011.9197616047663, 4012.899677508071, 4014.799260037001, 4062.756234625917, 4070.0, 3790.5451345838537, 4057.2088442753675, 4060.654844338235, 4068.4304197412384, 4087.591240875918, 2992.925176870574, 3546.7871927684164, 3566.1084728817796, 3576.0523461282783, 3604.8377822998027, 4446.866594002185, 4532.864014079583, 4893.608511319121, 5058.848234552969, 5162.432132465426, 4056.9594304057173, 4242.703010789246, 4429.051217464305, 4609.539046095397, 4625.306204069417, 4597.701149425287, 5486.945130548684, 5537.262347915142, 5547.113981246355, 5617.578681598897, 3763.9435408468894, 3862.4592557042038, 3871.9419208711893, 3904.25819094374, 3940.4680368150507, 5204.4535323791215, 5497.76300332426, 5825.796097136622, 5855.4144585541535, 5867.591777973298, 3184.5541624172633, 3260.02199340197, 3379.5268662387284, 3405.9441573112413, 4048.817803198863, 3172.873085076571, 3352.865885364607, 3873.69010479161, 4016.5581786003518, 4070.409790580349, 3918.843246270117, 4600.125976064537, 4601.688518772134, 4614.123316569841, 4654.488006319302, 4885.0, 5594.342687223536, 5627.352854421794, 5635.5773317001385, 5640.0, 1118.5246270335238, 1149.2185313986402, 1250.9687257818628, 1277.399622177575, 1296.8767967043116, 883.6553744039829, 902.2466240688967, 911.9407238529475, 914.3782228084833, 916.8258030974093, 3804.9048773780323, 4702.858914232578, 4874.073925954058, 4973.52751488608, 5001.4998500149695, 5412.945870541323, 5425.430329815392, 5427.701476418835, 5458.426865179178, 5478.918011155815, 4229.555896630871, 4492.101579684077, 4638.281066434708, 4828.647978566007, 4834.854954351375, 2731.808773385844, 2810.1148138336766, 2835.716428357189, 2840.2615320016944, 2875.3386721054276, 5387.326584176978, 5620.241267428926, 5623.718814059363, 5658.943410565842, 5690.374058853523, 4509.030558429953, 4684.859454216379, 4715.693479923794, 4843.176659967743, 5640.971795140998, 4594.839180628662, 4986.675866068694, 5188.896222075613, 5449.692073902314, 5678.829635110953, 5203.895922081613, 5436.9126174766, 5463.360991702552, 5466.945330546802, 5513.558915286848, 4798.568128868279, 4968.801247950041, 5307.256984022163, 5338.97330513345, 5362.854858056809, 4934.925976110433, 5055.216441451581, 5592.916106258328, 5639.520640745419, 5680.829575112753, 3516.6744903769018, 3766.5856755756295, 3781.773093614392, 3804.505414296124, 3823.9808800955816, 4512.9774351128035, 4539.72761634303, 5231.927454871666, 5564.415736347787, 5793.827314756966, 4795.451365989213, 5327.973360133329, 5483.890322193454, 5737.569682273763, 5738.942610573841, 4987.800487980585, 5223.242629818579, 5692.6299790513485, 5708.51578589578, 5723.3418156912485, 4837.40365679318, 4890.413150421972, 5510.6969116698965, 5533.806316778893, 5580.665160090408, 5680.914786278292, 5686.658800471985, 5687.260656114679, 5689.748255383809, 5702.7718891243885, 5078.441371449064, 5302.920456193083, 5358.446050645269, 5572.972135139298, 5585.0], "value": 3987.8179921247634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.2763842688325, 703.388052394417, 724.0876495615523, 730.5945200413768, 753.1827966656177, 13113.7377252455, 15044.849551504481, 15065.171415572166, 15087.698246035086, 15093.698126037472, 13438.328083595805, 13446.93276533616, 13489.39297731602, 13546.254955977418, 13606.523771667993, 646.4311405962758, 668.0080081079593, 791.6318911706055, 809.5183365897311, 830.0, 781.0861292288008, 789.8973133492638, 793.694427645355, 794.1105961323326, 795.6340083561569, 830.2030051150903, 832.6169961817571, 832.8792325112855, 835.2649668291895, 835.9884539706932, 807.5921659561942, 812.6140083460339, 819.9139090395512, 823.9258466738022, 824.4229039672193, 609.8322961185665, 619.3311223878246, 619.358963472808, 620.3331418724844, 620.6059152438189, 13610.183388996691, 13653.590392288248, 13666.974976876774, 13841.930790346085, 14253.50112746049, 13341.066125371228, 13492.190468571818, 13496.5276215332, 13520.256385898772, 13828.239446830421, 10811.567537298499, 10878.836817447745, 11010.284331518425, 11216.383098929555, 11295.378754168518, 3670.72469564781, 4257.233697934371, 4377.802998865059, 4383.978080109611, 4511.323301504801, 77011.61494192493, 78207.0, 78845.60577197134, 84121.15878841195, 86594.56702716446, 10246.38521688701, 10403.167746580406, 10496.265261431627, 10496.68509944703, 10527.894571070081, 19326.710099348522, 19373.8062619372, 19561.902190488956, 19734.013299334976, 19744.60510789776, 6441.25925518562, 6457.1605691260775, 6465.321141280192, 6580.769673061515, 6599.604023758494, 4089.8568550100604, 4134.64855487287, 4165.708400411942, 4169.124483858423, 4246.129543443587, 3361.09250502363, 3447.517347571342, 3460.463628137643, 3476.3394954958476, 3482.91292717679, 590.5718354193261, 652.425865238587, 653.3629711031801, 655.8524332025352, 669.1167658690579, 539.4928766959046, 576.3919065386058, 592.3070008090544, 597.202734349648, 636.3858876184412, 6668.933310666928, 7731.690732370642, 8035.959820200862, 8684.913150868411, 8755.124487551195, 564.3932772269826, 570.3099249907575, 583.107844997155, 633.56917296239, 641.1142941815649, 3219.7555500124718, 3798.6135060702645, 4355.978220108879, 4469.039156581351, 4472.865814025585, 118196.40901795436, 121251.0, 123025.0, 123996.38001809933, 127359.0, 63955.0, 81785.77321340184, 86135.569322153, 89118.55440722755, 103327.0, 78139.21860781433, 80703.59648201721, 81639.0, 85309.57345213235, 86493.13506864976, 9335.86262377471, 9705.181655747525, 9780.462074585967, 9793.87370452407, 9817.969113243007, 50601.73495662638, 51000.48999510106, 54776.72611637076, 56325.71837140788, 57070.7146464265, 53285.7335713319, 72470.0, 73304.63347683227, 73713.26286737063, 73935.0, 12182.817257740964, 12228.75542489163, 12263.816042759545, 12272.938635306766, 12736.554220602606, 13842.961777866902, 13906.652333691738, 14219.50231741884, 14239.216843073316, 14250.643733906321, 12112.757744844877, 12825.358732063547, 13047.28239946774, 13202.867971320547, 13268.0, 13093.869061309266, 13130.934345328595, 13173.60479185626, 13190.34048297562, 13208.33958302062, 10668.413237272025, 12461.127721059802, 12585.811212831632, 12751.107422480338, 12924.224546527239, 10357.326773759682, 10381.377117372982, 11161.218714689894, 11173.441327933408, 11516.769664606494, 10336.586536538754, 10695.5187016586, 10804.513796879317, 10930.56277748881, 10938.835917461085], "value": 7112.170120742786, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 121.0, 117.0, 118.0, 118.0, 120.0, 118.0, 119.0, 119.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 121.0, 179.0, 99.0, 133.0, 149.0, 100.0, 135.0, 132.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [234.0, 247.0, 204.0, 197.0, 205.0, 194.0, 194.0, 193.0, 208.0, 247.0], "value": 212.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 50.0, 61.0, 101.0, 88.0, 86.0, 51.0, 74.0, 104.0, 86.0], "value": 79.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 89.0, 72.0, 71.0, 63.0, 102.0, 100.0, 102.0, 119.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 74.0, 135.0, 130.0, 89.0, 91.0, 135.0, 88.0, 89.0, 90.0], "value": 101.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 116.0, 153.0, 122.0, 96.0, 96.0, 96.0, 100.0, 154.0, 100.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 86.0, 78.0, 135.0, 122.0, 140.0, 88.0, 140.0, 133.0, 123.0], "value": 118.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 79.0, 91.0, 59.0, 59.0, 60.0, 58.0, 67.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 78.0, 84.0, 78.0, 71.0, 70.0, 64.0, 74.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 81.0, 85.0, 87.0, 85.0, 88.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 142.0, 140.0, 144.0, 143.0, 144.0, 150.0, 194.0, 144.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 163.0, 178.0, 168.0, 166.0, 169.0, 173.0, 167.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 68.0, 72.0, 81.0, 87.0, 92.0, 77.0, 68.0], "value": 75.1, "unit": "score"}]}]} 20:40:43 INFO - Return code: 0 20:40:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:40:43 ERROR - # TBPL SUCCESS # 20:40:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:40:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:40:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:40:43 INFO - 2016-12-21 20:40:43.430 screenresolution[1677:10746] starting screenresolution argv=screenresolution get 20:40:43 INFO - 2016-12-21 20:40:43.433 screenresolution[1677:10746] Display 0: 1600x1200x32@60 20:40:43 INFO - 2016-12-21 20:40:43.439 screenresolution[1678:10749] starting screenresolution argv=screenresolution list 20:40:43 INFO - Available Modes on Display 0 20:40:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:40:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:40:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:40:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:40:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:40:43 INFO - Intel Iris: 20:40:43 INFO - Chipset Model: Intel Iris 20:40:43 INFO - Type: GPU 20:40:43 INFO - Bus: Built-In 20:40:43 INFO - VRAM (Dynamic, Max): 1536 MB 20:40:43 INFO - Vendor: Intel (0x8086) 20:40:43 INFO - Device ID: 0x0a2e 20:40:43 INFO - Revision ID: 0x0009 20:40:43 INFO - Displays: 20:40:43 INFO - Display: 20:40:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:40:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:40:43 INFO - Display Serial Number: 1600x1200 60 20:40:43 INFO - Main Display: Yes 20:40:43 INFO - Mirror: Off 20:40:43 INFO - Online: Yes 20:40:43 INFO - Rotation: Supported 20:40:43 INFO - Return code: 0 20:40:43 INFO - Running post-action listener: _resource_record_post_action 20:40:43 INFO - [mozharness: 2016-12-22 04:40:43.680248Z] Finished run-tests step (success) 20:40:43 INFO - Running post-run listener: _resource_record_post_run 20:40:43 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38717952; Write bytes: 660815872; Read time: 250; Write time: 1960 20:40:43 INFO - TinderboxPrint: CPU usage
54.6% 20:40:43 INFO - TinderboxPrint: I/O read bytes / time
38,717,952 / 250 20:40:43 INFO - TinderboxPrint: I/O write bytes / time
660,815,872 / 1,960 20:40:43 INFO - TinderboxPrint: CPU idle
2,200.9 (45.4%) 20:40:43 INFO - TinderboxPrint: CPU system
982.6 (20.3%) 20:40:43 INFO - TinderboxPrint: CPU user
1,662.2 (34.3%) 20:40:43 INFO - TinderboxPrint: Swap in / out
386,957,312 / 0 20:40:43 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 336357888; Write bytes: 333477376; Read time: 26361; Write time: 693 20:40:43 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 37755392; Write bytes: 309643776; Read time: 239; Write time: 1210 20:40:44 INFO - Running post-run listener: _upload_blobber_files 20:40:44 INFO - Blob upload gear active. 20:40:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:44 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 20:40:44 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'] 20:40:44 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 20:40:44 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:45 INFO - (blobuploader) - INFO - Done attempting. 20:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:46 INFO - (blobuploader) - INFO - Done attempting. 20:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:48 INFO - (blobuploader) - INFO - Done attempting. 20:40:48 INFO - (blobuploader) - INFO - Iteration through files over. 20:40:48 INFO - Return code: 0 20:40:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:40:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:40:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/244ee8e3f3fc040fb90caa39ce76531bf9c973d6e917527e6aaf7987bed07e5e10bed61c779f35679b5f1489aed1ddf8cc5bef19d92ed583760ff26e771cc8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4582ffb6ffa9f47b9f7cb495227202ad1235d4a3ce4e6969cc888d4125e2e807d12ad53f4f0f0f1e4916078077072aa469e669ddebfa69e71eeeb5cad42c83cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6e9465cab3416e08812a1f2ca12f7681cc2da05c30c6e126b9121a534a624e8b733e87b378e06d783a7fab809a4691e376faf1f88838e8cdd436b30769153c"} 20:40:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:40:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:40:48 INFO - Contents: 20:40:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/244ee8e3f3fc040fb90caa39ce76531bf9c973d6e917527e6aaf7987bed07e5e10bed61c779f35679b5f1489aed1ddf8cc5bef19d92ed583760ff26e771cc8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4582ffb6ffa9f47b9f7cb495227202ad1235d4a3ce4e6969cc888d4125e2e807d12ad53f4f0f0f1e4916078077072aa469e669ddebfa69e71eeeb5cad42c83cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6e9465cab3416e08812a1f2ca12f7681cc2da05c30c6e126b9121a534a624e8b733e87b378e06d783a7fab809a4691e376faf1f88838e8cdd436b30769153c"} 20:40:48 INFO - Running post-run listener: copy_logs_to_upload_dir 20:40:48 INFO - Copying logs to upload dir... 20:40:48 INFO - mkdir: /builds/slave/test/build/upload/logs 20:40:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.543514 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-21 20:40:48.792895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 20:40:48.796877) ========= 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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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/244ee8e3f3fc040fb90caa39ce76531bf9c973d6e917527e6aaf7987bed07e5e10bed61c779f35679b5f1489aed1ddf8cc5bef19d92ed583760ff26e771cc8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4582ffb6ffa9f47b9f7cb495227202ad1235d4a3ce4e6969cc888d4125e2e807d12ad53f4f0f0f1e4916078077072aa469e669ddebfa69e71eeeb5cad42c83cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6e9465cab3416e08812a1f2ca12f7681cc2da05c30c6e126b9121a534a624e8b733e87b378e06d783a7fab809a4691e376faf1f88838e8cdd436b30769153c"} build_url:https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/dA1qSNKTTfu9PjQ9sKhVwQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/244ee8e3f3fc040fb90caa39ce76531bf9c973d6e917527e6aaf7987bed07e5e10bed61c779f35679b5f1489aed1ddf8cc5bef19d92ed583760ff26e771cc8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4582ffb6ffa9f47b9f7cb495227202ad1235d4a3ce4e6969cc888d4125e2e807d12ad53f4f0f0f1e4916078077072aa469e669ddebfa69e71eeeb5cad42c83cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6e9465cab3416e08812a1f2ca12f7681cc2da05c30c6e126b9121a534a624e8b733e87b378e06d783a7fab809a4691e376faf1f88838e8cdd436b30769153c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 20:40:48.831095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:40:48.831385) ========= 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.Cp8XEV0pr1/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.Hn953XEsbt/Listeners TMPDIR=/var/folders/hh/jpj4h4js6sldqzcr1hnmqmnh00000w/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.005051 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 20:40:48.880377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 20:40:48.880694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 20:40:48.881012) ========= ========= Total master_lag: 0.18 =========