builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0183 starttime: 1486987863.53 results: success (0) buildid: 20170213030206 builduid: 124eca12da16496a945c3771324d006d revision: 00d16f03506b7f9f754b01a0a458c05445ac6dba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.527375) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.527875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.528181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.608119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.608474) ========= 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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-13 04:11:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-02-13 04:11:03 (37.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166227 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.801090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.804553) ========= 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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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.026274 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:03.853247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 04:11:03.856727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00d16f03506b7f9f754b01a0a458c05445ac6dba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 00d16f03506b7f9f754b01a0a458c05445ac6dba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IvtbX9V4Yf/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.89gQWvoYVG/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-13 04:11:03,968 truncating revision to first 12 chars 2017-02-13 04:11:03,968 Setting DEBUG logging. 2017-02-13 04:11:03,968 attempt 1/10 2017-02-13 04:11:03,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00d16f03506b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 04:11:05,474 unpacking tar archive at: mozilla-central-00d16f03506b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.779787 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 04:11:05.663177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:05.663563) ========= script_repo_revision: 00d16f03506b7f9f754b01a0a458c05445ac6dba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:05.664138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:05.664706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 04:11:05.687810) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-13 04:11:05.688202) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IvtbX9V4Yf/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.89gQWvoYVG/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:11:05 INFO - MultiFileLogger online at 20170213 04:11:05 in /builds/slave/test 04:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:05 INFO - {'append_to_log': False, 04:11:05 INFO - 'base_work_dir': '/builds/slave/test', 04:11:05 INFO - 'blob_upload_branch': 'Firefox', 04:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:05 INFO - 'branch': 'Firefox', 04:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:05 INFO - 'config_files': ('talos/mac_config.py',), 04:11:05 INFO - 'default_actions': ('clobber', 04:11:05 INFO - 'read-buildbot-config', 04:11:05 INFO - 'download-and-extract', 04:11:05 INFO - 'populate-webroot', 04:11:05 INFO - 'create-virtualenv', 04:11:05 INFO - 'install', 04:11:05 INFO - 'run-tests'), 04:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:05 INFO - 'download_minidump_stackwalk': True, 04:11:05 INFO - 'download_symbols': 'ondemand', 04:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:05 INFO - 'installer_path': 'installer.exe', 04:11:05 INFO - 'log_level': 'info', 04:11:05 INFO - 'log_name': 'talos', 04:11:05 INFO - 'log_to_console': True, 04:11:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:05 INFO - 'opt_config_files': (), 04:11:05 INFO - 'pip_index': False, 04:11:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:05 INFO - 'cmd': ('bash', 04:11:05 INFO - '-c', 04:11:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:05 INFO - 'enabled': True, 04:11:05 INFO - 'halt_on_failure': False, 04:11:05 INFO - 'name': 'check_screen_resolution'},), 04:11:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:05 INFO - 'cmd': ('bash', 04:11:05 INFO - '-c', 04:11:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:05 INFO - 'enabled': True, 04:11:05 INFO - 'halt_on_failure': False, 04:11:05 INFO - 'name': 'check_screen_resolution'},), 04:11:05 INFO - 'run_cmd_checks_enabled': True, 04:11:05 INFO - 'sps_profile': False, 04:11:05 INFO - 'sps_profile_interval': 0, 04:11:05 INFO - 'suite': 'dromaeojs-e10s', 04:11:05 INFO - 'system_bits': '32', 04:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:05 INFO - 'title': 't-yosemite-r7-0183', 04:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:05 INFO - 'use_talos_json': True, 04:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:05 INFO - 'work_dir': 'build'} 04:11:05 INFO - [mozharness: 2017-02-13 12:11:05.906627Z] Running clobber step. 04:11:05 INFO - Running pre-action listener: _resource_record_pre_action 04:11:05 INFO - Running main action method: clobber 04:11:05 INFO - rmtree: /builds/slave/test/build 04:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:08 INFO - Running post-action listener: _resource_record_post_action 04:11:08 INFO - [mozharness: 2017-02-13 12:11:08.451120Z] Finished clobber step (success) 04:11:08 INFO - [mozharness: 2017-02-13 12:11:08.451257Z] Running read-buildbot-config step. 04:11:08 INFO - Running pre-action listener: _resource_record_pre_action 04:11:08 INFO - Running main action method: read_buildbot_config 04:11:08 INFO - Using buildbot properties: 04:11:08 INFO - { 04:11:08 INFO - "project": "", 04:11:08 INFO - "product": "firefox", 04:11:08 INFO - "script_repo_revision": "production", 04:11:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:11:08 INFO - "repository": "", 04:11:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:11:08 INFO - "buildid": "20170213030206", 04:11:08 INFO - "stage_platform": "macosx64", 04:11:08 INFO - "basedir": "/builds/slave/test", 04:11:08 INFO - "nightly_build": "True", 04:11:08 INFO - "buildnumber": 57, 04:11:08 INFO - "slavename": "t-yosemite-r7-0183", 04:11:08 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:11:08 INFO - "platform": "yosemite_r7", 04:11:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:11:08 INFO - "branch": "mozilla-central", 04:11:08 INFO - "repo_path": "mozilla-central", 04:11:08 INFO - "revision": "00d16f03506b7f9f754b01a0a458c05445ac6dba", 04:11:08 INFO - "pgo_build": "False", 04:11:08 INFO - "builduid": "124eca12da16496a945c3771324d006d", 04:11:08 INFO - "slavebuilddir": "test" 04:11:08 INFO - } 04:11:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:11:08 INFO - Running post-action listener: _resource_record_post_action 04:11:08 INFO - [mozharness: 2017-02-13 12:11:08.454594Z] Finished read-buildbot-config step (success) 04:11:08 INFO - [mozharness: 2017-02-13 12:11:08.454706Z] Running download-and-extract step. 04:11:08 INFO - Running pre-action listener: _resource_record_pre_action 04:11:08 INFO - Running main action method: download_and_extract 04:11:08 INFO - mkdir: /builds/slave/test/build/tests 04:11: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')]} 04:11:08 INFO - trying https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:11:08 INFO - Downloading https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:11:09 INFO - Downloaded 1199 bytes. 04:11:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:11:09 INFO - Using the following test package requirements: 04:11:09 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:11:09 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:09 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:11:09 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'jsshell-mac.zip'], 04:11:09 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:11:09 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:11:09 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:11:09 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:11:09 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:11:09 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:11:09 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:09 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:11:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:11:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:09 INFO - Fetch https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:11:11 INFO - Expected file size: 51503231 04:11:11 INFO - Obtained file size: 51503231 04:11:27 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:11:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:11:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:11:29 INFO - Expected file size: 51503231 04:11:29 INFO - Obtained file size: 51503231 04:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:11:45 INFO - Expected file size: 14403647 04:11:45 INFO - Obtained file size: 14403647 04:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:45 INFO - trying https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:11:45 INFO - Downloading https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:11:48 INFO - Downloaded 70532788 bytes. 04:11:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:11:48 INFO - mkdir: /builds/slave/test/properties 04:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:48 INFO - Contents: 04:11:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:11:48 INFO - Running post-action listener: _resource_record_post_action 04:11:48 INFO - Running post-action listener: set_extra_try_arguments 04:11:48 INFO - [mozharness: 2017-02-13 12:11:48.772930Z] Finished download-and-extract step (success) 04:11:48 INFO - [mozharness: 2017-02-13 12:11:48.773076Z] Running populate-webroot step. 04:11:48 INFO - Running pre-action listener: _resource_record_pre_action 04:11:48 INFO - Running main action method: populate_webroot 04:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:48 INFO - '--tppagecycles', 04:11:48 INFO - '7'], 04:11:48 INFO - 'tests': ['tsvgm']}}, 04:11:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['damp', 'tps']}, 04:11:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'tests': ['damp', 'tps']}, 04:11:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['dromaeo_dom']}, 04:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['basic_compositor_video']}, 04:11:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:11:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['a11yr', 04:11:48 INFO - 'ts_paint', 04:11:48 INFO - 'tpaint', 04:11:48 INFO - 'sessionrestore', 04:11:48 INFO - 'sessionrestore_no_auto_restore', 04:11:48 INFO - 'tabpaint']}, 04:11:48 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:48 INFO - 'ts_paint', 04:11:48 INFO - 'tpaint', 04:11:48 INFO - 'sessionrestore', 04:11:48 INFO - 'sessionrestore_no_auto_restore', 04:11:48 INFO - 'tabpaint']}, 04:11:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:48 INFO - 'ts_paint', 04:11:48 INFO - 'tpaint', 04:11:48 INFO - 'sessionrestore', 04:11:48 INFO - 'sessionrestore_no_auto_restore', 04:11:48 INFO - 'tabpaint']}, 04:11:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:48 INFO - 'ts_paint', 04:11:48 INFO - 'tpaint', 04:11:48 INFO - 'sessionrestore', 04:11:48 INFO - 'sessionrestore_no_auto_restore', 04:11:48 INFO - 'tabpaint']}, 04:11:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['a11yr', 04:11:48 INFO - 'ts_paint', 04:11:48 INFO - 'tpaint', 04:11:48 INFO - 'sessionrestore', 04:11:48 INFO - 'sessionrestore_no_auto_restore', 04:11:48 INFO - 'tabpaint']}, 04:11:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['a11yr', 04:11:48 INFO - 'ts_paint', 04:11:48 INFO - 'tpaint', 04:11:48 INFO - 'sessionrestore', 04:11:48 INFO - 'sessionrestore_no_auto_restore', 04:11:48 INFO - 'tabpaint']}, 04:11:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['tsvgx', 04:11:48 INFO - 'tsvgr_opacity', 04:11:48 INFO - 'tart', 04:11:48 INFO - 'tscrollx', 04:11:48 INFO - 'cart', 04:11:48 INFO - 'tsvg_static']}, 04:11:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:48 INFO - 'tsvgr_opacity', 04:11:48 INFO - 'tart', 04:11:48 INFO - 'tscrollx', 04:11:48 INFO - 'cart', 04:11:48 INFO - 'tsvg_static']}, 04:11:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'talos_options': ['--disable-e10s'], 04:11:48 INFO - 'tests': ['tp5o']}, 04:11:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:11:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'talos_options': ['--disable-e10s', 04:11:48 INFO - '--xperf_path', 04:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:48 INFO - 'tests': ['tp5n']}, 04:11:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:11:48 INFO - 'talos_options': ['--xperf_path', 04:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:48 INFO - 'tests': ['tp5n']}}, 04:11:48 INFO - 'talos.zip': {'path': '', 04:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:48 INFO - Running post-action listener: _resource_record_post_action 04:11:48 INFO - [mozharness: 2017-02-13 12:11:48.791289Z] Finished populate-webroot step (success) 04:11:48 INFO - [mozharness: 2017-02-13 12:11:48.791424Z] Running create-virtualenv step. 04:11:48 INFO - Running pre-action listener: _resource_record_pre_action 04:11:48 INFO - Running main action method: create_virtualenv 04:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:48 INFO - Using real prefix '/tools/python27' 04:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:52 INFO - Installing pip.................done. 04:11:52 INFO - Return code: 0 04:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:11:53 INFO - Reading from file tmpfile_stdout 04:11:53 INFO - Output received: 04:11:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:53 INFO - 'HOME': '/Users/cltbld', 04:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PAGER': '/bin/cat', 04:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:11:53 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - 'XPC_FLAGS': '0x0', 04:11:53 INFO - 'XPC_SERVICE_NAME': '0', 04:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:11:53 INFO - Cleaning up... 04:11:53 INFO - Return code: 0 04:11:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:53 INFO - 'HOME': '/Users/cltbld', 04:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PAGER': '/bin/cat', 04:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:11:53 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - 'XPC_FLAGS': '0x0', 04:11:53 INFO - 'XPC_SERVICE_NAME': '0', 04:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:53 INFO - Downloading/unpacking psutil>=3.1.1 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:57 INFO - Installing collected packages: psutil 04:11:57 INFO - Running setup.py install for psutil 04:11:57 INFO - building 'psutil._psutil_osx' extension 04:11:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:11:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:11:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:11:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:11:58 INFO - building 'psutil._psutil_posix' extension 04:11:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:11:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:11:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:11:58 INFO - ^ 04:11:58 INFO - 1 warning generated. 04:11:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:11:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:58 INFO - Successfully installed psutil 04:11:58 INFO - Cleaning up... 04:11:58 INFO - Return code: 0 04:11:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:11: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 mozsystemmonitor==0.3 04:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:59 INFO - 'HOME': '/Users/cltbld', 04:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:59 INFO - 'LOGNAME': 'cltbld', 04:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:59 INFO - 'MOZ_NO_REMOTE': '1', 04:11:59 INFO - 'NO_EM_RESTART': '1', 04:11:59 INFO - 'PAGER': '/bin/cat', 04:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:59 INFO - 'PWD': '/builds/slave/test', 04:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:59 INFO - 'SHELL': '/bin/bash', 04:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:11:59 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:59 INFO - 'USER': 'cltbld', 04:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:59 INFO - 'XPC_FLAGS': '0x0', 04:11:59 INFO - 'XPC_SERVICE_NAME': '0', 04:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:12:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:02 INFO - Installing collected packages: mozsystemmonitor 04:12:02 INFO - Running setup.py install for mozsystemmonitor 04:12:02 INFO - Successfully installed mozsystemmonitor 04:12:02 INFO - Cleaning up... 04:12:02 INFO - Return code: 0 04:12:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:12:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:02 INFO - 'HOME': '/Users/cltbld', 04:12:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:02 INFO - 'LOGNAME': 'cltbld', 04:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:02 INFO - 'MOZ_NO_REMOTE': '1', 04:12:02 INFO - 'NO_EM_RESTART': '1', 04:12:02 INFO - 'PAGER': '/bin/cat', 04:12:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:02 INFO - 'PWD': '/builds/slave/test', 04:12:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:02 INFO - 'SHELL': '/bin/bash', 04:12:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:02 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:02 INFO - 'USER': 'cltbld', 04:12:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:02 INFO - 'XPC_FLAGS': '0x0', 04:12:02 INFO - 'XPC_SERVICE_NAME': '0', 04:12:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:02 INFO - Downloading/unpacking jsonschema==2.5.1 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:05 INFO - warning: no files found matching '*.txt' 04:12:05 INFO - no previously-included directories found matching 'build' 04:12:05 INFO - no previously-included directories found matching 'dist' 04:12:05 INFO - no previously-included directories found matching '.git*' 04:12:05 INFO - Installing collected packages: jsonschema, functools32 04:12:05 INFO - Running setup.py install for functools32 04:12:05 INFO - warning: no files found matching '*.txt' 04:12:05 INFO - no previously-included directories found matching 'build' 04:12:05 INFO - no previously-included directories found matching 'dist' 04:12:05 INFO - no previously-included directories found matching '.git*' 04:12:05 INFO - Successfully installed jsonschema functools32 04:12:05 INFO - Cleaning up... 04:12:06 INFO - Return code: 0 04:12:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:06 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:12:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:06 INFO - 'HOME': '/Users/cltbld', 04:12:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:06 INFO - 'LOGNAME': 'cltbld', 04:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:06 INFO - 'MOZ_NO_REMOTE': '1', 04:12:06 INFO - 'NO_EM_RESTART': '1', 04:12:06 INFO - 'PAGER': '/bin/cat', 04:12:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:06 INFO - 'PWD': '/builds/slave/test', 04:12:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:06 INFO - 'SHELL': '/bin/bash', 04:12:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:06 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:06 INFO - 'USER': 'cltbld', 04:12:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:06 INFO - 'XPC_FLAGS': '0x0', 04:12:06 INFO - 'XPC_SERVICE_NAME': '0', 04:12:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:06 INFO - Cleaning up... 04:12:06 INFO - Return code: 0 04:12:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:06 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:12:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:06 INFO - 'HOME': '/Users/cltbld', 04:12:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:06 INFO - 'LOGNAME': 'cltbld', 04:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:06 INFO - 'MOZ_NO_REMOTE': '1', 04:12:06 INFO - 'NO_EM_RESTART': '1', 04:12:06 INFO - 'PAGER': '/bin/cat', 04:12:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:06 INFO - 'PWD': '/builds/slave/test', 04:12:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:06 INFO - 'SHELL': '/bin/bash', 04:12:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:06 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:06 INFO - 'USER': 'cltbld', 04:12:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:06 INFO - 'XPC_FLAGS': '0x0', 04:12:06 INFO - 'XPC_SERVICE_NAME': '0', 04:12:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:10 INFO - Downloading docopt-0.6.1.tar.gz 04:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:10 INFO - Running setup.py install for blobuploader 04:12:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:10 INFO - Running setup.py install for requests 04:12:11 INFO - Running setup.py install for docopt 04:12:11 INFO - Successfully installed blobuploader requests docopt 04:12:11 INFO - Cleaning up... 04:12:11 INFO - Return code: 0 04:12:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:11 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:11 INFO - 'HOME': '/Users/cltbld', 04:12:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:11 INFO - 'LOGNAME': 'cltbld', 04:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:11 INFO - 'MOZ_NO_REMOTE': '1', 04:12:11 INFO - 'NO_EM_RESTART': '1', 04:12:11 INFO - 'PAGER': '/bin/cat', 04:12:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:11 INFO - 'PWD': '/builds/slave/test', 04:12:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:11 INFO - 'SHELL': '/bin/bash', 04:12:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:11 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:11 INFO - 'USER': 'cltbld', 04:12:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:11 INFO - 'XPC_FLAGS': '0x0', 04:12:11 INFO - 'XPC_SERVICE_NAME': '0', 04:12:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:11 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-9OSFp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:11 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-i9_XTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:11 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-wLbvty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:11 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-TA2u6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-aeD_qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-eQLeR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-1jHFeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-Am2FEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-IhcSPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-O6vXs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-hq7GGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-zK7IC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-RcGznw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:12 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-6jZReJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:13 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-mj_ftR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:13 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-BkJhhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:13 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-0ahNa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:13 INFO - Running setup.py install for manifestparser 04:12:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:13 INFO - Running setup.py install for mozcrash 04:12:13 INFO - Running setup.py install for mozdebug 04:12:13 INFO - Running setup.py install for mozdevice 04:12:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozfile 04:12:14 INFO - Running setup.py install for mozhttpd 04:12:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozinfo 04:12:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozInstall 04:12:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for mozleak 04:12:14 INFO - Running setup.py install for mozlog 04:12:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:14 INFO - Running setup.py install for moznetwork 04:12:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Running setup.py install for mozprocess 04:12:15 INFO - Running setup.py install for mozprofile 04:12:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Running setup.py install for mozrunner 04:12:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Running setup.py install for mozscreenshot 04:12:15 INFO - Running setup.py install for moztest 04:12:15 INFO - Running setup.py install for mozversion 04:12:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:15 INFO - Cleaning up... 04:12:15 INFO - Return code: 0 04:12:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:15 INFO - 'HOME': '/Users/cltbld', 04:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:15 INFO - 'LOGNAME': 'cltbld', 04:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:15 INFO - 'MOZ_NO_REMOTE': '1', 04:12:15 INFO - 'NO_EM_RESTART': '1', 04:12:15 INFO - 'PAGER': '/bin/cat', 04:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:15 INFO - 'PWD': '/builds/slave/test', 04:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:15 INFO - 'SHELL': '/bin/bash', 04:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:15 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:15 INFO - 'USER': 'cltbld', 04:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:15 INFO - 'XPC_FLAGS': '0x0', 04:12:15 INFO - 'XPC_SERVICE_NAME': '0', 04:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-DTir5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-ylZIe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-ClOE9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-e_LLTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-HsyfGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-QQXqrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-UkjvA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:16 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-R1i0Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-PbwqL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-oNZ6jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-1WeoX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-S4Etv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-nsL2vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-AmYEUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-2DB1Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-5u8QdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:17 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-YKZvp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:12:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:20 INFO - Downloading blessings-1.6.tar.gz 04:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:20 INFO - Installing collected packages: blessings 04:12:20 INFO - Running setup.py install for blessings 04:12:20 INFO - Successfully installed blessings 04:12:20 INFO - Cleaning up... 04:12:20 INFO - Return code: 0 04:12:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:21 INFO - Reading from file tmpfile_stdout 04:12:21 INFO - Current package versions: 04:12:21 INFO - blessings == 1.6 04:12:21 INFO - blobuploader == 1.2.4 04:12:21 INFO - docopt == 0.6.1 04:12:21 INFO - functools32 == 3.2.3-2 04:12:21 INFO - jsonschema == 2.5.1 04:12:21 INFO - manifestparser == 1.1 04:12:21 INFO - mozInstall == 1.12 04:12:21 INFO - mozcrash == 1.0 04:12:21 INFO - mozdebug == 0.1 04:12:21 INFO - mozdevice == 0.49 04:12:21 INFO - mozfile == 1.2 04:12:21 INFO - mozhttpd == 0.7 04:12:21 INFO - mozinfo == 0.9 04:12:21 INFO - mozleak == 0.1 04:12:21 INFO - mozlog == 3.4 04:12:21 INFO - moznetwork == 0.27 04:12:21 INFO - mozprocess == 0.24 04:12:21 INFO - mozprofile == 0.28 04:12:21 INFO - mozrunner == 6.13 04:12:21 INFO - mozscreenshot == 0.1 04:12:21 INFO - mozsystemmonitor == 0.3 04:12:21 INFO - moztest == 0.8 04:12:21 INFO - mozversion == 1.4 04:12:21 INFO - psutil == 3.1.1 04:12:21 INFO - requests == 1.2.3 04:12:21 INFO - wsgiref == 0.1.2 04:12:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:21 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:21 INFO - 'HOME': '/Users/cltbld', 04:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:21 INFO - 'LOGNAME': 'cltbld', 04:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:21 INFO - 'MOZ_NO_REMOTE': '1', 04:12:21 INFO - 'NO_EM_RESTART': '1', 04:12:21 INFO - 'PAGER': '/bin/cat', 04:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:21 INFO - 'PWD': '/builds/slave/test', 04:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:21 INFO - 'SHELL': '/bin/bash', 04:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:21 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:21 INFO - 'USER': 'cltbld', 04:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:21 INFO - 'XPC_FLAGS': '0x0', 04:12:21 INFO - 'XPC_SERVICE_NAME': '0', 04:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:12:21 INFO - Cleaning up... 04:12:21 INFO - Return code: 0 04:12:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:21 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 0x1076ccb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076cf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9089cd2ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, '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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:21 INFO - 'HOME': '/Users/cltbld', 04:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:21 INFO - 'LOGNAME': 'cltbld', 04:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:21 INFO - 'MOZ_NO_REMOTE': '1', 04:12:21 INFO - 'NO_EM_RESTART': '1', 04:12:21 INFO - 'PAGER': '/bin/cat', 04:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:21 INFO - 'PWD': '/builds/slave/test', 04:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:21 INFO - 'SHELL': '/bin/bash', 04:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:21 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:21 INFO - 'USER': 'cltbld', 04:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:21 INFO - 'XPC_FLAGS': '0x0', 04:12:21 INFO - 'XPC_SERVICE_NAME': '0', 04:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:21 INFO - Cleaning up... 04:12:21 INFO - Return code: 0 04:12:21 INFO - Running post-action listener: _resource_record_post_action 04:12:21 INFO - Running post-action listener: _start_resource_monitoring 04:12:21 INFO - Starting resource monitoring. 04:12:21 INFO - [mozharness: 2017-02-13 12:12:21.820024Z] Finished create-virtualenv step (success) 04:12:21 INFO - [mozharness: 2017-02-13 12:12:21.820972Z] Running install step. 04:12:21 INFO - Running pre-action listener: _resource_record_pre_action 04:12:21 INFO - Running main action method: install 04:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:22 INFO - Reading from file tmpfile_stdout 04:12:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:22 INFO - Reading from file tmpfile_stdout 04:12:22 INFO - Output received: 04:12:22 INFO - Usage: mozinstall [options] installer 04:12:22 INFO - Options: 04:12:22 INFO - -h, --help show this help message and exit 04:12:22 INFO - -d DEST, --destination=DEST 04:12:22 INFO - Directory to install application into. [default: 04:12:22 INFO - "/builds/slave/test"] 04:12:22 INFO - --app=APP Application being installed. [default: firefox] 04:12:22 INFO - mkdir: /builds/slave/test/build/application 04:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:12:43 INFO - Reading from file tmpfile_stdout 04:12:43 INFO - Output received: 04:12:43 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:12:43 INFO - Running post-action listener: _resource_record_post_action 04:12:43 INFO - [mozharness: 2017-02-13 12:12:43.910291Z] Finished install step (success) 04:12:43 INFO - [mozharness: 2017-02-13 12:12:43.910456Z] Running run-tests step. 04:12:43 INFO - Running pre-action listener: _resource_record_pre_action 04:12:43 INFO - Running main action method: run_tests 04:12:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:43 INFO - 2017-02-13 04:12:43.925 screenresolution[1629:7535] starting screenresolution argv=screenresolution get 04:12:43 INFO - 2017-02-13 04:12:43.927 screenresolution[1629:7535] Display 0: 1600x1200x32@60 04:12:43 INFO - 2017-02-13 04:12:43.933 screenresolution[1630:7538] starting screenresolution argv=screenresolution list 04:12:43 INFO - Available Modes on Display 0 04:12:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:44 INFO - Intel Iris: 04:12:44 INFO - Chipset Model: Intel Iris 04:12:44 INFO - Type: GPU 04:12:44 INFO - Bus: Built-In 04:12:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:44 INFO - Vendor: Intel (0x8086) 04:12:44 INFO - Device ID: 0x0a2e 04:12:44 INFO - Revision ID: 0x0009 04:12:44 INFO - Displays: 04:12:44 INFO - Display: 04:12:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:44 INFO - Display Serial Number: 1600x1200 60 04:12:44 INFO - Main Display: Yes 04:12:44 INFO - Mirror: Off 04:12:44 INFO - Online: Yes 04:12:44 INFO - Rotation: Supported 04:12:44 INFO - Return code: 0 04:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:44 INFO - Python 2.7.3 04:12:44 INFO - Return code: 0 04:12:44 INFO - grabbing minidump binary from tooltool 04:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:44 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 0x1074aad30>, '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 0x1073d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10749fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:12:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:12:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:12:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:44 INFO - Return code: 0 04:12:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:12:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:12:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0183 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:12:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IvtbX9V4Yf/Render', 04:12:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:44 INFO - 'HOME': '/Users/cltbld', 04:12:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:44 INFO - 'LOGNAME': 'cltbld', 04:12:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:44 INFO - 'MOZ_NO_REMOTE': '1', 04:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:44 INFO - 'NO_EM_RESTART': '1', 04:12:44 INFO - 'PAGER': '/bin/cat', 04:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:44 INFO - 'PWD': '/builds/slave/test', 04:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:44 INFO - 'SHELL': '/bin/bash', 04:12:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.89gQWvoYVG/Listeners', 04:12:44 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 04:12:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:44 INFO - 'USER': 'cltbld', 04:12:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:44 INFO - 'XPC_FLAGS': '0x0', 04:12:44 INFO - 'XPC_SERVICE_NAME': '0', 04:12:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:12:44 INFO - mozversion application_buildid: 20170213030206 04:12:44 INFO - mozversion application_changeset: 00d16f03506b7f9f754b01a0a458c05445ac6dba 04:12:44 INFO - mozversion application_display_name: Nightly 04:12:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:44 INFO - mozversion application_name: Firefox 04:12:44 INFO - mozversion application_remotingname: firefox 04:12:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:12:44 INFO - mozversion application_vendor: Mozilla 04:12:44 INFO - mozversion application_version: 54.0a1 04:12:44 INFO - mozversion platform_buildid: 20170213030206 04:12:44 INFO - mozversion platform_changeset: 00d16f03506b7f9f754b01a0a458c05445ac6dba 04:12:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:12:44 INFO - mozversion platform_version: 54.0a1 04:12:44 INFO - using testdate: 1486987964 04:12:44 INFO - actual date: 1486987964 04:12:44 INFO - starting webserver on 'localhost:49248' 04:12:44 INFO - SUITE-START | Running 2 tests 04:12:44 INFO - TEST-START | dromaeo_css 04:12:44 INFO - operating with platform_type : mac_ 04:12:44 INFO - Initialising browser for dromaeo_css test... 04:12:44 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmpFeQa98/profile http://localhost:49248/getInfo.html) 04:12:47 INFO - PROCESS | 1640 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:12:47 INFO - PROCESS | 1640 | 2017-02-13 04:12:47.541 plugin-container[1643:7707] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 04:12:47 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:12:47 INFO - PROCESS | 1640 | 2017-02-13 04:12:47.541 plugin-container[1643:7707] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9703, name = 'com.apple.CFPasteboardClient' 04:12:47 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:12:47 INFO - PROCESS | 1640 | 2017-02-13 04:12:47.542 plugin-container[1643:7707] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:12:47 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 04:12:47 INFO - PROCESS | 1640 | colorDepth:24 04:12:47 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 04:12:47 INFO - PROCESS | 1640 | __metrics 04:12:47 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:12:48 INFO - TEST-INFO | 1640: exit 0 04:12:48 INFO - Browser initialized. 04:12:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:48 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmpFeQa98/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:51 INFO - PROCESS | 1644 | 2017-02-13 04:12:51.016 plugin-container[1645:7834] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 04:12:51 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:12:51 INFO - PROCESS | 1644 | 2017-02-13 04:12:51.016 plugin-container[1645:7834] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 04:12:51 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:12:51 INFO - PROCESS | 1644 | 2017-02-13 04:12:51.017 plugin-container[1645:7834] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:00 INFO - PROCESS | 1644 | RSS: Main: 233496576 04:13:00 INFO - PROCESS | 1644 | 04:16:03 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 04:16:05 INFO - PROCESS | 1644 | RSS: Main: 254558208 04:16:05 INFO - PROCESS | 1644 | 04:17:48 INFO - PROCESS | 1644 | ************************* 04:17:48 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 04:17:48 INFO - PROCESS | 1644 | 04:17:48 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:17:48 INFO - PROCESS | 1644 | Full stack: 04:17:48 INFO - PROCESS | 1644 | ************************* 04:19:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 04:19:08 INFO - PROCESS | 1644 | RSS: Main: 260255744 04:19:08 INFO - PROCESS | 1644 | 04:22:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 04:22:11 INFO - PROCESS | 1644 | RSS: Main: 270729216 04:22:11 INFO - PROCESS | 1644 | 04:25:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 04:25:13 INFO - PROCESS | 1644 | RSS: Main: 263446528 04:25:13 INFO - PROCESS | 1644 | 04:28:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 04:28:17 INFO - PROCESS | 1644 | RSS: Main: 267350016 04:28:17 INFO - PROCESS | 1644 | 04:31:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 04:31:20 INFO - PROCESS | 1644 | RSS: Main: 268390400 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | __start_tp_report 04:31:20 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 04:31:20 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 04:31:20 INFO - PROCESS | 1644 | |i|pagename|runs| 04:31:20 INFO - PROCESS | 1644 | |0;dojo.html;3359.6304406515296;3359.7984120952747;3382.2559037011865;3385.8984230473093;3414.8634054637814;4905.852824415264;5316.9202461963105;5505.9724701376535;5607.887842243158;5635.633683810554;5512.531434828044;5625.774969001235;5658.8019419320335;5696.316442026952;5745.138229265602;5119.923201151985;5136.768845401947;5203.765830537635;5262.605304602151;5269.868253293679;5121.436641969399;5158.43257241705;5176.818811341604;5204.42751297357;5224.242484839696;5054.848354549369;5089.160288552384;5254.133068043769;5255.553277971377;5258.605604579672;4586.816527338902;4862.857228551287;5109.821156259551;5124.461931497176;5166.457521960216;5097.286379906816;5144.202648589475;5163.199704045879;5189.792408303663;5235.816746413857;4859.562639362439;5024.794049428147;5594.104943209067;5689.687067211302;5720.799772008001;6071.058985857199;6116.510679145657;6122.54080943931;6247;6248;6182.690865456754;6195.81412557624;6212.974859148235;6219.782307619212;6262.373762623702;5139.768710408003;5856.765729370777;5868.911966320508;5878.177055212273;5937.554683398719;6117.663528505975;6271.874562508724;6275.278342990615;6277.591956522811;6282.874342513124;5911.733971971272;5961.821145365646;5972.552058595623;6048.123022161762;6067.544934129958;6085.08723691441;6191.133241346215;6261.686915654199;6267.341929097471;6300.180976473029;6116.35778243278;6142.560166306793;6155.6614386209185;6193.38066193377;6247.156633854463;6173.722182501709;6273.215848018997;6283.465905398001;6286.15136956505;6288.968555157195;4688.765561721901;4690.835820746258;4957.206846904478;4960.131976904099;5042.924356134661;3371.7976921384798;4384.925693205185;4442.733435993786;4456.75487848165;5112.233165025202;4513.255312873404;4843.878903027453;5876.44173803488;5878.971180043475;5889.234399528034;5182.948170518246;6129.356417576179;6144.9246381882995;6154.569180157346;6269.059641053787;5758.510526605201;5839.445252700986;5846.736896839652;5865.706714664335;5884.558658100659;5437.891242175135;5443.156310771837;5450.482204190595;5462.562994960394;5479.671219726829;6235.407636274546;6250.843728906813;6287.088372186099;6291.842703932438;6294.307626161027;6147.477464415575;6212.192414986023;6228.875422491616;6260;6286.717097730521;6253.155823963707;6257.8748425030335;6259.436650701458;6295.464885484785;6303.023031430135;6202.658853763086;6238.781642642486;6240.5319601031015;6259.467945224525;6262.718177682106;4998.275250088789;6141.179174348115;6178.104174894705;6191.504679625529;6254.499640028877;5583.1904373864745;6126.816195514141;6167.5374346925055;6192.442680158807;6193.783217587363;5350.839474815762;5891.027980383189;5963.493103086286;6146.446819786241;6193;5840.970795145997;5921.14143449206;6019.337872834072;6032.788852390146;6080.300765412034;6155.569110162246;6165.599236049642;6172.598781079216;6173.382661733791;6182;5685.60200785941;5913.113033045078;5943.405659434022;5958.493528050164;5975.223220981245 04:31:20 INFO - PROCESS | 1644 | |1;ext.html;457.2683706070286;507.33285729266015;518.7535920437792;547.2693953571984;604.9122877182806;36964.815175924115;37634.623653763454;38789;38871.41692874602;39031;39479.81560553181;40232.59767402325;40381.59618403815;40423.393649095284;40477;8869.866951995726;10621.46892655368;11062.115030797517;11109.333439993587;11248.55005799767;10848.18638602108;10937.289076210061;10941.28881622696;10946.671599852018;11003.284786488892;10921.836172457419;10945.56217751289;10979.83530247047;11011.559537618527;11015.394153321564;10848.78302433947;10916.126709863232;10959.945200274027;10993.780124397466;11013;10863.293885897392;10922;10937.945310273397;10944.3980581068;10970.945145274301;36379;36609.620374675564;36643.26713465742;36647.08382290437;36782.816085919665;3604.3692353837973;3658.579263384718;3702.4446333049987;3704.685101766353;3849.3840985442475;26984.865075674694;27466.45067098647;28031.159065227872;28051.43897122046;28124.43751124966;3031.508197699263;3086.5370194470784;3164.256399746058;3174.3968645957425;3221.1624977505785;348024;411779;413888;415693;420500;47075.5292447078;47224.291635625494;54312;54326.728366357915;54361.45638543564;58152.418475815546;58162.83674326575;58421;58598.41401586015;58692.413075868695;13404.664883377798;14085.647858803612;14193.290335483185;14318.14091154534;14350.138991660533;10878.891211087946;10910.781784364426;11002.50488728009;11011.174161937886;11017.669469915754;17337.046462444687;17358;17440.563985900455;17449.476515704548;17516.948983060804;6436.485081193493;7535.773926782205;7622.352100071445;7647.617619119022;7676.19399963007;715.8926161075881;814.0597609760736;824.8905222475761;829.1708291708292;861.263619605241;25115;25729;27667.723322766513;28396.574051389245;28964.85517572441;987.5753426026733;991.9603215871284;1031.9071283584512;1043.801677681238;1143.8284257361297;12791.872081279069;15132.773008404884;15168;15245.923770381078;15529;569699;579855.1007244937;582545;593005;593596;57800.132998005065;57811.42188578145;57987.71006144942;58148;58255.417445825;1315.7631626307166;1348.2854087333728;1357.3349058961037;1359.232033900843;1360.8911287097008;28222.71777282201;28848.855755721088;29197.85401073066;29533.556996645497;29590.556141658322;49803;49937;50000;50026.74986625044;50138.74930625324;505302.4734876302;507014;509068;509815;510174;22806.543869122856;23252.651210232198;25890.87054564715;26047.479050418508;26408;39991;44268;44868;45688.54311456976;46245;29293.41413171682;34051.829740852125;36596.63403366039;36642;37870.62129378671;29876;36569.817150914074;37563.81218093892;37646.62353376431;37872.810635947746;30217.395652087274;32600.673993259763;33857.83071084629;34544.654553454144;35542.822285888404;26571.468570628866;31578.526322105645;32150.35699286048;32277.677223227467;32296.83851580727;24206.273811785675;24506.264812055666;24533.509329812947;24657.63013554834;24697.62953555662 04:31:20 INFO - PROCESS | 1644 | |2;jquery.html;358.7721796659121;382.28131113506606;397.13821008411753;402.43056075652953;418.73333167169307;17276.395326163587;17277.395291164798;20398.796012039893;20516.28193013243;20534.794652053475;17555;21233.893830530826;21440.678389824126;21469.785302146975;21914.23300184494;5568.192612071247;5630.296212973379;5661.547076233891;5872.9706351468185;5874.794382196624;5113.386393632751;5658.377578466366;5659.632123911953;5672.461116193955;5745.937001654686;5582.553395728332;5624.803131890385;5671.489565939065;6209.565330426872;6514.055461958013;5110;5628.183913332544;6427.550071494998;6513.185851768529;6527.151470308853;4887;4900.961403929551;5826.883462330729;5907.02534081876;5969.194158788551;13471.191728496322;13600.931995340059;13612.523561675294;23863.88068059666;25006.749932500625;2444.8166387521005;2473.0973194783955;2489.0073814687303;2539.7841183499427;2862.584925185857;10263.743406414826;10525.894741052645;11616.651500455;12683.74632507354;15363.385464581403;1698.371602507068;1740.9390671326569;1764.347191539126;1767.4255866843328;1817.7091665333483;128405.35797321047;131722.3413882934;132059.89364679606;132081.3395933014;132965.33517332352;11800.586979455678;11930.463129159209;11995.220310679779;12128.211666241843;12203;15724;15750.448734294474;15751.291191896393;15754.212289385485;15766.842331576538;8066.11272759996;8295.336373090138;8332.291755200877;8496.575171241413;8519.318454523624;6783.660816959133;7323.194448610649;7379.557226566423;7929.682812687543;8102.554359510284;4744.762761861962;4808.663393562487;4811.109944660249;4832.734199619054;4913.533214344631;1935;1974.6445639784977;1985.7914918933304;1987.1753222412826;1989.4529004523872;999.9450030248261;1002.1982414068862;1004.3622299839508;1011.145581983223;1047.8009178256107;21451.249206277706;21825.890870545547;21909.890450547646;21922.780772192073;21948.122075117135;982.6118683120128;1033.6433930294036;1056.709404913655;1057.772578895541;1062.5484169228203;10828.404437755842;11175.273607215506;11723.589674361356;12389.318587477776;12398.380080996094;674199;701931;702854;712768;720619;133304;136168;147728;151935;152185;443.6140557714809;465.05361589165886;467.2897196261731;468.2998916619607;1005.5424781724444;10140.695779126638;10624.043836054792;11111.38887361203;11419.60031398897;11447.542098315975;57966.710166448895;60706.39293607007;61272.693636531534;61798;61969;90457.09542904487;93221.5338923301;93346.53326733323;94303;94316.52841735748;5433.891322173456;5527.695976721319;7831.8825217622925;8373.07896131413;8932.687355942511;10902.400367979837;13114;13763.38064787107;13780.379882905494;13795.379207935466;9838.114569688762;10184.796304074025;10942;11019.338839669645;11589.594364197214;11373.886261137613;11377.2604780689;11413.486393112164;11616.419179041182;11777.234479758788;9928.702138935843;11318.377489238172;11449.656510304705;11595.710107247387;11907.702307442383;7700.768976930477;8263.380246481418;8626.913730862861;8629.741107766777;8893.688720894996;5944.702764861653;10822.080123189617;10934.359846022842;11694.356810375511;11824.881751182378 04:31:20 INFO - PROCESS | 1644 | |3;mootools.html;1351.628302216891;1356.6133651909201;1377.6624726941898;1384.8090642047844;1402.116666500105;7812.960935195323;8112.553809540473;8173.7139200128;8457.323414126862;8460.703875364363;8268.214519620626;8410.327173826094;8426.662933482668;8431.40980131391;8475.660973561051;2220.1452440810244;2221.8777967211795;2267.875266860322;2271.545690861826;2275.8179345652393;2066.875987440751;2236.3514580771557;2268.965965510519;2276.567452184088;2281.4866655002656;2084.114251443138;2229.777022297765;2240.473488730155;2260.7174103237094;2266.603344414721;2160.5030842906062;2217.8780167090804;2239.1491233331394;2243.8653680779125;2253.3352660965056;1914.827665510097;1943.6015616798663;1999.6200721862945;2221.1670623516184;2277.134688818255;8031.076426211002;8047.074586422578;8053.95973020137;8176.264136227708;8290.295324897392;5028.270900719375;5206.869828254286;5212.374515058179;5220.765065572058;5233.9738301308635;3319.717823984964;3403.285310084885;3438.2066218421787;3477.7565570410084;3479.373712731707;1194.8028575285155;1199.9760004799944;1210.3403645013489;1222.113967373656;1250.7998720204723;10641.627543035956;10650.893491065146;10695.893041069645;10703.678889633324;10765.677029689043;4089.1821635672986;4377.671674624416;4412.84555040572;4437.489688685778;4441.555844415597;8348.624311905858;8385.035720892054;8460.661573537112;8475.449095808875;8512.574371281411;5023.196288593807;5024.723640199751;5037.420696619935;5040.36995375578;5050.267711181858;3724.255148970217;4499.6400287976885;4698.859034228979;4699.060187962421;4736.123817093849;3096.922576935595;3566.91082722934;3571.982140089283;3625.546806649169;3637.94543081854;1005.2410430125209;1102.9962733912103;1123.7134530694784;1137.7553825927466;1156.4275683536703;832.4838600067876;860.9182127697859;865.6104752861238;901.2834796336928;923.4044041593269;5522.861928451741;5630.943690563124;5650.180723795027;5781.682007489544;5786.074228123564;915.7344370132587;947.2374738335706;961.7689357622255;966.0918736387773;974.9853752193723;3006.6542347629866;3634.3639863023864;3650.4159334506353;3819.3316169670197;3843.577206507282;9431.811363772686;9555.665551705657;9572.521373931415;9670.70987870365;9883.11052005323;9886.950565247127;9888.505574721235;9905;9920.255980801468;9936.850947235796;7473.215312392229;7657.540547567052;7673.462857599914;7686.077670679554;7700.807479813049;4549.567791059844;5521.2270282161335;5526.806561770319;5540.390557038803;5699.230603868425;6998.545094568837;6999.825004374931;8305.837182794292;8908.242799362128;9232.907670923474;6912.343327383891;9121.315901307296;9336.766580835534;9440.622375105193;9451.054894510495;5728.6562806230095;6801.421879140328;6919.308069193041;7194.4244460442;7207.387372073223;7859.9607001966915;7929.365650747811;7992.800179995546;7995.880061799194;8000.51996880189;5551;6688.799336019927;7021.227664956953;7174.426045916419;7185;6870.416014638811;6893.276205998298;6926.891697328403;7029.9648501757165;7084.929150708633;6343.175387199634;6359.841003974938;6383.553151279366;6427.357264273535;6444.355564443518;4785.617150628011;4869.878253043702;4881.341018962395;4894;4921.212605983025;4927.778249978688;4930.6795058321095;4987.326710894128;5070.873228169326;5095.694258344512 04:31:20 INFO - PROCESS | 1644 | |4;prototype.html;348.9827153846538;356.34432643935156;362.3694771098289;365.9615740347262;370.30752492838394;4581.748003859786;5145.845624631258;5353;5373.280550223925;5412.783488660454;4726.929096063562;5286.180642000487;5288.629795914288;5313.572745579099;5335.386430560487;4023.9798801006027;4040.4141399497057;4047.170330082326;4051.9392209116886;4063.1264278180183;3173.809821317006;3322.850471728778;3969.1863168050627;4069.212589376272;4073.490813648294;3823.617638236168;3978.8262462573466;3979.781112038837;3991.8602848900296;4003.4795476588147;3356.9496457553155;3446.3107378524396;3973.960260397402;4012.057166565855;4018.45750823638;3083.9691603083907;3481.8259087045544;3498.265364273506;3504.737144714157;3506.5798351667618;3966.8892710041237;4234.6823988201;4783.712977221343;4804.807807687724;5072.594192464631;4574.61115805157;4599.218132917378;4601.907961840744;4616.376789133457;4635.351050852883;4522.706024108423;5207.531322180984;5584.715515431433;5644.74598643062;5693.060644993571;3684.392075307571;3789.2042671039117;3798.829052692608;3839.7345566116123;3841.78870162141;4991.600671946272;5085.491450854922;5397.171055260309;5509.5041446270025;5903.675297858616;3311.437055700537;3475.409180439281;3491.755577109578;3758.793266370376;3894.357431023849;3656.725745569093;3704.8329776120436;3774.8112594370173;3788.886333410002;3903.6486716195677;3665.9450108248398;4319.6976211665515;4418.447694038246;4589.878882359961;4604.171249175113;4929.605631549467;5645.98372292983;5661.66030038199;5688.658680479184;5726.341470730836;1193.6061099837034;1269.05455435701;1269.6952731344595;1278.3799857069314;1279.0343290815374;799.3085980626716;832.9458585191943;862.977371814402;873.6287077991828;880.4717169698258;4375.7155784873885;4394.868153955386;4716.316134160527;5073.133679471087;5083.822066227664;4447.442720435763;5177.792888284426;5468.769526856426;5593.440655934374;5625.324961004624;4167.937480937789;4383.736975781463;4753.762311884392;4765.975315307156;5040.042391945519;2550.0474264889717;2693.9461210775676;2928.5167947288883;2929.721676440735;2938.4270067336665;5347.3583170019065;5370.9731451342495;5588;5771.6537007778825;5814.476697097281;5373.683447555374;5531.446855314436;5536.390996990328;5540.335159780852;5760.51035661965;5371.57027437804;6092.268927728613;6094.024956007018;6124.724387402489;6128.142060111588;5322.467753224647;5505.559555235492;5790.39200883918;5860.677662728421;5877.911831322448;5036.370453693288;5725.421611492817;5749.942500574941;5806.390329015392;5816.4698356215185;5132.384113906355;5137.794488220429;5541.667499949855;5745.195672605755;5898.911516327173;4093.91812163761;4197.685173611931;4208.6953044556285;4226.640735537514;4229.281022226291;4887.242477416006;5306;5389.83830485086;5876.794312199053;5891.293044834647;5363.785448582169;5577.271045975761;5641.5204707600315;5649.802256920988;5730.255066841284;4925.448483727758;5277.8416647500635;5645.68948707825;5668.631538949955;5680.318361796611;4404.9119017620105;4651.720537021324;5543.972280138573;5551.361593416808;5556.916646250229;4615.884602884955;4998.850953708486;5050.49495050492;5635.211070450222;5692.7722891083895;4696.849271928263;4952.257161425671;5538.335399752055;5592.804251851328;5632.802851900164 04:31:20 INFO - PROCESS | 1644 | |5;yui.html;672.5023482622861;689.6517258784313;747.8803391457365;753.9547627142372;806.3307454812506;14072.929635351822;15041.323140458679;15069.38334799647;15069.472568460105;15071.171085590287;13796.172229666226;13892.861071389283;13904.791428128587;13994.720105597882;13998.300084995735;856.6958729650978;869.7869022089596;872.7076429396128;874.3704532736419;877.5524482513932;849.9405041647087;859.9613017414231;861.1130535548396;874.1127755328315;874.6501399440243;916.715818096389;922.5940586142076;924.5885580916495;924.7410724997012;925.1349987761431;915.3363811236867;917.5137177296044;918.7335672654922;921.2123634292684;921.889373275208;679.4700133895569;685.8936864785966;687.3023880761032;687.3161204601454;689.396777819408;10776.838347424795;14817.259137043106;14823.629409264748;14836.035657682216;14842.960992730514;13034.15278006936;13561.796573051412;13885.236312002837;13949.442022319197;14040.368183431669;11116.359784992157;11395;11550.306981581132;11761.411929403495;11781.764364712744;2945.837978911159;3593.784372937606;3621.040424287566;3721.5162028936065;3723.962760372389;71330.64334678293;91403;91427.46507540948;93004;93453;10466.947665261625;10472.162227021972;10483.108935740394;10768.946155269174;10876.401797901033;21627.78372216289;21706;21828.890855545622;21843.344699659036;21851.672224916638;7396;7444.664990075459;7501.174870764212;7571.962140189264;7715.768526944201;3890.8832735017995;4171.249175148502;4172.144710334434;4177.895552611149;4186.455760751144;3440.3291358184915;3575.6245594212232;3652.1052342176336;3678.9816050919576;3686.060054686038;624.6127401011402;627.6579264300875;630.9905351419733;639.7728806273799;650.2099948562425;570.57207094679;595.2172892646156;649.6004956951441;658.4600627485512;691.1395312835552;8335;9044.366894317334;10080.949595251977;10098.242631802645;10102.444365559964;637.6461064109463;642.4025656139835;675.8276639457006;681.2234053179379;685.1469919949694;4438.800253988578;4842.467328593852;4877.396873793528;4903.215485522299;4925.40895092584;81912.18087819165;88033.11966880377;98637.01362986278;101321;101560.49219753854;65633;70660;73045.6347718258;76321.61839190769;81076.9730756724;44927.999999999345;66083.66958165179;71846.64076679583;75308;75899;10203.798008676105;10576.735581610521;10762.892371076188;10778.622748203776;10815.24293299493;42666.360004600574;45569.860753480105;45945.54054459413;46520;46726.065478690914;51201.74399127981;59230.40769592249;60195.69902150461;60557;60984.39015609787;12091.939540302243;12195.573154939535;12197.055436175116;12199.817002745143;13021.218726876417;13525.666534022923;13685.931570342085;13770.862291376958;13904.443822247402;13960.673735995064;12191.78629185229;12248.081393895316;12606.621801345975;12667.556635517712;12719.611733951771;12575.685607859878;12690.375488969625;12905.161164524276;12953.935230323788;13333.133346332457;12424.875751242733;12488.43802028929;12639.810402843781;12675.492980280686;13189.868101318863;10351.295028282108;10390.688279351632;10495.842562361418;10649.414282214553;10899.128069754242;7875.107725530135;9243.168114869693;10458.477076146315;10487.318324308895;10565.9471702641 04:31:20 INFO - PROCESS | 1644 | __end_tp_report 04:31:20 INFO - PROCESS | 1644 | __start_cc_report 04:31:20 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,412 04:31:20 INFO - PROCESS | 1644 | __end_cc_report 04:31:20 INFO - PROCESS | 1644 | __startTimestamp1486989080160__endTimestamp 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | ------- Summary: start ------- 04:31:20 INFO - PROCESS | 1644 | Number of tests: 6 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5677.61 Median:5913.11 stddev:676.87 (11.4%) stddev-sans-first:654.06 04:31:20 INFO - PROCESS | 1644 | Values: 3359.6 3359.8 3382.3 3385.9 3414.9 4905.9 5316.9 5506.0 5607.9 5635.6 5512.5 5625.8 5658.8 5696.3 5745.1 5119.9 5136.8 5203.8 5262.6 5269.9 5121.4 5158.4 5176.8 5204.4 5224.2 5054.8 5089.2 5254.1 5255.6 5258.6 4586.8 4862.9 5109.8 5124.5 5166.5 5097.3 5144.2 5163.2 5189.8 5235.8 4859.6 5024.8 5594.1 5689.7 5720.8 6071.1 6116.5 6122.5 6247.0 6248.0 6182.7 6195.8 6213.0 6219.8 6262.4 5139.8 5856.8 5868.9 5878.2 5937.6 6117.7 6271.9 6275.3 6277.6 6282.9 5911.7 5961.8 5972.6 6048.1 6067.5 6085.1 6191.1 6261.7 6267.3 6300.2 6116.4 6142.6 6155.7 6193.4 6247.2 6173.7 6273.2 6283.5 6286.2 6289.0 4688.8 4690.8 4957.2 4960.1 5042.9 3371.8 4384.9 4442.7 4456.8 5112.2 4513.3 4843.9 5876.4 5879.0 5889.2 5182.9 6129.4 6144.9 6154.6 6269.1 5758.5 5839.4 5846.7 5865.7 5884.6 5437.9 5443.2 5450.5 5462.6 5479.7 6235.4 6250.8 6287.1 6291.8 6294.3 6147.5 6212.2 6228.9 6260.0 6286.7 6253.2 6257.9 6259.4 6295.5 6303.0 6202.7 6238.8 6240.5 6259.5 6262.7 4998.3 6141.2 6178.1 6191.5 6254.5 5583.2 6126.8 6167.5 6192.4 6193.8 5350.8 5891.0 5963.5 6146.4 6193.0 5841.0 5921.1 6019.3 6032.8 6080.3 6155.6 6165.6 6172.6 6173.4 6182.0 5685.6 5913.1 5943.4 5958.5 5975.2 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:63032.59 Median:33229.25 stddev:134380.58 (404.4%) stddev-sans-first:134675.42 04:31:20 INFO - PROCESS | 1644 | Values: 457.3 507.3 518.8 547.3 604.9 36964.8 37634.6 38789.0 38871.4 39031.0 39479.8 40232.6 40381.6 40423.4 40477.0 8869.9 10621.5 11062.1 11109.3 11248.6 10848.2 10937.3 10941.3 10946.7 11003.3 10921.8 10945.6 10979.8 11011.6 11015.4 10848.8 10916.1 10959.9 10993.8 11013.0 10863.3 10922.0 10937.9 10944.4 10970.9 36379.0 36609.6 36643.3 36647.1 36782.8 3604.4 3658.6 3702.4 3704.7 3849.4 26984.9 27466.5 28031.2 28051.4 28124.4 3031.5 3086.5 3164.3 3174.4 3221.2 348024.0 411779.0 413888.0 415693.0 420500.0 47075.5 47224.3 54312.0 54326.7 54361.5 58152.4 58162.8 58421.0 58598.4 58692.4 13404.7 14085.6 14193.3 14318.1 14350.1 10878.9 10910.8 11002.5 11011.2 11017.7 17337.0 17358.0 17440.6 17449.5 17516.9 6436.5 7535.8 7622.4 7647.6 7676.2 715.9 814.1 824.9 829.2 861.3 25115.0 25729.0 27667.7 28396.6 28964.9 987.6 992.0 1031.9 1043.8 1143.8 12791.9 15132.8 15168.0 15245.9 15529.0 569699.0 579855.1 582545.0 593005.0 593596.0 57800.1 57811.4 57987.7 58148.0 58255.4 1315.8 1348.3 1357.3 1359.2 1360.9 28222.7 28848.9 29197.9 29533.6 29590.6 49803.0 49937.0 50000.0 50026.7 50138.7 505302.5 507014.0 509068.0 509815.0 510174.0 22806.5 23252.7 25890.9 26047.5 26408.0 39991.0 44268.0 44868.0 45688.5 46245.0 29293.4 34051.8 36596.6 36642.0 37870.6 29876.0 36569.8 37563.8 37646.6 37872.8 30217.4 32600.7 33857.8 34544.7 35542.8 26571.5 31578.5 32150.4 32277.7 32296.8 24206.3 24506.3 24533.5 24657.6 24697.6 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:39037.70 Median:21912.06 stddev:117340.16 (535.5%) stddev-sans-first:117633.39 04:31:20 INFO - PROCESS | 1644 | Values: 358.8 382.3 397.1 402.4 418.7 17276.4 17277.4 20398.8 20516.3 20534.8 17555.0 21233.9 21440.7 21469.8 21914.2 5568.2 5630.3 5661.5 5873.0 5874.8 5113.4 5658.4 5659.6 5672.5 5745.9 5582.6 5624.8 5671.5 6209.6 6514.1 5110.0 5628.2 6427.6 6513.2 6527.2 4887.0 4901.0 5826.9 5907.0 5969.2 13471.2 13600.9 13612.5 23863.9 25006.7 2444.8 2473.1 2489.0 2539.8 2862.6 10263.7 10525.9 11616.7 12683.7 15363.4 1698.4 1740.9 1764.3 1767.4 1817.7 128405.4 131722.3 132059.9 132081.3 132965.3 11800.6 11930.5 11995.2 12128.2 12203.0 15724.0 15750.4 15751.3 15754.2 15766.8 8066.1 8295.3 8332.3 8496.6 8519.3 6783.7 7323.2 7379.6 7929.7 8102.6 4744.8 4808.7 4811.1 4832.7 4913.5 1935.0 1974.6 1985.8 1987.2 1989.5 999.9 1002.2 1004.4 1011.1 1047.8 21451.2 21825.9 21909.9 21922.8 21948.1 982.6 1033.6 1056.7 1057.8 1062.5 10828.4 11175.3 11723.6 12389.3 12398.4 674199.0 701931.0 702854.0 712768.0 720619.0 133304.0 136168.0 147728.0 151935.0 152185.0 443.6 465.1 467.3 468.3 1005.5 10140.7 10624.0 11111.4 11419.6 11447.5 57966.7 60706.4 61272.7 61798.0 61969.0 90457.1 93221.5 93346.5 94303.0 94316.5 5433.9 5527.7 7831.9 8373.1 8932.7 10902.4 13114.0 13763.4 13780.4 13795.4 9838.1 10184.8 10942.0 11019.3 11589.6 11373.9 11377.3 11413.5 11616.4 11777.2 9928.7 11318.4 11449.7 11595.7 11907.7 7700.8 8263.4 8626.9 8629.7 8893.7 5944.7 10822.1 10934.4 11694.4 11824.9 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5270.77 Median:5377.60 stddev:2880.69 (53.6%) stddev-sans-first:2873.72 04:31:20 INFO - PROCESS | 1644 | Values: 1351.6 1356.6 1377.7 1384.8 1402.1 7813.0 8112.6 8173.7 8457.3 8460.7 8268.2 8410.3 8426.7 8431.4 8475.7 2220.1 2221.9 2267.9 2271.5 2275.8 2066.9 2236.4 2269.0 2276.6 2281.5 2084.1 2229.8 2240.5 2260.7 2266.6 2160.5 2217.9 2239.1 2243.9 2253.3 1914.8 1943.6 1999.6 2221.2 2277.1 8031.1 8047.1 8054.0 8176.3 8290.3 5028.3 5206.9 5212.4 5220.8 5234.0 3319.7 3403.3 3438.2 3477.8 3479.4 1194.8 1200.0 1210.3 1222.1 1250.8 10641.6 10650.9 10695.9 10703.7 10765.7 4089.2 4377.7 4412.8 4437.5 4441.6 8348.6 8385.0 8460.7 8475.4 8512.6 5023.2 5024.7 5037.4 5040.4 5050.3 3724.3 4499.6 4698.9 4699.1 4736.1 3096.9 3566.9 3572.0 3625.5 3637.9 1005.2 1103.0 1123.7 1137.8 1156.4 832.5 860.9 865.6 901.3 923.4 5522.9 5630.9 5650.2 5781.7 5786.1 915.7 947.2 961.8 966.1 975.0 3006.7 3634.4 3650.4 3819.3 3843.6 9431.8 9555.7 9572.5 9670.7 9883.1 9887.0 9888.5 9905.0 9920.3 9936.9 7473.2 7657.5 7673.5 7686.1 7700.8 4549.6 5521.2 5526.8 5540.4 5699.2 6998.5 6999.8 8305.8 8908.2 9232.9 6912.3 9121.3 9336.8 9440.6 9451.1 5728.7 6801.4 6919.3 7194.4 7207.4 7860.0 7929.4 7992.8 7995.9 8000.5 5551.0 6688.8 7021.2 7174.4 7185.0 6870.4 6893.3 6926.9 7030.0 7084.9 6343.2 6359.8 6383.6 6427.4 6444.4 4785.6 4869.9 4881.3 4894.0 4921.2 4927.8 4930.7 4987.3 5070.9 5095.7 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4450.76 Median:4927.53 stddev:1378.27 (28.0%) stddev-sans-first:1347.31 04:31:20 INFO - PROCESS | 1644 | Values: 349.0 356.3 362.4 366.0 370.3 4581.7 5145.8 5353.0 5373.3 5412.8 4726.9 5286.2 5288.6 5313.6 5335.4 4024.0 4040.4 4047.2 4051.9 4063.1 3173.8 3322.9 3969.2 4069.2 4073.5 3823.6 3978.8 3979.8 3991.9 4003.5 3356.9 3446.3 3974.0 4012.1 4018.5 3084.0 3481.8 3498.3 3504.7 3506.6 3966.9 4234.7 4783.7 4804.8 5072.6 4574.6 4599.2 4601.9 4616.4 4635.4 4522.7 5207.5 5584.7 5644.7 5693.1 3684.4 3789.2 3798.8 3839.7 3841.8 4991.6 5085.5 5397.2 5509.5 5903.7 3311.4 3475.4 3491.8 3758.8 3894.4 3656.7 3704.8 3774.8 3788.9 3903.6 3665.9 4319.7 4418.4 4589.9 4604.2 4929.6 5646.0 5661.7 5688.7 5726.3 1193.6 1269.1 1269.7 1278.4 1279.0 799.3 832.9 863.0 873.6 880.5 4375.7 4394.9 4716.3 5073.1 5083.8 4447.4 5177.8 5468.8 5593.4 5625.3 4167.9 4383.7 4753.8 4766.0 5040.0 2550.0 2693.9 2928.5 2929.7 2938.4 5347.4 5371.0 5588.0 5771.7 5814.5 5373.7 5531.4 5536.4 5540.3 5760.5 5371.6 6092.3 6094.0 6124.7 6128.1 5322.5 5505.6 5790.4 5860.7 5877.9 5036.4 5725.4 5749.9 5806.4 5816.5 5132.4 5137.8 5541.7 5745.2 5898.9 4093.9 4197.7 4208.7 4226.6 4229.3 4887.2 5306.0 5389.8 5876.8 5891.3 5363.8 5577.3 5641.5 5649.8 5730.3 4925.4 5277.8 5645.7 5668.6 5680.3 4404.9 4651.7 5544.0 5551.4 5556.9 4615.9 4998.9 5050.5 5635.2 5692.8 4696.8 4952.3 5538.3 5592.8 5632.8 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:18389.24 Median:4175.02 stddev:25349.12 (607.2%) stddev-sans-first:25385.33 04:31:20 INFO - PROCESS | 1644 | Values: 672.5 689.7 747.9 754.0 806.3 14072.9 15041.3 15069.4 15069.5 15071.2 13796.2 13892.9 13904.8 13994.7 13998.3 856.7 869.8 872.7 874.4 877.6 849.9 860.0 861.1 874.1 874.7 916.7 922.6 924.6 924.7 925.1 915.3 917.5 918.7 921.2 921.9 679.5 685.9 687.3 687.3 689.4 10776.8 14817.3 14823.6 14836.0 14843.0 13034.2 13561.8 13885.2 13949.4 14040.4 11116.4 11395.0 11550.3 11761.4 11781.8 2945.8 3593.8 3621.0 3721.5 3724.0 71330.6 91403.0 91427.5 93004.0 93453.0 10466.9 10472.2 10483.1 10768.9 10876.4 21627.8 21706.0 21828.9 21843.3 21851.7 7396.0 7444.7 7501.2 7572.0 7715.8 3890.9 4171.2 4172.1 4177.9 4186.5 3440.3 3575.6 3652.1 3679.0 3686.1 624.6 627.7 631.0 639.8 650.2 570.6 595.2 649.6 658.5 691.1 8335.0 9044.4 10080.9 10098.2 10102.4 637.6 642.4 675.8 681.2 685.1 4438.8 4842.5 4877.4 4903.2 4925.4 81912.2 88033.1 98637.0 101321.0 101560.5 65633.0 70660.0 73045.6 76321.6 81077.0 44928.0 66083.7 71846.6 75308.0 75899.0 10203.8 10576.7 10762.9 10778.6 10815.2 42666.4 45569.9 45945.5 46520.0 46726.1 51201.7 59230.4 60195.7 60557.0 60984.4 12091.9 12195.6 12197.1 12199.8 13021.2 13525.7 13685.9 13770.9 13904.4 13960.7 12191.8 12248.1 12606.6 12667.6 12719.6 12575.7 12690.4 12905.2 12953.9 13333.1 12424.9 12488.4 12639.8 12675.5 13189.9 10351.3 10390.7 10495.8 10649.4 10899.1 7875.1 9243.2 10458.5 10487.3 10565.9 04:31:20 INFO - PROCESS | 1644 | -------- Summary: end -------- 04:31:20 INFO - PROCESS | 1644 | 04:31:20 INFO - TEST-INFO | 1644: exit 0 04:31:20 INFO - TEST-OK | dromaeo_css | took 1116455ms 04:31:20 INFO - TEST-START | kraken 04:31:20 INFO - operating with platform_type : mac_ 04:31:20 INFO - Initialising browser for kraken test... 04:31:20 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmpeTDkxc/profile http://localhost:49248/getInfo.html) 04:31:23 INFO - PROCESS | 1659 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:31:23 INFO - PROCESS | 1659 | 2017-02-13 04:31:23.808 plugin-container[1660:10206] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 04:31:23 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:23 INFO - PROCESS | 1659 | 2017-02-13 04:31:23.808 plugin-container[1660:10206] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 04:31:23 INFO - PROCESS | 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:23 INFO - PROCESS | 1659 | 2017-02-13 04:31:23.808 plugin-container[1660:10206] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:31:23 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 04:31:23 INFO - PROCESS | 1659 | colorDepth:24 04:31:23 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 04:31:23 INFO - PROCESS | 1659 | __metrics 04:31:23 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:31:24 INFO - TEST-INFO | 1659: exit 0 04:31:24 INFO - Browser initialized. 04:31:24 INFO - Running cycle 1/1 for kraken test... 04:31:24 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmpeTDkxc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:27 INFO - PROCESS | 1661 | 2017-02-13 04:31:27.107 plugin-container[1662:10324] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x882f, name = 'com.apple.tsm.portname' 04:31:27 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:27 INFO - PROCESS | 1661 | 2017-02-13 04:31:27.107 plugin-container[1662:10324] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f17, name = 'com.apple.CFPasteboardClient' 04:31:27 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:27 INFO - PROCESS | 1661 | 2017-02-13 04:31:27.107 plugin-container[1662:10324] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:31:36 INFO - PROCESS | 1661 | RSS: Main: 233861120 04:31:36 INFO - PROCESS | 1661 | 04:31:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:40 INFO - PROCESS | 1661 | RSS: Main: 247357440 04:31:40 INFO - PROCESS | 1661 | 04:31:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 04:31:43 INFO - PROCESS | 1661 | RSS: Main: 255455232 04:31:43 INFO - PROCESS | 1661 | 04:31:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 04:31:48 INFO - PROCESS | 1661 | RSS: Main: 258150400 04:31:48 INFO - PROCESS | 1661 | 04:31:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 04:31:50 INFO - PROCESS | 1661 | RSS: Main: 260370432 04:31:50 INFO - PROCESS | 1661 | 04:31:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:53 INFO - PROCESS | 1661 | RSS: Main: 260751360 04:31:53 INFO - PROCESS | 1661 | 04:31:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:56 INFO - PROCESS | 1661 | RSS: Main: 266506240 04:31:56 INFO - PROCESS | 1661 | 04:31:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:00 INFO - PROCESS | 1661 | RSS: Main: 265920512 04:32:00 INFO - PROCESS | 1661 | 04:32:03 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 04:32:04 INFO - PROCESS | 1661 | RSS: Main: 265564160 04:32:04 INFO - PROCESS | 1661 | 04:32:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:06 INFO - PROCESS | 1661 | RSS: Main: 265048064 04:32:06 INFO - PROCESS | 1661 | 04:32:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:09 INFO - PROCESS | 1661 | RSS: Main: 265052160 04:32:09 INFO - PROCESS | 1661 | 04:32:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:12 INFO - PROCESS | 1661 | RSS: Main: 265318400 04:32:12 INFO - PROCESS | 1661 | 04:32:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:16 INFO - PROCESS | 1661 | RSS: Main: 265568256 04:32:16 INFO - PROCESS | 1661 | 04:32:19 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:19 INFO - PROCESS | 1661 | RSS: Main: 265285632 04:32:19 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 04:32:21 INFO - PROCESS | 1661 | RSS: Main: 267264000 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | __start_tp_report 04:32:21 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 04:32:21 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 04:32:21 INFO - PROCESS | 1661 | |i|pagename|runs| 04:32:21 INFO - PROCESS | 1661 | |0;ai-astar;116;121;119;119;119;154;177;119;120;120 04:32:21 INFO - PROCESS | 1661 | |1;audio-beat-detection;142;117;142;186;116;119;140;137;140;118 04:32:21 INFO - PROCESS | 1661 | |2;audio-dft;197;196;210;211;222;204;179;262;277;195 04:32:21 INFO - PROCESS | 1661 | |3;audio-fft;86;60;62;90;70;51;87;85;97;84 04:32:21 INFO - PROCESS | 1661 | |4;audio-oscillator;90;71;88;70;71;72;83;73;71;84 04:32:21 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;93;119;89;88;89;98;93;136;91;88 04:32:21 INFO - PROCESS | 1661 | |6;imaging-darkroom;105;122;97;96;96;97;121;114;97;97 04:32:21 INFO - PROCESS | 1661 | |7;imaging-desaturate;117;106;95;93;84;149;149;92;93;94 04:32:21 INFO - PROCESS | 1661 | |8;json-parse-financial;62;61;61;64;62;79;90;87;94;95 04:32:21 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;70;76;69;78;74;70;70;72;90;67 04:32:21 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;91;102;115;108;84;111;75;111;79;103 04:32:21 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;150;164;150;168;136;152;157;153;212;188 04:32:21 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;177;185;210;176;176;174;177;186;167;223 04:32:21 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;69;73;89;89;69;70;92;88;89;91 04:32:21 INFO - PROCESS | 1661 | __end_tp_report 04:32:21 INFO - PROCESS | 1661 | __start_cc_report 04:32:21 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1010 04:32:21 INFO - PROCESS | 1661 | __end_cc_report 04:32:21 INFO - PROCESS | 1661 | __startTimestamp1486989141882__endTimestamp 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | ------- Summary: start ------- 04:32:21 INFO - PROCESS | 1661 | Number of tests: 14 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:128.40 Median:120.00 stddev:20.33 (16.9%) stddev-sans-first:21.06 04:32:21 INFO - PROCESS | 1661 | Values: 116.0 121.0 119.0 119.0 119.0 154.0 177.0 119.0 120.0 120.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:140.00 stddev:21.02 (15.0%) stddev-sans-first:22.18 04:32:21 INFO - PROCESS | 1661 | Values: 142.0 117.0 142.0 186.0 116.0 119.0 140.0 137.0 140.0 118.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:215.30 Median:210.50 stddev:30.99 (14.7%) stddev-sans-first:32.16 04:32:21 INFO - PROCESS | 1661 | Values: 197.0 196.0 210.0 211.0 222.0 204.0 179.0 262.0 277.0 195.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:77.20 Median:85.50 stddev:15.28 (17.9%) stddev-sans-first:15.87 04:32:21 INFO - PROCESS | 1661 | Values: 86.0 60.0 62.0 90.0 70.0 51.0 87.0 85.0 97.0 84.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:7.97 (10.2%) stddev-sans-first:7.01 04:32:21 INFO - PROCESS | 1661 | Values: 90.0 71.0 88.0 70.0 71.0 72.0 83.0 73.0 71.0 84.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:90.00 stddev:16.14 (17.9%) stddev-sans-first:17.00 04:32:21 INFO - PROCESS | 1661 | Values: 93.0 119.0 89.0 88.0 89.0 98.0 93.0 136.0 91.0 88.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:96.50 stddev:10.74 (11.1%) stddev-sans-first:11.38 04:32:21 INFO - PROCESS | 1661 | Values: 105.0 122.0 97.0 96.0 96.0 97.0 121.0 114.0 97.0 97.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:107.20 Median:92.50 stddev:23.78 (25.7%) stddev-sans-first:24.95 04:32:21 INFO - PROCESS | 1661 | Values: 117.0 106.0 95.0 93.0 84.0 149.0 149.0 92.0 93.0 94.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:75.50 Median:83.00 stddev:14.89 (17.9%) stddev-sans-first:14.97 04:32:21 INFO - PROCESS | 1661 | Values: 62.0 61.0 61.0 64.0 62.0 79.0 90.0 87.0 94.0 95.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:73.00 stddev:6.67 (9.1%) stddev-sans-first:6.95 04:32:21 INFO - PROCESS | 1661 | Values: 70.0 76.0 69.0 78.0 74.0 70.0 70.0 72.0 90.0 67.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:97.90 Median:95.00 stddev:14.54 (15.3%) stddev-sans-first:15.21 04:32:21 INFO - PROCESS | 1661 | Values: 91.0 102.0 115.0 108.0 84.0 111.0 75.0 111.0 79.0 103.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:163.00 Median:160.50 stddev:22.05 (13.7%) stddev-sans-first:22.88 04:32:21 INFO - PROCESS | 1661 | Values: 150.0 164.0 150.0 168.0 136.0 152.0 157.0 153.0 212.0 188.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:181.00 stddev:17.65 (9.8%) stddev-sans-first:18.48 04:32:21 INFO - PROCESS | 1661 | Values: 177.0 185.0 210.0 176.0 176.0 174.0 177.0 186.0 167.0 223.0 04:32:21 INFO - PROCESS | 1661 | 04:32:21 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.90 Median:89.00 stddev:10.15 (11.4%) stddev-sans-first:9.63 04:32:21 INFO - PROCESS | 1661 | Values: 69.0 73.0 89.0 89.0 69.0 70.0 92.0 88.0 89.0 91.0 04:32:21 INFO - PROCESS | 1661 | -------- Summary: end -------- 04:32:21 INFO - PROCESS | 1661 | 04:32:22 INFO - TEST-INFO | 1661: exit 0 04:32:22 INFO - TEST-OK | kraken | took 61863ms 04:32:22 INFO - SUITE-END | took 1178s 04:32:23 INFO - Completed test suite (00:19:38) 04:32:23 INFO - javascript benchmark 04:32:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7087.990852007219, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.6304406515296, 3359.7984120952747, 3382.2559037011865, 3385.8984230473093, 3414.8634054637814, 4905.852824415264, 5316.9202461963105, 5505.9724701376535, 5607.887842243158, 5635.633683810554, 5512.531434828044, 5625.774969001235, 5658.8019419320335, 5696.316442026952, 5745.138229265602, 5119.923201151985, 5136.768845401947, 5203.765830537635, 5262.605304602151, 5269.868253293679, 5121.436641969399, 5158.43257241705, 5176.818811341604, 5204.42751297357, 5224.242484839696, 5054.848354549369, 5089.160288552384, 5254.133068043769, 5255.553277971377, 5258.605604579672, 4586.816527338902, 4862.857228551287, 5109.821156259551, 5124.461931497176, 5166.457521960216, 5097.286379906816, 5144.202648589475, 5163.199704045879, 5189.792408303663, 5235.816746413857, 4859.562639362439, 5024.794049428147, 5594.104943209067, 5689.687067211302, 5720.799772008001, 6071.058985857199, 6116.510679145657, 6122.54080943931, 6247.0, 6248.0, 6182.690865456754, 6195.81412557624, 6212.974859148235, 6219.782307619212, 6262.373762623702, 5139.768710408003, 5856.765729370777, 5868.911966320508, 5878.177055212273, 5937.554683398719, 6117.663528505975, 6271.874562508724, 6275.278342990615, 6277.591956522811, 6282.874342513124, 5911.733971971272, 5961.821145365646, 5972.552058595623, 6048.123022161762, 6067.544934129958, 6085.08723691441, 6191.133241346215, 6261.686915654199, 6267.341929097471, 6300.180976473029, 6116.35778243278, 6142.560166306793, 6155.6614386209185, 6193.38066193377, 6247.156633854463, 6173.722182501709, 6273.215848018997, 6283.465905398001, 6286.15136956505, 6288.968555157195, 4688.765561721901, 4690.835820746258, 4957.206846904478, 4960.131976904099, 5042.924356134661, 3371.7976921384798, 4384.925693205185, 4442.733435993786, 4456.75487848165, 5112.233165025202, 4513.255312873404, 4843.878903027453, 5876.44173803488, 5878.971180043475, 5889.234399528034, 5182.948170518246, 6129.356417576179, 6144.9246381882995, 6154.569180157346, 6269.059641053787, 5758.510526605201, 5839.445252700986, 5846.736896839652, 5865.706714664335, 5884.558658100659, 5437.891242175135, 5443.156310771837, 5450.482204190595, 5462.562994960394, 5479.671219726829, 6235.407636274546, 6250.843728906813, 6287.088372186099, 6291.842703932438, 6294.307626161027, 6147.477464415575, 6212.192414986023, 6228.875422491616, 6260.0, 6286.717097730521, 6253.155823963707, 6257.8748425030335, 6259.436650701458, 6295.464885484785, 6303.023031430135, 6202.658853763086, 6238.781642642486, 6240.5319601031015, 6259.467945224525, 6262.718177682106, 4998.275250088789, 6141.179174348115, 6178.104174894705, 6191.504679625529, 6254.499640028877, 5583.1904373864745, 6126.816195514141, 6167.5374346925055, 6192.442680158807, 6193.783217587363, 5350.839474815762, 5891.027980383189, 5963.493103086286, 6146.446819786241, 6193.0, 5840.970795145997, 5921.14143449206, 6019.337872834072, 6032.788852390146, 6080.300765412034, 6155.569110162246, 6165.599236049642, 6172.598781079216, 6173.382661733791, 6182.0, 5685.60200785941, 5913.113033045078, 5943.405659434022, 5958.493528050164, 5975.223220981245], "value": 5635.728843006687, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.2683706070286, 507.33285729266015, 518.7535920437792, 547.2693953571984, 604.9122877182806, 36964.815175924115, 37634.623653763454, 38789.0, 38871.41692874602, 39031.0, 39479.81560553181, 40232.59767402325, 40381.59618403815, 40423.393649095284, 40477.0, 8869.866951995726, 10621.46892655368, 11062.115030797517, 11109.333439993587, 11248.55005799767, 10848.18638602108, 10937.289076210061, 10941.28881622696, 10946.671599852018, 11003.284786488892, 10921.836172457419, 10945.56217751289, 10979.83530247047, 11011.559537618527, 11015.394153321564, 10848.78302433947, 10916.126709863232, 10959.945200274027, 10993.780124397466, 11013.0, 10863.293885897392, 10922.0, 10937.945310273397, 10944.3980581068, 10970.945145274301, 36379.0, 36609.620374675564, 36643.26713465742, 36647.08382290437, 36782.816085919665, 3604.3692353837973, 3658.579263384718, 3702.4446333049987, 3704.685101766353, 3849.3840985442475, 26984.865075674694, 27466.45067098647, 28031.159065227872, 28051.43897122046, 28124.43751124966, 3031.508197699263, 3086.5370194470784, 3164.256399746058, 3174.3968645957425, 3221.1624977505785, 348024.0, 411779.0, 413888.0, 415693.0, 420500.0, 47075.5292447078, 47224.291635625494, 54312.0, 54326.728366357915, 54361.45638543564, 58152.418475815546, 58162.83674326575, 58421.0, 58598.41401586015, 58692.413075868695, 13404.664883377798, 14085.647858803612, 14193.290335483185, 14318.14091154534, 14350.138991660533, 10878.891211087946, 10910.781784364426, 11002.50488728009, 11011.174161937886, 11017.669469915754, 17337.046462444687, 17358.0, 17440.563985900455, 17449.476515704548, 17516.948983060804, 6436.485081193493, 7535.773926782205, 7622.352100071445, 7647.617619119022, 7676.19399963007, 715.8926161075881, 814.0597609760736, 824.8905222475761, 829.1708291708292, 861.263619605241, 25115.0, 25729.0, 27667.723322766513, 28396.574051389245, 28964.85517572441, 987.5753426026733, 991.9603215871284, 1031.9071283584512, 1043.801677681238, 1143.8284257361297, 12791.872081279069, 15132.773008404884, 15168.0, 15245.923770381078, 15529.0, 569699.0, 579855.1007244937, 582545.0, 593005.0, 593596.0, 57800.132998005065, 57811.42188578145, 57987.71006144942, 58148.0, 58255.417445825, 1315.7631626307166, 1348.2854087333728, 1357.3349058961037, 1359.232033900843, 1360.8911287097008, 28222.71777282201, 28848.855755721088, 29197.85401073066, 29533.556996645497, 29590.556141658322, 49803.0, 49937.0, 50000.0, 50026.74986625044, 50138.74930625324, 505302.4734876302, 507014.0, 509068.0, 509815.0, 510174.0, 22806.543869122856, 23252.651210232198, 25890.87054564715, 26047.479050418508, 26408.0, 39991.0, 44268.0, 44868.0, 45688.54311456976, 46245.0, 29293.41413171682, 34051.829740852125, 36596.63403366039, 36642.0, 37870.62129378671, 29876.0, 36569.817150914074, 37563.81218093892, 37646.62353376431, 37872.810635947746, 30217.395652087274, 32600.673993259763, 33857.83071084629, 34544.654553454144, 35542.822285888404, 26571.468570628866, 31578.526322105645, 32150.35699286048, 32277.677223227467, 32296.83851580727, 24206.273811785675, 24506.264812055666, 24533.509329812947, 24657.63013554834, 24697.62953555662], "value": 19131.96931229841, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.7721796659121, 382.28131113506606, 397.13821008411753, 402.43056075652953, 418.73333167169307, 17276.395326163587, 17277.395291164798, 20398.796012039893, 20516.28193013243, 20534.794652053475, 17555.0, 21233.893830530826, 21440.678389824126, 21469.785302146975, 21914.23300184494, 5568.192612071247, 5630.296212973379, 5661.547076233891, 5872.9706351468185, 5874.794382196624, 5113.386393632751, 5658.377578466366, 5659.632123911953, 5672.461116193955, 5745.937001654686, 5582.553395728332, 5624.803131890385, 5671.489565939065, 6209.565330426872, 6514.055461958013, 5110.0, 5628.183913332544, 6427.550071494998, 6513.185851768529, 6527.151470308853, 4887.0, 4900.961403929551, 5826.883462330729, 5907.02534081876, 5969.194158788551, 13471.191728496322, 13600.931995340059, 13612.523561675294, 23863.88068059666, 25006.749932500625, 2444.8166387521005, 2473.0973194783955, 2489.0073814687303, 2539.7841183499427, 2862.584925185857, 10263.743406414826, 10525.894741052645, 11616.651500455, 12683.74632507354, 15363.385464581403, 1698.371602507068, 1740.9390671326569, 1764.347191539126, 1767.4255866843328, 1817.7091665333483, 128405.35797321047, 131722.3413882934, 132059.89364679606, 132081.3395933014, 132965.33517332352, 11800.586979455678, 11930.463129159209, 11995.220310679779, 12128.211666241843, 12203.0, 15724.0, 15750.448734294474, 15751.291191896393, 15754.212289385485, 15766.842331576538, 8066.11272759996, 8295.336373090138, 8332.291755200877, 8496.575171241413, 8519.318454523624, 6783.660816959133, 7323.194448610649, 7379.557226566423, 7929.682812687543, 8102.554359510284, 4744.762761861962, 4808.663393562487, 4811.109944660249, 4832.734199619054, 4913.533214344631, 1935.0, 1974.6445639784977, 1985.7914918933304, 1987.1753222412826, 1989.4529004523872, 999.9450030248261, 1002.1982414068862, 1004.3622299839508, 1011.145581983223, 1047.8009178256107, 21451.249206277706, 21825.890870545547, 21909.890450547646, 21922.780772192073, 21948.122075117135, 982.6118683120128, 1033.6433930294036, 1056.709404913655, 1057.772578895541, 1062.5484169228203, 10828.404437755842, 11175.273607215506, 11723.589674361356, 12389.318587477776, 12398.380080996094, 674199.0, 701931.0, 702854.0, 712768.0, 720619.0, 133304.0, 136168.0, 147728.0, 151935.0, 152185.0, 443.6140557714809, 465.05361589165886, 467.2897196261731, 468.2998916619607, 1005.5424781724444, 10140.695779126638, 10624.043836054792, 11111.38887361203, 11419.60031398897, 11447.542098315975, 57966.710166448895, 60706.39293607007, 61272.693636531534, 61798.0, 61969.0, 90457.09542904487, 93221.5338923301, 93346.53326733323, 94303.0, 94316.52841735748, 5433.891322173456, 5527.695976721319, 7831.8825217622925, 8373.07896131413, 8932.687355942511, 10902.400367979837, 13114.0, 13763.38064787107, 13780.379882905494, 13795.379207935466, 9838.114569688762, 10184.796304074025, 10942.0, 11019.338839669645, 11589.594364197214, 11373.886261137613, 11377.2604780689, 11413.486393112164, 11616.419179041182, 11777.234479758788, 9928.702138935843, 11318.377489238172, 11449.656510304705, 11595.710107247387, 11907.702307442383, 7700.768976930477, 8263.380246481418, 8626.913730862861, 8629.741107766777, 8893.688720894996, 5944.702764861653, 10822.080123189617, 10934.359846022842, 11694.356810375511, 11824.881751182378], "value": 9493.959679328316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.628302216891, 1356.6133651909201, 1377.6624726941898, 1384.8090642047844, 1402.116666500105, 7812.960935195323, 8112.553809540473, 8173.7139200128, 8457.323414126862, 8460.703875364363, 8268.214519620626, 8410.327173826094, 8426.662933482668, 8431.40980131391, 8475.660973561051, 2220.1452440810244, 2221.8777967211795, 2267.875266860322, 2271.545690861826, 2275.8179345652393, 2066.875987440751, 2236.3514580771557, 2268.965965510519, 2276.567452184088, 2281.4866655002656, 2084.114251443138, 2229.777022297765, 2240.473488730155, 2260.7174103237094, 2266.603344414721, 2160.5030842906062, 2217.8780167090804, 2239.1491233331394, 2243.8653680779125, 2253.3352660965056, 1914.827665510097, 1943.6015616798663, 1999.6200721862945, 2221.1670623516184, 2277.134688818255, 8031.076426211002, 8047.074586422578, 8053.95973020137, 8176.264136227708, 8290.295324897392, 5028.270900719375, 5206.869828254286, 5212.374515058179, 5220.765065572058, 5233.9738301308635, 3319.717823984964, 3403.285310084885, 3438.2066218421787, 3477.7565570410084, 3479.373712731707, 1194.8028575285155, 1199.9760004799944, 1210.3403645013489, 1222.113967373656, 1250.7998720204723, 10641.627543035956, 10650.893491065146, 10695.893041069645, 10703.678889633324, 10765.677029689043, 4089.1821635672986, 4377.671674624416, 4412.84555040572, 4437.489688685778, 4441.555844415597, 8348.624311905858, 8385.035720892054, 8460.661573537112, 8475.449095808875, 8512.574371281411, 5023.196288593807, 5024.723640199751, 5037.420696619935, 5040.36995375578, 5050.267711181858, 3724.255148970217, 4499.6400287976885, 4698.859034228979, 4699.060187962421, 4736.123817093849, 3096.922576935595, 3566.91082722934, 3571.982140089283, 3625.546806649169, 3637.94543081854, 1005.2410430125209, 1102.9962733912103, 1123.7134530694784, 1137.7553825927466, 1156.4275683536703, 832.4838600067876, 860.9182127697859, 865.6104752861238, 901.2834796336928, 923.4044041593269, 5522.861928451741, 5630.943690563124, 5650.180723795027, 5781.682007489544, 5786.074228123564, 915.7344370132587, 947.2374738335706, 961.7689357622255, 966.0918736387773, 974.9853752193723, 3006.6542347629866, 3634.3639863023864, 3650.4159334506353, 3819.3316169670197, 3843.577206507282, 9431.811363772686, 9555.665551705657, 9572.521373931415, 9670.70987870365, 9883.11052005323, 9886.950565247127, 9888.505574721235, 9905.0, 9920.255980801468, 9936.850947235796, 7473.215312392229, 7657.540547567052, 7673.462857599914, 7686.077670679554, 7700.807479813049, 4549.567791059844, 5521.2270282161335, 5526.806561770319, 5540.390557038803, 5699.230603868425, 6998.545094568837, 6999.825004374931, 8305.837182794292, 8908.242799362128, 9232.907670923474, 6912.343327383891, 9121.315901307296, 9336.766580835534, 9440.622375105193, 9451.054894510495, 5728.6562806230095, 6801.421879140328, 6919.308069193041, 7194.4244460442, 7207.387372073223, 7859.9607001966915, 7929.365650747811, 7992.800179995546, 7995.880061799194, 8000.51996880189, 5551.0, 6688.799336019927, 7021.227664956953, 7174.426045916419, 7185.0, 6870.416014638811, 6893.276205998298, 6926.891697328403, 7029.9648501757165, 7084.929150708633, 6343.175387199634, 6359.841003974938, 6383.553151279366, 6427.357264273535, 6444.355564443518, 4785.617150628011, 4869.878253043702, 4881.341018962395, 4894.0, 4921.212605983025, 4927.778249978688, 4930.6795058321095, 4987.326710894128, 5070.873228169326, 5095.694258344512], "value": 4281.030973411561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9827153846538, 356.34432643935156, 362.3694771098289, 365.9615740347262, 370.30752492838394, 4581.748003859786, 5145.845624631258, 5353.0, 5373.280550223925, 5412.783488660454, 4726.929096063562, 5286.180642000487, 5288.629795914288, 5313.572745579099, 5335.386430560487, 4023.9798801006027, 4040.4141399497057, 4047.170330082326, 4051.9392209116886, 4063.1264278180183, 3173.809821317006, 3322.850471728778, 3969.1863168050627, 4069.212589376272, 4073.490813648294, 3823.617638236168, 3978.8262462573466, 3979.781112038837, 3991.8602848900296, 4003.4795476588147, 3356.9496457553155, 3446.3107378524396, 3973.960260397402, 4012.057166565855, 4018.45750823638, 3083.9691603083907, 3481.8259087045544, 3498.265364273506, 3504.737144714157, 3506.5798351667618, 3966.8892710041237, 4234.6823988201, 4783.712977221343, 4804.807807687724, 5072.594192464631, 4574.61115805157, 4599.218132917378, 4601.907961840744, 4616.376789133457, 4635.351050852883, 4522.706024108423, 5207.531322180984, 5584.715515431433, 5644.74598643062, 5693.060644993571, 3684.392075307571, 3789.2042671039117, 3798.829052692608, 3839.7345566116123, 3841.78870162141, 4991.600671946272, 5085.491450854922, 5397.171055260309, 5509.5041446270025, 5903.675297858616, 3311.437055700537, 3475.409180439281, 3491.755577109578, 3758.793266370376, 3894.357431023849, 3656.725745569093, 3704.8329776120436, 3774.8112594370173, 3788.886333410002, 3903.6486716195677, 3665.9450108248398, 4319.6976211665515, 4418.447694038246, 4589.878882359961, 4604.171249175113, 4929.605631549467, 5645.98372292983, 5661.66030038199, 5688.658680479184, 5726.341470730836, 1193.6061099837034, 1269.05455435701, 1269.6952731344595, 1278.3799857069314, 1279.0343290815374, 799.3085980626716, 832.9458585191943, 862.977371814402, 873.6287077991828, 880.4717169698258, 4375.7155784873885, 4394.868153955386, 4716.316134160527, 5073.133679471087, 5083.822066227664, 4447.442720435763, 5177.792888284426, 5468.769526856426, 5593.440655934374, 5625.324961004624, 4167.937480937789, 4383.736975781463, 4753.762311884392, 4765.975315307156, 5040.042391945519, 2550.0474264889717, 2693.9461210775676, 2928.5167947288883, 2929.721676440735, 2938.4270067336665, 5347.3583170019065, 5370.9731451342495, 5588.0, 5771.6537007778825, 5814.476697097281, 5373.683447555374, 5531.446855314436, 5536.390996990328, 5540.335159780852, 5760.51035661965, 5371.57027437804, 6092.268927728613, 6094.024956007018, 6124.724387402489, 6128.142060111588, 5322.467753224647, 5505.559555235492, 5790.39200883918, 5860.677662728421, 5877.911831322448, 5036.370453693288, 5725.421611492817, 5749.942500574941, 5806.390329015392, 5816.4698356215185, 5132.384113906355, 5137.794488220429, 5541.667499949855, 5745.195672605755, 5898.911516327173, 4093.91812163761, 4197.685173611931, 4208.6953044556285, 4226.640735537514, 4229.281022226291, 4887.242477416006, 5306.0, 5389.83830485086, 5876.794312199053, 5891.293044834647, 5363.785448582169, 5577.271045975761, 5641.5204707600315, 5649.802256920988, 5730.255066841284, 4925.448483727758, 5277.8416647500635, 5645.68948707825, 5668.631538949955, 5680.318361796611, 4404.9119017620105, 4651.720537021324, 5543.972280138573, 5551.361593416808, 5556.916646250229, 4615.884602884955, 4998.850953708486, 5050.49495050492, 5635.211070450222, 5692.7722891083895, 4696.849271928263, 4952.257161425671, 5538.335399752055, 5592.804251851328, 5632.802851900164], "value": 4027.3531916410684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.5023482622861, 689.6517258784313, 747.8803391457365, 753.9547627142372, 806.3307454812506, 14072.929635351822, 15041.323140458679, 15069.38334799647, 15069.472568460105, 15071.171085590287, 13796.172229666226, 13892.861071389283, 13904.791428128587, 13994.720105597882, 13998.300084995735, 856.6958729650978, 869.7869022089596, 872.7076429396128, 874.3704532736419, 877.5524482513932, 849.9405041647087, 859.9613017414231, 861.1130535548396, 874.1127755328315, 874.6501399440243, 916.715818096389, 922.5940586142076, 924.5885580916495, 924.7410724997012, 925.1349987761431, 915.3363811236867, 917.5137177296044, 918.7335672654922, 921.2123634292684, 921.889373275208, 679.4700133895569, 685.8936864785966, 687.3023880761032, 687.3161204601454, 689.396777819408, 10776.838347424795, 14817.259137043106, 14823.629409264748, 14836.035657682216, 14842.960992730514, 13034.15278006936, 13561.796573051412, 13885.236312002837, 13949.442022319197, 14040.368183431669, 11116.359784992157, 11395.0, 11550.306981581132, 11761.411929403495, 11781.764364712744, 2945.837978911159, 3593.784372937606, 3621.040424287566, 3721.5162028936065, 3723.962760372389, 71330.64334678293, 91403.0, 91427.46507540948, 93004.0, 93453.0, 10466.947665261625, 10472.162227021972, 10483.108935740394, 10768.946155269174, 10876.401797901033, 21627.78372216289, 21706.0, 21828.890855545622, 21843.344699659036, 21851.672224916638, 7396.0, 7444.664990075459, 7501.174870764212, 7571.962140189264, 7715.768526944201, 3890.8832735017995, 4171.249175148502, 4172.144710334434, 4177.895552611149, 4186.455760751144, 3440.3291358184915, 3575.6245594212232, 3652.1052342176336, 3678.9816050919576, 3686.060054686038, 624.6127401011402, 627.6579264300875, 630.9905351419733, 639.7728806273799, 650.2099948562425, 570.57207094679, 595.2172892646156, 649.6004956951441, 658.4600627485512, 691.1395312835552, 8335.0, 9044.366894317334, 10080.949595251977, 10098.242631802645, 10102.444365559964, 637.6461064109463, 642.4025656139835, 675.8276639457006, 681.2234053179379, 685.1469919949694, 4438.800253988578, 4842.467328593852, 4877.396873793528, 4903.215485522299, 4925.40895092584, 81912.18087819165, 88033.11966880377, 98637.01362986278, 101321.0, 101560.49219753854, 65633.0, 70660.0, 73045.6347718258, 76321.61839190769, 81076.9730756724, 44927.999999999345, 66083.66958165179, 71846.64076679583, 75308.0, 75899.0, 10203.798008676105, 10576.735581610521, 10762.892371076188, 10778.622748203776, 10815.24293299493, 42666.360004600574, 45569.860753480105, 45945.54054459413, 46520.0, 46726.065478690914, 51201.74399127981, 59230.40769592249, 60195.69902150461, 60557.0, 60984.39015609787, 12091.939540302243, 12195.573154939535, 12197.055436175116, 12199.817002745143, 13021.218726876417, 13525.666534022923, 13685.931570342085, 13770.862291376958, 13904.443822247402, 13960.673735995064, 12191.78629185229, 12248.081393895316, 12606.621801345975, 12667.556635517712, 12719.611733951771, 12575.685607859878, 12690.375488969625, 12905.161164524276, 12953.935230323788, 13333.133346332457, 12424.875751242733, 12488.43802028929, 12639.810402843781, 12675.492980280686, 13189.868101318863, 10351.295028282108, 10390.688279351632, 10495.842562361418, 10649.414282214553, 10899.128069754242, 7875.107725530135, 9243.168114869693, 10458.477076146315, 10487.318324308895, 10565.9471702641], "value": 7183.995608052903, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1620.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 119.0, 119.0, 119.0, 154.0, 177.0, 119.0, 120.0, 120.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 142.0, 186.0, 116.0, 119.0, 140.0, 137.0, 140.0, 118.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 196.0, 210.0, 211.0, 222.0, 204.0, 179.0, 262.0, 277.0, 195.0], "value": 215.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 62.0, 90.0, 70.0, 51.0, 87.0, 85.0, 97.0, 84.0], "value": 77.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 88.0, 70.0, 71.0, 72.0, 83.0, 73.0, 71.0, 84.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 119.0, 89.0, 88.0, 89.0, 98.0, 93.0, 136.0, 91.0, 88.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 122.0, 97.0, 96.0, 96.0, 97.0, 121.0, 114.0, 97.0, 97.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 106.0, 95.0, 93.0, 84.0, 149.0, 149.0, 92.0, 93.0, 94.0], "value": 107.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 64.0, 62.0, 79.0, 90.0, 87.0, 94.0, 95.0], "value": 75.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 69.0, 78.0, 74.0, 70.0, 70.0, 72.0, 90.0, 67.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 102.0, 115.0, 108.0, 84.0, 111.0, 75.0, 111.0, 79.0, 103.0], "value": 97.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 164.0, 150.0, 168.0, 136.0, 152.0, 157.0, 153.0, 212.0, 188.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 185.0, 210.0, 176.0, 176.0, 174.0, 177.0, 186.0, 167.0, 223.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 89.0, 89.0, 69.0, 70.0, 92.0, 88.0, 89.0, 91.0], "value": 81.9, "unit": "score"}]}]} 04:32:23 INFO - Return code: 0 04:32:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:23 ERROR - # TBPL SUCCESS # 04:32:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:23 INFO - 2017-02-13 04:32:23.168 screenresolution[1666:10717] starting screenresolution argv=screenresolution get 04:32:23 INFO - 2017-02-13 04:32:23.171 screenresolution[1666:10717] Display 0: 1600x1200x32@60 04:32:23 INFO - 2017-02-13 04:32:23.177 screenresolution[1667:10720] starting screenresolution argv=screenresolution list 04:32:23 INFO - Available Modes on Display 0 04:32:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:23 INFO - Intel Iris: 04:32:23 INFO - Chipset Model: Intel Iris 04:32:23 INFO - Type: GPU 04:32:23 INFO - Bus: Built-In 04:32:23 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:23 INFO - Vendor: Intel (0x8086) 04:32:23 INFO - Device ID: 0x0a2e 04:32:23 INFO - Revision ID: 0x0009 04:32:23 INFO - Displays: 04:32:23 INFO - Display: 04:32:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:23 INFO - Display Serial Number: 1600x1200 60 04:32:23 INFO - Main Display: Yes 04:32:23 INFO - Mirror: Off 04:32:23 INFO - Online: Yes 04:32:23 INFO - Rotation: Supported 04:32:23 INFO - Return code: 0 04:32:23 INFO - Running post-action listener: _resource_record_post_action 04:32:23 INFO - [mozharness: 2017-02-13 12:32:23.418033Z] Finished run-tests step (success) 04:32:23 INFO - Running post-run listener: _resource_record_post_run 04:32:23 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 38213632; Write bytes: 558930944; Read time: 400; Write time: 1727 04:32:23 INFO - TinderboxPrint: CPU usage
54.5% 04:32:23 INFO - TinderboxPrint: I/O read bytes / time
38,213,632 / 400 04:32:23 INFO - TinderboxPrint: I/O write bytes / time
558,930,944 / 1,727 04:32:23 INFO - TinderboxPrint: CPU idle
2,186.3 (45.5%) 04:32:23 INFO - TinderboxPrint: CPU system
966.8 (20.1%) 04:32:23 INFO - TinderboxPrint: CPU user
1,652.5 (34.4%) 04:32:23 INFO - TinderboxPrint: Swap in / out
291,082,240 / 0 04:32:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 254026240; Write bytes: 256488960; Read time: 18192; Write time: 527 04:32:23 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 35645440; Write bytes: 301086208; Read time: 367; Write time: 1190 04:32:23 INFO - Running post-run listener: _upload_blobber_files 04:32:23 INFO - Blob upload gear active. 04:32:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:23 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 04:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:25 INFO - (blobuploader) - INFO - Done attempting. 04:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:26 INFO - (blobuploader) - INFO - Done attempting. 04:32:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:32:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:32:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:27 INFO - (blobuploader) - INFO - Done attempting. 04:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:32:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:30 INFO - (blobuploader) - INFO - Done attempting. 04:32:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:30 INFO - Return code: 0 04:32:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9750a441313138d2975b194a722c2cdb67bdf814c757c61a34ce18b5acb4e7e029d5940377b29dd1d9374d5bd91fb82c3c66c9563ee1b47ff7ddb5d1a8c75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0984b477ed39c920604109728f73a2c40a75c5031a6f0955a27c38e7f45de92cf6a78f861512efcdbfef2f68f34e01a606979450f98ad18d34a2bddc0bbdbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697295c3c3c368418f6a9675ae3c14d1ad78bd01ec3f0d158f78bd4fbca8bd3ec64304ed4fb4394394037f24aed7112a6229a6e6633540499514439ac03da75e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e3aea0567e4433a35ab848a1ed1e8eb984ffcdcb67b8d1d1ee7a261414fd62c5b3187a50d6a1e5b41f8052a8f77fa9e3dbd8726c501eb7d2e620523578d6d09"} 04:32:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:30 INFO - Contents: 04:32:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9750a441313138d2975b194a722c2cdb67bdf814c757c61a34ce18b5acb4e7e029d5940377b29dd1d9374d5bd91fb82c3c66c9563ee1b47ff7ddb5d1a8c75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0984b477ed39c920604109728f73a2c40a75c5031a6f0955a27c38e7f45de92cf6a78f861512efcdbfef2f68f34e01a606979450f98ad18d34a2bddc0bbdbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697295c3c3c368418f6a9675ae3c14d1ad78bd01ec3f0d158f78bd4fbca8bd3ec64304ed4fb4394394037f24aed7112a6229a6e6633540499514439ac03da75e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e3aea0567e4433a35ab848a1ed1e8eb984ffcdcb67b8d1d1ee7a261414fd62c5b3187a50d6a1e5b41f8052a8f77fa9e3dbd8726c501eb7d2e620523578d6d09"} 04:32:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:30 INFO - Copying logs to upload dir... 04:32:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.801772 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-13 04:32:30.551768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 04:32:30.559824) ========= 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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9750a441313138d2975b194a722c2cdb67bdf814c757c61a34ce18b5acb4e7e029d5940377b29dd1d9374d5bd91fb82c3c66c9563ee1b47ff7ddb5d1a8c75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0984b477ed39c920604109728f73a2c40a75c5031a6f0955a27c38e7f45de92cf6a78f861512efcdbfef2f68f34e01a606979450f98ad18d34a2bddc0bbdbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697295c3c3c368418f6a9675ae3c14d1ad78bd01ec3f0d158f78bd4fbca8bd3ec64304ed4fb4394394037f24aed7112a6229a6e6633540499514439ac03da75e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e3aea0567e4433a35ab848a1ed1e8eb984ffcdcb67b8d1d1ee7a261414fd62c5b3187a50d6a1e5b41f8052a8f77fa9e3dbd8726c501eb7d2e620523578d6d09"} build_url:https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010813 build_url: 'https://queue.taskcluster.net/v1/task/OiHtdGqdTnKV4tGNEp_XfA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9a9750a441313138d2975b194a722c2cdb67bdf814c757c61a34ce18b5acb4e7e029d5940377b29dd1d9374d5bd91fb82c3c66c9563ee1b47ff7ddb5d1a8c75", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b0984b477ed39c920604109728f73a2c40a75c5031a6f0955a27c38e7f45de92cf6a78f861512efcdbfef2f68f34e01a606979450f98ad18d34a2bddc0bbdbb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/697295c3c3c368418f6a9675ae3c14d1ad78bd01ec3f0d158f78bd4fbca8bd3ec64304ed4fb4394394037f24aed7112a6229a6e6633540499514439ac03da75e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e3aea0567e4433a35ab848a1ed1e8eb984ffcdcb67b8d1d1ee7a261414fd62c5b3187a50d6a1e5b41f8052a8f77fa9e3dbd8726c501eb7d2e620523578d6d09"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 04:32:30.601485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:32:30.601903) ========= 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.IvtbX9V4Yf/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.89gQWvoYVG/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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.005093 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 04:32:30.758998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 04:32:30.759427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 04:32:30.760080) ========= ========= Total master_lag: 0.32 =========