builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0337 starttime: 1490779689.08 results: success (0) buildid: 20170329004027 builduid: 6ea758aee0f34738a96547945a477588 revision: 93a70cd28ef91670a90a21c9553541c8d98d7027 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.076241) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.076641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.076915) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.102383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.103047) ========= 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.9safsSBiSH/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.XATjzwYpDv/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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-03-29 02:28:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.10M=0.002s 2017-03-29 02:28:09 (7.10 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082541 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.214009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.214649) ========= 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.9safsSBiSH/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.XATjzwYpDv/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.021989 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:09.262729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-29 02:28:09.263115) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93a70cd28ef91670a90a21c9553541c8d98d7027 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93a70cd28ef91670a90a21c9553541c8d98d7027 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9safsSBiSH/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.XATjzwYpDv/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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-03-29 02:28:09,433 truncating revision to first 12 chars 2017-03-29 02:28:09,433 Setting DEBUG logging. 2017-03-29 02:28:09,433 attempt 1/10 2017-03-29 02:28:09,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/93a70cd28ef9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 02:28:11,482 unpacking tar archive at: mozilla-aurora-93a70cd28ef9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.421577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-29 02:28:11.708309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:11.708631) ========= script_repo_revision: 93a70cd28ef91670a90a21c9553541c8d98d7027 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:11.709029) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:11.709301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 02:28:11.728999) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-29 02:28:11.729277) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9safsSBiSH/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.XATjzwYpDv/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:28:12 INFO - MultiFileLogger online at 20170329 02:28:12 in /builds/slave/test 02:28:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:28:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:12 INFO - {'append_to_log': False, 02:28:12 INFO - 'base_work_dir': '/builds/slave/test', 02:28:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:28:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:12 INFO - 'branch': 'Mozilla-Aurora', 02:28:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:12 INFO - 'config_files': ('talos/mac_config.py',), 02:28:12 INFO - 'default_actions': ('clobber', 02:28:12 INFO - 'read-buildbot-config', 02:28:12 INFO - 'download-and-extract', 02:28:12 INFO - 'populate-webroot', 02:28:12 INFO - 'create-virtualenv', 02:28:12 INFO - 'install', 02:28:12 INFO - 'run-tests'), 02:28:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:12 INFO - 'download_minidump_stackwalk': True, 02:28:12 INFO - 'download_symbols': 'ondemand', 02:28:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:12 INFO - 'gecko_profile': False, 02:28:12 INFO - 'gecko_profile_interval': 0, 02:28:12 INFO - 'installer_path': 'installer.exe', 02:28:12 INFO - 'log_level': 'info', 02:28:12 INFO - 'log_name': 'talos', 02:28:12 INFO - 'log_to_console': True, 02:28:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:28:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:28:12 INFO - 'opt_config_files': (), 02:28:12 INFO - 'pip_index': False, 02:28:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:28:12 INFO - 'cmd': ('bash', 02:28:12 INFO - '-c', 02:28:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:28:12 INFO - 'enabled': True, 02:28:12 INFO - 'halt_on_failure': False, 02:28:12 INFO - 'name': 'check_screen_resolution'},), 02:28:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:28:12 INFO - 'cmd': ('bash', 02:28:12 INFO - '-c', 02:28:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:28:12 INFO - 'enabled': True, 02:28:12 INFO - 'halt_on_failure': False, 02:28:12 INFO - 'name': 'check_screen_resolution'},), 02:28:12 INFO - 'run_cmd_checks_enabled': True, 02:28:12 INFO - 'suite': 'dromaeojs-e10s', 02:28:12 INFO - 'system_bits': '32', 02:28:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:12 INFO - 'title': 't-yosemite-r7-0337', 02:28:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:12 INFO - 'use_talos_json': True, 02:28:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:12 INFO - 'work_dir': 'build'} 02:28:12 INFO - [mozharness: 2017-03-29 09:28:12.016222Z] Running clobber step. 02:28:12 INFO - Running pre-action listener: _resource_record_pre_action 02:28:12 INFO - Running main action method: clobber 02:28:12 INFO - rmtree: /builds/slave/test/build 02:28:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:13 INFO - Running post-action listener: _resource_record_post_action 02:28:13 INFO - [mozharness: 2017-03-29 09:28:13.879573Z] Finished clobber step (success) 02:28:13 INFO - [mozharness: 2017-03-29 09:28:13.879729Z] Running read-buildbot-config step. 02:28:13 INFO - Running pre-action listener: _resource_record_pre_action 02:28:13 INFO - Running main action method: read_buildbot_config 02:28:13 INFO - Using buildbot properties: 02:28:13 INFO - { 02:28:13 INFO - "project": "", 02:28:13 INFO - "product": "firefox", 02:28:13 INFO - "script_repo_revision": "production", 02:28:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:28:13 INFO - "repository": "", 02:28:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:28:13 INFO - "buildid": "20170329004027", 02:28:13 INFO - "stage_platform": "macosx64", 02:28:13 INFO - "basedir": "/builds/slave/test", 02:28:13 INFO - "nightly_build": "True", 02:28:13 INFO - "buildnumber": 30, 02:28:13 INFO - "slavename": "t-yosemite-r7-0337", 02:28:13 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:28:13 INFO - "platform": "yosemite_r7", 02:28:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:28:13 INFO - "branch": "mozilla-aurora", 02:28:13 INFO - "repo_path": "releases/mozilla-aurora", 02:28:13 INFO - "revision": "93a70cd28ef91670a90a21c9553541c8d98d7027", 02:28:13 INFO - "pgo_build": "False", 02:28:13 INFO - "builduid": "6ea758aee0f34738a96547945a477588", 02:28:13 INFO - "slavebuilddir": "test" 02:28:13 INFO - } 02:28:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:28:13 INFO - Running post-action listener: _resource_record_post_action 02:28:13 INFO - [mozharness: 2017-03-29 09:28:13.883538Z] Finished read-buildbot-config step (success) 02:28:13 INFO - [mozharness: 2017-03-29 09:28:13.883648Z] Running download-and-extract step. 02:28:13 INFO - Running pre-action listener: _resource_record_pre_action 02:28:13 INFO - Running main action method: download_and_extract 02:28:13 INFO - mkdir: /builds/slave/test/build/tests 02:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:13 INFO - trying https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:28:13 INFO - Downloading https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:28:14 INFO - Downloaded 1199 bytes. 02:28:14 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:28:14 INFO - Using the following test package requirements: 02:28:14 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:28:14 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:28:14 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:28:14 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'jsshell-mac.zip'], 02:28:14 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:28:14 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:28:14 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:28:14 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:28:14 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:28:14 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:28:14 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:28:14 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:28:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:28:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:28:14 INFO - Fetch https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:28:16 INFO - Expected file size: 51787795 02:28:16 INFO - Obtained file size: 51787795 02:28:32 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:28:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:28:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:28:32 INFO - Fetch https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:28:34 INFO - Expected file size: 51787795 02:28:34 INFO - Obtained file size: 51787795 02:28:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:28:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:28:49 INFO - Fetch https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:28:51 INFO - Expected file size: 14404438 02:28:51 INFO - Obtained file size: 14404438 02:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:51 INFO - trying https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:28:51 INFO - Downloading https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:28:53 INFO - Downloaded 74739594 bytes. 02:28:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:28:53 INFO - mkdir: /builds/slave/test/properties 02:28:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:53 INFO - Contents: 02:28:53 INFO - build_url:https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:28:55 INFO - Running post-action listener: _resource_record_post_action 02:28:55 INFO - Running post-action listener: set_extra_try_arguments 02:28:55 INFO - [mozharness: 2017-03-29 09:28:55.064671Z] Finished download-and-extract step (success) 02:28:55 INFO - [mozharness: 2017-03-29 09:28:55.064794Z] Running populate-webroot step. 02:28:55 INFO - Running pre-action listener: _resource_record_pre_action 02:28:55 INFO - Running main action method: populate_webroot 02:28:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:55 INFO - '--tppagecycles', 02:28:55 INFO - '7'], 02:28:55 INFO - 'tests': ['tsvgm']}}, 02:28:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['damp', 'tps']}, 02:28:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'tests': ['damp', 'tps']}, 02:28:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['dromaeo_dom']}, 02:28:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['basic_compositor_video']}, 02:28:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:28:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['a11yr', 02:28:55 INFO - 'ts_paint', 02:28:55 INFO - 'tpaint', 02:28:55 INFO - 'sessionrestore', 02:28:55 INFO - 'sessionrestore_no_auto_restore', 02:28:55 INFO - 'tabpaint']}, 02:28:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:55 INFO - 'ts_paint', 02:28:55 INFO - 'tpaint', 02:28:55 INFO - 'sessionrestore', 02:28:55 INFO - 'sessionrestore_no_auto_restore', 02:28:55 INFO - 'tabpaint']}, 02:28:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:55 INFO - 'ts_paint', 02:28:55 INFO - 'tpaint', 02:28:55 INFO - 'sessionrestore', 02:28:55 INFO - 'sessionrestore_no_auto_restore', 02:28:55 INFO - 'tabpaint']}, 02:28:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:55 INFO - 'ts_paint', 02:28:55 INFO - 'tpaint', 02:28:55 INFO - 'sessionrestore', 02:28:55 INFO - 'sessionrestore_no_auto_restore', 02:28:55 INFO - 'tabpaint']}, 02:28:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['a11yr', 02:28:55 INFO - 'ts_paint', 02:28:55 INFO - 'tpaint', 02:28:55 INFO - 'sessionrestore', 02:28:55 INFO - 'sessionrestore_no_auto_restore', 02:28:55 INFO - 'tabpaint']}, 02:28:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['a11yr', 02:28:55 INFO - 'ts_paint', 02:28:55 INFO - 'tpaint', 02:28:55 INFO - 'sessionrestore', 02:28:55 INFO - 'sessionrestore_no_auto_restore', 02:28:55 INFO - 'tabpaint']}, 02:28:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['tsvgx', 02:28:55 INFO - 'tsvgr_opacity', 02:28:55 INFO - 'tart', 02:28:55 INFO - 'tscrollx', 02:28:55 INFO - 'cart', 02:28:55 INFO - 'tsvg_static']}, 02:28:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:55 INFO - 'tsvgr_opacity', 02:28:55 INFO - 'tart', 02:28:55 INFO - 'tscrollx', 02:28:55 INFO - 'cart', 02:28:55 INFO - 'tsvg_static']}, 02:28:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'talos_options': ['--disable-e10s'], 02:28:55 INFO - 'tests': ['tp5o']}, 02:28:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:28:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'talos_options': ['--disable-e10s', 02:28:55 INFO - '--xperf_path', 02:28:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:55 INFO - 'tests': ['tp5n']}, 02:28:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:28:55 INFO - 'talos_options': ['--xperf_path', 02:28:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:55 INFO - 'tests': ['tp5n']}}, 02:28:55 INFO - 'talos.zip': {'path': '', 02:28:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:55 INFO - Running post-action listener: _resource_record_post_action 02:28:55 INFO - [mozharness: 2017-03-29 09:28:55.083524Z] Finished populate-webroot step (success) 02:28:55 INFO - [mozharness: 2017-03-29 09:28:55.083659Z] Running create-virtualenv step. 02:28:55 INFO - Running pre-action listener: _resource_record_pre_action 02:28:55 INFO - Running main action method: create_virtualenv 02:28:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:55 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 02:28:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:55 INFO - Using real prefix '/tools/python27' 02:28:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:58 INFO - Installing pip.................done. 02:28:58 INFO - Return code: 0 02:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:28:59 INFO - Reading from file tmpfile_stdout 02:28:59 INFO - Output received: 02:28:59 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) 02:28:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:28:59 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 02:28:59 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 02:28:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:28:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:59 INFO - 'HOME': '/Users/cltbld', 02:28:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:59 INFO - 'LOGNAME': 'cltbld', 02:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:59 INFO - 'MOZ_NO_REMOTE': '1', 02:28:59 INFO - 'NO_EM_RESTART': '1', 02:28:59 INFO - 'PAGER': '/bin/cat', 02:28:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:59 INFO - 'PWD': '/builds/slave/test', 02:28:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:59 INFO - 'SHELL': '/bin/bash', 02:28:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:28:59 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:28:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:59 INFO - 'USER': 'cltbld', 02:28:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:59 INFO - 'XPC_FLAGS': '0x0', 02:28:59 INFO - 'XPC_SERVICE_NAME': '0', 02:28:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:59 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 02:28:59 INFO - Cleaning up... 02:28:59 INFO - Return code: 0 02:28:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:59 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:28:59 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 02:28:59 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 02:28:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:28:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:59 INFO - 'HOME': '/Users/cltbld', 02:28:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:59 INFO - 'LOGNAME': 'cltbld', 02:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:59 INFO - 'MOZ_NO_REMOTE': '1', 02:28:59 INFO - 'NO_EM_RESTART': '1', 02:28:59 INFO - 'PAGER': '/bin/cat', 02:28:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:59 INFO - 'PWD': '/builds/slave/test', 02:28:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:59 INFO - 'SHELL': '/bin/bash', 02:28:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:28:59 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:28:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:59 INFO - 'USER': 'cltbld', 02:28:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:59 INFO - 'XPC_FLAGS': '0x0', 02:28:59 INFO - 'XPC_SERVICE_NAME': '0', 02:28:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:59 INFO - Downloading/unpacking psutil>=3.1.1 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:03 INFO - Installing collected packages: psutil 02:29:03 INFO - Running setup.py install for psutil 02:29:03 INFO - building 'psutil._psutil_osx' extension 02:29:03 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 02:29:03 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 02:29:03 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 02:29:03 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 02:29:03 INFO - building 'psutil._psutil_posix' extension 02:29:03 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 02:29:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:29:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:29:03 INFO - ^ 02:29:03 INFO - 1 warning generated. 02:29:03 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 02:29:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:04 INFO - Successfully installed psutil 02:29:04 INFO - Cleaning up... 02:29:04 INFO - Return code: 0 02:29:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:29:04 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')]} 02:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:04 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')]} 02:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:04 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:04 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 02:29:04 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 02:29:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:04 INFO - 'HOME': '/Users/cltbld', 02:29:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:04 INFO - 'LOGNAME': 'cltbld', 02:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:04 INFO - 'MOZ_NO_REMOTE': '1', 02:29:04 INFO - 'NO_EM_RESTART': '1', 02:29:04 INFO - 'PAGER': '/bin/cat', 02:29:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:04 INFO - 'PWD': '/builds/slave/test', 02:29:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:04 INFO - 'SHELL': '/bin/bash', 02:29:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:04 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:04 INFO - 'USER': 'cltbld', 02:29:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:04 INFO - 'XPC_FLAGS': '0x0', 02:29:04 INFO - 'XPC_SERVICE_NAME': '0', 02:29:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:29:08 INFO - Installing collected packages: mozsystemmonitor 02:29:08 INFO - Running setup.py install for mozsystemmonitor 02:29:08 INFO - Successfully installed mozsystemmonitor 02:29:08 INFO - Cleaning up... 02:29:08 INFO - Return code: 0 02:29:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:29:08 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')]} 02:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:08 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')]} 02:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:08 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:08 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 02:29:08 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 02:29:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:08 INFO - 'HOME': '/Users/cltbld', 02:29:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:08 INFO - 'LOGNAME': 'cltbld', 02:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:08 INFO - 'MOZ_NO_REMOTE': '1', 02:29:08 INFO - 'NO_EM_RESTART': '1', 02:29:08 INFO - 'PAGER': '/bin/cat', 02:29:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:08 INFO - 'PWD': '/builds/slave/test', 02:29:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:08 INFO - 'SHELL': '/bin/bash', 02:29:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:08 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:08 INFO - 'USER': 'cltbld', 02:29:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:08 INFO - 'XPC_FLAGS': '0x0', 02:29:08 INFO - 'XPC_SERVICE_NAME': '0', 02:29:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:29:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:11 INFO - Downloading functools32-3.2.3-2.tar.gz 02:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:29:11 INFO - warning: no files found matching '*.txt' 02:29:11 INFO - no previously-included directories found matching 'build' 02:29:11 INFO - no previously-included directories found matching 'dist' 02:29:11 INFO - no previously-included directories found matching '.git*' 02:29:11 INFO - Installing collected packages: jsonschema, functools32 02:29:11 INFO - Running setup.py install for functools32 02:29:12 INFO - warning: no files found matching '*.txt' 02:29:12 INFO - no previously-included directories found matching 'build' 02:29:12 INFO - no previously-included directories found matching 'dist' 02:29:12 INFO - no previously-included directories found matching '.git*' 02:29:12 INFO - Successfully installed jsonschema functools32 02:29:12 INFO - Cleaning up... 02:29:12 INFO - Return code: 0 02:29:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:29:12 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')]} 02:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:12 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')]} 02:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:12 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:12 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 02:29:12 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 02:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:12 INFO - 'HOME': '/Users/cltbld', 02:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:12 INFO - 'LOGNAME': 'cltbld', 02:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:12 INFO - 'MOZ_NO_REMOTE': '1', 02:29:12 INFO - 'NO_EM_RESTART': '1', 02:29:12 INFO - 'PAGER': '/bin/cat', 02:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:12 INFO - 'PWD': '/builds/slave/test', 02:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:12 INFO - 'SHELL': '/bin/bash', 02:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:12 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:12 INFO - 'USER': 'cltbld', 02:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:12 INFO - 'XPC_FLAGS': '0x0', 02:29:12 INFO - 'XPC_SERVICE_NAME': '0', 02:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:29:12 INFO - Cleaning up... 02:29:12 INFO - Return code: 0 02:29:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:12 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')]} 02:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:12 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')]} 02:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:12 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:12 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 02:29:12 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 02:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:12 INFO - 'HOME': '/Users/cltbld', 02:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:12 INFO - 'LOGNAME': 'cltbld', 02:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:12 INFO - 'MOZ_NO_REMOTE': '1', 02:29:12 INFO - 'NO_EM_RESTART': '1', 02:29:12 INFO - 'PAGER': '/bin/cat', 02:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:12 INFO - 'PWD': '/builds/slave/test', 02:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:12 INFO - 'SHELL': '/bin/bash', 02:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:12 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:12 INFO - 'USER': 'cltbld', 02:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:12 INFO - 'XPC_FLAGS': '0x0', 02:29:12 INFO - 'XPC_SERVICE_NAME': '0', 02:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:12 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 02:29:12 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 02:29:12 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 02:29:12 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 02:29:12 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 02:29:12 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 02:29:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29:16 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 02:29:16 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 02:29:16 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 02:29:16 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 02:29:16 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 02:29:16 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 02:29:16 INFO - Downloading docopt-0.6.1.tar.gz 02:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:16 INFO - Running setup.py install for blobuploader 02:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:16 INFO - Running setup.py install for requests 02:29:17 INFO - Running setup.py install for docopt 02:29:17 INFO - Successfully installed blobuploader requests docopt 02:29:17 INFO - Cleaning up... 02:29:17 INFO - Return code: 0 02:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:17 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')]} 02:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:17 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')]} 02:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:17 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:17 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 02:29:17 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 02:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:17 INFO - 'HOME': '/Users/cltbld', 02:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:17 INFO - 'LOGNAME': 'cltbld', 02:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:17 INFO - 'MOZ_NO_REMOTE': '1', 02:29:17 INFO - 'NO_EM_RESTART': '1', 02:29:17 INFO - 'PAGER': '/bin/cat', 02:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:17 INFO - 'PWD': '/builds/slave/test', 02:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:17 INFO - 'SHELL': '/bin/bash', 02:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:17 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:17 INFO - 'USER': 'cltbld', 02:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:17 INFO - 'XPC_FLAGS': '0x0', 02:29:17 INFO - 'XPC_SERVICE_NAME': '0', 02:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:17 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-5zmWHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:17 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-nRvV1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-BaBaGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-hQwcql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-xP6sAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-rWiadC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4nW6ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-UMisSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-6x0M6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-KdIaaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-KRZKs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:18 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-rh3SVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:19 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_5pyFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:19 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-iSTfcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:19 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-lthMpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:19 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-fQFpBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:19 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-APSmxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:19 INFO - Running setup.py install for manifestparser 02:29:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:19 INFO - Running setup.py install for mozcrash 02:29:19 INFO - Running setup.py install for mozdebug 02:29:19 INFO - Running setup.py install for mozdevice 02:29:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Running setup.py install for mozfile 02:29:20 INFO - Running setup.py install for mozhttpd 02:29:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Running setup.py install for mozinfo 02:29:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Running setup.py install for mozInstall 02:29:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:20 INFO - Running setup.py install for mozleak 02:29:20 INFO - Running setup.py install for mozlog 02:29:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Running setup.py install for moznetwork 02:29:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Running setup.py install for mozprocess 02:29:21 INFO - Running setup.py install for mozprofile 02:29:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Running setup.py install for mozrunner 02:29:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Running setup.py install for mozscreenshot 02:29:21 INFO - Running setup.py install for moztest 02:29:22 INFO - Running setup.py install for mozversion 02:29:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:22 INFO - Cleaning up... 02:29:22 INFO - Return code: 0 02:29:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:22 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')]} 02:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:22 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')]} 02:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:22 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:22 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 02:29:22 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 02:29:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:22 INFO - 'HOME': '/Users/cltbld', 02:29:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:22 INFO - 'LOGNAME': 'cltbld', 02:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:22 INFO - 'MOZ_NO_REMOTE': '1', 02:29:22 INFO - 'NO_EM_RESTART': '1', 02:29:22 INFO - 'PAGER': '/bin/cat', 02:29:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:22 INFO - 'PWD': '/builds/slave/test', 02:29:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:22 INFO - 'SHELL': '/bin/bash', 02:29:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:22 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:22 INFO - 'USER': 'cltbld', 02:29:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:22 INFO - 'XPC_FLAGS': '0x0', 02:29:22 INFO - 'XPC_SERVICE_NAME': '0', 02:29:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-czVmZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:22 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)) 02:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-uO5BAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:22 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)) 02:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-iM8tgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:22 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)) 02:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-zz_K4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:22 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)) 02:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-gJxHl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:22 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)) 02:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:22 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-AeET9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-YdVq54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-BEk4dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Cjgl_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ma7ihM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-gD7xxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-zrZ2tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-drl1M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-YE96LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:23 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)) 02:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:23 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-tYetGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:24 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)) 02:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:24 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-6BctKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:24 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)) 02:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:24 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-jFHoOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:24 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)) 02:29:24 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)) 02:29:24 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)) 02:29:24 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)) 02:29:24 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)) 02:29:24 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)) 02:29:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:24 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 02:29:24 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 02:29:24 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 02:29:24 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 02:29:24 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 02:29:24 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 02:29:26 INFO - Downloading blessings-1.6.tar.gz 02:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:27 INFO - Installing collected packages: blessings 02:29:27 INFO - Running setup.py install for blessings 02:29:27 INFO - Successfully installed blessings 02:29:27 INFO - Cleaning up... 02:29:27 INFO - Return code: 0 02:29:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:27 INFO - Reading from file tmpfile_stdout 02:29:27 INFO - Current package versions: 02:29:27 INFO - blessings == 1.6 02:29:27 INFO - blobuploader == 1.2.4 02:29:27 INFO - docopt == 0.6.1 02:29:27 INFO - functools32 == 3.2.3-2 02:29:27 INFO - jsonschema == 2.5.1 02:29:27 INFO - manifestparser == 1.1 02:29:27 INFO - mozInstall == 1.12 02:29:27 INFO - mozcrash == 1.0 02:29:27 INFO - mozdebug == 0.1 02:29:27 INFO - mozdevice == 0.49 02:29:27 INFO - mozfile == 1.2 02:29:27 INFO - mozhttpd == 0.7 02:29:27 INFO - mozinfo == 0.9 02:29:27 INFO - mozleak == 0.1 02:29:27 INFO - mozlog == 3.4 02:29:27 INFO - moznetwork == 0.27 02:29:27 INFO - mozprocess == 0.25 02:29:27 INFO - mozprofile == 0.28 02:29:27 INFO - mozrunner == 6.13 02:29:27 INFO - mozscreenshot == 0.1 02:29:27 INFO - mozsystemmonitor == 0.3 02:29:27 INFO - moztest == 0.8 02:29:27 INFO - mozversion == 1.4 02:29:27 INFO - psutil == 3.1.1 02:29:27 INFO - requests == 1.2.3 02:29:27 INFO - wsgiref == 0.1.2 02:29:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:27 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')]} 02:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 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')]} 02:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:27 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 02:29:27 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 02:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:27 INFO - 'HOME': '/Users/cltbld', 02:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:27 INFO - 'LOGNAME': 'cltbld', 02:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:27 INFO - 'MOZ_NO_REMOTE': '1', 02:29:27 INFO - 'NO_EM_RESTART': '1', 02:29:27 INFO - 'PAGER': '/bin/cat', 02:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:27 INFO - 'PWD': '/builds/slave/test', 02:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:27 INFO - 'SHELL': '/bin/bash', 02:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:27 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:27 INFO - 'USER': 'cltbld', 02:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:27 INFO - 'XPC_FLAGS': '0x0', 02:29:27 INFO - 'XPC_SERVICE_NAME': '0', 02:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 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)) 02:29:27 INFO - Cleaning up... 02:29:27 INFO - Return code: 0 02:29:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:29:27 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')]} 02:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 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')]} 02:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 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 0x1075b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5946ff90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, '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.9safsSBiSH/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.XATjzwYpDv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 02:29:27 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 02:29:27 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 02:29:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:27 INFO - 'HOME': '/Users/cltbld', 02:29:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:27 INFO - 'LOGNAME': 'cltbld', 02:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:27 INFO - 'MOZ_NO_REMOTE': '1', 02:29:27 INFO - 'NO_EM_RESTART': '1', 02:29:27 INFO - 'PAGER': '/bin/cat', 02:29:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:27 INFO - 'PWD': '/builds/slave/test', 02:29:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:27 INFO - 'SHELL': '/bin/bash', 02:29:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:27 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:27 INFO - 'USER': 'cltbld', 02:29:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:27 INFO - 'XPC_FLAGS': '0x0', 02:29:27 INFO - 'XPC_SERVICE_NAME': '0', 02:29:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:29:28 INFO - Cleaning up... 02:29:28 INFO - Return code: 0 02:29:28 INFO - Running post-action listener: _resource_record_post_action 02:29:28 INFO - Running post-action listener: _start_resource_monitoring 02:29:28 INFO - Starting resource monitoring. 02:29:28 INFO - [mozharness: 2017-03-29 09:29:28.158570Z] Finished create-virtualenv step (success) 02:29:28 INFO - [mozharness: 2017-03-29 09:29:28.159588Z] Running install step. 02:29:28 INFO - Running pre-action listener: _resource_record_pre_action 02:29:28 INFO - Running main action method: install 02:29:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:28 INFO - Reading from file tmpfile_stdout 02:29:28 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:28 INFO - Reading from file tmpfile_stdout 02:29:28 INFO - Output received: 02:29:28 INFO - Usage: mozinstall [options] installer 02:29:28 INFO - Options: 02:29:28 INFO - -h, --help show this help message and exit 02:29:28 INFO - -d DEST, --destination=DEST 02:29:28 INFO - Directory to install application into. [default: 02:29:28 INFO - "/builds/slave/test"] 02:29:28 INFO - --app=APP Application being installed. [default: firefox] 02:29:28 INFO - mkdir: /builds/slave/test/build/application 02:29:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:29:48 INFO - Reading from file tmpfile_stdout 02:29:48 INFO - Output received: 02:29:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:29:48 INFO - Running post-action listener: _resource_record_post_action 02:29:48 INFO - [mozharness: 2017-03-29 09:29:48.846734Z] Finished install step (success) 02:29:48 INFO - [mozharness: 2017-03-29 09:29:48.846910Z] Running run-tests step. 02:29:48 INFO - Running pre-action listener: _resource_record_pre_action 02:29:48 INFO - Running main action method: run_tests 02:29:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:29:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:29:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:29:48 INFO - 2017-03-29 02:29:48.861 screenresolution[1901:18612] starting screenresolution argv=screenresolution get 02:29:48 INFO - 2017-03-29 02:29:48.864 screenresolution[1901:18612] Display 0: 1600x1200x32@60 02:29:48 INFO - 2017-03-29 02:29:48.869 screenresolution[1902:18614] starting screenresolution argv=screenresolution list 02:29:48 INFO - Available Modes on Display 0 02:29:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:29:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:29:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:29:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:29:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:29:49 INFO - Intel Iris: 02:29:49 INFO - Chipset Model: Intel Iris 02:29:49 INFO - Type: GPU 02:29:49 INFO - Bus: Built-In 02:29:49 INFO - VRAM (Dynamic, Max): 1536 MB 02:29:49 INFO - Vendor: Intel (0x8086) 02:29:49 INFO - Device ID: 0x0a2e 02:29:49 INFO - Revision ID: 0x0009 02:29:49 INFO - Displays: 02:29:49 INFO - Display: 02:29:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:29:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:29:49 INFO - Display Serial Number: 1600x1200 60 02:29:49 INFO - Main Display: Yes 02:29:49 INFO - Mirror: Off 02:29:49 INFO - Online: Yes 02:29:49 INFO - Rotation: Supported 02:29:49 INFO - Return code: 0 02:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:49 INFO - Python 2.7.3 02:29:49 INFO - Return code: 0 02:29:49 INFO - grabbing minidump binary from tooltool 02:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:29:49 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 0x107396d30>, '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 0x1072bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10738bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:49 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 02:29:49 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 02:29:49 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 02:29:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:49 INFO - Return code: 0 02:29:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:29:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:49 INFO - ENV: RUST_BACKTRACE is now 1 02:29:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:29:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 02:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0337 --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 02:29:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9safsSBiSH/Render', 02:29:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:29:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:29:49 INFO - 'HOME': '/Users/cltbld', 02:29:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:29:49 INFO - 'LOGNAME': 'cltbld', 02:29:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:49 INFO - 'MOZ_NO_REMOTE': '1', 02:29:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:49 INFO - 'NO_EM_RESTART': '1', 02:29:49 INFO - 'PAGER': '/bin/cat', 02:29:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:49 INFO - 'PWD': '/builds/slave/test', 02:29:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:29:49 INFO - 'RUST_BACKTRACE': '1', 02:29:49 INFO - 'SHELL': '/bin/bash', 02:29:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XATjzwYpDv/Listeners', 02:29:49 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 02:29:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:29:49 INFO - 'USER': 'cltbld', 02:29:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:29:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:49 INFO - 'XPC_FLAGS': '0x0', 02:29:49 INFO - 'XPC_SERVICE_NAME': '0', 02:29:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:29:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 02:29:49 INFO - mozversion application_buildid: 20170329004027 02:29:49 INFO - mozversion application_changeset: 93a70cd28ef91670a90a21c9553541c8d98d7027 02:29:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:29:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:49 INFO - mozversion application_name: Firefox 02:29:49 INFO - mozversion application_remotingname: firefox-dev 02:29:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:49 INFO - mozversion application_vendor: Mozilla 02:29:49 INFO - mozversion application_version: 54.0a2 02:29:49 INFO - mozversion platform_buildid: 20170329004027 02:29:49 INFO - mozversion platform_changeset: 93a70cd28ef91670a90a21c9553541c8d98d7027 02:29:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:49 INFO - mozversion platform_version: 54.0a2 02:29:49 INFO - using testdate: 1490779789 02:29:49 INFO - actual date: 1490779789 02:29:49 INFO - starting webserver on 'localhost:54650' 02:29:49 INFO - SUITE-START | Running 2 tests 02:29:49 INFO - TEST-START | dromaeo_css 02:29:49 INFO - operating with platform_type : mac_ 02:29:49 INFO - Initialising browser for dromaeo_css test... 02:29:49 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpJ8nMju/profile http://localhost:54650/getInfo.html) 02:29:52 INFO - PROCESS | 1912 | 2017-03-29 02:29:52.198 plugin-container[1915:18785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 02:29:52 INFO - PROCESS | 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:29:52 INFO - PROCESS | 1912 | 2017-03-29 02:29:52.199 plugin-container[1915:18785] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 02:29:52 INFO - PROCESS | 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:29:52 INFO - PROCESS | 1912 | 2017-03-29 02:29:52.199 plugin-container[1915:18785] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:29:52 INFO - PROCESS | 1912 | __metrics Screen width/height:1600/1200 02:29:52 INFO - PROCESS | 1912 | colorDepth:24 02:29:52 INFO - PROCESS | 1912 | Browser inner width/height: 1024/689 02:29:52 INFO - PROCESS | 1912 | __metrics 02:29:52 ERROR - PROCESS | 1912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:29:53 INFO - TEST-INFO | 1912: exit 0 02:29:53 INFO - Browser initialized. 02:29:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:53 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpJ8nMju/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:55 INFO - PROCESS | 1916 | 2017-03-29 02:29:55.355 plugin-container[1917:18919] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 02:29:55 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:29:55 INFO - PROCESS | 1916 | 2017-03-29 02:29:55.356 plugin-container[1917:18919] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:29:55 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:29:55 INFO - PROCESS | 1916 | 2017-03-29 02:29:55.356 plugin-container[1917:18919] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:30:05 INFO - PROCESS | 1916 | RSS: Main: 220684288 02:30:05 INFO - PROCESS | 1916 | 02:33:09 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54650/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54650/tests/dromaeo/cssquery-ext.html) 02:33:10 INFO - PROCESS | 1916 | RSS: Main: 242380800 02:33:10 INFO - PROCESS | 1916 | 02:34:53 INFO - PROCESS | 1916 | ************************* 02:34:53 INFO - PROCESS | 1916 | A coding exception was thrown and uncaught in a Task. 02:34:53 INFO - PROCESS | 1916 | 02:34:53 ERROR - PROCESS | 1916 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:34:53 INFO - PROCESS | 1916 | Full stack: 02:34:53 INFO - PROCESS | 1916 | ************************* 02:36:12 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54650/tests/dromaeo/cssquery-ext.html (next: http://localhost:54650/tests/dromaeo/cssquery-jquery.html) 02:36:13 INFO - PROCESS | 1916 | RSS: Main: 249257984 02:36:13 INFO - PROCESS | 1916 | 02:39:15 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54650/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54650/tests/dromaeo/cssquery-mootools.html) 02:39:16 INFO - PROCESS | 1916 | RSS: Main: 256675840 02:39:16 INFO - PROCESS | 1916 | 02:42:17 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54650/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54650/tests/dromaeo/cssquery-prototype.html) 02:42:18 INFO - PROCESS | 1916 | RSS: Main: 252858368 02:42:18 INFO - PROCESS | 1916 | 02:45:21 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54650/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54650/tests/dromaeo/cssquery-yui.html) 02:45:21 INFO - PROCESS | 1916 | RSS: Main: 258150400 02:45:21 INFO - PROCESS | 1916 | 02:48:24 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:54650/tests/dromaeo/cssquery-yui.html (next: http://localhost:54650/tests/dromaeo/cssquery-dojo.html) 02:48:25 INFO - PROCESS | 1916 | RSS: Main: 254283776 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | __start_tp_report 02:48:25 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 02:48:25 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 02:48:25 INFO - PROCESS | 1916 | |i|pagename|runs| 02:48:25 INFO - PROCESS | 1916 | |0;dojo.html;3481.878134265301;3494.1264683829045;3510.8946731598044;3531.823408829558;3539.1506038550756;6152.230971128609;6165.938340616587;6187.319394866567;6194.5354098442685;6220.377962203777;6112.388761123885;6129.877402451948;6200.968995155029;6211.720472578733;6219.31587525373;5506.669599824013;5558.166275058733;5566.025945459549;5574.10814269717;5629.7185140742795;5635.802746903859;5638.464345887134;5638.887222255553;5639.830805075834;5704.087346024637;5382.515573598375;5412.2152287918225;5508.7521061552325;5633.324001119871;5636.18275350074;5555.638883472561;5560.082586373243;5589.524890384322;5593.216949627055;5615.775368985236;5486.177073438977;5507.173923911405;5538.889222215533;5553.555715542747;5564.137558678412;5886.852828679274;6206.627602343829;6229.937700622981;6270.090836828635;6302.338254483305;6308.684565771693;6316.715747791361;6333;6343.270523889765;6343.619382837044;6542.738290468375;6579.144711187515;6587.275399706028;6601.834954126137;6602.537822352389;6222.595531290543;6286.277078135981;6289.276733175652;6300.3384644612115;6313.305536390993;6364.49084073273;6396.968015159988;6429.260635026938;6613.404793568602;6704.530682852153;5736.512396446349;5781.93034288658;6358.618482890949;6380.55336126476;6388.488920886318;6501.2198536175965;6503.187101612299;6525.347465253437;6533.967330163318;6541.6402097885075;6441.645709486023;6446.419822216023;6458.38645328693;6464.997925321582;6476.5466417350335;6254.718537665816;6272.717727702265;6289.339619339995;6304.810855674337;6454.386833250834;5265.789368425297;5266;5270.525652691276;5270.894582108336;5318.095923692981;4619.214733495314;4663.183942809995;4679.906401872012;4693.601043911306;4712.316714076508;5973.581849270509;6065.393460653988;6094.786682466092;6242.563020588606;6246.15676883624;6412.4549413299455;6415.326390728999;6496.350364963466;6501.544891857619;6502.284748677642;6191.19514463117;6197.907031394533;6220.409061139185;6244;6245.718942647592;5532.86167845799;5781.768729250783;5785;5802.564807639444;5822.097574875901;6582.473402127723;6588.143541339595;6602.075709400592;6616.2722100567935;6668.633225172662;5418.738850075271;5508.944910550843;6578.276389597045;6587.703553340207;6616.90074648871;5793.015187418065;5884.146798714248;6452;6677.732890684319;6732.306405103787;5633.802816901389;6259.217597800275;6332.746690132527;6336.778212762531;6445.1943507061615;6545.14913061299;6582.275949645439;6582.736690532325;6585.901211481927;6612.636305003271;5006.524380183877;6257.1552840367785;6263.342349053284;6279.277883043325;6364.554481186273;5338.012467693489;6071.150038994456;6334.366563343813;6369.522285828489;6393.680315984275;4574.336721175345;5478.91781623268;6200.224971878515;6237.064440333987;6267.6866156692895;4998.825041123543;6348.206474190726;6351.888419526472;6379.266384365857;6386.16979792624;6252.749890004349;6295.937040629535;6322.683865806599;6342.619442833445;6343.111964324906 02:48:25 INFO - PROCESS | 1916 | |1;ext.html;662.8442316055726;762.8588711088446;805.8589746794312;830.4850992384722;953.7567920180348;38528;39183.21633567331;40646.593534064654;40690.59309406905;40791.77624671261;39353.60646393535;39651.40522892159;39664.405033924515;39704;39744.8076557703;7820.687172513107;7942.4043196760185;8790.824183516326;10742.086922611586;10879.564817407294;8927.955360223223;10534.209934254923;10622.203334749885;10629.255952083357;10631.946840265788;10630.734231644232;10658.840117398246;10673.83989240162;10680.931906809335;10683.893161068407;10572.418516981563;10612.575496980111;10613.363198208093;10632.521536530874;10643.308184967953;10415.218858585637;10430.16558675304;10481.37111773296;10488.58045678172;10489.160867130611;34419.31161376758;34580.7896723616;34650.48024279638;34681.47977780335;34734.305313893834;3752.2870654575545;3798.3542797724454;3801.7909015004166;3816.561095474028;3818.694504439638;25136.12023579184;25141.245762626968;25292;26696.19911402661;26717.732822671915;3060.7245347918793;3083.02884591353;3133.9216519586967;3156.542301366312;3265.7877237979455;334768;344547.2772636121;346689;347846;348171;44640;44650.55349446464;44795.776021120335;44830.77584612056;44951.775241123585;38379.23241535154;46962.530374695816;47248.763756181;47337.28994065092;47382.5261747385;13676.29046369204;13700.65748356299;13721.313934303245;13734.244616546186;13812.86187138136;11814.645560633195;11909.821352679717;12045.63863084109;12061.698457538632;12065.095117866194;12099.697507562381;12168.81746773799;12171.452284647212;12212.877871221173;12236.81644775329;4668.043051174569;4959.429665588504;5469.425710300441;5568.805091821848;5697.4587414195585;1078.191356482638;1078.309881675728;1097.5170924793065;1101.531848964187;1146.2091157101572;24228.152014679403;24449.877750611133;26876.790544425156;27479.038233661726;28358.85820570884;1129.768397478515;1163.784699830534;1175.6766889105393;1190.827330037157;1196.7427003194355;12621.873781262253;13315.667108322175;13849.16904985704;14177.51621186842;14321.64195895111;489601;489963;494393;494622;498597;56798.7160064197;57161.71419142961;57234.7138264306;57285;57388;1421.2396367943102;1456.8324642666016;1466.8899832512604;1472.433113251406;1477.9113253204841;25833.225003249932;26505.469890602464;26655.33361665974;27375.315617109733;27457.039003635575;43575.12849743051;43619;43629.909252268946;43684.12631747411;43751.56248437475;336487;379506.1024694859;387752;411332;412198;29302;32836.50745238871;32875.17812054718;32987.505187422685;32998;43522.78238608914;43787;44800.55199447964;44828.55171448374;45715;30379.240518986317;30478.542821858133;30522.694773052874;30834.38331233318;31320;30020.69979300179;30348;30393.088207353816;31116.066518004496;31332.843335783175;36482.27035459329;37102;37200.44199336958;37234;37263.813680931424;30796.53805192879;30916.95148828671;31023.68976310208;31793;32741.34517309688;23663.2901012963;24684.25947221586;24767.25698229056;25104.37239069038;25142.74857251477 02:48:25 INFO - PROCESS | 1916 | |2;jquery.html;422.74423973496016;432.74251820167007;433.8893582136555;446.93296005599154;448.47965397303136;18938.99999999998;20252.189912403486;21208.36374908751;21306.680399794015;21710;20449.773013619157;21058.473538161554;22021.449463763412;22063.44841378966;22332.665010024823;6321.905171422432;6470.288268290485;6510.08858759774;6528.183977002875;6530.379613936692;6303.432691057804;6746.190457145125;6797.592144471323;6799.354061364163;6800.795976120724;6378.107065010902;6439.839004024913;6774.8306292342595;6775.119234499508;6791.456683465336;6432.324605916381;6454.612723236597;6468.514861385368;6476.48188144952;6479.384458476437;6329.082283068975;7431.851362972764;7787.766367008999;7851.764447066597;7876.17300183484;28512.429751404856;28878.566821497483;29117.85441072781;29785.808567657266;29839.552406713916;2890.2340879666904;2954.9113526594238;2977.4045190961892;2994.356213414105;3026.8335241561704;16146.434874779443;17252.30990760368;17327.96032238057;17455.952642841345;17845.929244245257;2042.8672136311093;2116.5766846630736;2119.788021197883;2120.4910821402905;2126.0751573065613;159598;171171;176452;176635.11682441764;180181.09909450499;19582.902085489768;21006.78993210079;21262.362129136152;21316.253931112336;21523;30877.69122308793;31057.378852423277;31223.843880780452;31288.843555782074;31397.372052559276;8388.664453421794;10243.231757618209;10345;10426.113780328757;10609.84085238722;8704.95647521771;8807.383483156118;8831.337649676172;8978.057303983118;9022.729318120468;9428.62285508572;9474.099960503741;9561.90438095624;9605.231581473465;9635.22918166545;4064.2277967186733;4129.799405460732;4139.751614903115;4154.646855017358;4175.498940127204;841.4362377207286;965.9565319560637;977.8777652793401;979.1970584120952;1022.7034160093639;20532.38402847917;21642.89178554097;21646.78353216479;21719.67420488694;21749.565008699738;835.6907944060615;973.4597298499401;1003.7641154328727;1016.1159790981893;1017.0998666180484;7850.411219158586;11002.394868282321;11185.384803835705;11227.943860280646;11264.94367528157;641996;718301;730779;737626;758263.208683953;153151;157544;158758;159516.20241898947;163558;1193.7433451807904;1265.6709255593428;1277.4570807407001;1281.2312612432652;1323.9205647660979;19310.648254622043;19996.300129495397;20159.39521814348;20194.29319973794;20204.39386818398;59036.70481647564;63025.68487157535;65868.35329116619;67495.98756018761;67967.32032679807;85720.85674859528;87020.56489717764;87783.56108219418;88131;89820.652690211;11204.607838725606;11488.770224595628;11509.597164099216;11607.709807254887;11865.110116741107;11043;12293.508259669514;12714.61856144317;12916.09587328878;12954.740905182032;9497.810043799223;10902.50938707776;11014.944925275642;11022.338659680445;11027.062699670618;9944.701658950244;10064.39613623185;10067.29528932997;10243.282970192015;10327.690169294932;10477.947610262205;11085.44572771342;11253.099752019654;11276.887231127585;11598.014168795748;9468.715938521855;11445.969862712396;11487.597934072268;11547.364894930859;11881.702957425789;10901.672949811518;10994.670159895217;11025.61410350634;11035.282706624044;11126 02:48:25 INFO - PROCESS | 1916 | |3;mootools.html;1516.1130738517966;1539.4381050916418;1563.2340153324872;1575.6218507558183;1578.4633224703603;9340.906590934088;10595.311304765195;11012.834807477875;11233.21367504274;11239.943800281007;11131.220814542985;11298.943505282463;11325.603603873866;11335.37655428951;11376.317420954727;1932.9999999999966;2429.6841410616594;2430.5138972205627;2436.244764123119;2437.293184976355;2353.7175538935267;2407.723111842134;2428.5264373447185;2439.499902519988;2446.7675570820743;2130.1160018592263;2149.6668016457475;2158.4388059104667;2383.4875501767115;2399.0883464283634;2333.6499525071204;2338.543983923136;2341.718993720756;2361.8110551155864;2364.8935797889135;2132.922873948646;2137.5724855028902;2139.016052615799;2141.646628306328;2151.688005239247;11025.062869656089;11045.061169800576;11088.833667494913;11118;11120.944395277971;5771.624844385102;5898.557608179403;5954.017587098167;5965.343812180657;5984;3398.660133986606;3502.719782417426;3618.0050486116265;3685.8341374638208;3685.9262814743556;1158.571328608412;1232.4700378837097;1247.108317552945;1249.8375211222483;1818.2454281473172;13741.24423156726;13912.51306204278;14914.776278355941;15514.301856416376;15560.688786224213;3635.9455757829933;4098.897527561835;4574.4968053514085;4758.904821903612;4791.041791641685;11636.3600001999;11638.592649257236;11657.941710291394;11680.649580512598;11692.649220523397;5810.244668193192;5823.854403639858;5877.647341159544;5878.588498805043;5888.234529511222;4425.557444255549;5110.770015349318;5303.973480132575;5355.678659280456;5358.678479291255;3817.4273858921383;3861.4400911867624;3917.2557214129224;3940.9211815763524;3969.7419667721506;1038.4548112240982;1041.037040737315;1043.9634612788516;1050.6532844161409;1056.0812093478723;732.7362149626131;778.2295527427918;799.2886331165267;803.863343231652;806.5684858600621;6265.530085243534;6319.778807741707;6401;6422.807315780534;6486.870262594722;941.2140862379989;943.7451887990204;959.5633986536109;990.2424645146468;1012;3230.935381292361;3328.284418849959;3574.517440145547;3955.8022098895517;4079.6940229482907;10637.627683031056;13485.393157307944;13696.383662735001;13735.24456154901;13773.38019789112;13246.072774905664;13467.461301547828;13611.659708507168;13634.386452609657;13715.588532344045;7388.7783366498015;10048.196144308584;10084.647037353658;10119.645812396531;10131.797364052678;6182.381761823782;6624.701888415129;6666.466682665278;6823.351781580742;6943.444524437932;11939.746326635579;12073.215241009306;12077;12201.450934707782;12215.63353099373;12038.157328987238;12075.335856527976;12085.39573021363;12221.75556488883;12243;8334.708285209988;8346.958265208636;8434.987801463863;8445.746627601182;8449;10236.48817559134;10243.94878025605;10314.690559283234;10347.965203479593;10371;8590.1839325264;8783.692570759993;8792.736217913473;8865.512396818236;8965.910340896768;8573.871391929002;8587.09835467267;8602.569871506274;8644.265237454636;8661.696840610548;7676.309132178131;7785;7819.178986206594;7826.843463130819;7860.096088949844;5721.256236689203;5762.855928601818;5775.566832487496;5920.230370051866;6004.459598636144;5821.854453638693;5908.261467316585;5997.370276121119;6040.124181993674;6170.629762214281 02:48:25 INFO - PROCESS | 1916 | |4;prototype.html;337.886807919347;346.229639053107;346.5373726075689;358.2887967384741;383.98848034558966;4234.6400555952705;4528.298113792363;4947.282644016615;4969.403671559414;5247.921281180786;4211.683574034284;5106.208537676657;5207.505286997739;5290.761915713792;5313.1764576490705;4126.793660316987;4352.389615842143;4617.515160908107;4632.953670463295;4641.862743627816;3977.840886364542;4065.512138543364;4116.300228961084;4681.384922201835;4698.271767875985;3857;4537.2740361542155;4546.477155127153;4561.566651168134;4572.428446444194;4031.778252196128;4040.575739547364;4383.947852515374;4581.312803079548;4593.724376537401;3490.8080055596934;3523.028466748862;3837.9424308635394;4296.271867364247;4431.335299705038;4368.5194628590825;4496.977515112436;5161.741912904377;5193.688378697252;5193.922091168635;4565.360849481075;4692.897169165243;5099.286099946011;5141.794328226903;5149.124648809674;5410.377806552257;5681.914771278434;5709.400512946122;5711;5719.656820590778;4017.991004497751;4525.637948964075;4530.120000199913;4545.36364908913;4623.56076172763;5369.865753356158;5387.757550910218;5472.373260834782;5522.030172844472;6098.054801505774;3934.7048971327263;4150.958490415118;4219.472565929259;4465.665075119314;4532.886677833015;4045.3325201342036;4316.503602085801;4581.450225972904;4600.010997635524;4772.3557319761385;4090.6727461802984;4669.556392142741;5091.861418204363;5121.056786274622;5165.66423182492;5355.705436201047;5397.4062853086125;5676.8864622707315;5712.6001179917;5763.625364351304;1340.993295033538;1594.5216435069433;1599.3122957128546;1605.1974012993503;1623.5454072859618;1014.2646581228697;1076.682378698286;1091.8471414002047;1101.6529793115144;1147.7079796264857;4851.205054129924;5226.398964119099;5252.133397989365;5289.444608316071;5314.721649072534;5072.467390923974;5953.058961062308;5969.835986926849;5975.52195824333;5997.520198384206;4526.732514895834;4858.80564777412;4948.356713627206;5084;5243.397009343898;2973.3200741580936;3021.879124835026;3093.3040065984974;3101.8516206050876;3112.5837743826955;5009.323741294878;5089.905670280833;5119.564836988823;5738.139279108083;6194.287656919512;5115.488451154929;5277.938795498601;5372.70450125239;5707.571932105108;5864.827034593099;5264.842054738364;5413.864653383697;5473.890522189534;6110.969445152924;6181.072839074175;4850.927236091532;5269.631125821155;5638.520725738194;5690.601657883908;5975.701214939322;5820.388859169896;5838.423625620973;5841.50347220491;5860.38465961085;5942.465178133989;5889.911651325147;6133.815985520441;6162.907556386568;6176.197094377702;6211.472024877936;3885.73713543094;4106.568810274878;4499.388004895961;4568.657350698644;4628.9537104628525;5050.671706339076;5287.9471205287455;5470.56235501151;5485.890282194254;5967.343592204941;4821.54195351441;5006.499350064964;5086.54221120101;5693.943060569507;5713.742976545153;4872.393269600747;5071.898562028665;5171.456997015259;5535.861603459945;5687.232223649919;5366.865828354323;5489.917651235314;5497.257870187474;5513.381143956589;5526.038256418913;5206.854492011751;5282.867928301823;5451.618386712892;5513.393526712139;5623.128415095667;4405.625521830681;4527.864164075083;5330.200469929541;5485.890282194414;5511.807086751945 02:48:25 INFO - PROCESS | 1916 | |5;yui.html;701.631643387222;723.7466886589694;769.242296338107;783.1620166421927;839.8782176584396;12152;15001.549953501399;15276.159811210378;15888.682226355466;16037.71698264139;13514;14552.05411648242;14876.256187190624;14883.479078232263;14912.40350385986;820.3396266005863;944.5466176235411;948.4972964328916;951.3245595627113;951.5194826612551;904.5160838951163;932.2635118256569;955.961761529538;967.8016006718606;967.8354679704432;1002.8295189817712;1013.4881884648242;1016.8423894296396;1018.27193556607;1019.286499450384;1011.1152741351318;1011.5043628621996;1011.9949400252951;1013.6756238003842;1013.7516308504427;746.6266866566716;747.6000339818171;749.6589051981335;750.084896426359;751.2937838431857;15788.21058947048;15942.681146377123;16251.756223656655;16391.262393192217;16421.671566568722;13829.51596694111;13839.584812455541;14011.64970875726;14231.146131232055;14315.785263220956;11578.102328086154;11853.288802671867;11864.762704745943;11885.108616853771;11992.580259690869;3573.428251479777;3595.406757884946;3638.3632864248652;3684.078980254936;3803.8858834235016;100307.99999999927;100871.98256034838;111317.88682113156;115527;115596;10675.83986240207;10728.839067413996;10904.890951090547;10987.670369888916;10996.010359067563;22367.10531578751;22547.43631409228;22652;22690.773092268864;22853.857307134578;6574.178227721535;7728;7755.185705500954;7833.33416659579;7924.286814186751;4193.916121677549;4196.748195108304;4257.936130958038;4372.934405983913;4497.505274419811;3493.21402684394;3508.5789705235024;3558.5195998540385;3560.359135355661;3579.1767893384144;642.7653906324158;649.5355820588208;650.0346984727676;650.7006776882592;663.9535232533676;650.9902351464732;658.9621346379375;668.3717305732596;687.7592842505084;699.3915293694416;8691.391602587759;9145.862812057825;9206.447613143233;10192.451141280053;10458.163346932228;656.6224420957873;672.8762965847047;691.5788055545801;703.4126504368909;717.4081382859162;4882.6826256293225;4922.926156107661;4939.209726443752;4956.752162391938;4967.850964471072;86642.96749613734;101766.49116754517;102536;104454.4331835023;106370;90128.5493572541;90935.5453222743;91605;92565.5371723137;93311;79537;80930;81417;82279.17720822834;82402.58798706088;9466.980547639698;9711.5144242789;9718.416894986323;9731.221502279943;9734.659286925207;53760.92478150337;53779.462205377444;54639.45360546344;54797.1780423302;55698.72150639221;67584.32415675977;68592.62814743577;68931;69042;69087;10839.945800270949;10877.836832447678;11037.172212083966;11220.382878941737;11419.486123124645;12408.937955310166;13338.466461341437;13480.258585777876;13532.797008045085;13657.385417656427;10688.412137332522;11473.623165220228;11973.869757383416;12152.57465988686;12463.127581069239;11436.656900293005;11586.652400428;11979.940100299442;11988.220765650205;12554.121211515107;11415.200935934405;11788.469518871843;11828.940855295668;11932.940335298268;12462.31457269859;8936.41913275635;9108.407953483002;9292.692496808746;9307.906920930975;9447.858282125637;8478.279346255391;9673.467959262027;10055.648052318134;10207;10231.94884025575 02:48:25 INFO - PROCESS | 1916 | __end_tp_report 02:48:25 INFO - PROCESS | 1916 | __start_cc_report 02:48:25 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,408 02:48:25 INFO - PROCESS | 1916 | __end_cc_report 02:48:25 INFO - PROCESS | 1916 | __startTimestamp1490780905180__endTimestamp 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | ------- Summary: start ------- 02:48:25 INFO - PROCESS | 1916 | Number of tests: 6 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | [#0] dojo.html Cycles:165 Average:5989.62 Median:6245.72 stddev:657.15 (10.5%) stddev-sans-first:629.03 02:48:25 INFO - PROCESS | 1916 | Values: 3481.9 3494.1 3510.9 3531.8 3539.2 6152.2 6165.9 6187.3 6194.5 6220.4 6112.4 6129.9 6201.0 6211.7 6219.3 5506.7 5558.2 5566.0 5574.1 5629.7 5635.8 5638.5 5638.9 5639.8 5704.1 5382.5 5412.2 5508.8 5633.3 5636.2 5555.6 5560.1 5589.5 5593.2 5615.8 5486.2 5507.2 5538.9 5553.6 5564.1 5886.9 6206.6 6229.9 6270.1 6302.3 6308.7 6316.7 6333.0 6343.3 6343.6 6542.7 6579.1 6587.3 6601.8 6602.5 6222.6 6286.3 6289.3 6300.3 6313.3 6364.5 6397.0 6429.3 6613.4 6704.5 5736.5 5781.9 6358.6 6380.6 6388.5 6501.2 6503.2 6525.3 6534.0 6541.6 6441.6 6446.4 6458.4 6465.0 6476.5 6254.7 6272.7 6289.3 6304.8 6454.4 5265.8 5266.0 5270.5 5270.9 5318.1 4619.2 4663.2 4679.9 4693.6 4712.3 5973.6 6065.4 6094.8 6242.6 6246.2 6412.5 6415.3 6496.4 6501.5 6502.3 6191.2 6197.9 6220.4 6244.0 6245.7 5532.9 5781.8 5785.0 5802.6 5822.1 6582.5 6588.1 6602.1 6616.3 6668.6 5418.7 5508.9 6578.3 6587.7 6616.9 5793.0 5884.1 6452.0 6677.7 6732.3 5633.8 6259.2 6332.7 6336.8 6445.2 6545.1 6582.3 6582.7 6585.9 6612.6 5006.5 6257.2 6263.3 6279.3 6364.6 5338.0 6071.2 6334.4 6369.5 6393.7 4574.3 5478.9 6200.2 6237.1 6267.7 4998.8 6348.2 6351.9 6379.3 6386.2 6252.7 6295.9 6322.7 6342.6 6343.1 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | [#1] ext.html Cycles:180 Average:54394.38 Median:17226.96 stddev:109568.15 (636.0%) stddev-sans-first:109801.25 02:48:25 INFO - PROCESS | 1916 | Values: 662.8 762.9 805.9 830.5 953.8 38528.0 39183.2 40646.6 40690.6 40791.8 39353.6 39651.4 39664.4 39704.0 39744.8 7820.7 7942.4 8790.8 10742.1 10879.6 8928.0 10534.2 10622.2 10629.3 10631.9 10630.7 10658.8 10673.8 10680.9 10683.9 10572.4 10612.6 10613.4 10632.5 10643.3 10415.2 10430.2 10481.4 10488.6 10489.2 34419.3 34580.8 34650.5 34681.5 34734.3 3752.3 3798.4 3801.8 3816.6 3818.7 25136.1 25141.2 25292.0 26696.2 26717.7 3060.7 3083.0 3133.9 3156.5 3265.8 334768.0 344547.3 346689.0 347846.0 348171.0 44640.0 44650.6 44795.8 44830.8 44951.8 38379.2 46962.5 47248.8 47337.3 47382.5 13676.3 13700.7 13721.3 13734.2 13812.9 11814.6 11909.8 12045.6 12061.7 12065.1 12099.7 12168.8 12171.5 12212.9 12236.8 4668.0 4959.4 5469.4 5568.8 5697.5 1078.2 1078.3 1097.5 1101.5 1146.2 24228.2 24449.9 26876.8 27479.0 28358.9 1129.8 1163.8 1175.7 1190.8 1196.7 12621.9 13315.7 13849.2 14177.5 14321.6 489601.0 489963.0 494393.0 494622.0 498597.0 56798.7 57161.7 57234.7 57285.0 57388.0 1421.2 1456.8 1466.9 1472.4 1477.9 25833.2 26505.5 26655.3 27375.3 27457.0 43575.1 43619.0 43629.9 43684.1 43751.6 336487.0 379506.1 387752.0 411332.0 412198.0 29302.0 32836.5 32875.2 32987.5 32998.0 43522.8 43787.0 44800.6 44828.6 45715.0 30379.2 30478.5 30522.7 30834.4 31320.0 30020.7 30348.0 30393.1 31116.1 31332.8 36482.3 37102.0 37200.4 37234.0 37263.8 30796.5 30917.0 31023.7 31793.0 32741.3 23663.3 24684.3 24767.3 25104.4 25142.7 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | [#2] jquery.html Cycles:180 Average:42968.09 Median:21885.51 stddev:120815.31 (552.0%) stddev-sans-first:121112.00 02:48:25 INFO - PROCESS | 1916 | Values: 422.7 432.7 433.9 446.9 448.5 18939.0 20252.2 21208.4 21306.7 21710.0 20449.8 21058.5 22021.4 22063.4 22332.7 6321.9 6470.3 6510.1 6528.2 6530.4 6303.4 6746.2 6797.6 6799.4 6800.8 6378.1 6439.8 6774.8 6775.1 6791.5 6432.3 6454.6 6468.5 6476.5 6479.4 6329.1 7431.9 7787.8 7851.8 7876.2 28512.4 28878.6 29117.9 29785.8 29839.6 2890.2 2954.9 2977.4 2994.4 3026.8 16146.4 17252.3 17328.0 17456.0 17845.9 2042.9 2116.6 2119.8 2120.5 2126.1 159598.0 171171.0 176452.0 176635.1 180181.1 19582.9 21006.8 21262.4 21316.3 21523.0 30877.7 31057.4 31223.8 31288.8 31397.4 8388.7 10243.2 10345.0 10426.1 10609.8 8705.0 8807.4 8831.3 8978.1 9022.7 9428.6 9474.1 9561.9 9605.2 9635.2 4064.2 4129.8 4139.8 4154.6 4175.5 841.4 966.0 977.9 979.2 1022.7 20532.4 21642.9 21646.8 21719.7 21749.6 835.7 973.5 1003.8 1016.1 1017.1 7850.4 11002.4 11185.4 11227.9 11264.9 641996.0 718301.0 730779.0 737626.0 758263.2 153151.0 157544.0 158758.0 159516.2 163558.0 1193.7 1265.7 1277.5 1281.2 1323.9 19310.6 19996.3 20159.4 20194.3 20204.4 59036.7 63025.7 65868.4 67496.0 67967.3 85720.9 87020.6 87783.6 88131.0 89820.7 11204.6 11488.8 11509.6 11607.7 11865.1 11043.0 12293.5 12714.6 12916.1 12954.7 9497.8 10902.5 11014.9 11022.3 11027.1 9944.7 10064.4 10067.3 10243.3 10327.7 10477.9 11085.4 11253.1 11276.9 11598.0 9468.7 11446.0 11487.6 11547.4 11881.7 10901.7 10994.7 11025.6 11035.3 11126.0 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | [#3] mootools.html Cycles:180 Average:6615.12 Median:2436.77 stddev:4155.91 (170.5%) stddev-sans-first:4149.91 02:48:25 INFO - PROCESS | 1916 | Values: 1516.1 1539.4 1563.2 1575.6 1578.5 9340.9 10595.3 11012.8 11233.2 11239.9 11131.2 11298.9 11325.6 11335.4 11376.3 1933.0 2429.7 2430.5 2436.2 2437.3 2353.7 2407.7 2428.5 2439.5 2446.8 2130.1 2149.7 2158.4 2383.5 2399.1 2333.6 2338.5 2341.7 2361.8 2364.9 2132.9 2137.6 2139.0 2141.6 2151.7 11025.1 11045.1 11088.8 11118.0 11120.9 5771.6 5898.6 5954.0 5965.3 5984.0 3398.7 3502.7 3618.0 3685.8 3685.9 1158.6 1232.5 1247.1 1249.8 1818.2 13741.2 13912.5 14914.8 15514.3 15560.7 3635.9 4098.9 4574.5 4758.9 4791.0 11636.4 11638.6 11657.9 11680.6 11692.6 5810.2 5823.9 5877.6 5878.6 5888.2 4425.6 5110.8 5304.0 5355.7 5358.7 3817.4 3861.4 3917.3 3940.9 3969.7 1038.5 1041.0 1044.0 1050.7 1056.1 732.7 778.2 799.3 803.9 806.6 6265.5 6319.8 6401.0 6422.8 6486.9 941.2 943.7 959.6 990.2 1012.0 3230.9 3328.3 3574.5 3955.8 4079.7 10637.6 13485.4 13696.4 13735.2 13773.4 13246.1 13467.5 13611.7 13634.4 13715.6 7388.8 10048.2 10084.6 10119.6 10131.8 6182.4 6624.7 6666.5 6823.4 6943.4 11939.7 12073.2 12077.0 12201.5 12215.6 12038.2 12075.3 12085.4 12221.8 12243.0 8334.7 8347.0 8435.0 8445.7 8449.0 10236.5 10243.9 10314.7 10348.0 10371.0 8590.2 8783.7 8792.7 8865.5 8965.9 8573.9 8587.1 8602.6 8644.3 8661.7 7676.3 7785.0 7819.2 7826.8 7860.1 5721.3 5762.9 5775.6 5920.2 6004.5 5821.9 5908.3 5997.4 6040.1 6170.6 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | [#4] prototype.html Cycles:180 Average:4670.69 Median:5085.27 stddev:1310.72 (25.8%) stddev-sans-first:1273.42 02:48:25 INFO - PROCESS | 1916 | Values: 337.9 346.2 346.5 358.3 384.0 4234.6 4528.3 4947.3 4969.4 5247.9 4211.7 5106.2 5207.5 5290.8 5313.2 4126.8 4352.4 4617.5 4633.0 4641.9 3977.8 4065.5 4116.3 4681.4 4698.3 3857.0 4537.3 4546.5 4561.6 4572.4 4031.8 4040.6 4383.9 4581.3 4593.7 3490.8 3523.0 3837.9 4296.3 4431.3 4368.5 4497.0 5161.7 5193.7 5193.9 4565.4 4692.9 5099.3 5141.8 5149.1 5410.4 5681.9 5709.4 5711.0 5719.7 4018.0 4525.6 4530.1 4545.4 4623.6 5369.9 5387.8 5472.4 5522.0 6098.1 3934.7 4151.0 4219.5 4465.7 4532.9 4045.3 4316.5 4581.5 4600.0 4772.4 4090.7 4669.6 5091.9 5121.1 5165.7 5355.7 5397.4 5676.9 5712.6 5763.6 1341.0 1594.5 1599.3 1605.2 1623.5 1014.3 1076.7 1091.8 1101.7 1147.7 4851.2 5226.4 5252.1 5289.4 5314.7 5072.5 5953.1 5969.8 5975.5 5997.5 4526.7 4858.8 4948.4 5084.0 5243.4 2973.3 3021.9 3093.3 3101.9 3112.6 5009.3 5089.9 5119.6 5738.1 6194.3 5115.5 5277.9 5372.7 5707.6 5864.8 5264.8 5413.9 5473.9 6111.0 6181.1 4850.9 5269.6 5638.5 5690.6 5975.7 5820.4 5838.4 5841.5 5860.4 5942.5 5889.9 6133.8 6162.9 6176.2 6211.5 3885.7 4106.6 4499.4 4568.7 4629.0 5050.7 5287.9 5470.6 5485.9 5967.3 4821.5 5006.5 5086.5 5693.9 5713.7 4872.4 5071.9 5171.5 5535.9 5687.2 5366.9 5489.9 5497.3 5513.4 5526.0 5206.9 5282.9 5451.6 5513.4 5623.1 4405.6 4527.9 5330.2 5485.9 5511.8 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - PROCESS | 1916 | [#5] yui.html Cycles:180 Average:20547.49 Median:3616.89 stddev:30075.89 (831.5%) stddev-sans-first:30123.35 02:48:25 INFO - PROCESS | 1916 | Values: 701.6 723.7 769.2 783.2 839.9 12152.0 15001.5 15276.2 15888.7 16037.7 13514.0 14552.1 14876.3 14883.5 14912.4 820.3 944.5 948.5 951.3 951.5 904.5 932.3 956.0 967.8 967.8 1002.8 1013.5 1016.8 1018.3 1019.3 1011.1 1011.5 1012.0 1013.7 1013.8 746.6 747.6 749.7 750.1 751.3 15788.2 15942.7 16251.8 16391.3 16421.7 13829.5 13839.6 14011.6 14231.1 14315.8 11578.1 11853.3 11864.8 11885.1 11992.6 3573.4 3595.4 3638.4 3684.1 3803.9 100308.0 100872.0 111317.9 115527.0 115596.0 10675.8 10728.8 10904.9 10987.7 10996.0 22367.1 22547.4 22652.0 22690.8 22853.9 6574.2 7728.0 7755.2 7833.3 7924.3 4193.9 4196.7 4257.9 4372.9 4497.5 3493.2 3508.6 3558.5 3560.4 3579.2 642.8 649.5 650.0 650.7 664.0 651.0 659.0 668.4 687.8 699.4 8691.4 9145.9 9206.4 10192.5 10458.2 656.6 672.9 691.6 703.4 717.4 4882.7 4922.9 4939.2 4956.8 4967.9 86643.0 101766.5 102536.0 104454.4 106370.0 90128.5 90935.5 91605.0 92565.5 93311.0 79537.0 80930.0 81417.0 82279.2 82402.6 9467.0 9711.5 9718.4 9731.2 9734.7 53760.9 53779.5 54639.5 54797.2 55698.7 67584.3 68592.6 68931.0 69042.0 69087.0 10839.9 10877.8 11037.2 11220.4 11419.5 12408.9 13338.5 13480.3 13532.8 13657.4 10688.4 11473.6 11973.9 12152.6 12463.1 11436.7 11586.7 11979.9 11988.2 12554.1 11415.2 11788.5 11828.9 11932.9 12462.3 8936.4 9108.4 9292.7 9307.9 9447.9 8478.3 9673.5 10055.6 10207.0 10231.9 02:48:25 INFO - PROCESS | 1916 | -------- Summary: end -------- 02:48:25 INFO - PROCESS | 1916 | 02:48:25 INFO - TEST-INFO | 1916: exit 0 02:48:25 INFO - TEST-OK | dromaeo_css | took 1116523ms 02:48:25 INFO - TEST-START | kraken 02:48:25 INFO - operating with platform_type : mac_ 02:48:25 INFO - Initialising browser for kraken test... 02:48:25 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpRwU2GC/profile http://localhost:54650/getInfo.html) 02:48:28 INFO - PROCESS | 1923 | 2017-03-29 02:48:28.888 plugin-container[1925:21067] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 02:48:28 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:48:28 INFO - PROCESS | 1923 | 2017-03-29 02:48:28.888 plugin-container[1925:21067] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.CFPasteboardClient' 02:48:28 INFO - PROCESS | 1923 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:48:28 INFO - PROCESS | 1923 | 2017-03-29 02:48:28.888 plugin-container[1925:21067] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:48:28 INFO - PROCESS | 1923 | __metrics Screen width/height:1600/1200 02:48:28 INFO - PROCESS | 1923 | colorDepth:24 02:48:28 INFO - PROCESS | 1923 | Browser inner width/height: 1024/689 02:48:28 INFO - PROCESS | 1923 | __metrics 02:48:29 ERROR - PROCESS | 1923 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:48:29 INFO - TEST-INFO | 1923: exit 0 02:48:29 INFO - Browser initialized. 02:48:29 INFO - Running cycle 1/1 for kraken test... 02:48:29 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpRwU2GC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:32 INFO - PROCESS | 1926 | 2017-03-29 02:48:32.419 plugin-container[1927:21189] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 02:48:32 INFO - PROCESS | 1926 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:48:32 INFO - PROCESS | 1926 | 2017-03-29 02:48:32.419 plugin-container[1927:21189] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 02:48:32 INFO - PROCESS | 1926 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:48:32 INFO - PROCESS | 1926 | 2017-03-29 02:48:32.419 plugin-container[1927:21189] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:48:42 INFO - PROCESS | 1926 | RSS: Main: 220790784 02:48:42 INFO - PROCESS | 1926 | 02:48:45 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54650/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:46 INFO - PROCESS | 1926 | RSS: Main: 235147264 02:48:46 INFO - PROCESS | 1926 | 02:48:48 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54650/tests/kraken/driver.html?testName=audio-dft) 02:48:49 INFO - PROCESS | 1926 | RSS: Main: 243126272 02:48:49 INFO - PROCESS | 1926 | 02:48:53 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54650/tests/kraken/driver.html?testName=audio-fft) 02:48:53 INFO - PROCESS | 1926 | RSS: Main: 244723712 02:48:53 INFO - PROCESS | 1926 | 02:48:55 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54650/tests/kraken/driver.html?testName=audio-oscillator) 02:48:56 INFO - PROCESS | 1926 | RSS: Main: 247459840 02:48:56 INFO - PROCESS | 1926 | 02:48:58 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54650/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:59 INFO - PROCESS | 1926 | RSS: Main: 248107008 02:48:59 INFO - PROCESS | 1926 | 02:49:02 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54650/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:02 INFO - PROCESS | 1926 | RSS: Main: 251842560 02:49:02 INFO - PROCESS | 1926 | 02:49:05 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54650/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:06 INFO - PROCESS | 1926 | RSS: Main: 251404288 02:49:06 INFO - PROCESS | 1926 | 02:49:09 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54650/tests/kraken/driver.html?testName=json-parse-financial) 02:49:10 INFO - PROCESS | 1926 | RSS: Main: 251064320 02:49:10 INFO - PROCESS | 1926 | 02:49:12 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54650/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:49:12 INFO - PROCESS | 1926 | RSS: Main: 251346944 02:49:12 INFO - PROCESS | 1926 | 02:49:14 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:49:15 INFO - PROCESS | 1926 | RSS: Main: 250920960 02:49:15 INFO - PROCESS | 1926 | 02:49:17 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:49:18 INFO - PROCESS | 1926 | RSS: Main: 251006976 02:49:18 INFO - PROCESS | 1926 | 02:49:21 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:49:22 INFO - PROCESS | 1926 | RSS: Main: 251387904 02:49:22 INFO - PROCESS | 1926 | 02:49:24 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:49:25 INFO - PROCESS | 1926 | RSS: Main: 251101184 02:49:25 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:54650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54650/tests/kraken/driver.html?testName=ai-astar) 02:49:27 INFO - PROCESS | 1926 | RSS: Main: 254332928 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | __start_tp_report 02:49:27 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 02:49:27 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 02:49:27 INFO - PROCESS | 1926 | |i|pagename|runs| 02:49:27 INFO - PROCESS | 1926 | |0;ai-astar;106;119;121;121;118;136;177;159;118;118 02:49:27 INFO - PROCESS | 1926 | |1;audio-beat-detection;142;110;111;143;118;146;135;113;131;115 02:49:27 INFO - PROCESS | 1926 | |2;audio-dft;202;198;211;199;196;245;202;285;227;235 02:49:27 INFO - PROCESS | 1926 | |3;audio-fft;87;58;60;86;63;63;61;77;71;68 02:49:27 INFO - PROCESS | 1926 | |4;audio-oscillator;80;58;84;96;105;102;116;83;72;83 02:49:27 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;90;88;103;137;90;90;96;111;91;89 02:49:27 INFO - PROCESS | 1926 | |6;imaging-darkroom;96;97;97;129;108;96;98;97;119;154 02:49:27 INFO - PROCESS | 1926 | |7;imaging-desaturate;134;150;115;92;90;105;118;91;140;148 02:49:27 INFO - PROCESS | 1926 | |8;json-parse-financial;67;65;66;68;89;105;83;69;69;70 02:49:27 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;57;66;71;104;98;66;57;71;84;57 02:49:27 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;88;84;84;86;85;83;88;85;100;107 02:49:27 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;149;137;166;149;146;151;154;156;214;153 02:49:27 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;175;169;166;168;165;168;166;168;169;166 02:49:27 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;67;67;65;65;66;66;72;59;77;102 02:49:27 INFO - PROCESS | 1926 | __end_tp_report 02:49:27 INFO - PROCESS | 1926 | __start_cc_report 02:49:27 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,1015 02:49:27 INFO - PROCESS | 1926 | __end_cc_report 02:49:27 INFO - PROCESS | 1926 | __startTimestamp1490780967647__endTimestamp 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | ------- Summary: start ------- 02:49:27 INFO - PROCESS | 1926 | Number of tests: 14 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:129.30 Median:121.00 stddev:22.04 (18.2%) stddev-sans-first:21.71 02:49:27 INFO - PROCESS | 1926 | Values: 106.0 119.0 121.0 121.0 118.0 136.0 177.0 159.0 118.0 118.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:133.00 stddev:14.47 (10.9%) stddev-sans-first:14.20 02:49:27 INFO - PROCESS | 1926 | Values: 142.0 110.0 111.0 143.0 118.0 146.0 135.0 113.0 131.0 115.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:220.00 Median:219.00 stddev:28.59 (13.1%) stddev-sans-first:29.57 02:49:27 INFO - PROCESS | 1926 | Values: 202.0 198.0 211.0 199.0 196.0 245.0 202.0 285.0 227.0 235.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:69.40 Median:69.50 stddev:10.64 (15.3%) stddev-sans-first:9.18 02:49:27 INFO - PROCESS | 1926 | Values: 87.0 58.0 60.0 86.0 63.0 63.0 61.0 77.0 71.0 68.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:81.50 stddev:17.06 (20.9%) stddev-sans-first:17.85 02:49:27 INFO - PROCESS | 1926 | Values: 80.0 58.0 84.0 96.0 105.0 102.0 116.0 83.0 72.0 83.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:90.00 stddev:15.41 (17.1%) stddev-sans-first:16.04 02:49:27 INFO - PROCESS | 1926 | Values: 90.0 88.0 103.0 137.0 90.0 90.0 96.0 111.0 91.0 89.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:96.50 stddev:19.48 (20.2%) stddev-sans-first:20.08 02:49:27 INFO - PROCESS | 1926 | Values: 96.0 97.0 97.0 129.0 108.0 96.0 98.0 97.0 119.0 154.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:118.30 Median:149.00 stddev:23.64 (15.9%) stddev-sans-first:24.38 02:49:27 INFO - PROCESS | 1926 | Values: 134.0 150.0 115.0 92.0 90.0 105.0 118.0 91.0 140.0 148.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:75.10 Median:69.00 stddev:13.13 (19.0%) stddev-sans-first:13.59 02:49:27 INFO - PROCESS | 1926 | Values: 67.0 65.0 66.0 68.0 89.0 105.0 83.0 69.0 69.0 70.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:68.50 stddev:16.93 (24.7%) stddev-sans-first:16.93 02:49:27 INFO - PROCESS | 1926 | Values: 57.0 66.0 71.0 104.0 98.0 66.0 57.0 71.0 84.0 57.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:85.00 stddev:7.99 (9.4%) stddev-sans-first:8.46 02:49:27 INFO - PROCESS | 1926 | Values: 88.0 84.0 84.0 86.0 85.0 83.0 88.0 85.0 100.0 107.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:153.50 stddev:21.18 (13.8%) stddev-sans-first:22.24 02:49:27 INFO - PROCESS | 1926 | Values: 149.0 137.0 166.0 149.0 146.0 151.0 154.0 156.0 214.0 153.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:2.83 (1.7%) stddev-sans-first:1.48 02:49:27 INFO - PROCESS | 1926 | Values: 175.0 169.0 166.0 168.0 165.0 168.0 166.0 168.0 169.0 166.0 02:49:27 INFO - PROCESS | 1926 | 02:49:27 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:66.50 stddev:11.99 (18.0%) stddev-sans-first:12.65 02:49:27 INFO - PROCESS | 1926 | Values: 67.0 67.0 65.0 65.0 66.0 66.0 72.0 59.0 77.0 102.0 02:49:27 INFO - PROCESS | 1926 | -------- Summary: end -------- 02:49:27 INFO - PROCESS | 1926 | 02:49:28 INFO - TEST-INFO | 1926: exit 0 02:49:28 INFO - TEST-OK | kraken | took 62566ms 02:49:28 INFO - SUITE-END | took 1179s 02:49:28 INFO - Completed test suite (00:19:39) 02:49:28 INFO - javascript benchmark 02:49:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7683.951912722515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.878134265301, 3494.1264683829045, 3510.8946731598044, 3531.823408829558, 3539.1506038550756, 6152.230971128609, 6165.938340616587, 6187.319394866567, 6194.5354098442685, 6220.377962203777, 6112.388761123885, 6129.877402451948, 6200.968995155029, 6211.720472578733, 6219.31587525373, 5506.669599824013, 5558.166275058733, 5566.025945459549, 5574.10814269717, 5629.7185140742795, 5635.802746903859, 5638.464345887134, 5638.887222255553, 5639.830805075834, 5704.087346024637, 5382.515573598375, 5412.2152287918225, 5508.7521061552325, 5633.324001119871, 5636.18275350074, 5555.638883472561, 5560.082586373243, 5589.524890384322, 5593.216949627055, 5615.775368985236, 5486.177073438977, 5507.173923911405, 5538.889222215533, 5553.555715542747, 5564.137558678412, 5886.852828679274, 6206.627602343829, 6229.937700622981, 6270.090836828635, 6302.338254483305, 6308.684565771693, 6316.715747791361, 6333.0, 6343.270523889765, 6343.619382837044, 6542.738290468375, 6579.144711187515, 6587.275399706028, 6601.834954126137, 6602.537822352389, 6222.595531290543, 6286.277078135981, 6289.276733175652, 6300.3384644612115, 6313.305536390993, 6364.49084073273, 6396.968015159988, 6429.260635026938, 6613.404793568602, 6704.530682852153, 5736.512396446349, 5781.93034288658, 6358.618482890949, 6380.55336126476, 6388.488920886318, 6501.2198536175965, 6503.187101612299, 6525.347465253437, 6533.967330163318, 6541.6402097885075, 6441.645709486023, 6446.419822216023, 6458.38645328693, 6464.997925321582, 6476.5466417350335, 6254.718537665816, 6272.717727702265, 6289.339619339995, 6304.810855674337, 6454.386833250834, 5265.789368425297, 5266.0, 5270.525652691276, 5270.894582108336, 5318.095923692981, 4619.214733495314, 4663.183942809995, 4679.906401872012, 4693.601043911306, 4712.316714076508, 5973.581849270509, 6065.393460653988, 6094.786682466092, 6242.563020588606, 6246.15676883624, 6412.4549413299455, 6415.326390728999, 6496.350364963466, 6501.544891857619, 6502.284748677642, 6191.19514463117, 6197.907031394533, 6220.409061139185, 6244.0, 6245.718942647592, 5532.86167845799, 5781.768729250783, 5785.0, 5802.564807639444, 5822.097574875901, 6582.473402127723, 6588.143541339595, 6602.075709400592, 6616.2722100567935, 6668.633225172662, 5418.738850075271, 5508.944910550843, 6578.276389597045, 6587.703553340207, 6616.90074648871, 5793.015187418065, 5884.146798714248, 6452.0, 6677.732890684319, 6732.306405103787, 5633.802816901389, 6259.217597800275, 6332.746690132527, 6336.778212762531, 6445.1943507061615, 6545.14913061299, 6582.275949645439, 6582.736690532325, 6585.901211481927, 6612.636305003271, 5006.524380183877, 6257.1552840367785, 6263.342349053284, 6279.277883043325, 6364.554481186273, 5338.012467693489, 6071.150038994456, 6334.366563343813, 6369.522285828489, 6393.680315984275, 4574.336721175345, 5478.91781623268, 6200.224971878515, 6237.064440333987, 6267.6866156692895, 4998.825041123543, 6348.206474190726, 6351.888419526472, 6379.266384365857, 6386.16979792624, 6252.749890004349, 6295.937040629535, 6322.683865806599, 6342.619442833445, 6343.111964324906], "value": 5951.763531689102, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.8442316055726, 762.8588711088446, 805.8589746794312, 830.4850992384722, 953.7567920180348, 38528.0, 39183.21633567331, 40646.593534064654, 40690.59309406905, 40791.77624671261, 39353.60646393535, 39651.40522892159, 39664.405033924515, 39704.0, 39744.8076557703, 7820.687172513107, 7942.4043196760185, 8790.824183516326, 10742.086922611586, 10879.564817407294, 8927.955360223223, 10534.209934254923, 10622.203334749885, 10629.255952083357, 10631.946840265788, 10630.734231644232, 10658.840117398246, 10673.83989240162, 10680.931906809335, 10683.893161068407, 10572.418516981563, 10612.575496980111, 10613.363198208093, 10632.521536530874, 10643.308184967953, 10415.218858585637, 10430.16558675304, 10481.37111773296, 10488.58045678172, 10489.160867130611, 34419.31161376758, 34580.7896723616, 34650.48024279638, 34681.47977780335, 34734.305313893834, 3752.2870654575545, 3798.3542797724454, 3801.7909015004166, 3816.561095474028, 3818.694504439638, 25136.12023579184, 25141.245762626968, 25292.0, 26696.19911402661, 26717.732822671915, 3060.7245347918793, 3083.02884591353, 3133.9216519586967, 3156.542301366312, 3265.7877237979455, 334768.0, 344547.2772636121, 346689.0, 347846.0, 348171.0, 44640.0, 44650.55349446464, 44795.776021120335, 44830.77584612056, 44951.775241123585, 38379.23241535154, 46962.530374695816, 47248.763756181, 47337.28994065092, 47382.5261747385, 13676.29046369204, 13700.65748356299, 13721.313934303245, 13734.244616546186, 13812.86187138136, 11814.645560633195, 11909.821352679717, 12045.63863084109, 12061.698457538632, 12065.095117866194, 12099.697507562381, 12168.81746773799, 12171.452284647212, 12212.877871221173, 12236.81644775329, 4668.043051174569, 4959.429665588504, 5469.425710300441, 5568.805091821848, 5697.4587414195585, 1078.191356482638, 1078.309881675728, 1097.5170924793065, 1101.531848964187, 1146.2091157101572, 24228.152014679403, 24449.877750611133, 26876.790544425156, 27479.038233661726, 28358.85820570884, 1129.768397478515, 1163.784699830534, 1175.6766889105393, 1190.827330037157, 1196.7427003194355, 12621.873781262253, 13315.667108322175, 13849.16904985704, 14177.51621186842, 14321.64195895111, 489601.0, 489963.0, 494393.0, 494622.0, 498597.0, 56798.7160064197, 57161.71419142961, 57234.7138264306, 57285.0, 57388.0, 1421.2396367943102, 1456.8324642666016, 1466.8899832512604, 1472.433113251406, 1477.9113253204841, 25833.225003249932, 26505.469890602464, 26655.33361665974, 27375.315617109733, 27457.039003635575, 43575.12849743051, 43619.0, 43629.909252268946, 43684.12631747411, 43751.56248437475, 336487.0, 379506.1024694859, 387752.0, 411332.0, 412198.0, 29302.0, 32836.50745238871, 32875.17812054718, 32987.505187422685, 32998.0, 43522.78238608914, 43787.0, 44800.55199447964, 44828.55171448374, 45715.0, 30379.240518986317, 30478.542821858133, 30522.694773052874, 30834.38331233318, 31320.0, 30020.69979300179, 30348.0, 30393.088207353816, 31116.066518004496, 31332.843335783175, 36482.27035459329, 37102.0, 37200.44199336958, 37234.0, 37263.813680931424, 30796.53805192879, 30916.95148828671, 31023.68976310208, 31793.0, 32741.34517309688, 23663.2901012963, 24684.25947221586, 24767.25698229056, 25104.37239069038, 25142.74857251477], "value": 18449.31170238632, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.74423973496016, 432.74251820167007, 433.8893582136555, 446.93296005599154, 448.47965397303136, 18938.99999999998, 20252.189912403486, 21208.36374908751, 21306.680399794015, 21710.0, 20449.773013619157, 21058.473538161554, 22021.449463763412, 22063.44841378966, 22332.665010024823, 6321.905171422432, 6470.288268290485, 6510.08858759774, 6528.183977002875, 6530.379613936692, 6303.432691057804, 6746.190457145125, 6797.592144471323, 6799.354061364163, 6800.795976120724, 6378.107065010902, 6439.839004024913, 6774.8306292342595, 6775.119234499508, 6791.456683465336, 6432.324605916381, 6454.612723236597, 6468.514861385368, 6476.48188144952, 6479.384458476437, 6329.082283068975, 7431.851362972764, 7787.766367008999, 7851.764447066597, 7876.17300183484, 28512.429751404856, 28878.566821497483, 29117.85441072781, 29785.808567657266, 29839.552406713916, 2890.2340879666904, 2954.9113526594238, 2977.4045190961892, 2994.356213414105, 3026.8335241561704, 16146.434874779443, 17252.30990760368, 17327.96032238057, 17455.952642841345, 17845.929244245257, 2042.8672136311093, 2116.5766846630736, 2119.788021197883, 2120.4910821402905, 2126.0751573065613, 159598.0, 171171.0, 176452.0, 176635.11682441764, 180181.09909450499, 19582.902085489768, 21006.78993210079, 21262.362129136152, 21316.253931112336, 21523.0, 30877.69122308793, 31057.378852423277, 31223.843880780452, 31288.843555782074, 31397.372052559276, 8388.664453421794, 10243.231757618209, 10345.0, 10426.113780328757, 10609.84085238722, 8704.95647521771, 8807.383483156118, 8831.337649676172, 8978.057303983118, 9022.729318120468, 9428.62285508572, 9474.099960503741, 9561.90438095624, 9605.231581473465, 9635.22918166545, 4064.2277967186733, 4129.799405460732, 4139.751614903115, 4154.646855017358, 4175.498940127204, 841.4362377207286, 965.9565319560637, 977.8777652793401, 979.1970584120952, 1022.7034160093639, 20532.38402847917, 21642.89178554097, 21646.78353216479, 21719.67420488694, 21749.565008699738, 835.6907944060615, 973.4597298499401, 1003.7641154328727, 1016.1159790981893, 1017.0998666180484, 7850.411219158586, 11002.394868282321, 11185.384803835705, 11227.943860280646, 11264.94367528157, 641996.0, 718301.0, 730779.0, 737626.0, 758263.208683953, 153151.0, 157544.0, 158758.0, 159516.20241898947, 163558.0, 1193.7433451807904, 1265.6709255593428, 1277.4570807407001, 1281.2312612432652, 1323.9205647660979, 19310.648254622043, 19996.300129495397, 20159.39521814348, 20194.29319973794, 20204.39386818398, 59036.70481647564, 63025.68487157535, 65868.35329116619, 67495.98756018761, 67967.32032679807, 85720.85674859528, 87020.56489717764, 87783.56108219418, 88131.0, 89820.652690211, 11204.607838725606, 11488.770224595628, 11509.597164099216, 11607.709807254887, 11865.110116741107, 11043.0, 12293.508259669514, 12714.61856144317, 12916.09587328878, 12954.740905182032, 9497.810043799223, 10902.50938707776, 11014.944925275642, 11022.338659680445, 11027.062699670618, 9944.701658950244, 10064.39613623185, 10067.29528932997, 10243.282970192015, 10327.690169294932, 10477.947610262205, 11085.44572771342, 11253.099752019654, 11276.887231127585, 11598.014168795748, 9468.715938521855, 11445.969862712396, 11487.597934072268, 11547.364894930859, 11881.702957425789, 10901.672949811518, 10994.670159895217, 11025.61410350634, 11035.282706624044, 11126.0], "value": 11649.436474009619, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.1130738517966, 1539.4381050916418, 1563.2340153324872, 1575.6218507558183, 1578.4633224703603, 9340.906590934088, 10595.311304765195, 11012.834807477875, 11233.21367504274, 11239.943800281007, 11131.220814542985, 11298.943505282463, 11325.603603873866, 11335.37655428951, 11376.317420954727, 1932.9999999999966, 2429.6841410616594, 2430.5138972205627, 2436.244764123119, 2437.293184976355, 2353.7175538935267, 2407.723111842134, 2428.5264373447185, 2439.499902519988, 2446.7675570820743, 2130.1160018592263, 2149.6668016457475, 2158.4388059104667, 2383.4875501767115, 2399.0883464283634, 2333.6499525071204, 2338.543983923136, 2341.718993720756, 2361.8110551155864, 2364.8935797889135, 2132.922873948646, 2137.5724855028902, 2139.016052615799, 2141.646628306328, 2151.688005239247, 11025.062869656089, 11045.061169800576, 11088.833667494913, 11118.0, 11120.944395277971, 5771.624844385102, 5898.557608179403, 5954.017587098167, 5965.343812180657, 5984.0, 3398.660133986606, 3502.719782417426, 3618.0050486116265, 3685.8341374638208, 3685.9262814743556, 1158.571328608412, 1232.4700378837097, 1247.108317552945, 1249.8375211222483, 1818.2454281473172, 13741.24423156726, 13912.51306204278, 14914.776278355941, 15514.301856416376, 15560.688786224213, 3635.9455757829933, 4098.897527561835, 4574.4968053514085, 4758.904821903612, 4791.041791641685, 11636.3600001999, 11638.592649257236, 11657.941710291394, 11680.649580512598, 11692.649220523397, 5810.244668193192, 5823.854403639858, 5877.647341159544, 5878.588498805043, 5888.234529511222, 4425.557444255549, 5110.770015349318, 5303.973480132575, 5355.678659280456, 5358.678479291255, 3817.4273858921383, 3861.4400911867624, 3917.2557214129224, 3940.9211815763524, 3969.7419667721506, 1038.4548112240982, 1041.037040737315, 1043.9634612788516, 1050.6532844161409, 1056.0812093478723, 732.7362149626131, 778.2295527427918, 799.2886331165267, 803.863343231652, 806.5684858600621, 6265.530085243534, 6319.778807741707, 6401.0, 6422.807315780534, 6486.870262594722, 941.2140862379989, 943.7451887990204, 959.5633986536109, 990.2424645146468, 1012.0, 3230.935381292361, 3328.284418849959, 3574.517440145547, 3955.8022098895517, 4079.6940229482907, 10637.627683031056, 13485.393157307944, 13696.383662735001, 13735.24456154901, 13773.38019789112, 13246.072774905664, 13467.461301547828, 13611.659708507168, 13634.386452609657, 13715.588532344045, 7388.7783366498015, 10048.196144308584, 10084.647037353658, 10119.645812396531, 10131.797364052678, 6182.381761823782, 6624.701888415129, 6666.466682665278, 6823.351781580742, 6943.444524437932, 11939.746326635579, 12073.215241009306, 12077.0, 12201.450934707782, 12215.63353099373, 12038.157328987238, 12075.335856527976, 12085.39573021363, 12221.75556488883, 12243.0, 8334.708285209988, 8346.958265208636, 8434.987801463863, 8445.746627601182, 8449.0, 10236.48817559134, 10243.94878025605, 10314.690559283234, 10347.965203479593, 10371.0, 8590.1839325264, 8783.692570759993, 8792.736217913473, 8865.512396818236, 8965.910340896768, 8573.871391929002, 8587.09835467267, 8602.569871506274, 8644.265237454636, 8661.696840610548, 7676.309132178131, 7785.0, 7819.178986206594, 7826.843463130819, 7860.096088949844, 5721.256236689203, 5762.855928601818, 5775.566832487496, 5920.230370051866, 6004.459598636144, 5821.854453638693, 5908.261467316585, 5997.370276121119, 6040.124181993674, 6170.629762214281], "value": 5029.022974655158, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.886807919347, 346.229639053107, 346.5373726075689, 358.2887967384741, 383.98848034558966, 4234.6400555952705, 4528.298113792363, 4947.282644016615, 4969.403671559414, 5247.921281180786, 4211.683574034284, 5106.208537676657, 5207.505286997739, 5290.761915713792, 5313.1764576490705, 4126.793660316987, 4352.389615842143, 4617.515160908107, 4632.953670463295, 4641.862743627816, 3977.840886364542, 4065.512138543364, 4116.300228961084, 4681.384922201835, 4698.271767875985, 3857.0, 4537.2740361542155, 4546.477155127153, 4561.566651168134, 4572.428446444194, 4031.778252196128, 4040.575739547364, 4383.947852515374, 4581.312803079548, 4593.724376537401, 3490.8080055596934, 3523.028466748862, 3837.9424308635394, 4296.271867364247, 4431.335299705038, 4368.5194628590825, 4496.977515112436, 5161.741912904377, 5193.688378697252, 5193.922091168635, 4565.360849481075, 4692.897169165243, 5099.286099946011, 5141.794328226903, 5149.124648809674, 5410.377806552257, 5681.914771278434, 5709.400512946122, 5711.0, 5719.656820590778, 4017.991004497751, 4525.637948964075, 4530.120000199913, 4545.36364908913, 4623.56076172763, 5369.865753356158, 5387.757550910218, 5472.373260834782, 5522.030172844472, 6098.054801505774, 3934.7048971327263, 4150.958490415118, 4219.472565929259, 4465.665075119314, 4532.886677833015, 4045.3325201342036, 4316.503602085801, 4581.450225972904, 4600.010997635524, 4772.3557319761385, 4090.6727461802984, 4669.556392142741, 5091.861418204363, 5121.056786274622, 5165.66423182492, 5355.705436201047, 5397.4062853086125, 5676.8864622707315, 5712.6001179917, 5763.625364351304, 1340.993295033538, 1594.5216435069433, 1599.3122957128546, 1605.1974012993503, 1623.5454072859618, 1014.2646581228697, 1076.682378698286, 1091.8471414002047, 1101.6529793115144, 1147.7079796264857, 4851.205054129924, 5226.398964119099, 5252.133397989365, 5289.444608316071, 5314.721649072534, 5072.467390923974, 5953.058961062308, 5969.835986926849, 5975.52195824333, 5997.520198384206, 4526.732514895834, 4858.80564777412, 4948.356713627206, 5084.0, 5243.397009343898, 2973.3200741580936, 3021.879124835026, 3093.3040065984974, 3101.8516206050876, 3112.5837743826955, 5009.323741294878, 5089.905670280833, 5119.564836988823, 5738.139279108083, 6194.287656919512, 5115.488451154929, 5277.938795498601, 5372.70450125239, 5707.571932105108, 5864.827034593099, 5264.842054738364, 5413.864653383697, 5473.890522189534, 6110.969445152924, 6181.072839074175, 4850.927236091532, 5269.631125821155, 5638.520725738194, 5690.601657883908, 5975.701214939322, 5820.388859169896, 5838.423625620973, 5841.50347220491, 5860.38465961085, 5942.465178133989, 5889.911651325147, 6133.815985520441, 6162.907556386568, 6176.197094377702, 6211.472024877936, 3885.73713543094, 4106.568810274878, 4499.388004895961, 4568.657350698644, 4628.9537104628525, 5050.671706339076, 5287.9471205287455, 5470.56235501151, 5485.890282194254, 5967.343592204941, 4821.54195351441, 5006.499350064964, 5086.54221120101, 5693.943060569507, 5713.742976545153, 4872.393269600747, 5071.898562028665, 5171.456997015259, 5535.861603459945, 5687.232223649919, 5366.865828354323, 5489.917651235314, 5497.257870187474, 5513.381143956589, 5526.038256418913, 5206.854492011751, 5282.867928301823, 5451.618386712892, 5513.393526712139, 5623.128415095667, 4405.625521830681, 4527.864164075083, 5330.200469929541, 5485.890282194414, 5511.807086751945], "value": 4278.217774449578, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.631643387222, 723.7466886589694, 769.242296338107, 783.1620166421927, 839.8782176584396, 12152.0, 15001.549953501399, 15276.159811210378, 15888.682226355466, 16037.71698264139, 13514.0, 14552.05411648242, 14876.256187190624, 14883.479078232263, 14912.40350385986, 820.3396266005863, 944.5466176235411, 948.4972964328916, 951.3245595627113, 951.5194826612551, 904.5160838951163, 932.2635118256569, 955.961761529538, 967.8016006718606, 967.8354679704432, 1002.8295189817712, 1013.4881884648242, 1016.8423894296396, 1018.27193556607, 1019.286499450384, 1011.1152741351318, 1011.5043628621996, 1011.9949400252951, 1013.6756238003842, 1013.7516308504427, 746.6266866566716, 747.6000339818171, 749.6589051981335, 750.084896426359, 751.2937838431857, 15788.21058947048, 15942.681146377123, 16251.756223656655, 16391.262393192217, 16421.671566568722, 13829.51596694111, 13839.584812455541, 14011.64970875726, 14231.146131232055, 14315.785263220956, 11578.102328086154, 11853.288802671867, 11864.762704745943, 11885.108616853771, 11992.580259690869, 3573.428251479777, 3595.406757884946, 3638.3632864248652, 3684.078980254936, 3803.8858834235016, 100307.99999999927, 100871.98256034838, 111317.88682113156, 115527.0, 115596.0, 10675.83986240207, 10728.839067413996, 10904.890951090547, 10987.670369888916, 10996.010359067563, 22367.10531578751, 22547.43631409228, 22652.0, 22690.773092268864, 22853.857307134578, 6574.178227721535, 7728.0, 7755.185705500954, 7833.33416659579, 7924.286814186751, 4193.916121677549, 4196.748195108304, 4257.936130958038, 4372.934405983913, 4497.505274419811, 3493.21402684394, 3508.5789705235024, 3558.5195998540385, 3560.359135355661, 3579.1767893384144, 642.7653906324158, 649.5355820588208, 650.0346984727676, 650.7006776882592, 663.9535232533676, 650.9902351464732, 658.9621346379375, 668.3717305732596, 687.7592842505084, 699.3915293694416, 8691.391602587759, 9145.862812057825, 9206.447613143233, 10192.451141280053, 10458.163346932228, 656.6224420957873, 672.8762965847047, 691.5788055545801, 703.4126504368909, 717.4081382859162, 4882.6826256293225, 4922.926156107661, 4939.209726443752, 4956.752162391938, 4967.850964471072, 86642.96749613734, 101766.49116754517, 102536.0, 104454.4331835023, 106370.0, 90128.5493572541, 90935.5453222743, 91605.0, 92565.5371723137, 93311.0, 79537.0, 80930.0, 81417.0, 82279.17720822834, 82402.58798706088, 9466.980547639698, 9711.5144242789, 9718.416894986323, 9731.221502279943, 9734.659286925207, 53760.92478150337, 53779.462205377444, 54639.45360546344, 54797.1780423302, 55698.72150639221, 67584.32415675977, 68592.62814743577, 68931.0, 69042.0, 69087.0, 10839.945800270949, 10877.836832447678, 11037.172212083966, 11220.382878941737, 11419.486123124645, 12408.937955310166, 13338.466461341437, 13480.258585777876, 13532.797008045085, 13657.385417656427, 10688.412137332522, 11473.623165220228, 11973.869757383416, 12152.57465988686, 12463.127581069239, 11436.656900293005, 11586.652400428, 11979.940100299442, 11988.220765650205, 12554.121211515107, 11415.200935934405, 11788.469518871843, 11828.940855295668, 11932.940335298268, 12462.31457269859, 8936.41913275635, 9108.407953483002, 9292.692496808746, 9307.906920930975, 9447.858282125637, 8478.279346255391, 9673.467959262027, 10055.648052318134, 10207.0, 10231.94884025575], "value": 7478.0775039726705, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 121.0, 121.0, 118.0, 136.0, 177.0, 159.0, 118.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 111.0, 143.0, 118.0, 146.0, 135.0, 113.0, 131.0, 115.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 198.0, 211.0, 199.0, 196.0, 245.0, 202.0, 285.0, 227.0, 235.0], "value": 220.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 58.0, 60.0, 86.0, 63.0, 63.0, 61.0, 77.0, 71.0, 68.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 84.0, 96.0, 105.0, 102.0, 116.0, 83.0, 72.0, 83.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 103.0, 137.0, 90.0, 90.0, 96.0, 111.0, 91.0, 89.0], "value": 98.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 129.0, 108.0, 96.0, 98.0, 97.0, 119.0, 154.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 150.0, 115.0, 92.0, 90.0, 105.0, 118.0, 91.0, 140.0, 148.0], "value": 118.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 68.0, 89.0, 105.0, 83.0, 69.0, 69.0, 70.0], "value": 75.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 66.0, 71.0, 104.0, 98.0, 66.0, 57.0, 71.0, 84.0, 57.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 84.0, 86.0, 85.0, 83.0, 88.0, 85.0, 100.0, 107.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 137.0, 166.0, 149.0, 146.0, 151.0, 154.0, 156.0, 214.0, 153.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 166.0, 168.0, 165.0, 168.0, 166.0, 168.0, 169.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 65.0, 66.0, 66.0, 72.0, 59.0, 77.0, 102.0], "value": 70.6, "unit": "score"}]}]} 02:49:28 INFO - Return code: 0 02:49:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:49:28 ERROR - # TBPL SUCCESS # 02:49:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:28 INFO - 2017-03-29 02:49:28.955 screenresolution[1931:21571] starting screenresolution argv=screenresolution get 02:49:28 INFO - 2017-03-29 02:49:28.957 screenresolution[1931:21571] Display 0: 1600x1200x32@60 02:49:28 INFO - 2017-03-29 02:49:28.964 screenresolution[1932:21574] starting screenresolution argv=screenresolution list 02:49:28 INFO - Available Modes on Display 0 02:49:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:29 INFO - Intel Iris: 02:49:29 INFO - Chipset Model: Intel Iris 02:49:29 INFO - Type: GPU 02:49:29 INFO - Bus: Built-In 02:49:29 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:29 INFO - Vendor: Intel (0x8086) 02:49:29 INFO - Device ID: 0x0a2e 02:49:29 INFO - Revision ID: 0x0009 02:49:29 INFO - Displays: 02:49:29 INFO - Display: 02:49:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:29 INFO - Display Serial Number: 1600x1200 60 02:49:29 INFO - Main Display: Yes 02:49:29 INFO - Mirror: Off 02:49:29 INFO - Online: Yes 02:49:29 INFO - Rotation: Supported 02:49:29 INFO - Return code: 0 02:49:29 INFO - Running post-action listener: _resource_record_post_action 02:49:29 INFO - [mozharness: 2017-03-29 09:49:29.199654Z] Finished run-tests step (success) 02:49:29 INFO - Running post-run listener: _resource_record_post_run 02:49:29 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 1138688; Write bytes: 512211968; Read time: 11; Write time: 1614 02:49:29 INFO - TinderboxPrint: CPU usage
54.6% 02:49:29 INFO - TinderboxPrint: I/O read bytes / time
1,138,688 / 11 02:49:29 INFO - TinderboxPrint: I/O write bytes / time
512,211,968 / 1,614 02:49:29 INFO - TinderboxPrint: CPU idle
2,182.2 (45.4%) 02:49:29 INFO - TinderboxPrint: CPU system
966.9 (20.1%) 02:49:29 INFO - TinderboxPrint: CPU user
1,652.5 (34.4%) 02:49:29 INFO - TinderboxPrint: Swap in / out
208,756,736 / 0 02:49:29 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201323008; Write bytes: 199155712; Read time: 15494; Write time: 421 02:49:29 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 1138688; Write bytes: 303152128; Read time: 11; Write time: 1157 02:49:29 INFO - Running post-run listener: _upload_blobber_files 02:49:29 INFO - Blob upload gear active. 02:49:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:49:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:49:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:49:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:49:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:49:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:30 INFO - (blobuploader) - INFO - Done attempting. 02:49:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:49:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:49:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:31 INFO - (blobuploader) - INFO - Done attempting. 02:49:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:49:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:49:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:32 INFO - (blobuploader) - INFO - Done attempting. 02:49:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:49:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:34 INFO - (blobuploader) - INFO - Done attempting. 02:49:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:49:34 INFO - Return code: 0 02:49:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:49:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:49:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dabca5ea6cc9bbbea31e8ae4a557be47c21c0d1c8d5eb53486ae7e05ce9d0398866b5f3e3c7b2c8451d93bd4f855c57004c3cd7bfc6dce5b884c0d4adbad6274", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/765db5fb8e13dd51f6999d0ed707c834f8be20ee37cb36f38da9e290d455e3d25310d18b3284425f5d8dbe50cba2a45a9886687face7c13b8c5bf58d3b3d2f35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/394b32f649584fd42a2203021305bdc78328df00b9d79caed39d39ac52eb10183fd1733979ebb41730a4320ebf128b50b4a97c705db73db18f0abc6735172c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1fd5558cbd25002ea83b692981994d299e306246bc0f9abdea6a0fc4566c439fec5c57156ff5e3df8b805bebab6e9b75bc9dfd99981cf52fa6606ade06e14d"} 02:49:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:49:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:49:34 INFO - Contents: 02:49:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dabca5ea6cc9bbbea31e8ae4a557be47c21c0d1c8d5eb53486ae7e05ce9d0398866b5f3e3c7b2c8451d93bd4f855c57004c3cd7bfc6dce5b884c0d4adbad6274", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/765db5fb8e13dd51f6999d0ed707c834f8be20ee37cb36f38da9e290d455e3d25310d18b3284425f5d8dbe50cba2a45a9886687face7c13b8c5bf58d3b3d2f35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/394b32f649584fd42a2203021305bdc78328df00b9d79caed39d39ac52eb10183fd1733979ebb41730a4320ebf128b50b4a97c705db73db18f0abc6735172c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1fd5558cbd25002ea83b692981994d299e306246bc0f9abdea6a0fc4566c439fec5c57156ff5e3df8b805bebab6e9b75bc9dfd99981cf52fa6606ade06e14d"} 02:49:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:49:34 INFO - Copying logs to upload dir... 02:49:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:49:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.971014 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-29 02:49:34.749220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:34.752600) ========= 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.9safsSBiSH/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.XATjzwYpDv/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dabca5ea6cc9bbbea31e8ae4a557be47c21c0d1c8d5eb53486ae7e05ce9d0398866b5f3e3c7b2c8451d93bd4f855c57004c3cd7bfc6dce5b884c0d4adbad6274", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/765db5fb8e13dd51f6999d0ed707c834f8be20ee37cb36f38da9e290d455e3d25310d18b3284425f5d8dbe50cba2a45a9886687face7c13b8c5bf58d3b3d2f35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/394b32f649584fd42a2203021305bdc78328df00b9d79caed39d39ac52eb10183fd1733979ebb41730a4320ebf128b50b4a97c705db73db18f0abc6735172c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1fd5558cbd25002ea83b692981994d299e306246bc0f9abdea6a0fc4566c439fec5c57156ff5e3df8b805bebab6e9b75bc9dfd99981cf52fa6606ade06e14d"} build_url:https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/BpvuIEGERui6qrnZGEemBQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dabca5ea6cc9bbbea31e8ae4a557be47c21c0d1c8d5eb53486ae7e05ce9d0398866b5f3e3c7b2c8451d93bd4f855c57004c3cd7bfc6dce5b884c0d4adbad6274", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/765db5fb8e13dd51f6999d0ed707c834f8be20ee37cb36f38da9e290d455e3d25310d18b3284425f5d8dbe50cba2a45a9886687face7c13b8c5bf58d3b3d2f35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/394b32f649584fd42a2203021305bdc78328df00b9d79caed39d39ac52eb10183fd1733979ebb41730a4320ebf128b50b4a97c705db73db18f0abc6735172c5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1fd5558cbd25002ea83b692981994d299e306246bc0f9abdea6a0fc4566c439fec5c57156ff5e3df8b805bebab6e9b75bc9dfd99981cf52fa6606ade06e14d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:34.792181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:34.792653) ========= 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.9safsSBiSH/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.XATjzwYpDv/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 02:49:34.849515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 02:49:34.849829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 02:49:34.850180) ========= ========= Total master_lag: 0.21 =========