builder: graphics_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0352 starttime: 1484085488.03 results: success (0) buildid: 20170110113605 builduid: bbdcd4a9b195478db67edad459f2168c revision: dde7452acab4b3256784f0cf260d2d9243fdef73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.026967) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.027454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.027769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.053215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.053853) ========= 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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-10 13:58:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.05M=0.001s 2017-01-10 13:58:08 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.178914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.179297) ========= 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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.021500 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.228782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:08.229294) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev dde7452acab4b3256784f0cf260d2d9243fdef73 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev dde7452acab4b3256784f0cf260d2d9243fdef73 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-10 13:58:08,316 truncating revision to first 12 chars 2017-01-10 13:58:08,316 Setting DEBUG logging. 2017-01-10 13:58:08,316 attempt 1/10 2017-01-10 13:58:08,316 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/dde7452acab4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 13:58:09,020 unpacking tar archive at: graphics-dde7452acab4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.960734 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:09.223687) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:09.224057) ========= script_repo_revision: dde7452acab4b3256784f0cf260d2d9243fdef73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:09.224511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:09.224817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 13:58:09.244964) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-10 13:58:09.245470) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:09 INFO - MultiFileLogger online at 20170110 13:58:09 in /builds/slave/test 13:58:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 13:58:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:09 INFO - {'append_to_log': False, 13:58:09 INFO - 'base_work_dir': '/builds/slave/test', 13:58:09 INFO - 'blob_upload_branch': 'Graphics', 13:58:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:09 INFO - 'branch': 'Graphics', 13:58:09 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:09 INFO - 'config_files': ('talos/mac_config.py',), 13:58:09 INFO - 'default_actions': ('clobber', 13:58:09 INFO - 'read-buildbot-config', 13:58:09 INFO - 'download-and-extract', 13:58:09 INFO - 'populate-webroot', 13:58:09 INFO - 'create-virtualenv', 13:58:09 INFO - 'install', 13:58:09 INFO - 'run-tests'), 13:58:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:09 INFO - 'download_minidump_stackwalk': True, 13:58:09 INFO - 'download_symbols': 'ondemand', 13:58:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:09 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:09 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:09 INFO - 'installer_path': 'installer.exe', 13:58:09 INFO - 'log_level': 'info', 13:58:09 INFO - 'log_name': 'talos', 13:58:09 INFO - 'log_to_console': True, 13:58:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:58:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:58:09 INFO - 'opt_config_files': (), 13:58:09 INFO - 'pip_index': False, 13:58:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:09 INFO - 'cmd': ('bash', 13:58:09 INFO - '-c', 13:58:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:09 INFO - 'enabled': True, 13:58:09 INFO - 'halt_on_failure': False, 13:58:09 INFO - 'name': 'check_screen_resolution'},), 13:58:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:58:09 INFO - 'cmd': ('bash', 13:58:09 INFO - '-c', 13:58:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:58:09 INFO - 'enabled': True, 13:58:09 INFO - 'halt_on_failure': False, 13:58:09 INFO - 'name': 'check_screen_resolution'},), 13:58:09 INFO - 'run_cmd_checks_enabled': True, 13:58:09 INFO - 'sps_profile': False, 13:58:09 INFO - 'sps_profile_interval': 0, 13:58:09 INFO - 'suite': 'dromaeojs-e10s', 13:58:09 INFO - 'system_bits': '32', 13:58:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:09 INFO - 'title': 't-yosemite-r7-0352', 13:58:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:09 INFO - 'use_talos_json': True, 13:58:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:09 INFO - 'work_dir': 'build'} 13:58:09 INFO - [mozharness: 2017-01-10 21:58:09.452763Z] Running clobber step. 13:58:09 INFO - Running pre-action listener: _resource_record_pre_action 13:58:09 INFO - Running main action method: clobber 13:58:09 INFO - rmtree: /builds/slave/test/build 13:58:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:11 INFO - Running post-action listener: _resource_record_post_action 13:58:11 INFO - [mozharness: 2017-01-10 21:58:11.558328Z] Finished clobber step (success) 13:58:11 INFO - [mozharness: 2017-01-10 21:58:11.558461Z] Running read-buildbot-config step. 13:58:11 INFO - Running pre-action listener: _resource_record_pre_action 13:58:11 INFO - Running main action method: read_buildbot_config 13:58:11 INFO - Using buildbot properties: 13:58:11 INFO - { 13:58:11 INFO - "project": "", 13:58:11 INFO - "product": "firefox", 13:58:11 INFO - "script_repo_revision": "default", 13:58:11 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs-e10s", 13:58:11 INFO - "repository": "", 13:58:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs-e10s", 13:58:11 INFO - "buildid": "20170110113605", 13:58:11 INFO - "pgo_build": "False", 13:58:11 INFO - "basedir": "/builds/slave/test", 13:58:11 INFO - "buildnumber": 1, 13:58:11 INFO - "slavename": "t-yosemite-r7-0352", 13:58:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 13:58:11 INFO - "platform": "yosemite_r7", 13:58:11 INFO - "scheduler": "tests-graphics-macosx64-talos-8-3600", 13:58:11 INFO - "branch": "graphics", 13:58:11 INFO - "repo_path": "projects/graphics", 13:58:11 INFO - "revision": "dde7452acab4b3256784f0cf260d2d9243fdef73", 13:58:11 INFO - "stage_platform": "macosx64", 13:58:11 INFO - "builduid": "bbdcd4a9b195478db67edad459f2168c", 13:58:11 INFO - "slavebuilddir": "test" 13:58:11 INFO - } 13:58:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 13:58:11 INFO - Running post-action listener: _resource_record_post_action 13:58:11 INFO - [mozharness: 2017-01-10 21:58:11.561757Z] Finished read-buildbot-config step (success) 13:58:11 INFO - [mozharness: 2017-01-10 21:58:11.561875Z] Running download-and-extract step. 13:58:11 INFO - Running pre-action listener: _resource_record_pre_action 13:58:11 INFO - Running main action method: download_and_extract 13:58:11 INFO - mkdir: /builds/slave/test/build/tests 13:58: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')]} 13:58:11 INFO - trying https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 13:58:11 INFO - Downloading https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 13:58:12 INFO - Downloaded 1199 bytes. 13:58:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 13:58:12 INFO - Using the following test package requirements: 13:58:12 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:58:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 13:58:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 13:58:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'jsshell-mac.zip'], 13:58:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 13:58:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 13:58:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 13:58:12 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 13:58:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 13:58:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 13:58:12 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 13:58:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:58:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:58:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:58:12 INFO - Fetch https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:58:13 INFO - Expected file size: 16309970 13:58:13 INFO - Obtained file size: 16309970 13:58:20 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:58:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 13:58:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:58:20 INFO - Fetch https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 13:58:20 INFO - Expected file size: 16309970 13:58:20 INFO - Obtained file size: 16309970 13:58:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 13:58:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:58:27 INFO - Fetch https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 13:58:28 INFO - Expected file size: 14403529 13:58:28 INFO - Obtained file size: 14403529 13:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:28 INFO - trying https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:58:28 INFO - Downloading https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 13:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 13:58:30 INFO - Downloaded 69874190 bytes. 13:58:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:58:30 INFO - mkdir: /builds/slave/test/properties 13:58:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:58:30 INFO - Writing to file /builds/slave/test/properties/build_url 13:58:30 INFO - Contents: 13:58:30 INFO - build_url:https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 13:58:31 INFO - Running post-action listener: _resource_record_post_action 13:58:31 INFO - Running post-action listener: set_extra_try_arguments 13:58:31 INFO - [mozharness: 2017-01-10 21:58:31.443973Z] Finished download-and-extract step (success) 13:58:31 INFO - [mozharness: 2017-01-10 21:58:31.444074Z] Running populate-webroot step. 13:58:31 INFO - Running pre-action listener: _resource_record_pre_action 13:58:31 INFO - Running main action method: populate_webroot 13:58:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:31 INFO - '--tppagecycles', 13:58:31 INFO - '7'], 13:58:31 INFO - 'tests': ['tsvgm']}}, 13:58:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:58:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:58:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:58:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['damp', 'tps']}, 13:58:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'tests': ['damp', 'tps']}, 13:58:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['dromaeo_dom']}, 13:58:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['basic_compositor_video']}, 13:58:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:58:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['a11yr', 13:58:31 INFO - 'ts_paint', 13:58:31 INFO - 'tpaint', 13:58:31 INFO - 'sessionrestore', 13:58:31 INFO - 'sessionrestore_no_auto_restore', 13:58:31 INFO - 'tabpaint']}, 13:58:31 INFO - 'other-e10s': {'tests': ['a11yr', 13:58:31 INFO - 'ts_paint', 13:58:31 INFO - 'tpaint', 13:58:31 INFO - 'sessionrestore', 13:58:31 INFO - 'sessionrestore_no_auto_restore', 13:58:31 INFO - 'tabpaint']}, 13:58:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:58:31 INFO - 'ts_paint', 13:58:31 INFO - 'tpaint', 13:58:31 INFO - 'sessionrestore', 13:58:31 INFO - 'sessionrestore_no_auto_restore', 13:58:31 INFO - 'tabpaint']}, 13:58:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:58:31 INFO - 'ts_paint', 13:58:31 INFO - 'tpaint', 13:58:31 INFO - 'sessionrestore', 13:58:31 INFO - 'sessionrestore_no_auto_restore', 13:58:31 INFO - 'tabpaint']}, 13:58:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['a11yr', 13:58:31 INFO - 'ts_paint', 13:58:31 INFO - 'tpaint', 13:58:31 INFO - 'sessionrestore', 13:58:31 INFO - 'sessionrestore_no_auto_restore', 13:58:31 INFO - 'tabpaint']}, 13:58:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['a11yr', 13:58:31 INFO - 'ts_paint', 13:58:31 INFO - 'tpaint', 13:58:31 INFO - 'sessionrestore', 13:58:31 INFO - 'sessionrestore_no_auto_restore', 13:58:31 INFO - 'tabpaint']}, 13:58:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['tsvgx', 13:58:31 INFO - 'tsvgr_opacity', 13:58:31 INFO - 'tart', 13:58:31 INFO - 'tscrollx', 13:58:31 INFO - 'cart', 13:58:31 INFO - 'tsvg_static']}, 13:58:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:58:31 INFO - 'tsvgr_opacity', 13:58:31 INFO - 'tart', 13:58:31 INFO - 'tscrollx', 13:58:31 INFO - 'cart', 13:58:31 INFO - 'tsvg_static']}, 13:58:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'talos_options': ['--disable-e10s'], 13:58:31 INFO - 'tests': ['tp5o']}, 13:58:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:58:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'talos_options': ['--disable-e10s', 13:58:31 INFO - '--xperf_path', 13:58:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:31 INFO - 'tests': ['tp5n']}, 13:58:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:58:31 INFO - 'talos_options': ['--xperf_path', 13:58:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:31 INFO - 'tests': ['tp5n']}}, 13:58:31 INFO - 'talos.zip': {'path': '', 13:58:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:31 INFO - Running post-action listener: _resource_record_post_action 13:58:31 INFO - [mozharness: 2017-01-10 21:58:31.462258Z] Finished populate-webroot step (success) 13:58:31 INFO - [mozharness: 2017-01-10 21:58:31.462364Z] Running create-virtualenv step. 13:58:31 INFO - Running pre-action listener: _resource_record_pre_action 13:58:31 INFO - Running main action method: create_virtualenv 13:58:31 INFO - Creating virtualenv /builds/slave/test/build/venv 13:58:31 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 13:58:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:58:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:31 INFO - Using real prefix '/tools/python27' 13:58:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:58:32 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:35 INFO - Installing pip.................done. 13:58:35 INFO - Return code: 0 13:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:58:35 INFO - Reading from file tmpfile_stdout 13:58:35 INFO - Output received: 13:58:35 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) 13:58:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:58:35 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')]} 13:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:35 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')]} 13:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:35 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:35 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 13:58:35 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 13:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:35 INFO - 'HOME': '/Users/cltbld', 13:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:35 INFO - 'LOGNAME': 'cltbld', 13:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:35 INFO - 'MOZ_NO_REMOTE': '1', 13:58:35 INFO - 'NO_EM_RESTART': '1', 13:58:35 INFO - 'PAGER': '/bin/cat', 13:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:35 INFO - 'PWD': '/builds/slave/test', 13:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:35 INFO - 'SHELL': '/bin/bash', 13:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:35 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:35 INFO - 'USER': 'cltbld', 13:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:35 INFO - 'XPC_FLAGS': '0x0', 13:58:35 INFO - 'XPC_SERVICE_NAME': '0', 13:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:35 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 13:58:35 INFO - Cleaning up... 13:58:35 INFO - Return code: 0 13:58:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:58:35 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')]} 13:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:35 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')]} 13:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:35 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:35 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 13:58:35 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 13:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:35 INFO - 'HOME': '/Users/cltbld', 13:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:35 INFO - 'LOGNAME': 'cltbld', 13:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:35 INFO - 'MOZ_NO_REMOTE': '1', 13:58:35 INFO - 'NO_EM_RESTART': '1', 13:58:35 INFO - 'PAGER': '/bin/cat', 13:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:35 INFO - 'PWD': '/builds/slave/test', 13:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:35 INFO - 'SHELL': '/bin/bash', 13:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:35 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:35 INFO - 'USER': 'cltbld', 13:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:35 INFO - 'XPC_FLAGS': '0x0', 13:58:35 INFO - 'XPC_SERVICE_NAME': '0', 13:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:35 INFO - Downloading/unpacking psutil>=3.1.1 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:39 INFO - Installing collected packages: psutil 13:58:39 INFO - Running setup.py install for psutil 13:58:39 INFO - building 'psutil._psutil_osx' extension 13:58:39 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 13:58:39 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 13:58:39 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 13:58:39 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 13:58:39 INFO - building 'psutil._psutil_posix' extension 13:58:39 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 13:58:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:58:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:58:39 INFO - ^ 13:58:39 INFO - 1 warning generated. 13:58:39 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 13:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:40 INFO - Successfully installed psutil 13:58:40 INFO - Cleaning up... 13:58:40 INFO - Return code: 0 13:58:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:58:40 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')]} 13:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:40 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')]} 13:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:40 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:40 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 13:58:40 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 13:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:40 INFO - 'HOME': '/Users/cltbld', 13:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:40 INFO - 'LOGNAME': 'cltbld', 13:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:40 INFO - 'MOZ_NO_REMOTE': '1', 13:58:40 INFO - 'NO_EM_RESTART': '1', 13:58:40 INFO - 'PAGER': '/bin/cat', 13:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:40 INFO - 'PWD': '/builds/slave/test', 13:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:40 INFO - 'SHELL': '/bin/bash', 13:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:40 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:40 INFO - 'USER': 'cltbld', 13:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:40 INFO - 'XPC_FLAGS': '0x0', 13:58:40 INFO - 'XPC_SERVICE_NAME': '0', 13:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 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 13:58:40 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 13:58:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:58:43 INFO - Installing collected packages: mozsystemmonitor 13:58:43 INFO - Running setup.py install for mozsystemmonitor 13:58:43 INFO - Successfully installed mozsystemmonitor 13:58:43 INFO - Cleaning up... 13:58:43 INFO - Return code: 0 13:58:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:43 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 13:58:43 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 13:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:43 INFO - 'HOME': '/Users/cltbld', 13:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:43 INFO - 'LOGNAME': 'cltbld', 13:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:43 INFO - 'MOZ_NO_REMOTE': '1', 13:58:43 INFO - 'NO_EM_RESTART': '1', 13:58:43 INFO - 'PAGER': '/bin/cat', 13:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:43 INFO - 'PWD': '/builds/slave/test', 13:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:43 INFO - 'SHELL': '/bin/bash', 13:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:43 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:43 INFO - 'USER': 'cltbld', 13:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:43 INFO - 'XPC_FLAGS': '0x0', 13:58:43 INFO - 'XPC_SERVICE_NAME': '0', 13:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:43 INFO - Downloading/unpacking jsonschema==2.5.1 13:58:43 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 13:58:43 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 13:58:43 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 13:58:43 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 13:58:43 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 13:58:43 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 13:58:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:58:46 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 13:58:46 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 13:58:46 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 13:58:46 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 13:58:46 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 13:58:46 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 13:58:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:46 INFO - warning: no files found matching '*.txt' 13:58:46 INFO - no previously-included directories found matching 'build' 13:58:46 INFO - no previously-included directories found matching 'dist' 13:58:46 INFO - no previously-included directories found matching '.git*' 13:58:46 INFO - Installing collected packages: jsonschema, functools32 13:58:46 INFO - Running setup.py install for functools32 13:58:46 INFO - warning: no files found matching '*.txt' 13:58:46 INFO - no previously-included directories found matching 'build' 13:58:46 INFO - no previously-included directories found matching 'dist' 13:58:46 INFO - no previously-included directories found matching '.git*' 13:58:47 INFO - Successfully installed jsonschema functools32 13:58:47 INFO - Cleaning up... 13:58:47 INFO - Return code: 0 13:58:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:58:47 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')]} 13:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:47 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')]} 13:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:47 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:47 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 13:58:47 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 13:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:47 INFO - 'HOME': '/Users/cltbld', 13:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:47 INFO - 'LOGNAME': 'cltbld', 13:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:47 INFO - 'MOZ_NO_REMOTE': '1', 13:58:47 INFO - 'NO_EM_RESTART': '1', 13:58:47 INFO - 'PAGER': '/bin/cat', 13:58:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:47 INFO - 'PWD': '/builds/slave/test', 13:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:47 INFO - 'SHELL': '/bin/bash', 13:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:47 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:47 INFO - 'USER': 'cltbld', 13:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:47 INFO - 'XPC_FLAGS': '0x0', 13:58:47 INFO - 'XPC_SERVICE_NAME': '0', 13:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:58:47 INFO - Cleaning up... 13:58:47 INFO - Return code: 0 13:58:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:58:47 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')]} 13:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:47 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')]} 13:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:47 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:47 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 13:58:47 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 13:58:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:47 INFO - 'HOME': '/Users/cltbld', 13:58:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:47 INFO - 'LOGNAME': 'cltbld', 13:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:47 INFO - 'MOZ_NO_REMOTE': '1', 13:58:47 INFO - 'NO_EM_RESTART': '1', 13:58:47 INFO - 'PAGER': '/bin/cat', 13:58:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:47 INFO - 'PWD': '/builds/slave/test', 13:58:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:47 INFO - 'SHELL': '/bin/bash', 13:58:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:47 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:47 INFO - 'USER': 'cltbld', 13:58:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:47 INFO - 'XPC_FLAGS': '0x0', 13:58:47 INFO - 'XPC_SERVICE_NAME': '0', 13:58:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:58:47 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 13:58:47 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 13:58:47 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 13:58:47 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 13:58:47 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 13:58:47 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 13:58:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:58:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:58:50 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 13:58:50 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 13:58:50 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 13:58:50 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 13:58:50 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 13:58:50 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 13:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:58:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58:51 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 13:58:51 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 13:58:51 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 13:58:51 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 13:58:51 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 13:58:51 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 13:58:51 INFO - Downloading docopt-0.6.1.tar.gz 13:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:51 INFO - Running setup.py install for blobuploader 13:58:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:58:51 INFO - Running setup.py install for requests 13:58:52 INFO - Running setup.py install for docopt 13:58:52 INFO - Successfully installed blobuploader requests docopt 13:58:52 INFO - Cleaning up... 13:58:52 INFO - Return code: 0 13:58:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:52 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:52 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 13:58:52 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 13:58:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:52 INFO - 'HOME': '/Users/cltbld', 13:58:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:52 INFO - 'LOGNAME': 'cltbld', 13:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:52 INFO - 'MOZ_NO_REMOTE': '1', 13:58:52 INFO - 'NO_EM_RESTART': '1', 13:58:52 INFO - 'PAGER': '/bin/cat', 13:58:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:52 INFO - 'PWD': '/builds/slave/test', 13:58:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:52 INFO - 'SHELL': '/bin/bash', 13:58:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:52 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:52 INFO - 'USER': 'cltbld', 13:58:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:52 INFO - 'XPC_FLAGS': '0x0', 13:58:52 INFO - 'XPC_SERVICE_NAME': '0', 13:58:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:52 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-r51Xv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:52 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-XRC14I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:52 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ZFR70B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:52 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-RTllfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-gezNV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Z_vi6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-PYFbiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-rSHU_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-jwSZW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-M83ZVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-rQWnJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-6GirGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:53 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-MijsiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:54 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-SBFC5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:54 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-YgnWgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:54 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-WRNtjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:54 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-N3mLdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:54 INFO - Running setup.py install for manifestparser 13:58:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:58:54 INFO - Running setup.py install for mozcrash 13:58:54 INFO - Running setup.py install for mozdebug 13:58:54 INFO - Running setup.py install for mozdevice 13:58:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Running setup.py install for mozfile 13:58:55 INFO - Running setup.py install for mozhttpd 13:58:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Running setup.py install for mozinfo 13:58:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Running setup.py install for mozInstall 13:58:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Running setup.py install for mozleak 13:58:55 INFO - Running setup.py install for mozlog 13:58:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:58:55 INFO - Running setup.py install for moznetwork 13:58:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:56 INFO - Running setup.py install for mozprocess 13:58:56 INFO - Running setup.py install for mozprofile 13:58:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:56 INFO - Running setup.py install for mozrunner 13:58:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:56 INFO - Running setup.py install for mozscreenshot 13:58:56 INFO - Running setup.py install for moztest 13:58:56 INFO - Running setup.py install for mozversion 13:58:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:56 INFO - Cleaning up... 13:58:57 INFO - Return code: 0 13:58:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:57 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')]} 13:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:57 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')]} 13:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:57 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:58:57 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 13:58:57 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 13:58:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:58:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:58:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:58:57 INFO - 'HOME': '/Users/cltbld', 13:58:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:58:57 INFO - 'LOGNAME': 'cltbld', 13:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:57 INFO - 'MOZ_NO_REMOTE': '1', 13:58:57 INFO - 'NO_EM_RESTART': '1', 13:58:57 INFO - 'PAGER': '/bin/cat', 13:58:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:57 INFO - 'PWD': '/builds/slave/test', 13:58:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:58:57 INFO - 'SHELL': '/bin/bash', 13:58:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:58:57 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:58:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:58:57 INFO - 'USER': 'cltbld', 13:58:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:58:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:57 INFO - 'XPC_FLAGS': '0x0', 13:58:57 INFO - 'XPC_SERVICE_NAME': '0', 13:58:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-NPE8hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:57 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)) 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-QTIQuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:57 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)) 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-tYqz58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:57 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)) 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-mG4izA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ty0feV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:57 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)) 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-PkfYpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:57 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)) 13:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:57 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-jiQSWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-gf_m1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-BpMUBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-MoGMAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-hEmpoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-2XOeP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-xi5Rxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-cK8UzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-5HX02m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:58 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)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-QgvxAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:58 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-bw6Zn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:59 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)) 13:58:59 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)) 13:58:59 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)) 13:58:59 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)) 13:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:59 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 13:58:59 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 13:58:59 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 13:58:59 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 13:58:59 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 13:58:59 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 13:59:01 INFO - Downloading blessings-1.6.tar.gz 13:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:59:01 INFO - Installing collected packages: blessings 13:59:01 INFO - Running setup.py install for blessings 13:59:01 INFO - Successfully installed blessings 13:59:01 INFO - Cleaning up... 13:59:02 INFO - Return code: 0 13:59:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:59:02 INFO - Reading from file tmpfile_stdout 13:59:02 INFO - Current package versions: 13:59:02 INFO - blessings == 1.6 13:59:02 INFO - blobuploader == 1.2.4 13:59:02 INFO - docopt == 0.6.1 13:59:02 INFO - functools32 == 3.2.3-2 13:59:02 INFO - jsonschema == 2.5.1 13:59:02 INFO - manifestparser == 1.1 13:59:02 INFO - mozInstall == 1.12 13:59:02 INFO - mozcrash == 1.0 13:59:02 INFO - mozdebug == 0.1 13:59:02 INFO - mozdevice == 0.49 13:59:02 INFO - mozfile == 1.2 13:59:02 INFO - mozhttpd == 0.7 13:59:02 INFO - mozinfo == 0.9 13:59:02 INFO - mozleak == 0.1 13:59:02 INFO - mozlog == 3.4 13:59:02 INFO - moznetwork == 0.27 13:59:02 INFO - mozprocess == 0.24 13:59:02 INFO - mozprofile == 0.28 13:59:02 INFO - mozrunner == 6.13 13:59:02 INFO - mozscreenshot == 0.1 13:59:02 INFO - mozsystemmonitor == 0.3 13:59:02 INFO - moztest == 0.8 13:59:02 INFO - mozversion == 1.4 13:59:02 INFO - psutil == 3.1.1 13:59:02 INFO - requests == 1.2.3 13:59:02 INFO - wsgiref == 0.1.2 13:59:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:59: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')]} 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:02 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 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:59:02 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 13:59:02 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 13:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:02 INFO - 'HOME': '/Users/cltbld', 13:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:02 INFO - 'LOGNAME': 'cltbld', 13:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:02 INFO - 'MOZ_NO_REMOTE': '1', 13:59:02 INFO - 'NO_EM_RESTART': '1', 13:59:02 INFO - 'PAGER': '/bin/cat', 13:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:02 INFO - 'PWD': '/builds/slave/test', 13:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:02 INFO - 'SHELL': '/bin/bash', 13:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:59:02 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:02 INFO - 'USER': 'cltbld', 13:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:02 INFO - 'XPC_FLAGS': '0x0', 13:59:02 INFO - 'XPC_SERVICE_NAME': '0', 13:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 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)) 13:59:02 INFO - Cleaning up... 13:59:02 INFO - Return code: 0 13:59:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:59: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')]} 13:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ad4db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad50768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf6156b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, '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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 13:59: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', 'jsonschema'] in /builds/slave/test/build 13:59: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 jsonschema 13:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:02 INFO - 'HOME': '/Users/cltbld', 13:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:02 INFO - 'LOGNAME': 'cltbld', 13:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:02 INFO - 'MOZ_NO_REMOTE': '1', 13:59:02 INFO - 'NO_EM_RESTART': '1', 13:59:02 INFO - 'PAGER': '/bin/cat', 13:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:02 INFO - 'PWD': '/builds/slave/test', 13:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:02 INFO - 'SHELL': '/bin/bash', 13:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:59:02 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:02 INFO - 'USER': 'cltbld', 13:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:02 INFO - 'XPC_FLAGS': '0x0', 13:59:02 INFO - 'XPC_SERVICE_NAME': '0', 13:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:59:02 INFO - Cleaning up... 13:59:02 INFO - Return code: 0 13:59:02 INFO - Running post-action listener: _resource_record_post_action 13:59:02 INFO - Running post-action listener: _start_resource_monitoring 13:59:02 INFO - Starting resource monitoring. 13:59:02 INFO - [mozharness: 2017-01-10 21:59:02.850381Z] Finished create-virtualenv step (success) 13:59:02 INFO - [mozharness: 2017-01-10 21:59:02.851361Z] Running install step. 13:59:02 INFO - Running pre-action listener: _resource_record_pre_action 13:59:02 INFO - Running main action method: install 13:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:59:03 INFO - Reading from file tmpfile_stdout 13:59:03 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:59:03 INFO - Reading from file tmpfile_stdout 13:59:03 INFO - Output received: 13:59:03 INFO - Usage: mozinstall [options] installer 13:59:03 INFO - Options: 13:59:03 INFO - -h, --help show this help message and exit 13:59:03 INFO - -d DEST, --destination=DEST 13:59:03 INFO - Directory to install application into. [default: 13:59:03 INFO - "/builds/slave/test"] 13:59:03 INFO - --app=APP Application being installed. [default: firefox] 13:59:03 INFO - mkdir: /builds/slave/test/build/application 13:59:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:59:24 INFO - Reading from file tmpfile_stdout 13:59:24 INFO - Output received: 13:59:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:59:24 INFO - Running post-action listener: _resource_record_post_action 13:59:24 INFO - [mozharness: 2017-01-10 21:59:24.873979Z] Finished install step (success) 13:59:24 INFO - [mozharness: 2017-01-10 21:59:24.874125Z] Running run-tests step. 13:59:24 INFO - Running pre-action listener: _resource_record_pre_action 13:59:24 INFO - Running main action method: run_tests 13:59:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:59:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:59:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:59:24 INFO - 2017-01-10 13:59:24.888 screenresolution[1954:10523] starting screenresolution argv=screenresolution get 13:59:24 INFO - 2017-01-10 13:59:24.891 screenresolution[1954:10523] Display 0: 1600x1200x32@60 13:59:24 INFO - 2017-01-10 13:59:24.897 screenresolution[1955:10526] starting screenresolution argv=screenresolution list 13:59:24 INFO - Available Modes on Display 0 13:59:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:59:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:59:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:59:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:59:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:59:25 INFO - Intel Iris: 13:59:25 INFO - Chipset Model: Intel Iris 13:59:25 INFO - Type: GPU 13:59:25 INFO - Bus: Built-In 13:59:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:59:25 INFO - Vendor: Intel (0x8086) 13:59:25 INFO - Device ID: 0x0a2e 13:59:25 INFO - Revision ID: 0x0009 13:59:25 INFO - Displays: 13:59:25 INFO - Display: 13:59:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:59:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:59:25 INFO - Display Serial Number: 1600x1200 60 13:59:25 INFO - Main Display: Yes 13:59:25 INFO - Mirror: Off 13:59:25 INFO - Online: Yes 13:59:25 INFO - Rotation: Supported 13:59:25 INFO - Return code: 0 13:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:59:25 INFO - Python 2.7.3 13:59:25 INFO - Return code: 0 13:59:25 INFO - grabbing minidump binary from tooltool 13:59:25 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')]} 13:59:25 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 0x10ab2bd30>, '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 0x10aa52db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab20be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:59:25 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 13:59:25 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 13:59:25 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 13:59:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:25 INFO - Return code: 0 13:59:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:59:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:59:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:59:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:59:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 13:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0352 --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 13:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j1NBi8GTAs/Render', 13:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:59:25 INFO - 'HOME': '/Users/cltbld', 13:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:59:25 INFO - 'LOGNAME': 'cltbld', 13:59:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:59:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:25 INFO - 'MOZ_NO_REMOTE': '1', 13:59:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:59:25 INFO - 'NO_EM_RESTART': '1', 13:59:25 INFO - 'PAGER': '/bin/cat', 13:59:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:25 INFO - 'PWD': '/builds/slave/test', 13:59:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:59:25 INFO - 'SHELL': '/bin/bash', 13:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DJh9Cx7HBm/Listeners', 13:59:25 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 13:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:59:25 INFO - 'USER': 'cltbld', 13:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:25 INFO - 'XPC_FLAGS': '0x0', 13:59:25 INFO - 'XPC_SERVICE_NAME': '0', 13:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:59:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 13:59:25 INFO - mozversion application_buildid: 20170110113605 13:59:25 INFO - mozversion application_changeset: dde7452acab4b3256784f0cf260d2d9243fdef73 13:59:25 INFO - mozversion application_display_name: Nightly 13:59:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:25 INFO - mozversion application_name: Firefox 13:59:25 INFO - mozversion application_remotingname: firefox 13:59:25 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 13:59:25 INFO - mozversion application_vendor: Mozilla 13:59:25 INFO - mozversion application_version: 53.0a1 13:59:25 INFO - mozversion platform_buildid: 20170110113605 13:59:25 INFO - mozversion platform_changeset: dde7452acab4b3256784f0cf260d2d9243fdef73 13:59:25 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 13:59:25 INFO - mozversion platform_version: 53.0a1 13:59:25 INFO - using testdate: 1484085565 13:59:25 INFO - actual date: 1484085565 13:59:25 INFO - starting webserver on 'localhost:49342' 13:59:25 INFO - SUITE-START | Running 2 tests 13:59:25 INFO - TEST-START | dromaeo_css 13:59:25 INFO - operating with platform_type : mac_ 13:59:25 INFO - Initialising browser for dromaeo_css test... 13:59:25 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpAuIXnc/profile http://localhost:49342/getInfo.html) 13:59:28 INFO - PROCESS | 1965 | 2017-01-10 13:59:28.214 plugin-container[1967:10683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904f, name = 'com.apple.tsm.portname' 13:59:28 INFO - PROCESS | 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:28 INFO - PROCESS | 1965 | 2017-01-10 13:59:28.218 plugin-container[1967:10683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a0b, name = 'com.apple.CFPasteboardClient' 13:59:28 INFO - PROCESS | 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:28 INFO - PROCESS | 1965 | 2017-01-10 13:59:28.218 plugin-container[1967:10683] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:59:28 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 13:59:28 INFO - PROCESS | 1965 | colorDepth:24 13:59:28 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 13:59:28 INFO - PROCESS | 1965 | __metrics 13:59:28 ERROR - PROCESS | 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 13:59:29 INFO - TEST-INFO | 1965: exit 0 13:59:29 INFO - Browser initialized. 13:59:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:29 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpAuIXnc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:31 INFO - PROCESS | 1968 | 2017-01-10 13:59:31.356 plugin-container[1969:10802] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 13:59:31 INFO - PROCESS | 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:31 INFO - PROCESS | 1968 | 2017-01-10 13:59:31.357 plugin-container[1969:10802] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 13:59:31 INFO - PROCESS | 1968 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:59:31 INFO - PROCESS | 1968 | 2017-01-10 13:59:31.357 plugin-container[1969:10802] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:59:41 INFO - PROCESS | 1968 | RSS: Main: 233209856 13:59:41 INFO - PROCESS | 1968 | 14:02:43 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49342/tests/dromaeo/cssquery-ext.html) 14:02:45 INFO - PROCESS | 1968 | RSS: Main: 248705024 14:02:45 INFO - PROCESS | 1968 | 14:04:29 INFO - PROCESS | 1968 | ************************* 14:04:29 INFO - PROCESS | 1968 | A coding exception was thrown and uncaught in a Task. 14:04:29 INFO - PROCESS | 1968 | 14:04:29 INFO - PROCESS | 1968 | Full message: ReferenceError: fetch is not defined 14:04:29 INFO - PROCESS | 1968 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 14:04:29 INFO - PROCESS | 1968 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 14:04:29 INFO - PROCESS | 1968 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 14:04:29 INFO - PROCESS | 1968 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:04:29 INFO - PROCESS | 1968 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:04:29 INFO - PROCESS | 1968 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:04:29 INFO - PROCESS | 1968 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 14:04:29 INFO - PROCESS | 1968 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 14:04:29 INFO - PROCESS | 1968 | TaskImpl@resource://gre/modules/Task.jsm:277:3 14:04:29 INFO - PROCESS | 1968 | asyncFunction@resource://gre/modules/Task.jsm:252:14 14:04:29 INFO - PROCESS | 1968 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 14:04:29 INFO - PROCESS | 1968 | 14:04:29 INFO - PROCESS | 1968 | ************************* 14:05:48 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49342/tests/dromaeo/cssquery-ext.html (next: http://localhost:49342/tests/dromaeo/cssquery-jquery.html) 14:05:48 INFO - PROCESS | 1968 | RSS: Main: 261681152 14:05:48 INFO - PROCESS | 1968 | 14:08:50 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49342/tests/dromaeo/cssquery-mootools.html) 14:08:51 INFO - PROCESS | 1968 | RSS: Main: 271126528 14:08:51 INFO - PROCESS | 1968 | 14:11:53 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49342/tests/dromaeo/cssquery-prototype.html) 14:11:53 INFO - PROCESS | 1968 | RSS: Main: 267223040 14:11:53 INFO - PROCESS | 1968 | 14:14:56 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49342/tests/dromaeo/cssquery-yui.html) 14:14:57 INFO - PROCESS | 1968 | RSS: Main: 271814656 14:14:57 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:49342/tests/dromaeo/cssquery-yui.html (next: http://localhost:49342/tests/dromaeo/cssquery-dojo.html) 14:18:00 INFO - PROCESS | 1968 | RSS: Main: 272080896 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | __start_tp_report 14:18:00 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 14:18:00 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 14:18:00 INFO - PROCESS | 1968 | |i|pagename|runs| 14:18:00 INFO - PROCESS | 1968 | |0;dojo.html;3367.2423704666453;3372.983135084324;3390.9830450847744;3392.9491057634123;3404.3021180657965;5612.5229355504725;5816.767329306828;5823.33031701354;5829.242198514193;5859.560532960035;5696.715164241782;5821.970890145554;5822.796202132926;5838.2994040715175;5859.970700146493;5103.617228707843;5180.1452760294505;5259.710715910624;5285.180796976475;5328.733563321838;5237.319148510707;5359.249705041278;5362.383325917511;5379.838604841861;5431.103867861798;5138.229265610151;5187.766550505198;5302.734863256822;5308;5310.123829568117;5176.948230517684;5188.351456067991;5216.713080780593;5220.765065572058;5254.658447200958;5143;5227.372715274153;5231.973840130813;5261;5264.684118952837;4488.708233964782;5676.602637815355;5737.3688894221605;5743.82768516941;5801.506871915893;6101.822802906966;6141.2098563120835;6214.533909956726;6251.593646413014;6291.182146320949;6210.875782484371;6272.749090036393;6278;6288.622682639057;6309.87380252397;5917.940820591782;5948.881022379528;5953.613015154001;5962.25471816023;6003.519718422515;6199.969000154971;6255.12428260044;6261.060840873905;6262.749490020439;6315.305316415191;6115.877682446326;6123.160610921289;6132.263729246456;6201.658908759971;6224.844378890564;6150.3849615039035;6269.780557680459;6287.96856015717;6289.371062893674;6298.307186209513;5501.229827824108;6150.876982460326;6151.292601350812;6172.197614310111;6323.7786677466065;5094.796208151706;5318.574514038867;5544.140658197985;6210;6239.282482514569;5010.3737032870895;5049.798008079709;5060.620453466005;5065.848024559269;5102.744862756922;3646.796557136192;4012.2176175646055;4064.552899181088;4505.594496495266;4524.5701658342405;5723.141528770634;5775.653460792366;5875.735591898289;5907.822765317047;5943.138244954457;6234.563580549318;6243.937560624336;6267.4986001119805;6287.182666253358;6293;5916.112583112482;5921.555883308769;5934.080217566284;5956.821295361146;5958.344582095966;5543.223948647193;5544.722763861791;5545.861353466115;5553.527950124204;5554.166874968787;6130.5204358993005;6247.625142491465;6247.9062814056915;6271.96864015677;6368.745250189941;6208.0998255253635;6266.686665666607;6282.277538082996;6284.214473190851;6306.4639505642535;6331.96834015827;6358.968205158944;6359.8092057238355;6370.8088757337355;6408.070829729756;6124.785632503019;6146.293176284785;6152.723127459186;6188.783392581238;6262.2172228471445;5274.709890955881;6185.165002724574;6260.812175634738;6277.121203031488;6285;6013.398660133952;6044.90932636002;6091.969540152271;6192.318844927145;6203;6047.395260474093;6071.51427885777;6094.39056094387;6108.5723999319625;6133.018717005258;5767.653940763567;5921.437463440966;5939.198208241832;5947.226860508106;5960.701964901824;6105.793350784953;6121.54443000217;6130.846728831815;6133.294671112879;6141.570090093651;5986.431289027535;5989.610675306091;5999.460048595647;6010.879782404415;6013.6692481913915 14:18:00 INFO - PROCESS | 1968 | |1;ext.html;441.7327516852304;459.54964135147554;475.51259958542494;481.56899574880504;504.78042051707536;31592;31616.841915790417;37508.249835003284;37520;42198.789006054925;34108.82945585275;34394.65605343946;40935.38596921041;41185.58814411855;41616.37575436371;7728.613569321539;8332.70835520757;8354.289885359753;9430.43417394955;9457.905420945806;8423.705170319041;9055.95472022639;10371.274010819247;10572.78854422911;11467.311961282308;11277.887221127765;11315.83026254607;11324.716882077973;11334.829977550344;11353.829692554618;9567.808643827155;11273.718157046058;11318.60384886525;11342.432878356049;11342.716432089264;11156.107511399068;11168.050715689094;11233.887661123448;11249.887501125047;11256.268342557789;39041.219175616614;39168;39172.60827391747;39204.019899502455;39281;4025.5370632377067;4079.2657321682086;4084.4690190275373;4093.385992101179;4096.9552764045275;29275.121746347642;29730.554041689393;30097.548536771967;30227.244318891982;30240.395192096254;3126.265327648001;3233.547303377529;3241.8379081045855;3263.673632636741;3304.686054824788;455101;458682.83830197685;460620;461494.6925265352;462552.9999999966;60899.39100608937;61098.38901610927;61226;61724.38275617276;61725.38274617196;50023.74988125036;63734.681326594;64095.67952160303;64206.678966604864;64254.35745642577;15449.459268925533;15761;15929.203539822962;15976.360945562279;16017.839821601634;11105.611303604335;11377.829332560019;11802.46888890002;12195.51217951272;12370.44333005017;15083.849161508464;16892.577685557713;17458.388956386465;17529.211185496682;17548.736768948474;6820.555619412265;6871.381575658214;6873.725050998004;6927.376536111673;6950.930490695028;860.2687715441824;879.4942907828024;893.6425429828121;895.7984453498041;920.1580553793204;29297.41405171927;29309;29356.853215733783;29826.701732982827;30211.79152833862;1054.9630762923261;1093.9343639381664;1097.665212110314;1107.7950579142885;1188.7087663522493;14923.179225142505;15201.695966080837;15407.383704651913;15436.665688171883;15695.215239237992;562770;566498;568526;569878;573604;58243.417565824646;58357.41642583605;58374.708126459096;58828;58847;1423.8576142385887;1441.8558144185497;1459.3797636004656;1461.5980605333618;1463.6853076588584;21692.45768855791;24354.51290974206;24523.877380612983;24726.50546989086;24860.751392486567;36009.639903601674;50101.74949125231;50637.493625063275;50666.493335066174;53107.73446132745;432472.2398596029;436574;519956;522317.3884130555;524343;23770.762292376854;24207.273781786575;24235.63646545268;36223.818880905426;36488.635113648525;41442.792786035876;41489.58510414978;41609.37585936274;41663.16673666449;42613;28617.14148575546;34824.47763283603;34989.47515787316;35740.82129589335;36013;34496.655033449344;34735.13162170966;35296.47055294224;35489.29021419609;35776.82111589425;33732;33904.491432628034;33919.321613567095;34290.65709342974;34403.82798085993;26532.469350613264;27410.72589274082;28122.01572944937;29902.401951960404;30374.088777336714;23511.29466116019;23513.529729404974;23673.040869891265;23680.52638947246;23803.88098059568 14:18:00 INFO - PROCESS | 1968 | |2;jquery.html;388.52599828209577;389.9044734040161;398.30098177698136;401.73686235515737;419.7397613479643;15904.602384940383;17177.57056073599;19497.902510487445;20785.480362990933;20876.686849697227;20746.962651867423;21120;21263.468413289676;21454.785452145476;21472.24847130351;4488.97755511222;5027.49725027498;5352.57179425645;5396.83809485716;5418.8916221675545;5204.375474943012;5352.946470535284;5366.114591092465;5399.298091248133;5400.162974738922;5200.453952335007;5283.682979021251;5288.418273989858;5290.788368465257;5300.09898317285;4638.817101639061;5245.501677340647;5276.261323414725;5278.155495120763;5294.391145018314;5055.545000949895;5217.139172036609;5226.216067589892;5245.632805703603;5261.973690131563;13053.804192937114;13170.736585268241;13173.407196676077;13208.933955330162;13359.1316564423;2621.777148942342;2637.116565950409;2682.1283082997907;2702.337927207847;2715.8777854996574;9982.950085249528;10355.27513074085;10366.740831479197;14009.649758756012;14070.73363397289;1767.6641438126715;1843.9262429502803;1850.5928695686928;1853.5829438376393;1871.728599353086;111402.44298778454;113206.43396783045;113822;131122;137576;11727.472263748152;11946.820797688042;12014.15900886947;12031.759364812655;12205.633830985085;14057.507987220399;14616.049956752777;15749;15753.13357765334;15763.605909852116;8350.83298334042;8585.914140858637;8696.434731742416;8755.518446485377;8840.690575829944;8416.2004609562;8427.705030324032;8435.662573496991;8584.914150858536;8594.656213751505;4695.272232803853;4790.94599188178;4843.15244832153;4854.077725232195;4855.878603034882;1750.8706884059711;1982.3854605072474;1986.8609197356047;2023.9494012649802;2056.311135769504;683.2689022745615;830.9418340716213;837.7277384849948;866.3156106675656;880.540064572936;19080.904595476935;19102.522436939187;19496.51258718515;20570.14536818983;21913.013914373892;900.4642237868458;918.5866360137965;934.0892629686002;934.4346670264392;942.6135284533308;11334.319940803578;11495.770084598262;11555.595554155732;11574.421278936188;11576.884231157748;684659;722392;733509;743464.5653543504;747471;145156.27421862824;146194;147967;149465;151366.94532218808;1082.658962426833;1110.4891749795024;1128.5429401092736;1128.7968165730247;1129.175701737736;17425.73861392055;19503.376561285877;20382.59234815266;20537.589248215252;20652.58694826125;44395.11209775851;52995.47004529905;56591.434085660265;56622.43377566336;60748.785024298384;66176.66911665603;72906.63546682232;77502.89988400401;83176;84403;7104.644767761694;7367.594782287026;7978.561179135203;8061.959690201512;8524.147585241426;11903.285802851857;12834;13097.869021309665;13360.665983350495;13401.06192566511;10680.412577308012;11377.4880130396;11423.371714555778;11677.357745323749;11695.298282103102;11087.778244434905;11112.22214444981;11253.549858005588;11354.602588909349;11601.651950441501;9159.35884488106;10369.688909332732;11262.831057534308;11639;11697.181197316106;7288.08898887639;7424.665890034853;7489.66296516669;7533.171351151259;7612.82001289801;9691.418514889128;11227.887721122685;11445.313281203154;11673.357965311989;11732.002779763474 14:18:00 INFO - PROCESS | 1968 | |3;mootools.html;1323.73525294941;1449.1015570346387;1453.178953891052;1469.7721853112764;1481.207553958632;6486;7480.952666626663;7656.96171519143;8320.791980200505;8336.16638336166;6334.271558770743;7969.601519924009;8030.799230019238;8052.677892884278;8063.677452901877;2158.5251244726137;2185.3007037747925;2193.2762188477764;2196.1105752170397;2198.329509499602;2052.374025922093;2225.7662945390744;2259.8757068361233;2276.7609401012905;2276.8178545716387;2043.4891277180704;2187.58435897179;2266.931992040233;2275.260540324393;2275.306031660343;2176.1948079210792;2233.2630232023394;2263.671767593706;2267.319804058776;2271.4775601611723;2266.150193677371;2273.6703178039256;2281.543691261738;2299.988500057506;2308.4690521180055;8136.796580085486;8296.626651800683;8301.086880443207;8306.8338633227;8329.416940814146;4985.900281994376;5081.822136225214;5116.386033675945;5116.411612664554;5324.760385782649;3230.0632816483194;3233.0300909727225;3380.0873764083804;3448.413769659164;3465.2376477175235;1055.3245922609535;1231.2120243044458;1240.683625675447;1243.7388148488828;1280.489022952915;7846.019247594051;9002.774930626721;9976.750581235527;10492.737681557946;10508.316959397614;4141.97929010353;4273.401723758676;4382.693211475166;4541;4588.862334129982;8114.43198976066;9204.355695101412;9220.8616870747;9228.03105673908;9228.815423691623;4600.010997635524;4877.902441951142;5149.2276158576515;5149.253358263031;5160.045391602565;4589.747563884019;4678.929816052762;4712.269598212282;4719.244920812722;4741.2651039088305;3049.3748781500185;3589.6589823966683;3648.1791596891017;3649.39784935488;3685.1155722626913;938.3712912348743;1050.2700623066896;1111.5887121764838;1123.00052952872;1133.1557989298026;807.8004163816728;833.9867061520282;926.7405126564573;934.4673536084503;943.1841457139525;5229.189475631283;5595.496405323459;5601.271834661549;5721.284839395075;5894.8821023579285;911.2937473458123;1018.5823812236947;1036.9585216591402;1047.7642530430592;1058.333250052462;3687.410014397737;3821.770693758328;3895.668868146183;3898.941515877264;3926.646601805794;8122.5126492410645;9416.62333506652;9700.223982081416;9757.756056098513;9759.414435133915;9460.810783784285;9470.100340467645;9595;9607;9660.033996600425;7566.735164269334;7623.428242881806;7666.578338191453;7696.422768292288;7709.691612335556;5373.946260537345;5435.891282174413;5483.479069488392;5552.69460179694;5561.888762224814;9084.909150908406;9157.130072643089;9157.725268241964;9161.587728552098;9166.862497062682;6877.209120951155;8907.153820387053;9242.907570924473;9277.721668349961;9289;6557.2131344239;6596.967015164893;6608.306127856698;6651.63416012124;6696.5647232929705;7642.5032372895585;7717.3440257576485;7719.614019299125;7729.690812367442;7748.57382843949;5852.795152169653;6928.653567321715;7048.753293634698;7091.688037713039;7160.319769621878;6883.862322753617;6911.75808846688;6924.549904256207;6964.79105626832;6981.232064473005;5128.358955130609;6116.755329786759;6258.593191442542;6329.177206963065;6336.398042185985;4697.224957882048;4873.585745211697;4903.509649035068;4922.507749225192;4993.500649935123;4883.560479556715;4912.901741965212;4933.777979990838;5019.974900125622;5042.890564075898 14:18:00 INFO - PROCESS | 1968 | |4;prototype.html;357.99284014319716;365.9542557180352;369.163843893581;374.509392695569;376.7965298738681;4925.325389367615;4963.213243232438;5272.789088436458;5450.618456708032;5586.21792948987;5240.764165612547;5354.759035843386;5441.564674826004;5501.697406642633;5506.504414602685;4116.361963895601;4117.814698338567;4260.01909112262;4263.637590804786;4305.547917468668;3809.942850857239;4115.8765237042935;4288.807003684841;4328.523862375137;4337.609615134637;3748.625137486257;3786.2048969716393;4043.07009387841;4105.3431450967855;4116.855910043149;3764.6800021998165;4140.730852494578;4153.06556024895;4166.895827604304;4183.079722461053;3311.288073064303;3582.8208589570418;3598.6581274779114;3598.7660802048044;3612.4039533477207;4172.520160181588;4929.65492415531;5053.4946505349535;5414.485623865727;5445.346558412976;3974.7615143091507;4146.610885353411;4435.512093669694;4714.222153344694;4754.286856971482;5264.52619264268;5293.444188360244;5760.567957403212;5795.797147099874;5861.912071318934;3126.937461250785;3181.427343078245;3527.6825085742407;3666.9816650916573;3715.758475699071;5636.182753500761;6085.2393450818645;6088.452039316483;6090.421409966046;6114.633122012649;3260.8532616032335;3507.9298414031578;3905.1603905160528;3918.686505079587;3969.61063627728;3257.039173443792;3904.492415985904;4006.677796327205;4042.5351084625645;4043.9191216175514;4343.087951530151;4675.7895894684825;4724.149653062482;4736.621070314435;4780.354652121989;5334.933013397258;5527.723613819293;5791.754772723884;5881.5000724938;5888.411158884163;1249.787536118862;1267.6260503151593;1292.7460363447442;1298.6493646715335;1299.616613099138;850.4472093139509;868.7133246028795;879.7096958003843;887.6360692116201;888.4136469929815;4693.81224751013;5114.232865070269;5151.922721159186;5177.974110129425;5192.324997750344;4818.614510839195;5633;5688;5698.857528561819;5715.856553792328;4278.871633850989;4504.702601673105;4612.654050946193;4841.975790121027;5174.327337446108;2397.640353946887;2444.327809852269;2883.61071255382;3001.9399612007637;3090.1656552731088;4973.378327709036;5474.315710536183;5697.401772813878;5962.34414214436;6006.459418652343;5743.282089738783;5874.794382196603;5876.794312199053;6163.599366041193;6166.260048794174;5423.511883930465;6092.482139018144;6233.781817636361;6237.5945563539135;6267.498600111889;5023.367405593124;5146.665466744649;5631.621027383537;5649.655393012018;6003.42967418112;4948.505149485167;5612.747426365741;5872.882542349214;5971.328028152125;6034.909476357946;5519.834404967857;6118.724657390517;6155.661438620739;6218.502519798496;6235.469985051322;3687.9900454253034;3788.3938569828697;3884.1649045454233;3954.1696243789124;3957.496151462426;4872.9269060964825;5985.665590419652;6003.279606447254;6003.429674180946;6042.697865106639;5532.861678458071;5653.745581448927;5702.806428400109;5807.167269602042;5846.239988801599;4851.29656199842;5005.499450054966;5761.91357129635;5855.306558982916;5911.379305173067;4663.976680116578;4874.317595536557;5073;5377.569794416359;5636.577256705681;4457.955420445754;5297.046531624191;5786.4213578643485;5856.824295271149;5919.733611987384;5223.410950283161;5472.124460086367;5698.971505142447;5703.914441283467;5727.828165155052 14:18:00 INFO - PROCESS | 1968 | |5;yui.html;712.5760172697246;767.7428061599364;823.7034667519696;830.1988581019316;839.6431516605443;15288.006279591833;15820.525384238492;16000.679986400264;16038.599035024115;16060.437884674038;14680.632984175374;14707.779383309258;14812;14845.628859278524;14854.405823767063;689.7413469948744;700.184285307616;862.8274345130967;867.3278209387728;886.6896586194845;881.532787622561;886.450400751535;893.5041052216018;894.977625559363;895.2703546609525;943.5470973932516;945.2579724915943;945.2863088368273;947.7156852944123;950.116391755667;915.2586405011962;939.5208443693765;941.6092321686492;941.9340646154772;943.504660053474;696.3384784454738;696.5576858694766;698.0192829075157;699.9475039372068;701.1761180612759;11678;15140;15198.620034499116;15212.923935380362;15531.145786981711;12901.548445804352;14536.781948270784;14783.113013219241;14826.629334266621;14880.925595372062;12271.57049503272;12571.371431428392;12699.809502857464;12853.550125745647;13045.478180872753;4472.5303843096335;4493.33746513792;4537.2059889519205;4580.152671755703;4733.408323959505;112190.43904780505;113387.43306283499;114400;114646;114972;10690.893091069145;10732.248742587944;10792.298500597437;10805;10953.890461095447;20977.79022209789;21011.894940525504;21037.579248414946;21127.471813204793;21155.365339039854;7406.703731850774;7596.278353556403;7605.2333041053525;7642.847143057108;7824.295813376823;4235.195312890541;4257.893552661209;4279.786010699452;4296.61330480252;4357;3376.307856889332;3472.3749725049734;3474.704650104719;3475.2701932594437;3477.2871561329866;568.687222027883;634.0932466572846;640.5260107520402;640.5804198250154;658.7529676371361;581.9883602328015;648.0506058624138;667.5827607745159;668.4665119198185;672.4989882537541;8148.348132149414;9304.488253146006;9611.903880961241;9730.221582273402;9790.657326993522;529.721896004593;623.314354210365;636.9585976911486;668.9498287628447;691.2292793535172;4575.908481830411;4723.574878260973;4758.666893317504;4777.880552986203;4789.128677901145;102793;104024;104589;104775;106725.39911901328;91997.54001230084;93313;94992.23197843893;95977.520112399;96268.03731962731;80810;81583.77624335639;82047.5897620508;82641.58679206566;83191;8341.749747507585;8625.749266356468;9187.632494700405;9406.670766523139;10566.841497377392;50330.748346258035;50533.74733126311;51387.48612513827;51442.45672629827;52416.47583524269;58039;63176;63320.683396582725;63436;73925.6303718478;12788.36058197105;13013.284269364896;13165.802512962122;13279.468821247043;13524.59426217215;14865.943699825373;14970.382337102872;15047.774283385977;15153.62115947066;15345.769813453031;13658.453661853415;13901.791473127709;14074.085184462978;14277.214753188258;14360.066595671247;13623.727525449634;13678.658033549242;13927.373268202753;14207.431702731776;14287.142771433748;11355.432228388712;13268.336583170996;13365.331733413095;14055.929720351332;14227.928860356045;10959.452027398438;11254.606088786853;11295.661130166109;11339.829902551302;11603.419829008348;7258;8342.79143021405;10114.241431892491;10351.84472232902;10861.511231994422 14:18:00 INFO - PROCESS | 1968 | __end_tp_report 14:18:00 INFO - PROCESS | 1968 | __start_cc_report 14:18:00 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,380 14:18:00 INFO - PROCESS | 1968 | __end_cc_report 14:18:00 INFO - PROCESS | 1968 | __startTimestamp1484086680296__endTimestamp 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | ------- Summary: start ------- 14:18:00 INFO - PROCESS | 1968 | Number of tests: 6 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | [#0] dojo.html Cycles:165 Average:5750.02 Median:5960.70 stddev:656.46 (11.0%) stddev-sans-first:631.30 14:18:00 INFO - PROCESS | 1968 | Values: 3367.2 3373.0 3391.0 3392.9 3404.3 5612.5 5816.8 5823.3 5829.2 5859.6 5696.7 5822.0 5822.8 5838.3 5860.0 5103.6 5180.1 5259.7 5285.2 5328.7 5237.3 5359.2 5362.4 5379.8 5431.1 5138.2 5187.8 5302.7 5308.0 5310.1 5176.9 5188.4 5216.7 5220.8 5254.7 5143.0 5227.4 5232.0 5261.0 5264.7 4488.7 5676.6 5737.4 5743.8 5801.5 6101.8 6141.2 6214.5 6251.6 6291.2 6210.9 6272.7 6278.0 6288.6 6309.9 5917.9 5948.9 5953.6 5962.3 6003.5 6200.0 6255.1 6261.1 6262.7 6315.3 6115.9 6123.2 6132.3 6201.7 6224.8 6150.4 6269.8 6288.0 6289.4 6298.3 5501.2 6150.9 6151.3 6172.2 6323.8 5094.8 5318.6 5544.1 6210.0 6239.3 5010.4 5049.8 5060.6 5065.8 5102.7 3646.8 4012.2 4064.6 4505.6 4524.6 5723.1 5775.7 5875.7 5907.8 5943.1 6234.6 6243.9 6267.5 6287.2 6293.0 5916.1 5921.6 5934.1 5956.8 5958.3 5543.2 5544.7 5545.9 5553.5 5554.2 6130.5 6247.6 6247.9 6272.0 6368.7 6208.1 6266.7 6282.3 6284.2 6306.5 6332.0 6359.0 6359.8 6370.8 6408.1 6124.8 6146.3 6152.7 6188.8 6262.2 5274.7 6185.2 6260.8 6277.1 6285.0 6013.4 6044.9 6092.0 6192.3 6203.0 6047.4 6071.5 6094.4 6108.6 6133.0 5767.7 5921.4 5939.2 5947.2 5960.7 6105.8 6121.5 6130.8 6133.3 6141.6 5986.4 5989.6 5999.5 6010.9 6013.7 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | [#1] ext.html Cycles:180 Average:63826.66 Median:34615.89 stddev:135350.79 (391.0%) stddev-sans-first:135646.82 14:18:00 INFO - PROCESS | 1968 | Values: 441.7 459.5 475.5 481.6 504.8 31592.0 31616.8 37508.2 37520.0 42198.8 34108.8 34394.7 40935.4 41185.6 41616.4 7728.6 8332.7 8354.3 9430.4 9457.9 8423.7 9056.0 10371.3 10572.8 11467.3 11277.9 11315.8 11324.7 11334.8 11353.8 9567.8 11273.7 11318.6 11342.4 11342.7 11156.1 11168.1 11233.9 11249.9 11256.3 39041.2 39168.0 39172.6 39204.0 39281.0 4025.5 4079.3 4084.5 4093.4 4097.0 29275.1 29730.6 30097.5 30227.2 30240.4 3126.3 3233.5 3241.8 3263.7 3304.7 455101.0 458682.8 460620.0 461494.7 462553.0 60899.4 61098.4 61226.0 61724.4 61725.4 50023.7 63734.7 64095.7 64206.7 64254.4 15449.5 15761.0 15929.2 15976.4 16017.8 11105.6 11377.8 11802.5 12195.5 12370.4 15083.8 16892.6 17458.4 17529.2 17548.7 6820.6 6871.4 6873.7 6927.4 6950.9 860.3 879.5 893.6 895.8 920.2 29297.4 29309.0 29356.9 29826.7 30211.8 1055.0 1093.9 1097.7 1107.8 1188.7 14923.2 15201.7 15407.4 15436.7 15695.2 562770.0 566498.0 568526.0 569878.0 573604.0 58243.4 58357.4 58374.7 58828.0 58847.0 1423.9 1441.9 1459.4 1461.6 1463.7 21692.5 24354.5 24523.9 24726.5 24860.8 36009.6 50101.7 50637.5 50666.5 53107.7 432472.2 436574.0 519956.0 522317.4 524343.0 23770.8 24207.3 24235.6 36223.8 36488.6 41442.8 41489.6 41609.4 41663.2 42613.0 28617.1 34824.5 34989.5 35740.8 36013.0 34496.7 34735.1 35296.5 35489.3 35776.8 33732.0 33904.5 33919.3 34290.7 34403.8 26532.5 27410.7 28122.0 29902.4 30374.1 23511.3 23513.5 23673.0 23680.5 23803.9 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | [#2] jquery.html Cycles:180 Average:38913.59 Median:21692.63 stddev:120837.44 (557.0%) stddev-sans-first:121141.79 14:18:00 INFO - PROCESS | 1968 | Values: 388.5 389.9 398.3 401.7 419.7 15904.6 17177.6 19497.9 20785.5 20876.7 20747.0 21120.0 21263.5 21454.8 21472.2 4489.0 5027.5 5352.6 5396.8 5418.9 5204.4 5352.9 5366.1 5399.3 5400.2 5200.5 5283.7 5288.4 5290.8 5300.1 4638.8 5245.5 5276.3 5278.2 5294.4 5055.5 5217.1 5226.2 5245.6 5262.0 13053.8 13170.7 13173.4 13208.9 13359.1 2621.8 2637.1 2682.1 2702.3 2715.9 9983.0 10355.3 10366.7 14009.6 14070.7 1767.7 1843.9 1850.6 1853.6 1871.7 111402.4 113206.4 113822.0 131122.0 137576.0 11727.5 11946.8 12014.2 12031.8 12205.6 14057.5 14616.0 15749.0 15753.1 15763.6 8350.8 8585.9 8696.4 8755.5 8840.7 8416.2 8427.7 8435.7 8584.9 8594.7 4695.3 4790.9 4843.2 4854.1 4855.9 1750.9 1982.4 1986.9 2023.9 2056.3 683.3 830.9 837.7 866.3 880.5 19080.9 19102.5 19496.5 20570.1 21913.0 900.5 918.6 934.1 934.4 942.6 11334.3 11495.8 11555.6 11574.4 11576.9 684659.0 722392.0 733509.0 743464.6 747471.0 145156.3 146194.0 147967.0 149465.0 151366.9 1082.7 1110.5 1128.5 1128.8 1129.2 17425.7 19503.4 20382.6 20537.6 20652.6 44395.1 52995.5 56591.4 56622.4 60748.8 66176.7 72906.6 77502.9 83176.0 84403.0 7104.6 7367.6 7978.6 8062.0 8524.1 11903.3 12834.0 13097.9 13360.7 13401.1 10680.4 11377.5 11423.4 11677.4 11695.3 11087.8 11112.2 11253.5 11354.6 11601.7 9159.4 10369.7 11262.8 11639.0 11697.2 7288.1 7424.7 7489.7 7533.2 7612.8 9691.4 11227.9 11445.3 11673.4 11732.0 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | [#3] mootools.html Cycles:180 Average:5231.32 Median:5276.97 stddev:2801.47 (53.1%) stddev-sans-first:2793.94 14:18:00 INFO - PROCESS | 1968 | Values: 1323.7 1449.1 1453.2 1469.8 1481.2 6486.0 7481.0 7657.0 8320.8 8336.2 6334.3 7969.6 8030.8 8052.7 8063.7 2158.5 2185.3 2193.3 2196.1 2198.3 2052.4 2225.8 2259.9 2276.8 2276.8 2043.5 2187.6 2266.9 2275.3 2275.3 2176.2 2233.3 2263.7 2267.3 2271.5 2266.2 2273.7 2281.5 2300.0 2308.5 8136.8 8296.6 8301.1 8306.8 8329.4 4985.9 5081.8 5116.4 5116.4 5324.8 3230.1 3233.0 3380.1 3448.4 3465.2 1055.3 1231.2 1240.7 1243.7 1280.5 7846.0 9002.8 9976.8 10492.7 10508.3 4142.0 4273.4 4382.7 4541.0 4588.9 8114.4 9204.4 9220.9 9228.0 9228.8 4600.0 4877.9 5149.2 5149.3 5160.0 4589.7 4678.9 4712.3 4719.2 4741.3 3049.4 3589.7 3648.2 3649.4 3685.1 938.4 1050.3 1111.6 1123.0 1133.2 807.8 834.0 926.7 934.5 943.2 5229.2 5595.5 5601.3 5721.3 5894.9 911.3 1018.6 1037.0 1047.8 1058.3 3687.4 3821.8 3895.7 3898.9 3926.6 8122.5 9416.6 9700.2 9757.8 9759.4 9460.8 9470.1 9595.0 9607.0 9660.0 7566.7 7623.4 7666.6 7696.4 7709.7 5373.9 5435.9 5483.5 5552.7 5561.9 9084.9 9157.1 9157.7 9161.6 9166.9 6877.2 8907.2 9242.9 9277.7 9289.0 6557.2 6597.0 6608.3 6651.6 6696.6 7642.5 7717.3 7719.6 7729.7 7748.6 5852.8 6928.7 7048.8 7091.7 7160.3 6883.9 6911.8 6924.5 6964.8 6981.2 5128.4 6116.8 6258.6 6329.2 6336.4 4697.2 4873.6 4903.5 4922.5 4993.5 4883.6 4912.9 4933.8 5020.0 5042.9 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | [#4] prototype.html Cycles:180 Average:4593.39 Median:5093.62 stddev:1449.21 (28.5%) stddev-sans-first:1417.98 14:18:00 INFO - PROCESS | 1968 | Values: 358.0 366.0 369.2 374.5 376.8 4925.3 4963.2 5272.8 5450.6 5586.2 5240.8 5354.8 5441.6 5501.7 5506.5 4116.4 4117.8 4260.0 4263.6 4305.5 3809.9 4115.9 4288.8 4328.5 4337.6 3748.6 3786.2 4043.1 4105.3 4116.9 3764.7 4140.7 4153.1 4166.9 4183.1 3311.3 3582.8 3598.7 3598.8 3612.4 4172.5 4929.7 5053.5 5414.5 5445.3 3974.8 4146.6 4435.5 4714.2 4754.3 5264.5 5293.4 5760.6 5795.8 5861.9 3126.9 3181.4 3527.7 3667.0 3715.8 5636.2 6085.2 6088.5 6090.4 6114.6 3260.9 3507.9 3905.2 3918.7 3969.6 3257.0 3904.5 4006.7 4042.5 4043.9 4343.1 4675.8 4724.1 4736.6 4780.4 5334.9 5527.7 5791.8 5881.5 5888.4 1249.8 1267.6 1292.7 1298.6 1299.6 850.4 868.7 879.7 887.6 888.4 4693.8 5114.2 5151.9 5178.0 5192.3 4818.6 5633.0 5688.0 5698.9 5715.9 4278.9 4504.7 4612.7 4842.0 5174.3 2397.6 2444.3 2883.6 3001.9 3090.2 4973.4 5474.3 5697.4 5962.3 6006.5 5743.3 5874.8 5876.8 6163.6 6166.3 5423.5 6092.5 6233.8 6237.6 6267.5 5023.4 5146.7 5631.6 5649.7 6003.4 4948.5 5612.7 5872.9 5971.3 6034.9 5519.8 6118.7 6155.7 6218.5 6235.5 3688.0 3788.4 3884.2 3954.2 3957.5 4872.9 5985.7 6003.3 6003.4 6042.7 5532.9 5653.7 5702.8 5807.2 5846.2 4851.3 5005.5 5761.9 5855.3 5911.4 4664.0 4874.3 5073.0 5377.6 5636.6 4458.0 5297.0 5786.4 5856.8 5919.7 5223.4 5472.1 5699.0 5703.9 5727.8 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - PROCESS | 1968 | [#5] yui.html Cycles:180 Average:20974.81 Median:4515.27 stddev:30659.69 (679.0%) stddev-sans-first:30707.95 14:18:00 INFO - PROCESS | 1968 | Values: 712.6 767.7 823.7 830.2 839.6 15288.0 15820.5 16000.7 16038.6 16060.4 14680.6 14707.8 14812.0 14845.6 14854.4 689.7 700.2 862.8 867.3 886.7 881.5 886.5 893.5 895.0 895.3 943.5 945.3 945.3 947.7 950.1 915.3 939.5 941.6 941.9 943.5 696.3 696.6 698.0 699.9 701.2 11678.0 15140.0 15198.6 15212.9 15531.1 12901.5 14536.8 14783.1 14826.6 14880.9 12271.6 12571.4 12699.8 12853.6 13045.5 4472.5 4493.3 4537.2 4580.2 4733.4 112190.4 113387.4 114400.0 114646.0 114972.0 10690.9 10732.2 10792.3 10805.0 10953.9 20977.8 21011.9 21037.6 21127.5 21155.4 7406.7 7596.3 7605.2 7642.8 7824.3 4235.2 4257.9 4279.8 4296.6 4357.0 3376.3 3472.4 3474.7 3475.3 3477.3 568.7 634.1 640.5 640.6 658.8 582.0 648.1 667.6 668.5 672.5 8148.3 9304.5 9611.9 9730.2 9790.7 529.7 623.3 637.0 668.9 691.2 4575.9 4723.6 4758.7 4777.9 4789.1 102793.0 104024.0 104589.0 104775.0 106725.4 91997.5 93313.0 94992.2 95977.5 96268.0 80810.0 81583.8 82047.6 82641.6 83191.0 8341.7 8625.7 9187.6 9406.7 10566.8 50330.7 50533.7 51387.5 51442.5 52416.5 58039.0 63176.0 63320.7 63436.0 73925.6 12788.4 13013.3 13165.8 13279.5 13524.6 14865.9 14970.4 15047.8 15153.6 15345.8 13658.5 13901.8 14074.1 14277.2 14360.1 13623.7 13678.7 13927.4 14207.4 14287.1 11355.4 13268.3 13365.3 14055.9 14227.9 10959.5 11254.6 11295.7 11339.8 11603.4 7258.0 8342.8 10114.2 10351.8 10861.5 14:18:00 INFO - PROCESS | 1968 | -------- Summary: end -------- 14:18:00 INFO - PROCESS | 1968 | 14:18:00 INFO - TEST-INFO | 1968: exit 0 14:18:00 INFO - TEST-OK | dromaeo_css | took 1115443ms 14:18:00 INFO - TEST-START | kraken 14:18:00 INFO - operating with platform_type : mac_ 14:18:00 INFO - Initialising browser for kraken test... 14:18:00 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpcTZgUO/profile http://localhost:49342/getInfo.html) 14:18:03 INFO - PROCESS | 1975 | 2017-01-10 14:18:03.687 plugin-container[1976:12850] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 14:18:03 INFO - PROCESS | 1975 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:03 INFO - PROCESS | 1975 | 2017-01-10 14:18:03.691 plugin-container[1976:12850] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 14:18:03 INFO - PROCESS | 1975 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:03 INFO - PROCESS | 1975 | 2017-01-10 14:18:03.691 plugin-container[1976:12850] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:18:03 INFO - PROCESS | 1975 | __metrics Screen width/height:1600/1200 14:18:03 INFO - PROCESS | 1975 | colorDepth:24 14:18:03 INFO - PROCESS | 1975 | Browser inner width/height: 1024/689 14:18:03 INFO - PROCESS | 1975 | __metrics 14:18:03 ERROR - PROCESS | 1975 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 14:18:04 INFO - TEST-INFO | 1975: exit 0 14:18:04 INFO - Browser initialized. 14:18:04 INFO - Running cycle 1/1 for kraken test... 14:18:04 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpcTZgUO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:06 INFO - PROCESS | 1977 | 2017-01-10 14:18:06.851 plugin-container[1978:12965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:18:06 INFO - PROCESS | 1977 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:06 INFO - PROCESS | 1977 | 2017-01-10 14:18:06.851 plugin-container[1978:12965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8947, name = 'com.apple.CFPasteboardClient' 14:18:06 INFO - PROCESS | 1977 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:18:06 INFO - PROCESS | 1977 | 2017-01-10 14:18:06.851 plugin-container[1978:12965] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:18:16 INFO - PROCESS | 1977 | RSS: Main: 233259008 14:18:16 INFO - PROCESS | 1977 | 14:18:19 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49342/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:20 INFO - PROCESS | 1977 | RSS: Main: 245952512 14:18:20 INFO - PROCESS | 1977 | 14:18:22 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49342/tests/kraken/driver.html?testName=audio-dft) 14:18:23 INFO - PROCESS | 1977 | RSS: Main: 254087168 14:18:23 INFO - PROCESS | 1977 | 14:18:27 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49342/tests/kraken/driver.html?testName=audio-fft) 14:18:27 INFO - PROCESS | 1977 | RSS: Main: 256606208 14:18:27 INFO - PROCESS | 1977 | 14:18:29 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49342/tests/kraken/driver.html?testName=audio-oscillator) 14:18:30 INFO - PROCESS | 1977 | RSS: Main: 257826816 14:18:30 INFO - PROCESS | 1977 | 14:18:32 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:33 INFO - PROCESS | 1977 | RSS: Main: 258150400 14:18:33 INFO - PROCESS | 1977 | 14:18:35 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49342/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:36 INFO - PROCESS | 1977 | RSS: Main: 264994816 14:18:36 INFO - PROCESS | 1977 | 14:18:39 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49342/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:40 INFO - PROCESS | 1977 | RSS: Main: 264859648 14:18:40 INFO - PROCESS | 1977 | 14:18:43 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49342/tests/kraken/driver.html?testName=json-parse-financial) 14:18:43 INFO - PROCESS | 1977 | RSS: Main: 264560640 14:18:43 INFO - PROCESS | 1977 | 14:18:45 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:45 INFO - PROCESS | 1977 | RSS: Main: 264224768 14:18:45 INFO - PROCESS | 1977 | 14:18:47 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:48 INFO - PROCESS | 1977 | RSS: Main: 264298496 14:18:48 INFO - PROCESS | 1977 | 14:18:50 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:51 INFO - PROCESS | 1977 | RSS: Main: 264253440 14:18:51 INFO - PROCESS | 1977 | 14:18:54 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:55 INFO - PROCESS | 1977 | RSS: Main: 264556544 14:18:55 INFO - PROCESS | 1977 | 14:18:58 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:58 INFO - PROCESS | 1977 | RSS: Main: 264560640 14:18:58 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49342/tests/kraken/driver.html?testName=ai-astar) 14:19:00 INFO - PROCESS | 1977 | RSS: Main: 266121216 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | __start_tp_report 14:19:00 INFO - PROCESS | 1977 | _x_x_mozilla_page_load 14:19:00 INFO - PROCESS | 1977 | _x_x_mozilla_page_load_details 14:19:00 INFO - PROCESS | 1977 | |i|pagename|runs| 14:19:00 INFO - PROCESS | 1977 | |0;ai-astar;106;116;117;119;118;118;118;117;117;119 14:19:00 INFO - PROCESS | 1977 | |1;audio-beat-detection;146;113;110;150;112;117;113;114;131;114 14:19:00 INFO - PROCESS | 1977 | |2;audio-dft;196;201;222;218;206;265;281;200;195;195 14:19:00 INFO - PROCESS | 1977 | |3;audio-fft;79;59;62;78;87;86;83;84;79;64 14:19:00 INFO - PROCESS | 1977 | |4;audio-oscillator;89;76;94;102;102;102;84;73;95;71 14:19:00 INFO - PROCESS | 1977 | |5;imaging-gaussian-blur;89;89;89;87;91;96;91;78;136;85 14:19:00 INFO - PROCESS | 1977 | |6;imaging-darkroom;97;95;96;96;97;100;152;92;152;152 14:19:00 INFO - PROCESS | 1977 | |7;imaging-desaturate;101;93;92;92;95;94;92;90;96;93 14:19:00 INFO - PROCESS | 1977 | |8;json-parse-financial;62;62;60;61;63;63;62;63;63;61 14:19:00 INFO - PROCESS | 1977 | |9;json-stringify-tinderbox;68;76;69;88;78;78;71;75;111;71 14:19:00 INFO - PROCESS | 1977 | |10;stanford-crypto-aes;89;87;93;100;114;111;80;113;113;112 14:19:00 INFO - PROCESS | 1977 | |11;stanford-crypto-ccm;133;155;155;155;158;158;153;156;220;158 14:19:00 INFO - PROCESS | 1977 | |12;stanford-crypto-pbkdf2;171;173;175;174;176;174;172;172;171;172 14:19:00 INFO - PROCESS | 1977 | |13;stanford-crypto-sha256-iterative;72;73;79;94;91;88;67;67;66;69 14:19:00 INFO - PROCESS | 1977 | __end_tp_report 14:19:00 INFO - PROCESS | 1977 | __start_cc_report 14:19:00 INFO - PROCESS | 1977 | _x_x_mozilla_cycle_collect,917 14:19:00 INFO - PROCESS | 1977 | __end_cc_report 14:19:00 INFO - PROCESS | 1977 | __startTimestamp1484086740965__endTimestamp 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | ------- Summary: start ------- 14:19:00 INFO - PROCESS | 1977 | Number of tests: 14 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#0] ai-astar Cycles:10 Average:116.50 Median:118.00 stddev:3.81 (3.2%) stddev-sans-first:1.00 14:19:00 INFO - PROCESS | 1977 | Values: 106.0 116.0 117.0 119.0 118.0 118.0 118.0 117.0 117.0 119.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:115.50 stddev:14.91 (12.9%) stddev-sans-first:13.04 14:19:00 INFO - PROCESS | 1977 | Values: 146.0 113.0 110.0 150.0 112.0 117.0 113.0 114.0 131.0 114.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#2] audio-dft Cycles:10 Average:217.90 Median:212.00 stddev:30.72 (14.5%) stddev-sans-first:31.54 14:19:00 INFO - PROCESS | 1977 | Values: 196.0 201.0 222.0 218.0 206.0 265.0 281.0 200.0 195.0 195.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#3] audio-fft Cycles:10 Average:76.10 Median:81.00 stddev:10.46 (12.9%) stddev-sans-first:11.04 14:19:00 INFO - PROCESS | 1977 | Values: 79.0 59.0 62.0 78.0 87.0 86.0 83.0 84.0 79.0 64.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:80.00 stddev:12.21 (15.3%) stddev-sans-first:12.95 14:19:00 INFO - PROCESS | 1977 | Values: 89.0 76.0 94.0 102.0 102.0 102.0 84.0 73.0 95.0 71.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:89.00 stddev:15.77 (17.7%) stddev-sans-first:16.66 14:19:00 INFO - PROCESS | 1977 | Values: 89.0 89.0 89.0 87.0 91.0 96.0 91.0 78.0 136.0 85.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#6] imaging-darkroom Cycles:10 Average:112.90 Median:95.50 stddev:27.05 (28.3%) stddev-sans-first:28.08 14:19:00 INFO - PROCESS | 1977 | Values: 97.0 95.0 96.0 96.0 97.0 100.0 152.0 92.0 152.0 152.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:93.00 stddev:3.05 (3.3%) stddev-sans-first:1.80 14:19:00 INFO - PROCESS | 1977 | Values: 101.0 93.0 92.0 92.0 95.0 94.0 92.0 90.0 96.0 93.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.50 stddev:1.05 (1.7%) stddev-sans-first:1.12 14:19:00 INFO - PROCESS | 1977 | Values: 62.0 62.0 60.0 61.0 63.0 63.0 62.0 63.0 63.0 61.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:75.50 stddev:12.82 (17.0%) stddev-sans-first:13.02 14:19:00 INFO - PROCESS | 1977 | Values: 68.0 76.0 69.0 88.0 78.0 78.0 71.0 75.0 111.0 71.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#10] stanford-crypto-aes Cycles:10 Average:101.20 Median:97.00 stddev:13.01 (13.4%) stddev-sans-first:13.03 14:19:00 INFO - PROCESS | 1977 | Values: 89.0 87.0 93.0 100.0 114.0 111.0 80.0 113.0 113.0 112.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#11] stanford-crypto-ccm Cycles:10 Average:160.10 Median:157.00 stddev:22.31 (14.2%) stddev-sans-first:21.40 14:19:00 INFO - PROCESS | 1977 | Values: 133.0 155.0 155.0 155.0 158.0 158.0 153.0 156.0 220.0 158.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.50 stddev:1.70 (1.0%) stddev-sans-first:1.64 14:19:00 INFO - PROCESS | 1977 | Values: 171.0 173.0 175.0 174.0 176.0 174.0 172.0 172.0 171.0 172.0 14:19:00 INFO - PROCESS | 1977 | 14:19:00 INFO - PROCESS | 1977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:76.00 stddev:10.72 (14.1%) stddev-sans-first:11.24 14:19:00 INFO - PROCESS | 1977 | Values: 72.0 73.0 79.0 94.0 91.0 88.0 67.0 67.0 66.0 69.0 14:19:00 INFO - PROCESS | 1977 | -------- Summary: end -------- 14:19:00 INFO - PROCESS | 1977 | 14:19:01 INFO - TEST-INFO | 1977: exit 0 14:19:01 INFO - TEST-OK | kraken | took 60879ms 14:19:01 INFO - SUITE-END | took 1176s 14:19:02 INFO - Completed test suite (00:19:36) 14:19:02 INFO - javascript benchmark 14:19:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.120620249336, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.2423704666453, 3372.983135084324, 3390.9830450847744, 3392.9491057634123, 3404.3021180657965, 5612.5229355504725, 5816.767329306828, 5823.33031701354, 5829.242198514193, 5859.560532960035, 5696.715164241782, 5821.970890145554, 5822.796202132926, 5838.2994040715175, 5859.970700146493, 5103.617228707843, 5180.1452760294505, 5259.710715910624, 5285.180796976475, 5328.733563321838, 5237.319148510707, 5359.249705041278, 5362.383325917511, 5379.838604841861, 5431.103867861798, 5138.229265610151, 5187.766550505198, 5302.734863256822, 5308.0, 5310.123829568117, 5176.948230517684, 5188.351456067991, 5216.713080780593, 5220.765065572058, 5254.658447200958, 5143.0, 5227.372715274153, 5231.973840130813, 5261.0, 5264.684118952837, 4488.708233964782, 5676.602637815355, 5737.3688894221605, 5743.82768516941, 5801.506871915893, 6101.822802906966, 6141.2098563120835, 6214.533909956726, 6251.593646413014, 6291.182146320949, 6210.875782484371, 6272.749090036393, 6278.0, 6288.622682639057, 6309.87380252397, 5917.940820591782, 5948.881022379528, 5953.613015154001, 5962.25471816023, 6003.519718422515, 6199.969000154971, 6255.12428260044, 6261.060840873905, 6262.749490020439, 6315.305316415191, 6115.877682446326, 6123.160610921289, 6132.263729246456, 6201.658908759971, 6224.844378890564, 6150.3849615039035, 6269.780557680459, 6287.96856015717, 6289.371062893674, 6298.307186209513, 5501.229827824108, 6150.876982460326, 6151.292601350812, 6172.197614310111, 6323.7786677466065, 5094.796208151706, 5318.574514038867, 5544.140658197985, 6210.0, 6239.282482514569, 5010.3737032870895, 5049.798008079709, 5060.620453466005, 5065.848024559269, 5102.744862756922, 3646.796557136192, 4012.2176175646055, 4064.552899181088, 4505.594496495266, 4524.5701658342405, 5723.141528770634, 5775.653460792366, 5875.735591898289, 5907.822765317047, 5943.138244954457, 6234.563580549318, 6243.937560624336, 6267.4986001119805, 6287.182666253358, 6293.0, 5916.112583112482, 5921.555883308769, 5934.080217566284, 5956.821295361146, 5958.344582095966, 5543.223948647193, 5544.722763861791, 5545.861353466115, 5553.527950124204, 5554.166874968787, 6130.5204358993005, 6247.625142491465, 6247.9062814056915, 6271.96864015677, 6368.745250189941, 6208.0998255253635, 6266.686665666607, 6282.277538082996, 6284.214473190851, 6306.4639505642535, 6331.96834015827, 6358.968205158944, 6359.8092057238355, 6370.8088757337355, 6408.070829729756, 6124.785632503019, 6146.293176284785, 6152.723127459186, 6188.783392581238, 6262.2172228471445, 5274.709890955881, 6185.165002724574, 6260.812175634738, 6277.121203031488, 6285.0, 6013.398660133952, 6044.90932636002, 6091.969540152271, 6192.318844927145, 6203.0, 6047.395260474093, 6071.51427885777, 6094.39056094387, 6108.5723999319625, 6133.018717005258, 5767.653940763567, 5921.437463440966, 5939.198208241832, 5947.226860508106, 5960.701964901824, 6105.793350784953, 6121.54443000217, 6130.846728831815, 6133.294671112879, 6141.570090093651, 5986.431289027535, 5989.610675306091, 5999.460048595647, 6010.879782404415, 6013.6692481913915], "value": 5707.887599762371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.7327516852304, 459.54964135147554, 475.51259958542494, 481.56899574880504, 504.78042051707536, 31592.0, 31616.841915790417, 37508.249835003284, 37520.0, 42198.789006054925, 34108.82945585275, 34394.65605343946, 40935.38596921041, 41185.58814411855, 41616.37575436371, 7728.613569321539, 8332.70835520757, 8354.289885359753, 9430.43417394955, 9457.905420945806, 8423.705170319041, 9055.95472022639, 10371.274010819247, 10572.78854422911, 11467.311961282308, 11277.887221127765, 11315.83026254607, 11324.716882077973, 11334.829977550344, 11353.829692554618, 9567.808643827155, 11273.718157046058, 11318.60384886525, 11342.432878356049, 11342.716432089264, 11156.107511399068, 11168.050715689094, 11233.887661123448, 11249.887501125047, 11256.268342557789, 39041.219175616614, 39168.0, 39172.60827391747, 39204.019899502455, 39281.0, 4025.5370632377067, 4079.2657321682086, 4084.4690190275373, 4093.385992101179, 4096.9552764045275, 29275.121746347642, 29730.554041689393, 30097.548536771967, 30227.244318891982, 30240.395192096254, 3126.265327648001, 3233.547303377529, 3241.8379081045855, 3263.673632636741, 3304.686054824788, 455101.0, 458682.83830197685, 460620.0, 461494.6925265352, 462552.9999999966, 60899.39100608937, 61098.38901610927, 61226.0, 61724.38275617276, 61725.38274617196, 50023.74988125036, 63734.681326594, 64095.67952160303, 64206.678966604864, 64254.35745642577, 15449.459268925533, 15761.0, 15929.203539822962, 15976.360945562279, 16017.839821601634, 11105.611303604335, 11377.829332560019, 11802.46888890002, 12195.51217951272, 12370.44333005017, 15083.849161508464, 16892.577685557713, 17458.388956386465, 17529.211185496682, 17548.736768948474, 6820.555619412265, 6871.381575658214, 6873.725050998004, 6927.376536111673, 6950.930490695028, 860.2687715441824, 879.4942907828024, 893.6425429828121, 895.7984453498041, 920.1580553793204, 29297.41405171927, 29309.0, 29356.853215733783, 29826.701732982827, 30211.79152833862, 1054.9630762923261, 1093.9343639381664, 1097.665212110314, 1107.7950579142885, 1188.7087663522493, 14923.179225142505, 15201.695966080837, 15407.383704651913, 15436.665688171883, 15695.215239237992, 562770.0, 566498.0, 568526.0, 569878.0, 573604.0, 58243.417565824646, 58357.41642583605, 58374.708126459096, 58828.0, 58847.0, 1423.8576142385887, 1441.8558144185497, 1459.3797636004656, 1461.5980605333618, 1463.6853076588584, 21692.45768855791, 24354.51290974206, 24523.877380612983, 24726.50546989086, 24860.751392486567, 36009.639903601674, 50101.74949125231, 50637.493625063275, 50666.493335066174, 53107.73446132745, 432472.2398596029, 436574.0, 519956.0, 522317.3884130555, 524343.0, 23770.762292376854, 24207.273781786575, 24235.63646545268, 36223.818880905426, 36488.635113648525, 41442.792786035876, 41489.58510414978, 41609.37585936274, 41663.16673666449, 42613.0, 28617.14148575546, 34824.47763283603, 34989.47515787316, 35740.82129589335, 36013.0, 34496.655033449344, 34735.13162170966, 35296.47055294224, 35489.29021419609, 35776.82111589425, 33732.0, 33904.491432628034, 33919.321613567095, 34290.65709342974, 34403.82798085993, 26532.469350613264, 27410.72589274082, 28122.01572944937, 29902.401951960404, 30374.088777336714, 23511.29466116019, 23513.529729404974, 23673.040869891265, 23680.52638947246, 23803.88098059568], "value": 19284.790463644844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.52599828209577, 389.9044734040161, 398.30098177698136, 401.73686235515737, 419.7397613479643, 15904.602384940383, 17177.57056073599, 19497.902510487445, 20785.480362990933, 20876.686849697227, 20746.962651867423, 21120.0, 21263.468413289676, 21454.785452145476, 21472.24847130351, 4488.97755511222, 5027.49725027498, 5352.57179425645, 5396.83809485716, 5418.8916221675545, 5204.375474943012, 5352.946470535284, 5366.114591092465, 5399.298091248133, 5400.162974738922, 5200.453952335007, 5283.682979021251, 5288.418273989858, 5290.788368465257, 5300.09898317285, 4638.817101639061, 5245.501677340647, 5276.261323414725, 5278.155495120763, 5294.391145018314, 5055.545000949895, 5217.139172036609, 5226.216067589892, 5245.632805703603, 5261.973690131563, 13053.804192937114, 13170.736585268241, 13173.407196676077, 13208.933955330162, 13359.1316564423, 2621.777148942342, 2637.116565950409, 2682.1283082997907, 2702.337927207847, 2715.8777854996574, 9982.950085249528, 10355.27513074085, 10366.740831479197, 14009.649758756012, 14070.73363397289, 1767.6641438126715, 1843.9262429502803, 1850.5928695686928, 1853.5829438376393, 1871.728599353086, 111402.44298778454, 113206.43396783045, 113822.0, 131122.0, 137576.0, 11727.472263748152, 11946.820797688042, 12014.15900886947, 12031.759364812655, 12205.633830985085, 14057.507987220399, 14616.049956752777, 15749.0, 15753.13357765334, 15763.605909852116, 8350.83298334042, 8585.914140858637, 8696.434731742416, 8755.518446485377, 8840.690575829944, 8416.2004609562, 8427.705030324032, 8435.662573496991, 8584.914150858536, 8594.656213751505, 4695.272232803853, 4790.94599188178, 4843.15244832153, 4854.077725232195, 4855.878603034882, 1750.8706884059711, 1982.3854605072474, 1986.8609197356047, 2023.9494012649802, 2056.311135769504, 683.2689022745615, 830.9418340716213, 837.7277384849948, 866.3156106675656, 880.540064572936, 19080.904595476935, 19102.522436939187, 19496.51258718515, 20570.14536818983, 21913.013914373892, 900.4642237868458, 918.5866360137965, 934.0892629686002, 934.4346670264392, 942.6135284533308, 11334.319940803578, 11495.770084598262, 11555.595554155732, 11574.421278936188, 11576.884231157748, 684659.0, 722392.0, 733509.0, 743464.5653543504, 747471.0, 145156.27421862824, 146194.0, 147967.0, 149465.0, 151366.94532218808, 1082.658962426833, 1110.4891749795024, 1128.5429401092736, 1128.7968165730247, 1129.175701737736, 17425.73861392055, 19503.376561285877, 20382.59234815266, 20537.589248215252, 20652.58694826125, 44395.11209775851, 52995.47004529905, 56591.434085660265, 56622.43377566336, 60748.785024298384, 66176.66911665603, 72906.63546682232, 77502.89988400401, 83176.0, 84403.0, 7104.644767761694, 7367.594782287026, 7978.561179135203, 8061.959690201512, 8524.147585241426, 11903.285802851857, 12834.0, 13097.869021309665, 13360.665983350495, 13401.06192566511, 10680.412577308012, 11377.4880130396, 11423.371714555778, 11677.357745323749, 11695.298282103102, 11087.778244434905, 11112.22214444981, 11253.549858005588, 11354.602588909349, 11601.651950441501, 9159.35884488106, 10369.688909332732, 11262.831057534308, 11639.0, 11697.181197316106, 7288.08898887639, 7424.665890034853, 7489.66296516669, 7533.171351151259, 7612.82001289801, 9691.418514889128, 11227.887721122685, 11445.313281203154, 11673.357965311989, 11732.002779763474], "value": 9479.600128718392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.73525294941, 1449.1015570346387, 1453.178953891052, 1469.7721853112764, 1481.207553958632, 6486.0, 7480.952666626663, 7656.96171519143, 8320.791980200505, 8336.16638336166, 6334.271558770743, 7969.601519924009, 8030.799230019238, 8052.677892884278, 8063.677452901877, 2158.5251244726137, 2185.3007037747925, 2193.2762188477764, 2196.1105752170397, 2198.329509499602, 2052.374025922093, 2225.7662945390744, 2259.8757068361233, 2276.7609401012905, 2276.8178545716387, 2043.4891277180704, 2187.58435897179, 2266.931992040233, 2275.260540324393, 2275.306031660343, 2176.1948079210792, 2233.2630232023394, 2263.671767593706, 2267.319804058776, 2271.4775601611723, 2266.150193677371, 2273.6703178039256, 2281.543691261738, 2299.988500057506, 2308.4690521180055, 8136.796580085486, 8296.626651800683, 8301.086880443207, 8306.8338633227, 8329.416940814146, 4985.900281994376, 5081.822136225214, 5116.386033675945, 5116.411612664554, 5324.760385782649, 3230.0632816483194, 3233.0300909727225, 3380.0873764083804, 3448.413769659164, 3465.2376477175235, 1055.3245922609535, 1231.2120243044458, 1240.683625675447, 1243.7388148488828, 1280.489022952915, 7846.019247594051, 9002.774930626721, 9976.750581235527, 10492.737681557946, 10508.316959397614, 4141.97929010353, 4273.401723758676, 4382.693211475166, 4541.0, 4588.862334129982, 8114.43198976066, 9204.355695101412, 9220.8616870747, 9228.03105673908, 9228.815423691623, 4600.010997635524, 4877.902441951142, 5149.2276158576515, 5149.253358263031, 5160.045391602565, 4589.747563884019, 4678.929816052762, 4712.269598212282, 4719.244920812722, 4741.2651039088305, 3049.3748781500185, 3589.6589823966683, 3648.1791596891017, 3649.39784935488, 3685.1155722626913, 938.3712912348743, 1050.2700623066896, 1111.5887121764838, 1123.00052952872, 1133.1557989298026, 807.8004163816728, 833.9867061520282, 926.7405126564573, 934.4673536084503, 943.1841457139525, 5229.189475631283, 5595.496405323459, 5601.271834661549, 5721.284839395075, 5894.8821023579285, 911.2937473458123, 1018.5823812236947, 1036.9585216591402, 1047.7642530430592, 1058.333250052462, 3687.410014397737, 3821.770693758328, 3895.668868146183, 3898.941515877264, 3926.646601805794, 8122.5126492410645, 9416.62333506652, 9700.223982081416, 9757.756056098513, 9759.414435133915, 9460.810783784285, 9470.100340467645, 9595.0, 9607.0, 9660.033996600425, 7566.735164269334, 7623.428242881806, 7666.578338191453, 7696.422768292288, 7709.691612335556, 5373.946260537345, 5435.891282174413, 5483.479069488392, 5552.69460179694, 5561.888762224814, 9084.909150908406, 9157.130072643089, 9157.725268241964, 9161.587728552098, 9166.862497062682, 6877.209120951155, 8907.153820387053, 9242.907570924473, 9277.721668349961, 9289.0, 6557.2131344239, 6596.967015164893, 6608.306127856698, 6651.63416012124, 6696.5647232929705, 7642.5032372895585, 7717.3440257576485, 7719.614019299125, 7729.690812367442, 7748.57382843949, 5852.795152169653, 6928.653567321715, 7048.753293634698, 7091.688037713039, 7160.319769621878, 6883.862322753617, 6911.75808846688, 6924.549904256207, 6964.79105626832, 6981.232064473005, 5128.358955130609, 6116.755329786759, 6258.593191442542, 6329.177206963065, 6336.398042185985, 4697.224957882048, 4873.585745211697, 4903.509649035068, 4922.507749225192, 4993.500649935123, 4883.560479556715, 4912.901741965212, 4933.777979990838, 5019.974900125622, 5042.890564075898], "value": 4281.635514447575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.99284014319716, 365.9542557180352, 369.163843893581, 374.509392695569, 376.7965298738681, 4925.325389367615, 4963.213243232438, 5272.789088436458, 5450.618456708032, 5586.21792948987, 5240.764165612547, 5354.759035843386, 5441.564674826004, 5501.697406642633, 5506.504414602685, 4116.361963895601, 4117.814698338567, 4260.01909112262, 4263.637590804786, 4305.547917468668, 3809.942850857239, 4115.8765237042935, 4288.807003684841, 4328.523862375137, 4337.609615134637, 3748.625137486257, 3786.2048969716393, 4043.07009387841, 4105.3431450967855, 4116.855910043149, 3764.6800021998165, 4140.730852494578, 4153.06556024895, 4166.895827604304, 4183.079722461053, 3311.288073064303, 3582.8208589570418, 3598.6581274779114, 3598.7660802048044, 3612.4039533477207, 4172.520160181588, 4929.65492415531, 5053.4946505349535, 5414.485623865727, 5445.346558412976, 3974.7615143091507, 4146.610885353411, 4435.512093669694, 4714.222153344694, 4754.286856971482, 5264.52619264268, 5293.444188360244, 5760.567957403212, 5795.797147099874, 5861.912071318934, 3126.937461250785, 3181.427343078245, 3527.6825085742407, 3666.9816650916573, 3715.758475699071, 5636.182753500761, 6085.2393450818645, 6088.452039316483, 6090.421409966046, 6114.633122012649, 3260.8532616032335, 3507.9298414031578, 3905.1603905160528, 3918.686505079587, 3969.61063627728, 3257.039173443792, 3904.492415985904, 4006.677796327205, 4042.5351084625645, 4043.9191216175514, 4343.087951530151, 4675.7895894684825, 4724.149653062482, 4736.621070314435, 4780.354652121989, 5334.933013397258, 5527.723613819293, 5791.754772723884, 5881.5000724938, 5888.411158884163, 1249.787536118862, 1267.6260503151593, 1292.7460363447442, 1298.6493646715335, 1299.616613099138, 850.4472093139509, 868.7133246028795, 879.7096958003843, 887.6360692116201, 888.4136469929815, 4693.81224751013, 5114.232865070269, 5151.922721159186, 5177.974110129425, 5192.324997750344, 4818.614510839195, 5633.0, 5688.0, 5698.857528561819, 5715.856553792328, 4278.871633850989, 4504.702601673105, 4612.654050946193, 4841.975790121027, 5174.327337446108, 2397.640353946887, 2444.327809852269, 2883.61071255382, 3001.9399612007637, 3090.1656552731088, 4973.378327709036, 5474.315710536183, 5697.401772813878, 5962.34414214436, 6006.459418652343, 5743.282089738783, 5874.794382196603, 5876.794312199053, 6163.599366041193, 6166.260048794174, 5423.511883930465, 6092.482139018144, 6233.781817636361, 6237.5945563539135, 6267.498600111889, 5023.367405593124, 5146.665466744649, 5631.621027383537, 5649.655393012018, 6003.42967418112, 4948.505149485167, 5612.747426365741, 5872.882542349214, 5971.328028152125, 6034.909476357946, 5519.834404967857, 6118.724657390517, 6155.661438620739, 6218.502519798496, 6235.469985051322, 3687.9900454253034, 3788.3938569828697, 3884.1649045454233, 3954.1696243789124, 3957.496151462426, 4872.9269060964825, 5985.665590419652, 6003.279606447254, 6003.429674180946, 6042.697865106639, 5532.861678458071, 5653.745581448927, 5702.806428400109, 5807.167269602042, 5846.239988801599, 4851.29656199842, 5005.499450054966, 5761.91357129635, 5855.306558982916, 5911.379305173067, 4663.976680116578, 4874.317595536557, 5073.0, 5377.569794416359, 5636.577256705681, 4457.955420445754, 5297.046531624191, 5786.4213578643485, 5856.824295271149, 5919.733611987384, 5223.410950283161, 5472.124460086367, 5698.971505142447, 5703.914441283467, 5727.828165155052], "value": 4145.993414231275, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5760172697246, 767.7428061599364, 823.7034667519696, 830.1988581019316, 839.6431516605443, 15288.006279591833, 15820.525384238492, 16000.679986400264, 16038.599035024115, 16060.437884674038, 14680.632984175374, 14707.779383309258, 14812.0, 14845.628859278524, 14854.405823767063, 689.7413469948744, 700.184285307616, 862.8274345130967, 867.3278209387728, 886.6896586194845, 881.532787622561, 886.450400751535, 893.5041052216018, 894.977625559363, 895.2703546609525, 943.5470973932516, 945.2579724915943, 945.2863088368273, 947.7156852944123, 950.116391755667, 915.2586405011962, 939.5208443693765, 941.6092321686492, 941.9340646154772, 943.504660053474, 696.3384784454738, 696.5576858694766, 698.0192829075157, 699.9475039372068, 701.1761180612759, 11678.0, 15140.0, 15198.620034499116, 15212.923935380362, 15531.145786981711, 12901.548445804352, 14536.781948270784, 14783.113013219241, 14826.629334266621, 14880.925595372062, 12271.57049503272, 12571.371431428392, 12699.809502857464, 12853.550125745647, 13045.478180872753, 4472.5303843096335, 4493.33746513792, 4537.2059889519205, 4580.152671755703, 4733.408323959505, 112190.43904780505, 113387.43306283499, 114400.0, 114646.0, 114972.0, 10690.893091069145, 10732.248742587944, 10792.298500597437, 10805.0, 10953.890461095447, 20977.79022209789, 21011.894940525504, 21037.579248414946, 21127.471813204793, 21155.365339039854, 7406.703731850774, 7596.278353556403, 7605.2333041053525, 7642.847143057108, 7824.295813376823, 4235.195312890541, 4257.893552661209, 4279.786010699452, 4296.61330480252, 4357.0, 3376.307856889332, 3472.3749725049734, 3474.704650104719, 3475.2701932594437, 3477.2871561329866, 568.687222027883, 634.0932466572846, 640.5260107520402, 640.5804198250154, 658.7529676371361, 581.9883602328015, 648.0506058624138, 667.5827607745159, 668.4665119198185, 672.4989882537541, 8148.348132149414, 9304.488253146006, 9611.903880961241, 9730.221582273402, 9790.657326993522, 529.721896004593, 623.314354210365, 636.9585976911486, 668.9498287628447, 691.2292793535172, 4575.908481830411, 4723.574878260973, 4758.666893317504, 4777.880552986203, 4789.128677901145, 102793.0, 104024.0, 104589.0, 104775.0, 106725.39911901328, 91997.54001230084, 93313.0, 94992.23197843893, 95977.520112399, 96268.03731962731, 80810.0, 81583.77624335639, 82047.5897620508, 82641.58679206566, 83191.0, 8341.749747507585, 8625.749266356468, 9187.632494700405, 9406.670766523139, 10566.841497377392, 50330.748346258035, 50533.74733126311, 51387.48612513827, 51442.45672629827, 52416.47583524269, 58039.0, 63176.0, 63320.683396582725, 63436.0, 73925.6303718478, 12788.36058197105, 13013.284269364896, 13165.802512962122, 13279.468821247043, 13524.59426217215, 14865.943699825373, 14970.382337102872, 15047.774283385977, 15153.62115947066, 15345.769813453031, 13658.453661853415, 13901.791473127709, 14074.085184462978, 14277.214753188258, 14360.066595671247, 13623.727525449634, 13678.658033549242, 13927.373268202753, 14207.431702731776, 14287.142771433748, 11355.432228388712, 13268.336583170996, 13365.331733413095, 14055.929720351332, 14227.928860356045, 10959.452027398438, 11254.606088786853, 11295.661130166109, 11339.829902551302, 11603.419829008348, 7258.0, 8342.79143021405, 10114.241431892491, 10351.84472232902, 10861.511231994422], "value": 7571.2427259140995, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 110.0, 150.0, 112.0, 117.0, 113.0, 114.0, 131.0, 114.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 201.0, 222.0, 218.0, 206.0, 265.0, 281.0, 200.0, 195.0, 195.0], "value": 217.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 62.0, 78.0, 87.0, 86.0, 83.0, 84.0, 79.0, 64.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 76.0, 94.0, 102.0, 102.0, 102.0, 84.0, 73.0, 95.0, 71.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 87.0, 91.0, 96.0, 91.0, 78.0, 136.0, 85.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 97.0, 100.0, 152.0, 92.0, 152.0, 152.0], "value": 112.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 93.0, 92.0, 92.0, 95.0, 94.0, 92.0, 90.0, 96.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 61.0, 63.0, 63.0, 62.0, 63.0, 63.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 69.0, 88.0, 78.0, 78.0, 71.0, 75.0, 111.0, 71.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 93.0, 100.0, 114.0, 111.0, 80.0, 113.0, 113.0, 112.0], "value": 101.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 155.0, 155.0, 155.0, 158.0, 158.0, 153.0, 156.0, 220.0, 158.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 175.0, 174.0, 176.0, 174.0, 172.0, 172.0, 171.0, 172.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 79.0, 94.0, 91.0, 88.0, 67.0, 67.0, 66.0, 69.0], "value": 76.6, "unit": "score"}]}]} 14:19:02 INFO - Return code: 0 14:19:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:19:02 ERROR - # TBPL SUCCESS # 14:19:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:02 INFO - 2017-01-10 14:19:02.308 screenresolution[1982:13368] starting screenresolution argv=screenresolution get 14:19:02 INFO - 2017-01-10 14:19:02.311 screenresolution[1982:13368] Display 0: 1600x1200x32@60 14:19:02 INFO - 2017-01-10 14:19:02.317 screenresolution[1983:13370] starting screenresolution argv=screenresolution list 14:19:02 INFO - Available Modes on Display 0 14:19:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:02 INFO - Intel Iris: 14:19:02 INFO - Chipset Model: Intel Iris 14:19:02 INFO - Type: GPU 14:19:02 INFO - Bus: Built-In 14:19:02 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:02 INFO - Vendor: Intel (0x8086) 14:19:02 INFO - Device ID: 0x0a2e 14:19:02 INFO - Revision ID: 0x0009 14:19:02 INFO - Displays: 14:19:02 INFO - Display: 14:19:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:02 INFO - Display Serial Number: 1600x1200 60 14:19:02 INFO - Main Display: Yes 14:19:02 INFO - Mirror: Off 14:19:02 INFO - Online: Yes 14:19:02 INFO - Rotation: Supported 14:19:02 INFO - Return code: 0 14:19:02 INFO - Running post-action listener: _resource_record_post_action 14:19:02 INFO - [mozharness: 2017-01-10 22:19:02.551922Z] Finished run-tests step (success) 14:19:02 INFO - Running post-run listener: _resource_record_post_run 14:19:02 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 434176; Write bytes: 554210304; Read time: 8; Write time: 1697 14:19:02 INFO - TinderboxPrint: CPU usage
54.7% 14:19:02 INFO - TinderboxPrint: I/O read bytes / time
434,176 / 8 14:19:02 INFO - TinderboxPrint: I/O write bytes / time
554,210,304 / 1,697 14:19:02 INFO - TinderboxPrint: CPU idle
2,175.0 (45.3%) 14:19:02 INFO - TinderboxPrint: CPU system
970.2 (20.2%) 14:19:02 INFO - TinderboxPrint: CPU user
1,652.6 (34.4%) 14:19:02 INFO - TinderboxPrint: Swap in / out
250,888,192 / 0 14:19:02 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 0; Write bytes: 253540352; Read time: 0; Write time: 568 14:19:02 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 352256; Write bytes: 299138048; Read time: 6; Write time: 1119 14:19:03 INFO - Running post-run listener: _upload_blobber_files 14:19:03 INFO - Blob upload gear active. 14:19:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:19:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:19:03 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:19:03 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:19:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:04 INFO - (blobuploader) - INFO - Done attempting. 14:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:05 INFO - (blobuploader) - INFO - Done attempting. 14:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:07 INFO - (blobuploader) - INFO - Done attempting. 14:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:19:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:09 INFO - (blobuploader) - INFO - Done attempting. 14:19:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:09 INFO - Return code: 0 14:19:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:19:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7216d39684cb5aeb4173c41e85688ecd24a824cd356cb9e34f443cbb643bf9ca58d935c69624e0f4cc8e417157ee4e6f18c681a0b28d6bf13b54d00e59fc6096", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3cdfb6e9194900192112c69b67d69cc5e64f3aa3614e14b80ddfd622f166569df6a9e599d6c710d2fedf8ac439011c809119d87971afaa55bddf2d6e7743b210", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10a906216870ffeaff8ad6e467988d77bb9be1952377f64522f875955176afe98cd42fd089cd7cf1839ba5c29d9853cbb5c14f312d9eab061a80e9dffd60ec69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7e77e9a4f5c26fae3e72265b67e83d93f5d9933d2fd330abe8888bc25ca2b9f76254589f2fcb3d8ae0e0bda0a1a749f15c706e46fc0f555ba33b2773f491900"} 14:19:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:19:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:19:09 INFO - Contents: 14:19:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7216d39684cb5aeb4173c41e85688ecd24a824cd356cb9e34f443cbb643bf9ca58d935c69624e0f4cc8e417157ee4e6f18c681a0b28d6bf13b54d00e59fc6096", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3cdfb6e9194900192112c69b67d69cc5e64f3aa3614e14b80ddfd622f166569df6a9e599d6c710d2fedf8ac439011c809119d87971afaa55bddf2d6e7743b210", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10a906216870ffeaff8ad6e467988d77bb9be1952377f64522f875955176afe98cd42fd089cd7cf1839ba5c29d9853cbb5c14f312d9eab061a80e9dffd60ec69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7e77e9a4f5c26fae3e72265b67e83d93f5d9933d2fd330abe8888bc25ca2b9f76254589f2fcb3d8ae0e0bda0a1a749f15c706e46fc0f555ba33b2773f491900"} 14:19:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:19:09 INFO - Copying logs to upload dir... 14:19:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:19:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.090811 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-10 14:19:09.379352) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 14:19:09.383206) ========= 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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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/Graphics/sha512/7216d39684cb5aeb4173c41e85688ecd24a824cd356cb9e34f443cbb643bf9ca58d935c69624e0f4cc8e417157ee4e6f18c681a0b28d6bf13b54d00e59fc6096", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3cdfb6e9194900192112c69b67d69cc5e64f3aa3614e14b80ddfd622f166569df6a9e599d6c710d2fedf8ac439011c809119d87971afaa55bddf2d6e7743b210", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10a906216870ffeaff8ad6e467988d77bb9be1952377f64522f875955176afe98cd42fd089cd7cf1839ba5c29d9853cbb5c14f312d9eab061a80e9dffd60ec69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7e77e9a4f5c26fae3e72265b67e83d93f5d9933d2fd330abe8888bc25ca2b9f76254589f2fcb3d8ae0e0bda0a1a749f15c706e46fc0f555ba33b2773f491900"} build_url:https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/R-92bzRATEmME__yQl3d2g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7216d39684cb5aeb4173c41e85688ecd24a824cd356cb9e34f443cbb643bf9ca58d935c69624e0f4cc8e417157ee4e6f18c681a0b28d6bf13b54d00e59fc6096", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3cdfb6e9194900192112c69b67d69cc5e64f3aa3614e14b80ddfd622f166569df6a9e599d6c710d2fedf8ac439011c809119d87971afaa55bddf2d6e7743b210", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10a906216870ffeaff8ad6e467988d77bb9be1952377f64522f875955176afe98cd42fd089cd7cf1839ba5c29d9853cbb5c14f312d9eab061a80e9dffd60ec69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a7e77e9a4f5c26fae3e72265b67e83d93f5d9933d2fd330abe8888bc25ca2b9f76254589f2fcb3d8ae0e0bda0a1a749f15c706e46fc0f555ba33b2773f491900"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-10 14:19:09.418998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:19:09.419383) ========= 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.j1NBi8GTAs/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.DJh9Cx7HBm/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.005282 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 14:19:09.468414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 14:19:09.468766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 14:19:09.469119) ========= ========= Total master_lag: 0.20 =========