builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0120 starttime: 1491296142.91 results: success (0) buildid: 20170404004003 builduid: 1e000a41d3274e0a963144b8113a90bf revision: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.911523) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.912013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.912480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.987659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.988018) ========= 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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-04-04 01:55:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-04-04 01:55:43 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132984 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.147134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.147462) ========= 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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.029799 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.200199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 01:55:43.200607) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e3ce3282ec26d1cff472f2bed8c65693ea168ff8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e3ce3282ec26d1cff472f2bed8c65693ea168ff8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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-04-04 01:55:43,298 truncating revision to first 12 chars 2017-04-04 01:55:43,298 Setting DEBUG logging. 2017-04-04 01:55:43,298 attempt 1/10 2017-04-04 01:55:43,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e3ce3282ec26?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 01:55:44,419 unpacking tar archive at: mozilla-aurora-e3ce3282ec26/testing/mozharness/ program finished with exit code 0 elapsedTime=1.396444 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 01:55:44.624512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.625263) ========= script_repo_revision: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.626213) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.626938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.649137) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-04 01:55:44.649487) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:55:44 INFO - MultiFileLogger online at 20170404 01:55:44 in /builds/slave/test 01:55:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:55:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:55:44 INFO - {'append_to_log': False, 01:55:44 INFO - 'base_work_dir': '/builds/slave/test', 01:55:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:55:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:55:44 INFO - 'branch': 'Mozilla-Aurora', 01:55:44 INFO - 'buildbot_json_path': 'buildprops.json', 01:55:44 INFO - 'config_files': ('talos/mac_config.py',), 01:55:44 INFO - 'default_actions': ('clobber', 01:55:44 INFO - 'read-buildbot-config', 01:55:44 INFO - 'download-and-extract', 01:55:44 INFO - 'populate-webroot', 01:55:44 INFO - 'create-virtualenv', 01:55:44 INFO - 'install', 01:55:44 INFO - 'run-tests'), 01:55:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:55:44 INFO - 'download_minidump_stackwalk': True, 01:55:44 INFO - 'download_symbols': 'ondemand', 01:55:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:55:44 INFO - 'tooltool.py': '/tools/tooltool.py', 01:55:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:55:44 INFO - '/tools/misc-python/virtualenv.py')}, 01:55:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:55:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:55:44 INFO - 'gecko_profile': False, 01:55:44 INFO - 'gecko_profile_interval': 0, 01:55:44 INFO - 'installer_path': 'installer.exe', 01:55:44 INFO - 'log_level': 'info', 01:55:44 INFO - 'log_name': 'talos', 01:55:44 INFO - 'log_to_console': True, 01:55:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:55:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:55:44 INFO - 'opt_config_files': (), 01:55:44 INFO - 'pip_index': False, 01:55:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:55:44 INFO - 'cmd': ('bash', 01:55:44 INFO - '-c', 01:55:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:55:44 INFO - 'enabled': True, 01:55:44 INFO - 'halt_on_failure': False, 01:55:44 INFO - 'name': 'check_screen_resolution'},), 01:55:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:55:44 INFO - 'cmd': ('bash', 01:55:44 INFO - '-c', 01:55:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:55:44 INFO - 'enabled': True, 01:55:44 INFO - 'halt_on_failure': False, 01:55:44 INFO - 'name': 'check_screen_resolution'},), 01:55:44 INFO - 'run_cmd_checks_enabled': True, 01:55:44 INFO - 'suite': 'dromaeojs-e10s', 01:55:44 INFO - 'system_bits': '32', 01:55:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:55:44 INFO - 'title': 't-yosemite-r7-0120', 01:55:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:55:44 INFO - 'use_talos_json': True, 01:55:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:55:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:55:44 INFO - 'work_dir': 'build'} 01:55:44 INFO - [mozharness: 2017-04-04 08:55:44.859823Z] Running clobber step. 01:55:44 INFO - Running pre-action listener: _resource_record_pre_action 01:55:44 INFO - Running main action method: clobber 01:55:44 INFO - rmtree: /builds/slave/test/build 01:55:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:55:47 INFO - Running post-action listener: _resource_record_post_action 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.467894Z] Finished clobber step (success) 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.468066Z] Running read-buildbot-config step. 01:55:47 INFO - Running pre-action listener: _resource_record_pre_action 01:55:47 INFO - Running main action method: read_buildbot_config 01:55:47 INFO - Using buildbot properties: 01:55:47 INFO - { 01:55:47 INFO - "project": "", 01:55:47 INFO - "product": "firefox", 01:55:47 INFO - "script_repo_revision": "production", 01:55:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:55:47 INFO - "repository": "", 01:55:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:55:47 INFO - "buildid": "20170404004003", 01:55:47 INFO - "stage_platform": "macosx64", 01:55:47 INFO - "basedir": "/builds/slave/test", 01:55:47 INFO - "nightly_build": "True", 01:55:47 INFO - "buildnumber": 37, 01:55:47 INFO - "slavename": "t-yosemite-r7-0120", 01:55:47 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 01:55:47 INFO - "platform": "yosemite_r7", 01:55:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:55:47 INFO - "branch": "mozilla-aurora", 01:55:47 INFO - "repo_path": "releases/mozilla-aurora", 01:55:47 INFO - "revision": "e3ce3282ec26d1cff472f2bed8c65693ea168ff8", 01:55:47 INFO - "pgo_build": "False", 01:55:47 INFO - "builduid": "1e000a41d3274e0a963144b8113a90bf", 01:55:47 INFO - "slavebuilddir": "test" 01:55:47 INFO - } 01:55:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:55:47 INFO - Running post-action listener: _resource_record_post_action 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.471455Z] Finished read-buildbot-config step (success) 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.471557Z] Running download-and-extract step. 01:55:47 INFO - Running pre-action listener: _resource_record_pre_action 01:55:47 INFO - Running main action method: download_and_extract 01:55:47 INFO - mkdir: /builds/slave/test/build/tests 01:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:55:47 INFO - trying https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:55:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:55:48 INFO - Downloaded 1199 bytes. 01:55:48 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:55:48 INFO - Using the following test package requirements: 01:55:48 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:55:48 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:55:48 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:55:48 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'jsshell-mac.zip'], 01:55:48 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:55:48 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:55:48 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:55:48 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:55:48 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:55:48 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:48 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:55:48 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:55:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:55:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:55:48 INFO - Fetch https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:55:51 INFO - Expected file size: 51790454 01:55:51 INFO - Obtained file size: 51790454 01:56:07 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:56:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:56:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:56:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:56:09 INFO - Expected file size: 51790454 01:56:09 INFO - Obtained file size: 51790454 01:56:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:56:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:56:23 INFO - Fetch https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:56:25 INFO - Expected file size: 14404438 01:56:25 INFO - Obtained file size: 14404438 01:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:25 INFO - trying https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:56:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:56:27 INFO - Downloaded 74709766 bytes. 01:56:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:56:27 INFO - mkdir: /builds/slave/test/properties 01:56:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:56:27 INFO - Writing to file /builds/slave/test/properties/build_url 01:56:27 INFO - Contents: 01:56:27 INFO - build_url:https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:56:28 INFO - Running post-action listener: _resource_record_post_action 01:56:28 INFO - Running post-action listener: set_extra_try_arguments 01:56:28 INFO - [mozharness: 2017-04-04 08:56:28.194299Z] Finished download-and-extract step (success) 01:56:28 INFO - [mozharness: 2017-04-04 08:56:28.194431Z] Running populate-webroot step. 01:56:28 INFO - Running pre-action listener: _resource_record_pre_action 01:56:28 INFO - Running main action method: populate_webroot 01:56:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:56:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:56:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:56:28 INFO - '--tppagecycles', 01:56:28 INFO - '7'], 01:56:28 INFO - 'tests': ['tsvgm']}}, 01:56:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:56:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:56:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:56:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:56:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['damp', 'tps']}, 01:56:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'tests': ['damp', 'tps']}, 01:56:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['dromaeo_dom']}, 01:56:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:56:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['basic_compositor_video']}, 01:56:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:56:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['a11yr', 01:56:28 INFO - 'ts_paint', 01:56:28 INFO - 'tpaint', 01:56:28 INFO - 'sessionrestore', 01:56:28 INFO - 'sessionrestore_no_auto_restore', 01:56:28 INFO - 'tabpaint']}, 01:56:28 INFO - 'other-e10s': {'tests': ['a11yr', 01:56:28 INFO - 'ts_paint', 01:56:28 INFO - 'tpaint', 01:56:28 INFO - 'sessionrestore', 01:56:28 INFO - 'sessionrestore_no_auto_restore', 01:56:28 INFO - 'tabpaint']}, 01:56:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:56:28 INFO - 'ts_paint', 01:56:28 INFO - 'tpaint', 01:56:28 INFO - 'sessionrestore', 01:56:28 INFO - 'sessionrestore_no_auto_restore', 01:56:28 INFO - 'tabpaint']}, 01:56:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:56:28 INFO - 'ts_paint', 01:56:28 INFO - 'tpaint', 01:56:28 INFO - 'sessionrestore', 01:56:28 INFO - 'sessionrestore_no_auto_restore', 01:56:28 INFO - 'tabpaint']}, 01:56:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['a11yr', 01:56:28 INFO - 'ts_paint', 01:56:28 INFO - 'tpaint', 01:56:28 INFO - 'sessionrestore', 01:56:28 INFO - 'sessionrestore_no_auto_restore', 01:56:28 INFO - 'tabpaint']}, 01:56:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['a11yr', 01:56:28 INFO - 'ts_paint', 01:56:28 INFO - 'tpaint', 01:56:28 INFO - 'sessionrestore', 01:56:28 INFO - 'sessionrestore_no_auto_restore', 01:56:28 INFO - 'tabpaint']}, 01:56:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['tsvgx', 01:56:28 INFO - 'tsvgr_opacity', 01:56:28 INFO - 'tart', 01:56:28 INFO - 'tscrollx', 01:56:28 INFO - 'cart', 01:56:28 INFO - 'tsvg_static']}, 01:56:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:56:28 INFO - 'tsvgr_opacity', 01:56:28 INFO - 'tart', 01:56:28 INFO - 'tscrollx', 01:56:28 INFO - 'cart', 01:56:28 INFO - 'tsvg_static']}, 01:56:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'talos_options': ['--disable-e10s'], 01:56:28 INFO - 'tests': ['tp5o']}, 01:56:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:56:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'talos_options': ['--disable-e10s', 01:56:28 INFO - '--xperf_path', 01:56:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:28 INFO - 'tests': ['tp5n']}, 01:56:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:56:28 INFO - 'talos_options': ['--xperf_path', 01:56:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:28 INFO - 'tests': ['tp5n']}}, 01:56:28 INFO - 'talos.zip': {'path': '', 01:56:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:56:28 INFO - Running post-action listener: _resource_record_post_action 01:56:28 INFO - [mozharness: 2017-04-04 08:56:28.212751Z] Finished populate-webroot step (success) 01:56:28 INFO - [mozharness: 2017-04-04 08:56:28.212859Z] Running create-virtualenv step. 01:56:28 INFO - Running pre-action listener: _resource_record_pre_action 01:56:28 INFO - Running main action method: create_virtualenv 01:56:28 INFO - Creating virtualenv /builds/slave/test/build/venv 01:56:28 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 01:56:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:56:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:56:28 INFO - Using real prefix '/tools/python27' 01:56:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:56:29 INFO - Installing distribute.............................................................................................................................................................................................done. 01:56:32 INFO - Installing pip.................done. 01:56:32 INFO - Return code: 0 01:56:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:56:32 INFO - Reading from file tmpfile_stdout 01:56:32 INFO - Output received: 01:56:32 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) 01:56:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:56:32 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')]} 01:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:32 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')]} 01:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:32 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:32 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 01:56:32 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 01:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:32 INFO - 'HOME': '/Users/cltbld', 01:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:32 INFO - 'LOGNAME': 'cltbld', 01:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:32 INFO - 'MOZ_NO_REMOTE': '1', 01:56:32 INFO - 'NO_EM_RESTART': '1', 01:56:32 INFO - 'PAGER': '/bin/cat', 01:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:32 INFO - 'PWD': '/builds/slave/test', 01:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:32 INFO - 'SHELL': '/bin/bash', 01:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:32 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:32 INFO - 'USER': 'cltbld', 01:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:32 INFO - 'XPC_FLAGS': '0x0', 01:56:32 INFO - 'XPC_SERVICE_NAME': '0', 01:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:32 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 01:56:32 INFO - Cleaning up... 01:56:32 INFO - Return code: 0 01:56:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:56:32 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')]} 01:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:32 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')]} 01:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:32 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:32 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 01:56:32 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 01:56:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:32 INFO - 'HOME': '/Users/cltbld', 01:56:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:32 INFO - 'LOGNAME': 'cltbld', 01:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:32 INFO - 'MOZ_NO_REMOTE': '1', 01:56:32 INFO - 'NO_EM_RESTART': '1', 01:56:32 INFO - 'PAGER': '/bin/cat', 01:56:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:32 INFO - 'PWD': '/builds/slave/test', 01:56:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:32 INFO - 'SHELL': '/bin/bash', 01:56:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:32 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:32 INFO - 'USER': 'cltbld', 01:56:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:32 INFO - 'XPC_FLAGS': '0x0', 01:56:32 INFO - 'XPC_SERVICE_NAME': '0', 01:56:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:32 INFO - Downloading/unpacking psutil>=3.1.1 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:32 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 01:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:56:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:36 INFO - Installing collected packages: psutil 01:56:36 INFO - Running setup.py install for psutil 01:56:36 INFO - building 'psutil._psutil_osx' extension 01:56:36 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 01:56:37 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 01:56:37 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 01:56:37 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 01:56:37 INFO - building 'psutil._psutil_posix' extension 01:56:37 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 01:56:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:56:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:56:37 INFO - ^ 01:56:37 INFO - 1 warning generated. 01:56:37 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 01:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:37 INFO - Successfully installed psutil 01:56:37 INFO - Cleaning up... 01:56:38 INFO - Return code: 0 01:56:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:56:38 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')]} 01:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:38 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')]} 01:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:38 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:38 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 01:56:38 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 01:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:38 INFO - 'HOME': '/Users/cltbld', 01:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:38 INFO - 'LOGNAME': 'cltbld', 01:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:38 INFO - 'MOZ_NO_REMOTE': '1', 01:56:38 INFO - 'NO_EM_RESTART': '1', 01:56:38 INFO - 'PAGER': '/bin/cat', 01:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:38 INFO - 'PWD': '/builds/slave/test', 01:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:38 INFO - 'SHELL': '/bin/bash', 01:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:38 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:38 INFO - 'USER': 'cltbld', 01:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:38 INFO - 'XPC_FLAGS': '0x0', 01:56:38 INFO - 'XPC_SERVICE_NAME': '0', 01:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:56:38 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 01:56:38 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 01:56:38 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 01:56:38 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 01:56:38 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 01:56:38 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 01:56:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:56:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:56:41 INFO - Installing collected packages: mozsystemmonitor 01:56:41 INFO - Running setup.py install for mozsystemmonitor 01:56:41 INFO - Successfully installed mozsystemmonitor 01:56:41 INFO - Cleaning up... 01:56:41 INFO - Return code: 0 01:56:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:56:41 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')]} 01:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:41 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')]} 01:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:41 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:41 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 01:56:41 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 01:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:41 INFO - 'HOME': '/Users/cltbld', 01:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:41 INFO - 'LOGNAME': 'cltbld', 01:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:41 INFO - 'MOZ_NO_REMOTE': '1', 01:56:41 INFO - 'NO_EM_RESTART': '1', 01:56:41 INFO - 'PAGER': '/bin/cat', 01:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:41 INFO - 'PWD': '/builds/slave/test', 01:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:41 INFO - 'SHELL': '/bin/bash', 01:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:41 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:41 INFO - 'USER': 'cltbld', 01:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:41 INFO - 'XPC_FLAGS': '0x0', 01:56:41 INFO - 'XPC_SERVICE_NAME': '0', 01:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:41 INFO - Downloading/unpacking jsonschema==2.5.1 01:56:41 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 01:56:41 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 01:56:41 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 01:56:41 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 01:56:41 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 01:56:41 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 01:56:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:56:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:56:44 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 01:56:44 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 01:56:44 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 01:56:44 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 01:56:44 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 01:56:44 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 01:56:44 INFO - Downloading functools32-3.2.3-2.tar.gz 01:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:56:44 INFO - warning: no files found matching '*.txt' 01:56:44 INFO - no previously-included directories found matching 'build' 01:56:44 INFO - no previously-included directories found matching 'dist' 01:56:44 INFO - no previously-included directories found matching '.git*' 01:56:44 INFO - Installing collected packages: jsonschema, functools32 01:56:44 INFO - Running setup.py install for functools32 01:56:44 INFO - warning: no files found matching '*.txt' 01:56:44 INFO - no previously-included directories found matching 'build' 01:56:44 INFO - no previously-included directories found matching 'dist' 01:56:44 INFO - no previously-included directories found matching '.git*' 01:56:44 INFO - Successfully installed jsonschema functools32 01:56:44 INFO - Cleaning up... 01:56:44 INFO - Return code: 0 01:56:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:44 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:44 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 01:56:44 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 01:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:44 INFO - 'HOME': '/Users/cltbld', 01:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:44 INFO - 'LOGNAME': 'cltbld', 01:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:44 INFO - 'MOZ_NO_REMOTE': '1', 01:56:44 INFO - 'NO_EM_RESTART': '1', 01:56:44 INFO - 'PAGER': '/bin/cat', 01:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:44 INFO - 'PWD': '/builds/slave/test', 01:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:44 INFO - 'SHELL': '/bin/bash', 01:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:44 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:44 INFO - 'USER': 'cltbld', 01:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:44 INFO - 'XPC_FLAGS': '0x0', 01:56:44 INFO - 'XPC_SERVICE_NAME': '0', 01:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:56:45 INFO - Cleaning up... 01:56:45 INFO - Return code: 0 01:56:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:45 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:45 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 01:56:45 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 01:56:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:45 INFO - 'HOME': '/Users/cltbld', 01:56:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:45 INFO - 'LOGNAME': 'cltbld', 01:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:45 INFO - 'MOZ_NO_REMOTE': '1', 01:56:45 INFO - 'NO_EM_RESTART': '1', 01:56:45 INFO - 'PAGER': '/bin/cat', 01:56:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:45 INFO - 'PWD': '/builds/slave/test', 01:56:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:45 INFO - 'SHELL': '/bin/bash', 01:56:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:45 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:45 INFO - 'USER': 'cltbld', 01:56:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:45 INFO - 'XPC_FLAGS': '0x0', 01:56:45 INFO - 'XPC_SERVICE_NAME': '0', 01:56:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:45 INFO - Downloading/unpacking blobuploader==1.2.4 01:56:45 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 01:56:45 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 01:56:45 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 01:56:45 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 01:56:45 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 01:56:45 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 01:56:48 INFO - Downloading blobuploader-1.2.4.tar.gz 01:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:56:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:56:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 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 01:56:48 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 01:56:49 INFO - Downloading docopt-0.6.1.tar.gz 01:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:56:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:56:49 INFO - Running setup.py install for blobuploader 01:56:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:56:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:56:49 INFO - Running setup.py install for requests 01:56:49 INFO - Running setup.py install for docopt 01:56:50 INFO - Successfully installed blobuploader requests docopt 01:56:50 INFO - Cleaning up... 01:56:50 INFO - Return code: 0 01:56:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:50 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')]} 01:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:50 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')]} 01:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:50 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:50 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 01:56:50 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 01:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:50 INFO - 'HOME': '/Users/cltbld', 01:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:50 INFO - 'LOGNAME': 'cltbld', 01:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:50 INFO - 'MOZ_NO_REMOTE': '1', 01:56:50 INFO - 'NO_EM_RESTART': '1', 01:56:50 INFO - 'PAGER': '/bin/cat', 01:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:50 INFO - 'PWD': '/builds/slave/test', 01:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:50 INFO - 'SHELL': '/bin/bash', 01:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:50 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:50 INFO - 'USER': 'cltbld', 01:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:50 INFO - 'XPC_FLAGS': '0x0', 01:56:50 INFO - 'XPC_SERVICE_NAME': '0', 01:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ZWcetc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-caqMCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ZVAWZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-gCm9e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Moj0kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:50 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-9viBdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-WLvCvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-XN7f81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ylUShf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-9j7OsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-r1U1s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-COWGMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-IVdlR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Wz0r7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:51 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-XoH1Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:52 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-_RfsZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:52 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-e5fnBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:52 INFO - Running setup.py install for manifestparser 01:56:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:52 INFO - Running setup.py install for mozcrash 01:56:52 INFO - Running setup.py install for mozdebug 01:56:52 INFO - Running setup.py install for mozdevice 01:56:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:52 INFO - Running setup.py install for mozfile 01:56:53 INFO - Running setup.py install for mozhttpd 01:56:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Running setup.py install for mozinfo 01:56:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Running setup.py install for mozInstall 01:56:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Running setup.py install for mozleak 01:56:53 INFO - Running setup.py install for mozlog 01:56:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Running setup.py install for moznetwork 01:56:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:53 INFO - Running setup.py install for mozprocess 01:56:54 INFO - Running setup.py install for mozprofile 01:56:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:54 INFO - Running setup.py install for mozrunner 01:56:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:54 INFO - Running setup.py install for mozscreenshot 01:56:54 INFO - Running setup.py install for moztest 01:56:54 INFO - Running setup.py install for mozversion 01:56:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:54 INFO - Cleaning up... 01:56:54 INFO - Return code: 0 01:56:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:54 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:56:54 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 01:56:54 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 01:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:54 INFO - 'HOME': '/Users/cltbld', 01:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:54 INFO - 'LOGNAME': 'cltbld', 01:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:54 INFO - 'MOZ_NO_REMOTE': '1', 01:56:54 INFO - 'NO_EM_RESTART': '1', 01:56:54 INFO - 'PAGER': '/bin/cat', 01:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:54 INFO - 'PWD': '/builds/slave/test', 01:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:54 INFO - 'SHELL': '/bin/bash', 01:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:56:54 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:54 INFO - 'USER': 'cltbld', 01:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:54 INFO - 'XPC_FLAGS': '0x0', 01:56:54 INFO - 'XPC_SERVICE_NAME': '0', 01:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-s_AKmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-eqKKYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-HyC86v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-Mzx9fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-rTYQ_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-LPcyGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-QtUfX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-M84xRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:55 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)) 01:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:55 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-9Q5ZVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-AozNkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-_gvkSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-ScqVPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-HwEEZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-BbTSxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-GTyM7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-hoplIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:56 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)) 01:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:56 INFO - Running setup.py (path:/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/pip-SLCuKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:56 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)) 01:56:56 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)) 01:56:56 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)) 01:56:56 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)) 01:56:56 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)) 01:56:56 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)) 01:56:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:56 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 01:56:56 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 01:56:56 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 01:56:56 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 01:56:56 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 01:56:56 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 01:56:59 INFO - Downloading blessings-1.6.tar.gz 01:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:56:59 INFO - Installing collected packages: blessings 01:56:59 INFO - Running setup.py install for blessings 01:56:59 INFO - Successfully installed blessings 01:56:59 INFO - Cleaning up... 01:56:59 INFO - Return code: 0 01:56:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:56:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:00 INFO - Reading from file tmpfile_stdout 01:57:00 INFO - Current package versions: 01:57:00 INFO - blessings == 1.6 01:57:00 INFO - blobuploader == 1.2.4 01:57:00 INFO - docopt == 0.6.1 01:57:00 INFO - functools32 == 3.2.3-2 01:57:00 INFO - jsonschema == 2.5.1 01:57:00 INFO - manifestparser == 1.1 01:57:00 INFO - mozInstall == 1.12 01:57:00 INFO - mozcrash == 1.0 01:57:00 INFO - mozdebug == 0.1 01:57:00 INFO - mozdevice == 0.49 01:57:00 INFO - mozfile == 1.2 01:57:00 INFO - mozhttpd == 0.7 01:57:00 INFO - mozinfo == 0.9 01:57:00 INFO - mozleak == 0.1 01:57:00 INFO - mozlog == 3.4 01:57:00 INFO - moznetwork == 0.27 01:57:00 INFO - mozprocess == 0.25 01:57:00 INFO - mozprofile == 0.28 01:57:00 INFO - mozrunner == 6.13 01:57:00 INFO - mozscreenshot == 0.1 01:57:00 INFO - mozsystemmonitor == 0.3 01:57:00 INFO - moztest == 0.8 01:57:00 INFO - mozversion == 1.4 01:57:00 INFO - psutil == 3.1.1 01:57:00 INFO - requests == 1.2.3 01:57:00 INFO - wsgiref == 0.1.2 01:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:00 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')]} 01:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:00 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')]} 01:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:00 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:57:00 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 01:57:00 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 01:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:00 INFO - 'HOME': '/Users/cltbld', 01:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:00 INFO - 'LOGNAME': 'cltbld', 01:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:00 INFO - 'MOZ_NO_REMOTE': '1', 01:57:00 INFO - 'NO_EM_RESTART': '1', 01:57:00 INFO - 'PAGER': '/bin/cat', 01:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:00 INFO - 'PWD': '/builds/slave/test', 01:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:00 INFO - 'SHELL': '/bin/bash', 01:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:57:00 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:00 INFO - 'USER': 'cltbld', 01:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:00 INFO - 'XPC_FLAGS': '0x0', 01:57:00 INFO - 'XPC_SERVICE_NAME': '0', 01:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 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)) 01:57:00 INFO - Cleaning up... 01:57:00 INFO - Return code: 0 01:57:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:57:00 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')]} 01:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:00 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')]} 01:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:00 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 0x10f397b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f39a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb26bd82390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, '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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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 01:57:00 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 01:57:00 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 01:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:00 INFO - 'HOME': '/Users/cltbld', 01:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:00 INFO - 'LOGNAME': 'cltbld', 01:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:00 INFO - 'MOZ_NO_REMOTE': '1', 01:57:00 INFO - 'NO_EM_RESTART': '1', 01:57:00 INFO - 'PAGER': '/bin/cat', 01:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:00 INFO - 'PWD': '/builds/slave/test', 01:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:00 INFO - 'SHELL': '/bin/bash', 01:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:57:00 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:00 INFO - 'USER': 'cltbld', 01:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:00 INFO - 'XPC_FLAGS': '0x0', 01:57:00 INFO - 'XPC_SERVICE_NAME': '0', 01:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:57:00 INFO - Cleaning up... 01:57:00 INFO - Return code: 0 01:57:00 INFO - Running post-action listener: _resource_record_post_action 01:57:00 INFO - Running post-action listener: _start_resource_monitoring 01:57:00 INFO - Starting resource monitoring. 01:57:00 INFO - [mozharness: 2017-04-04 08:57:00.761213Z] Finished create-virtualenv step (success) 01:57:00 INFO - [mozharness: 2017-04-04 08:57:00.762200Z] Running install step. 01:57:00 INFO - Running pre-action listener: _resource_record_pre_action 01:57:00 INFO - Running main action method: install 01:57:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:01 INFO - Reading from file tmpfile_stdout 01:57:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:57:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:57:01 INFO - Reading from file tmpfile_stdout 01:57:01 INFO - Output received: 01:57:01 INFO - Usage: mozinstall [options] installer 01:57:01 INFO - Options: 01:57:01 INFO - -h, --help show this help message and exit 01:57:01 INFO - -d DEST, --destination=DEST 01:57:01 INFO - Directory to install application into. [default: 01:57:01 INFO - "/builds/slave/test"] 01:57:01 INFO - --app=APP Application being installed. [default: firefox] 01:57:01 INFO - mkdir: /builds/slave/test/build/application 01:57:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:57:21 INFO - Reading from file tmpfile_stdout 01:57:21 INFO - Output received: 01:57:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:57:21 INFO - Running post-action listener: _resource_record_post_action 01:57:21 INFO - [mozharness: 2017-04-04 08:57:21.420974Z] Finished install step (success) 01:57:21 INFO - [mozharness: 2017-04-04 08:57:21.421106Z] Running run-tests step. 01:57:21 INFO - Running pre-action listener: _resource_record_pre_action 01:57:21 INFO - Running main action method: run_tests 01:57:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:57:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:57:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:57:21 INFO - 2017-04-04 01:57:21.435 screenresolution[1638:11508] starting screenresolution argv=screenresolution get 01:57:21 INFO - 2017-04-04 01:57:21.438 screenresolution[1638:11508] Display 0: 1600x1200x32@60 01:57:21 INFO - 2017-04-04 01:57:21.443 screenresolution[1639:11511] starting screenresolution argv=screenresolution list 01:57:21 INFO - Available Modes on Display 0 01:57:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:57:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:57:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:57:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:57:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:57:21 INFO - Intel Iris: 01:57:21 INFO - Chipset Model: Intel Iris 01:57:21 INFO - Type: GPU 01:57:21 INFO - Bus: Built-In 01:57:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:57:21 INFO - Vendor: Intel (0x8086) 01:57:21 INFO - Device ID: 0x0a2e 01:57:21 INFO - Revision ID: 0x0009 01:57:21 INFO - Displays: 01:57:21 INFO - Display: 01:57:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:57:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:57:21 INFO - Display Serial Number: 1600x1200 60 01:57:21 INFO - Main Display: Yes 01:57:21 INFO - Mirror: Off 01:57:21 INFO - Online: Yes 01:57:21 INFO - Rotation: Supported 01:57:21 INFO - Return code: 0 01:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:57:21 INFO - Python 2.7.3 01:57:21 INFO - Return code: 0 01:57:21 INFO - grabbing minidump binary from tooltool 01:57: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')]} 01:57:21 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 0x10f175d30>, '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 0x10f09cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f16abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:57:21 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 01:57:21 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 01:57:21 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 01:57:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:57:21 INFO - Return code: 0 01:57:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:57:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:57:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:57:21 INFO - ENV: RUST_BACKTRACE is now 1 01:57:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:57:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 01:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0120 --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 01:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Q3EPDqo9G/Render', 01:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:21 INFO - 'HOME': '/Users/cltbld', 01:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:21 INFO - 'LOGNAME': 'cltbld', 01:57:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:57:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:21 INFO - 'MOZ_NO_REMOTE': '1', 01:57:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:57:21 INFO - 'NO_EM_RESTART': '1', 01:57:21 INFO - 'PAGER': '/bin/cat', 01:57:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:21 INFO - 'PWD': '/builds/slave/test', 01:57:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:21 INFO - 'RUST_BACKTRACE': '1', 01:57:21 INFO - 'SHELL': '/bin/bash', 01:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5pfSUDVY7/Listeners', 01:57:21 INFO - 'TMPDIR': '/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/', 01:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:21 INFO - 'USER': 'cltbld', 01:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:21 INFO - 'XPC_FLAGS': '0x0', 01:57:21 INFO - 'XPC_SERVICE_NAME': '0', 01:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:57:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0120', '--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 01:57:22 INFO - mozversion application_buildid: 20170404004003 01:57:22 INFO - mozversion application_changeset: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 01:57:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:57:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:57:22 INFO - mozversion application_name: Firefox 01:57:22 INFO - mozversion application_remotingname: firefox-dev 01:57:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:57:22 INFO - mozversion application_vendor: Mozilla 01:57:22 INFO - mozversion application_version: 54.0a2 01:57:22 INFO - mozversion platform_buildid: 20170404004003 01:57:22 INFO - mozversion platform_changeset: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 01:57:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:57:22 INFO - mozversion platform_version: 54.0a2 01:57:22 INFO - using testdate: 1491296242 01:57:22 INFO - actual date: 1491296242 01:57:22 INFO - starting webserver on 'localhost:49241' 01:57:22 INFO - SUITE-START | Running 2 tests 01:57:22 INFO - TEST-START | dromaeo_css 01:57:22 INFO - operating with platform_type : mac_ 01:57:22 INFO - Initialising browser for dromaeo_css test... 01:57:22 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpfvZCrX/profile http://localhost:49241/getInfo.html) 01:57:25 INFO - PROCESS | 1649 | 2017-04-04 01:57:25.042 plugin-container[1652:11696] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 01:57:25 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:57:25 INFO - PROCESS | 1649 | 2017-04-04 01:57:25.043 plugin-container[1652:11696] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 01:57:25 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:57:25 INFO - PROCESS | 1649 | 2017-04-04 01:57:25.043 plugin-container[1652:11696] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:57:25 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 01:57:25 INFO - PROCESS | 1649 | colorDepth:24 01:57:25 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 01:57:25 INFO - PROCESS | 1649 | __metrics 01:57:25 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 01:57:25 INFO - TEST-INFO | 1649: exit 0 01:57:25 INFO - Browser initialized. 01:57:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:57:25 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpfvZCrX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:28 INFO - PROCESS | 1654 | 2017-04-04 01:57:28.347 plugin-container[1655:11836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 01:57:28 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:57:28 INFO - PROCESS | 1654 | 2017-04-04 01:57:28.347 plugin-container[1655:11836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 01:57:28 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:57:28 INFO - PROCESS | 1654 | 2017-04-04 01:57:28.347 plugin-container[1655:11836] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:57:38 INFO - PROCESS | 1654 | RSS: Main: 220631040 01:57:38 INFO - PROCESS | 1654 | 02:00:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:00:43 INFO - PROCESS | 1654 | RSS: Main: 241319936 02:00:43 INFO - PROCESS | 1654 | 02:02:26 INFO - PROCESS | 1654 | ************************* 02:02:26 INFO - PROCESS | 1654 | A coding exception was thrown and uncaught in a Task. 02:02:26 INFO - PROCESS | 1654 | 02:02:26 ERROR - PROCESS | 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:02:26 INFO - PROCESS | 1654 | Full stack: 02:02:26 INFO - PROCESS | 1654 | ************************* 02:03:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:03:46 INFO - PROCESS | 1654 | RSS: Main: 247263232 02:03:46 INFO - PROCESS | 1654 | 02:06:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:06:48 INFO - PROCESS | 1654 | RSS: Main: 256794624 02:06:48 INFO - PROCESS | 1654 | 02:09:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:09:51 INFO - PROCESS | 1654 | RSS: Main: 253505536 02:09:51 INFO - PROCESS | 1654 | 02:12:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:12:55 INFO - PROCESS | 1654 | RSS: Main: 258707456 02:12:55 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:15:58 INFO - PROCESS | 1654 | RSS: Main: 254750720 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | __start_tp_report 02:15:58 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 02:15:58 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 02:15:58 INFO - PROCESS | 1654 | |i|pagename|runs| 02:15:58 INFO - PROCESS | 1654 | |0;dojo.html;2917.504024315867;3028.1975276551716;3476.72186225102;3520.7711498752597;3521.6478352164777;5948.791792287271;6004.849878753028;6084.604500707451;6094.17728606638;6121.816345509631;5664.745086471108;6094.786682466114;6132.540059495534;6135.171751813504;6141.846453838656;5365.651232669884;5406;5458.61789674723;5459.017376872162;5486.945130548704;5499.945000550003;5502.147167189092;5514.338279406476;5520.1167813149905;5531.529819965308;5305;5331.093714068598;5519.586031047687;5525.392206857243;5527.944720552783;5392.1911713242935;5410.053240682904;5452.263944367499;5456.290682211326;5496.615236933416;5319.840404787863;5478.150886612541;5481;5495.560355171577;5520.972395137998;6107.4503294703245;6110.511159107261;6154.230721159855;6168.1056246843955;6180.227471566054;6238.844028899269;6304.243490781136;6311.274203466614;6329.354367864388;6435.935640643581;6425.871482570369;6452.967525195993;6465.159529261213;6483.481321494269;6513.348665133496;6190.288116866528;6198.783042593487;6204.844878878019;6212.689365531751;6233.501319894398;6411.487081033506;6472.514561407913;6542.672866356663;6642.966785166043;6653.334666533405;6297.464715499143;6307.400796924285;6319;6371.9681401593625;6419.807405777834;6467.353264673495;6494.090827284184;6503.512236582181;6508.381703738138;6510.3489651034515;4827.565519103297;5252.29094072303;5371.435999220103;6304.250336339646;6468.126802881645;6062.060380641008;6265.624062556261;6309.936900631027;6339;6359.3958573936325;4697.741624210633;5029.2958985742025;5058.317127187856;5073.34046573943;5078.984203159383;3836.9232615348096;4571.26859702446;4624.1445332613575;4625.653076019312;4659.091477161988;5456.854060647309;6056.273247210363;6088.360722124202;6097.146399504073;6157.507399408126;6258.530610204253;6297.937020629735;6542.21493420783;6550.181227346582;6562.639054852029;5086.898262034739;6064.787732429344;6071.6660583667435;6108.297545782203;6116.204893363834;5724.227229324071;5741.224934633855;5747.540196784331;5750.281214848144;5763.711814409263;6385.233771947396;6467.870642587216;6714.4292735116105;6720.798376048726;6747.055412242192;6349.587276826992;6402.743890244338;6415.230172379344;6446.613203207822;6453.51598630114;6692.799216023527;6704.027915952257;6715.4627629790475;6724.630145342053;6741.629210393476;6182.969085154546;6432.6140431572385;6445.8388540285;6452.257990331172;6452.612843229421;6285.717142728679;6315.115883776183;6346.174997250328;6401.935980640134;6436.613803171825;6330.715117819801;6338.556301059066;6338.904916426165;6340.778072767431;6351.301356850835;6274.341194174546;6305.779297724557;6321.367863213826;6349.238091429058;6357.364263573606;6012.158297838394;6034.24571928509;6165;6187.628742275478;6210.4100110489435;6295.244570651551;6348.873022539616;6354.777582784581;6363.172787537591;6377.904331435125;6034.758609655564;6301.40136687014;6307.526935479766;6320.810375688737;6332 02:15:58 INFO - PROCESS | 1654 | |1;ext.html;747.9080542408084;801.2388231180379;824.4517395931706;963.8650588917557;967.3470407474953;39043;39859;41306;41319;41445.79277103618;39569;39755.40366894491;39856.40215396771;39858.80070599643;39946;7289.854202915939;7393.889091663629;9033.232175265077;10712.303700259497;11151.72120696985;10756.515956781963;10842.891571084267;10884.183686223525;10895.564177432892;10928.344299342025;10914.945425272903;10937.289076210021;10937.507812148433;10938.234323597351;10944.960228778253;10176.592936282539;10837.18721095921;10870.61952831651;10906.291091079054;10918.781624367468;8989.775255618597;9167.587458564381;10657.946710266477;10666.36001839892;10667;28527.85736071327;34762.60949562014;34778;35060.474092888624;35147.1213219669;3798.8480460781534;3831.214601006787;3836.5779764225913;3844.115853353744;3850.2876967761053;20449;22823.88588057049;23379.883100584557;24415.755842441704;25506.872465637553;2695.892164313425;3078.707522785332;3086.3672947046025;3109.5491153782573;3156.4949608062598;295381;298010;349064;351437.2428137843;355750;35172.824135879666;39053.41419878704;43985.56014439878;44153.77923110364;44165.558344416146;37965.62034379676;37966.72199668029;37999.05002374963;38015.42976855349;38081.23837523234;13551.59345219645;13632.250226237455;13752.862471375158;13763.931180344034;13797.551257118059;9916.20670346385;12114.69713257158;12146.635600931986;12153.93923030397;12154.574589889311;11945.402729863472;11946.283223006474;11956.940215298868;12009.879901201051;12056.578019769442;4769.880752981134;5496.835094947158;5570.108782594765;5585.8603534911135;5619.297587801525;1030.8093002794508;1080.68660088575;1090.907272881814;1147.9942600286945;1195.7369378736664;22590.548189036457;25472.72636368174;26112.477750444883;26329.605055924178;26729;1112.9833052504218;1194.6774370919977;1231.335079057299;1274.4774642396574;1295.6436979830432;11124.55501779936;11204.76747557768;12704;13677.589672309847;13894.652633684238;410986;412598;413546.86453135684;415990;416920;55289.44710552924;55418.44581554214;55786;55840.441595584336;55890.72054639701;1407.7958695989025;1445.4290555230625;1453.5639308207496;1454.0911930043724;1461.4154338264566;25071.247862564152;25838.354041149123;26095.608565871906;26112.8694356527;26129.869350653124;43062.56937430711;43151.784241078596;43169.3524597125;43179.704608861786;43231.9192020202;398468;400002;400034;400374;400629;29176;30395.848020759753;31104.911328104314;31217;31414.685853141174;38597.6140238594;38787;39005;39810.40284395794;40263.597364027155;28070.71929280681;28199.71800282053;28334.866605335556;28544.57183142213;29291.974780882567;28335.57496637511;28384.43231135407;28784.568231476962;29031;29169.854150729112;32412;33403.99788006364;33455.83272083624;33486.832565837016;33684.66315336815;28644.28389290201;28833.84664613392;28898.422031559672;29086.27284317909;29559.55660665135;22942.885285573466;23029.76970230276;23394.76605233926;23494.76505234926;23523.764762352843 02:15:58 INFO - PROCESS | 1654 | |2;jquery.html;388.25261371859165;404.0847480456765;407.2445613387165;424.8725382385284;431.5986132896405;20039.59920801585;20304.578679492442;20917.47706307343;21207.575848483022;21413;20802.791972080275;21227.257046003393;21414.03636836342;21471.785282147175;21845.67231491525;6275.4038366355235;6570.835729106787;6609.834754131137;6613.404793568578;6618.8676226475445;5371.946280537203;6525.119108920282;6948.861022779542;7263.491555591111;7347.448941329421;7306.963465182694;7308.634568271592;7335.633218339061;7357.632118394085;7360.595167265798;7126.287371262884;7270;7303.780886573385;7343.118825740892;7353.48525603208;6865.828354291133;7143.642817859139;7226.024486694281;7233.168185658611;7235.746748863817;24192.153274635304;24365.756342436525;24672.25983220506;24894;24939.251822445174;2845.1891211004763;2962.7185417385313;2970.3168271297504;2979.463696534623;2984.910452686423;14746.778798318033;15517.456889008943;15566.143862087582;16030.118343491104;16204.918975405048;1952.9902350488298;1987.153055496224;2010.5074256807177;2015.7379540659767;2019.707142464349;143785;151394.48605513913;162487.1875640626;174830.12584937122;177270;16157.353705851869;19650.410487685393;20549.89725051365;20930.953452327627;21168.894155529124;31080.067597972098;31218.375632487223;31479.685203148132;31521.36957260842;31561.684383156335;10171.237157213238;10280.588776449007;10444.895551044392;10503.05472507478;10572.788544229072;8658.696945606873;8765.956170219108;8777.078406767325;8903.332250081141;8927.508987005776;9254.259659227246;9364.719058428258;9406.294527910433;9457.952710236543;9472.957974622786;3466.8959931202103;4072.226277007359;4133.21468920904;4148.875533733993;4169.415622063597;778.8364443466935;802.6869520886859;875.5403413207989;889.235257678396;921.2215677752289;14480.927595361956;17613.463788682202;17684.29262829498;21074.946252687303;21161;841.8232171243985;926.7312479381039;935.6912218967724;939.7556635274741;948.3835506920557;8861.778455538662;10416.479176041168;10730.624428144978;10853.565857365775;10878.945605271923;711717;733570.3321483465;769092;769320.4601930976;770122.2249937641;165525;167683;169409;172359;175075.24924750588;988.4217732626494;1152.8749028748964;1185.887340702632;1199.4482538032428;1212.2302338015425;17979.460616181535;18159.63802714828;18482.075896205406;18505.074746262362;18760.624787504446;48031;64986.025209620944;66966.66616832723;67198.66400667965;67793.66103169453;92119.53940230524;93072.06927930634;94429;94871.52564237134;94908;9008.459492430475;9692.806143877224;11601.535938562363;11925.165238433226;11987.34069626179;12771.297578633264;12787.552435664707;12976.351182441029;13056.086073974731;13144;10792.08267297257;10956.34261944286;11120.11039116885;11169.88830111721;11228.214025018171;10319.535620897228;10333;10346.430946298025;10412.271141020055;10652.09457196147;10937.125029997422;11347.092232621206;11444.256123351955;11557.768844623228;11587;11426.657200284004;11631.47658355359;11908.285502869856;11968.940155299168;11978.58074967372;10163.898361016296;10403.323783954018;10603.681889543326;10933.961273678988;11310.20828542027 02:15:58 INFO - PROCESS | 1654 | |3;mootools.html;1468.1191285228863;1513.3341329814887;1538.1770752647342;1564.139723152266;1565.7103435864367;10568.841467377995;11215.38315392653;11253.662390128298;11301.152413568974;11417.714557136076;11162.497687604056;11286.717832054203;11334.206605537616;11341;11344;2411.40920474484;2454.3250606083293;2464.8890799913956;2465.864377459239;2468.4816188600416;2270.398344438725;2272.522770218256;2466.1738317663603;2468.395243165427;2479.6280557916275;2392.4616961183683;2437.1104546840365;2444.64552639868;2469.0370755405315;2475.62865570165;2370.798482129021;2426.2478631624253;2428.890699918508;2437.305367970129;2444.3155916343453;2412.819038572114;2418.1899063813644;2425.527022230648;2426.8543887366814;2443.535728211652;11160.16298777595;11337.43312834355;11339.489722962404;11352.716182095432;11412.42937853104;5851.531877449794;5941.702914854283;5976.581639285252;6037.7584896604085;6068.362821903725;2719.225020869043;3163.7627177961745;3380.6619338066243;3404.914877128067;3492.8253587320787;1111.6720567432626;1190.2263528706324;1195.6831439668495;1244.8817362350562;1255.4978008796463;13882.028258021943;14007.229602371866;15014.099154050791;15428.305726242346;15625.296861641253;3866.207427477417;4014.5383280922483;4704.529547045337;4855.854324370204;4902;10235.130013948898;11191.776164476827;11737.413129343498;11817.350045747566;11818.822717659243;5761.48146666802;5922.052471604523;5929.080992446177;5935.139404786281;5968.7015649217365;5248.7900483980975;5342.5993050521365;5383.703896285742;5408.188771684278;5470.64440811346;3978.980105099456;4008.0981779100052;4027.939580906289;4085.632293093636;4095.037666148453;907.03626648307;950.7242899559051;1076.4552866636402;1079.1312993040679;1090.929089609173;949.5632009275672;954.7994921066515;977.5014742481244;977.7408986618552;1004.7136566078779;5854.853628659318;6734.0572319875255;6799.626020568916;6903.482238832108;6980.616066116412;960.3613596958085;992.4987881119988;1011.8077565262577;1012.8430093335545;1029.613894789454;4077.1641813428178;4174.979125104355;4247.723897946624;4291.527931927485;4315.4605674290715;12796.808047879289;13423.3959471824;13442.260675662737;13449.529266475822;13495.797563036562;11082.335059896432;13007.609771706864;13251.403686834115;13385;13891.374888130058;9993.450360230258;10177.287589868785;10186.08325250731;10211.846822297523;10280.640177593748;6882.208546017272;6912.27421120775;6913.51605387618;6966.686499107654;7161.892571611325;12162.878371216175;12187.87812121903;12375.938120309342;12408.379581021094;12434.12961092751;11163.330200188015;12704;12764.936175319064;12783.424745886643;12975.610731678065;9255.722328329892;9459.621615135318;9478.38390504615;9502.192313653417;9516.524173791144;10205.049128953027;10283.7429064271;10340.12108970746;10410.791784164427;10427.478626068818;8717.259032982014;8812.47125172466;8836.381453298207;8933.553322333728;9054.049324820799;8627.396082274181;8679.435836670596;8679.86980195285;8772.56137193125;8787.209151176425;7483.550986940801;7885.842283154419;7909.8813517796125;7973.8405231896195;8032.799180020546;5034.270030845433;5097.898042039064;5230.215467679878;6027.728752206073;6255.78104766331;5978.910316345171;6006.189164462917;6038.426349496791;6050.667213303311;6178.969105154445 02:15:58 INFO - PROCESS | 1654 | |4;prototype.html;321.8991050606924;344.6949449736982;373.99626003739974;378.96778773804226;386.7196282695045;4241.681873859461;4556.134334476447;4953.628477864157;5020.899582008362;5173.275741396207;4251.8511852085185;4695.5539223773685;5198.896022079556;5210.374755029392;5211.86970325742;3996.8601098961544;4102.282100632392;4227.450431443908;4306.375575541545;4317.395564620955;3878.886007126123;4251.80866860992;4255.893602659943;4281.571842815709;4291.334843099325;4286.207051695431;4293.076988447483;4299.333603291495;4343.9149208379995;4350.195213885426;3921.5882332355263;4060.654844338235;4229.302165142748;4297.033167537279;4366.161994703452;3403.8937345362856;3654.7076233901225;3896.337622604164;3916.784576848272;3923.7645741255615;3787.712177859541;4683.92269777953;4881.902361952741;4983.579679791278;4991.851874068984;4590.472095709003;4697.95302046982;4894.632902532288;4929;4945.972151417902;4677.438707355105;5297.589596733477;5470.753816078286;5499.587530935196;5519.454552725243;3655.8903232903053;3814.7520411173186;4150.896227594334;4403.383526306319;4502.369668246448;5152.716600586966;5214.661047031931;5689.317281926195;5830.883382332372;5849.941500585025;3939.527256729211;4501.527339629357;4556.521565235603;4576.656750743708;4590.472095709036;3909.843606255775;4188.727732697365;4611.930821037688;4712.764361781898;4738.763061846894;4386.495553011445;4778.307145463888;4885.6335774817035;4947.6289278304275;4985.700857948535;5524.806631767869;5526.226328314039;5537.390887002426;5584.794006367462;5626.887462250814;1448.2758620689656;1464.985350146506;1471.2051297417133;1564.9921750391175;1579.3287852662572;967.6322997260996;1094.9233553651327;1181.4092953523239;1182.4864173857477;1210.5339444314002;4376.934345984812;4487.304467807495;4715.434147902273;4827.517248275144;5168.3539557555305;5137.306463627438;5239.5112321647675;5266.393749906315;5513.5037846594;5566.276384070126;4312.439382880206;4533.909321813545;4794.9280760787915;4807.78364973577;5165.457626949192;3001.6737028802854;3016.3062495626127;3018.1589230569334;3029.2881172924344;3045;5461.105614024574;5587.525060369914;5678.205051292823;5963.373845746221;6072.210612620331;4881.658283920163;5235.476452354734;5696.686682232434;5725.799597014085;5936.168936348915;5421.674699518042;5646.6894320811925;5709.34342550612;5780.16187652788;5972.835297117021;5277.656952298242;5736.766595182056;5770.394108618535;5810.593258472036;5855.912161317498;4715.434147902273;4994.825181118644;5118.488151184852;5637.718114094361;5681.965804278843;5919.6152250103605;5935.614185077956;5982.49148822355;6010.055073014279;6038.51691864641;3844.8462061518344;4017.799110044428;4479.3057076153245;4572.542745725401;4590.150822097922;4620.422447194101;5661.05625074967;5700.287464066992;5741;5796.275465566804;5062.658645294236;5475.315585551806;5479.6164268500825;5593.406593406594;5628.521575665951;4627.991206134273;4789;5093.337866077386;5273.6572122811895;5564.777408903598;4698.043564039971;5265.394479634738;5303.231031500333;5509.851158048285;5564.777408903598;4807.826834289492;5241.764120614505;5345.438728933406;5645.266115405136;5697.8860422790485;4550.453945526558;5120.846374608767;5185.377754669313;5479.4520547944885;5528.004959107399 02:15:58 INFO - PROCESS | 1654 | |5;yui.html;695.4992405468062;701.0780823217468;730.5032577847063;765.9333508839028;849.1762989899797;14158.433662653482;15511.379544818194;16048.679026419464;16215.675686486278;16246.43137490188;12698.682532936682;12757.872421275784;15037.849621503781;15113.471028514005;15210.923945380286;925.3799954030799;946.7017889364828;951.5480146930222;951.9476428796413;954.0745476887408;892.2727976699002;937.2221056523069;938.3478482454697;953.4946478366477;954.2890546542835;840.7603832907622;978.3054031637511;984.1241295247236;984.2273815055183;986.0189111833699;975.1808480876027;978.5792109392922;981.5582987655583;981.9607215711363;982.3909176310661;717.8061923280737;726.836461796097;727.6943683652878;728.5191773429564;729.1141263365037;14065.36705848229;15786.21068946548;16123.113228772412;16146.677066458722;16720.74918876218;12150.635480935585;12157.756844863054;12187.817182742267;12360.258384496869;12584.68538286541;11588.478518466689;11719.882801171965;11825.053995680411;11883.346415947119;11934.761304773856;3308.884189053396;3390.6439823818637;3609.043603445089;3642.3990041643096;3669.3028324618504;55382.615434614054;71054.64472677655;79672.20327796706;82255.17744822535;91452.99999999933;9192.264618830477;9454.43273403598;10674.946625266824;11126.332420054661;11223.60717374888;22522.436939076328;22753.772462275498;22781.544369112526;22814.97332620036;22882.771172288398;7947.046354437504;7983.5209887406945;8060.31487323584;8081.353491720648;8143.470674406145;4258.190943720683;4274;4299.849505267363;4446.1330040642415;4544.909101818012;3491.755577109578;3535.7524973251625;3555.591107022674;3577.2487777567003;3584.1577229351083;656.2944834303144;658.6574981009848;661.3551787007725;661.8940969444866;705.8941158826217;666.8799616069155;674.3559900295206;708.7413094220675;715.3061530315586;728.5228175545027;8786.604602792762;10424.5830166794;10433.530491127918;10650.840237396445;10685.893141068489;562.8846086552247;576.9048107062372;581.2995340614634;590.9231799865989;607.0620890723842;3840.30874442603;4477.238869392146;4932.557261765238;5003.124453220672;5007.248912663057;94344.52827735817;94518;95129;95535.52232238794;95853.52073239589;82587.5870620655;82799.17200828035;83443;83705;84228;70433.6478317605;70600.64699676468;70909.64545177344;71538.64230678813;72375.27624723685;7936.444448888753;9617.807643846943;9725.610975560898;9762.267829912644;9981.750456238362;46862;47801.760991194824;47958;48433.54699359025;49402.50597493979;60432;60915.08627370504;62159;62299.377006229355;62518;11031.338119712522;11263.211575189986;11628.709282268012;11651.475683594428;11972.461239244429;12402.875971240534;12471.189372690746;13023.544175953795;13417.262050587311;13499.730005400033;11845.822312665145;12014.519419223134;12125.878741212828;12319.384030798603;12398.070144739;11757.235779674636;11941.16411851162;12041.638750837488;12237.877621223673;12396.628101156979;11609.825852612386;11783.587574434854;11923.761524769283;12023.75952480963;12299.446524906221;8798.516081615573;8865.911340886767;8941.865872012055;8944.852373047768;9231.307651925998;9358.210799456321;9696.0788725071;9820.361676491006;10258.230632702427;10322 02:15:58 INFO - PROCESS | 1654 | __end_tp_report 02:15:58 INFO - PROCESS | 1654 | __start_cc_report 02:15:58 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,413 02:15:58 INFO - PROCESS | 1654 | __end_cc_report 02:15:58 INFO - PROCESS | 1654 | __startTimestamp1491297358448__endTimestamp 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | ------- Summary: start ------- 02:15:58 INFO - PROCESS | 1654 | Number of tests: 6 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5954.14 Median:6204.84 stddev:706.70 (11.4%) stddev-sans-first:667.51 02:15:58 INFO - PROCESS | 1654 | Values: 2917.5 3028.2 3476.7 3520.8 3521.6 5948.8 6004.8 6084.6 6094.2 6121.8 5664.7 6094.8 6132.5 6135.2 6141.8 5365.7 5406.0 5458.6 5459.0 5486.9 5499.9 5502.1 5514.3 5520.1 5531.5 5305.0 5331.1 5519.6 5525.4 5527.9 5392.2 5410.1 5452.3 5456.3 5496.6 5319.8 5478.2 5481.0 5495.6 5521.0 6107.5 6110.5 6154.2 6168.1 6180.2 6238.8 6304.2 6311.3 6329.4 6435.9 6425.9 6453.0 6465.2 6483.5 6513.3 6190.3 6198.8 6204.8 6212.7 6233.5 6411.5 6472.5 6542.7 6643.0 6653.3 6297.5 6307.4 6319.0 6372.0 6419.8 6467.4 6494.1 6503.5 6508.4 6510.3 4827.6 5252.3 5371.4 6304.3 6468.1 6062.1 6265.6 6309.9 6339.0 6359.4 4697.7 5029.3 5058.3 5073.3 5079.0 3836.9 4571.3 4624.1 4625.7 4659.1 5456.9 6056.3 6088.4 6097.1 6157.5 6258.5 6297.9 6542.2 6550.2 6562.6 5086.9 6064.8 6071.7 6108.3 6116.2 5724.2 5741.2 5747.5 5750.3 5763.7 6385.2 6467.9 6714.4 6720.8 6747.1 6349.6 6402.7 6415.2 6446.6 6453.5 6692.8 6704.0 6715.5 6724.6 6741.6 6183.0 6432.6 6445.8 6452.3 6452.6 6285.7 6315.1 6346.2 6401.9 6436.6 6330.7 6338.6 6338.9 6340.8 6351.3 6274.3 6305.8 6321.4 6349.2 6357.4 6012.2 6034.2 6165.0 6187.6 6210.4 6295.2 6348.9 6354.8 6363.2 6377.9 6034.8 6301.4 6307.5 6320.8 6332.0 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:51162.61 Median:162336.49 stddev:101509.49 (62.5%) stddev-sans-first:101723.67 02:15:58 INFO - PROCESS | 1654 | Values: 747.9 801.2 824.5 963.9 967.3 39043.0 39859.0 41306.0 41319.0 41445.8 39569.0 39755.4 39856.4 39858.8 39946.0 7289.9 7393.9 9033.2 10712.3 11151.7 10756.5 10842.9 10884.2 10895.6 10928.3 10914.9 10937.3 10937.5 10938.2 10945.0 10176.6 10837.2 10870.6 10906.3 10918.8 8989.8 9167.6 10657.9 10666.4 10667.0 28527.9 34762.6 34778.0 35060.5 35147.1 3798.8 3831.2 3836.6 3844.1 3850.3 20449.0 22823.9 23379.9 24415.8 25506.9 2695.9 3078.7 3086.4 3109.5 3156.5 295381.0 298010.0 349064.0 351437.2 355750.0 35172.8 39053.4 43985.6 44153.8 44165.6 37965.6 37966.7 37999.1 38015.4 38081.2 13551.6 13632.3 13752.9 13763.9 13797.6 9916.2 12114.7 12146.6 12153.9 12154.6 11945.4 11946.3 11956.9 12009.9 12056.6 4769.9 5496.8 5570.1 5585.9 5619.3 1030.8 1080.7 1090.9 1148.0 1195.7 22590.5 25472.7 26112.5 26329.6 26729.0 1113.0 1194.7 1231.3 1274.5 1295.6 11124.6 11204.8 12704.0 13677.6 13894.7 410986.0 412598.0 413546.9 415990.0 416920.0 55289.4 55418.4 55786.0 55840.4 55890.7 1407.8 1445.4 1453.6 1454.1 1461.4 25071.2 25838.4 26095.6 26112.9 26129.9 43062.6 43151.8 43169.4 43179.7 43231.9 398468.0 400002.0 400034.0 400374.0 400629.0 29176.0 30395.8 31104.9 31217.0 31414.7 38597.6 38787.0 39005.0 39810.4 40263.6 28070.7 28199.7 28334.9 28544.6 29292.0 28335.6 28384.4 28784.6 29031.0 29169.9 32412.0 33404.0 33455.8 33486.8 33684.7 28644.3 28833.8 28898.4 29086.3 29559.6 22942.9 23029.8 23394.8 23494.8 23523.8 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:43752.69 Median:23018.91 stddev:126050.32 (547.6%) stddev-sans-first:126361.87 02:15:58 INFO - PROCESS | 1654 | Values: 388.3 404.1 407.2 424.9 431.6 20039.6 20304.6 20917.5 21207.6 21413.0 20802.8 21227.3 21414.0 21471.8 21845.7 6275.4 6570.8 6609.8 6613.4 6618.9 5371.9 6525.1 6948.9 7263.5 7347.4 7307.0 7308.6 7335.6 7357.6 7360.6 7126.3 7270.0 7303.8 7343.1 7353.5 6865.8 7143.6 7226.0 7233.2 7235.7 24192.2 24365.8 24672.3 24894.0 24939.3 2845.2 2962.7 2970.3 2979.5 2984.9 14746.8 15517.5 15566.1 16030.1 16204.9 1953.0 1987.2 2010.5 2015.7 2019.7 143785.0 151394.5 162487.2 174830.1 177270.0 16157.4 19650.4 20549.9 20931.0 21168.9 31080.1 31218.4 31479.7 31521.4 31561.7 10171.2 10280.6 10444.9 10503.1 10572.8 8658.7 8766.0 8777.1 8903.3 8927.5 9254.3 9364.7 9406.3 9458.0 9473.0 3466.9 4072.2 4133.2 4148.9 4169.4 778.8 802.7 875.5 889.2 921.2 14480.9 17613.5 17684.3 21074.9 21161.0 841.8 926.7 935.7 939.8 948.4 8861.8 10416.5 10730.6 10853.6 10878.9 711717.0 733570.3 769092.0 769320.5 770122.2 165525.0 167683.0 169409.0 172359.0 175075.2 988.4 1152.9 1185.9 1199.4 1212.2 17979.5 18159.6 18482.1 18505.1 18760.6 48031.0 64986.0 66966.7 67198.7 67793.7 92119.5 93072.1 94429.0 94871.5 94908.0 9008.5 9692.8 11601.5 11925.2 11987.3 12771.3 12787.6 12976.4 13056.1 13144.0 10792.1 10956.3 11120.1 11169.9 11228.2 10319.5 10333.0 10346.4 10412.3 10652.1 10937.1 11347.1 11444.3 11557.8 11587.0 11426.7 11631.5 11908.3 11968.9 11978.6 10163.9 10403.3 10603.7 10934.0 11310.2 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:6739.15 Median:2467.28 stddev:4174.41 (169.2%) stddev-sans-first:4167.33 02:15:58 INFO - PROCESS | 1654 | Values: 1468.1 1513.3 1538.2 1564.1 1565.7 10568.8 11215.4 11253.7 11301.2 11417.7 11162.5 11286.7 11334.2 11341.0 11344.0 2411.4 2454.3 2464.9 2465.9 2468.5 2270.4 2272.5 2466.2 2468.4 2479.6 2392.5 2437.1 2444.6 2469.0 2475.6 2370.8 2426.2 2428.9 2437.3 2444.3 2412.8 2418.2 2425.5 2426.9 2443.5 11160.2 11337.4 11339.5 11352.7 11412.4 5851.5 5941.7 5976.6 6037.8 6068.4 2719.2 3163.8 3380.7 3404.9 3492.8 1111.7 1190.2 1195.7 1244.9 1255.5 13882.0 14007.2 15014.1 15428.3 15625.3 3866.2 4014.5 4704.5 4855.9 4902.0 10235.1 11191.8 11737.4 11817.4 11818.8 5761.5 5922.1 5929.1 5935.1 5968.7 5248.8 5342.6 5383.7 5408.2 5470.6 3979.0 4008.1 4027.9 4085.6 4095.0 907.0 950.7 1076.5 1079.1 1090.9 949.6 954.8 977.5 977.7 1004.7 5854.9 6734.1 6799.6 6903.5 6980.6 960.4 992.5 1011.8 1012.8 1029.6 4077.2 4175.0 4247.7 4291.5 4315.5 12796.8 13423.4 13442.3 13449.5 13495.8 11082.3 13007.6 13251.4 13385.0 13891.4 9993.5 10177.3 10186.1 10211.8 10280.6 6882.2 6912.3 6913.5 6966.7 7161.9 12162.9 12187.9 12375.9 12408.4 12434.1 11163.3 12704.0 12764.9 12783.4 12975.6 9255.7 9459.6 9478.4 9502.2 9516.5 10205.0 10283.7 10340.1 10410.8 10427.5 8717.3 8812.5 8836.4 8933.6 9054.0 8627.4 8679.4 8679.9 8772.6 8787.2 7483.6 7885.8 7909.9 7973.8 8032.8 5034.3 5097.9 5230.2 6027.7 6255.8 5978.9 6006.2 6038.4 6050.7 6179.0 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4576.11 Median:4881.78 stddev:1286.93 (26.4%) stddev-sans-first:1250.30 02:15:58 INFO - PROCESS | 1654 | Values: 321.9 344.7 374.0 379.0 386.7 4241.7 4556.1 4953.6 5020.9 5173.3 4251.9 4695.6 5198.9 5210.4 5211.9 3996.9 4102.3 4227.5 4306.4 4317.4 3878.9 4251.8 4255.9 4281.6 4291.3 4286.2 4293.1 4299.3 4343.9 4350.2 3921.6 4060.7 4229.3 4297.0 4366.2 3403.9 3654.7 3896.3 3916.8 3923.8 3787.7 4683.9 4881.9 4983.6 4991.9 4590.5 4698.0 4894.6 4929.0 4946.0 4677.4 5297.6 5470.8 5499.6 5519.5 3655.9 3814.8 4150.9 4403.4 4502.4 5152.7 5214.7 5689.3 5830.9 5849.9 3939.5 4501.5 4556.5 4576.7 4590.5 3909.8 4188.7 4611.9 4712.8 4738.8 4386.5 4778.3 4885.6 4947.6 4985.7 5524.8 5526.2 5537.4 5584.8 5626.9 1448.3 1465.0 1471.2 1565.0 1579.3 967.6 1094.9 1181.4 1182.5 1210.5 4376.9 4487.3 4715.4 4827.5 5168.4 5137.3 5239.5 5266.4 5513.5 5566.3 4312.4 4533.9 4794.9 4807.8 5165.5 3001.7 3016.3 3018.2 3029.3 3045.0 5461.1 5587.5 5678.2 5963.4 6072.2 4881.7 5235.5 5696.7 5725.8 5936.2 5421.7 5646.7 5709.3 5780.2 5972.8 5277.7 5736.8 5770.4 5810.6 5855.9 4715.4 4994.8 5118.5 5637.7 5682.0 5919.6 5935.6 5982.5 6010.1 6038.5 3844.8 4017.8 4479.3 4572.5 4590.2 4620.4 5661.1 5700.3 5741.0 5796.3 5062.7 5475.3 5479.6 5593.4 5628.5 4628.0 4789.0 5093.3 5273.7 5564.8 4698.0 5265.4 5303.2 5509.9 5564.8 4807.8 5241.8 5345.4 5645.3 5697.9 4550.5 5120.8 5185.4 5479.5 5528.0 02:15:58 INFO - PROCESS | 1654 | 02:15:58 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:18569.20 Median:569.89 stddev:25638.36 (4498.8%) stddev-sans-first:25675.15 02:15:58 INFO - PROCESS | 1654 | Values: 695.5 701.1 730.5 765.9 849.2 14158.4 15511.4 16048.7 16215.7 16246.4 12698.7 12757.9 15037.8 15113.5 15210.9 925.4 946.7 951.5 951.9 954.1 892.3 937.2 938.3 953.5 954.3 840.8 978.3 984.1 984.2 986.0 975.2 978.6 981.6 982.0 982.4 717.8 726.8 727.7 728.5 729.1 14065.4 15786.2 16123.1 16146.7 16720.7 12150.6 12157.8 12187.8 12360.3 12584.7 11588.5 11719.9 11825.1 11883.3 11934.8 3308.9 3390.6 3609.0 3642.4 3669.3 55382.6 71054.6 79672.2 82255.2 91453.0 9192.3 9454.4 10674.9 11126.3 11223.6 22522.4 22753.8 22781.5 22815.0 22882.8 7947.0 7983.5 8060.3 8081.4 8143.5 4258.2 4274.0 4299.8 4446.1 4544.9 3491.8 3535.8 3555.6 3577.2 3584.2 656.3 658.7 661.4 661.9 705.9 666.9 674.4 708.7 715.3 728.5 8786.6 10424.6 10433.5 10650.8 10685.9 562.9 576.9 581.3 590.9 607.1 3840.3 4477.2 4932.6 5003.1 5007.2 94344.5 94518.0 95129.0 95535.5 95853.5 82587.6 82799.2 83443.0 83705.0 84228.0 70433.6 70600.6 70909.6 71538.6 72375.3 7936.4 9617.8 9725.6 9762.3 9981.8 46862.0 47801.8 47958.0 48433.5 49402.5 60432.0 60915.1 62159.0 62299.4 62518.0 11031.3 11263.2 11628.7 11651.5 11972.5 12402.9 12471.2 13023.5 13417.3 13499.7 11845.8 12014.5 12125.9 12319.4 12398.1 11757.2 11941.2 12041.6 12237.9 12396.6 11609.8 11783.6 11923.8 12023.8 12299.4 8798.5 8865.9 8941.9 8944.9 9231.3 9358.2 9696.1 9820.4 10258.2 10322.0 02:15:58 INFO - PROCESS | 1654 | -------- Summary: end -------- 02:15:58 INFO - PROCESS | 1654 | 02:15:59 INFO - TEST-INFO | 1654: exit 0 02:15:59 INFO - TEST-OK | dromaeo_css | took 1117097ms 02:15:59 INFO - TEST-START | kraken 02:15:59 INFO - operating with platform_type : mac_ 02:15:59 INFO - Initialising browser for kraken test... 02:15:59 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpdW9xZt/profile http://localhost:49241/getInfo.html) 02:16:01 INFO - PROCESS | 1660 | 2017-04-04 02:16:01.989 plugin-container[1662:14032] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 02:16:01 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:16:01 INFO - PROCESS | 1660 | 2017-04-04 02:16:01.990 plugin-container[1662:14032] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 02:16:01 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:16:01 INFO - PROCESS | 1660 | 2017-04-04 02:16:01.990 plugin-container[1662:14032] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:16:02 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 02:16:02 INFO - PROCESS | 1660 | colorDepth:24 02:16:02 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 02:16:02 INFO - PROCESS | 1660 | __metrics 02:16:02 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:16:02 INFO - TEST-INFO | 1660: exit 0 02:16:02 INFO - Browser initialized. 02:16:02 INFO - Running cycle 1/1 for kraken test... 02:16:02 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/tmpdW9xZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:05 INFO - PROCESS | 1663 | 2017-04-04 02:16:05.383 plugin-container[1664:14160] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b47, name = 'com.apple.tsm.portname' 02:16:05 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:16:05 INFO - PROCESS | 1663 | 2017-04-04 02:16:05.384 plugin-container[1664:14160] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 02:16:05 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:16:05 INFO - PROCESS | 1663 | 2017-04-04 02:16:05.384 plugin-container[1664:14160] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:16:15 INFO - PROCESS | 1663 | RSS: Main: 220708864 02:16:15 INFO - PROCESS | 1663 | 02:16:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:16:19 INFO - PROCESS | 1663 | RSS: Main: 235245568 02:16:19 INFO - PROCESS | 1663 | 02:16:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:16:22 INFO - PROCESS | 1663 | RSS: Main: 243126272 02:16:22 INFO - PROCESS | 1663 | 02:16:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:16:26 INFO - PROCESS | 1663 | RSS: Main: 246808576 02:16:26 INFO - PROCESS | 1663 | 02:16:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:16:28 INFO - PROCESS | 1663 | RSS: Main: 248274944 02:16:28 INFO - PROCESS | 1663 | 02:16:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:16:31 INFO - PROCESS | 1663 | RSS: Main: 248602624 02:16:31 INFO - PROCESS | 1663 | 02:16:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:16:35 INFO - PROCESS | 1663 | RSS: Main: 252465152 02:16:35 INFO - PROCESS | 1663 | 02:16:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:16:39 INFO - PROCESS | 1663 | RSS: Main: 251973632 02:16:39 INFO - PROCESS | 1663 | 02:16:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:16:43 INFO - PROCESS | 1663 | RSS: Main: 251891712 02:16:43 INFO - PROCESS | 1663 | 02:16:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:16:45 INFO - PROCESS | 1663 | RSS: Main: 251793408 02:16:45 INFO - PROCESS | 1663 | 02:16:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:16:48 INFO - PROCESS | 1663 | RSS: Main: 251826176 02:16:48 INFO - PROCESS | 1663 | 02:16:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:16:51 INFO - PROCESS | 1663 | RSS: Main: 251871232 02:16:51 INFO - PROCESS | 1663 | 02:16:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:16:54 INFO - PROCESS | 1663 | RSS: Main: 252456960 02:16:54 INFO - PROCESS | 1663 | 02:16:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:16:58 INFO - PROCESS | 1663 | RSS: Main: 252157952 02:16:58 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:17:00 INFO - PROCESS | 1663 | RSS: Main: 255590400 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | __start_tp_report 02:17:00 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 02:17:00 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 02:17:00 INFO - PROCESS | 1663 | |i|pagename|runs| 02:17:00 INFO - PROCESS | 1663 | |0;ai-astar;108;122;119;120;122;119;150;179;118;120 02:17:00 INFO - PROCESS | 1663 | |1;audio-beat-detection;153;110;107;180;146;114;123;112;130;109 02:17:00 INFO - PROCESS | 1663 | |2;audio-dft;197;198;194;196;200;196;189;186;240;278 02:17:00 INFO - PROCESS | 1663 | |3;audio-fft;81;51;64;115;87;63;60;64;80;86 02:17:00 INFO - PROCESS | 1663 | |4;audio-oscillator;90;70;118;107;98;62;86;102;103;117 02:17:00 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;77;121;139;123;135;137;89;90;90 02:17:00 INFO - PROCESS | 1663 | |6;imaging-darkroom;97;96;105;156;115;103;121;97;99;107 02:17:00 INFO - PROCESS | 1663 | |7;imaging-desaturate;97;92;89;78;147;146;89;140;146;127 02:17:00 INFO - PROCESS | 1663 | |8;json-parse-financial;68;66;67;67;70;69;69;67;70;83 02:17:00 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;55;63;60;72;65;63;63;49;73;85 02:17:00 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;84;82;96;70;98;92;105;103;75;94 02:17:00 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;126;136;144;169;156;156;161;152;210;160 02:17:00 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;171;167;186;243;162;164;151;200;218;169 02:17:00 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;59;80;59;79;86;84;90;80;66;71 02:17:00 INFO - PROCESS | 1663 | __end_tp_report 02:17:00 INFO - PROCESS | 1663 | __start_cc_report 02:17:00 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1012 02:17:00 INFO - PROCESS | 1663 | __end_cc_report 02:17:00 INFO - PROCESS | 1663 | __startTimestamp1491297420607__endTimestamp 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | ------- Summary: start ------- 02:17:00 INFO - PROCESS | 1663 | Number of tests: 14 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:127.70 Median:121.00 stddev:20.94 (17.3%) stddev-sans-first:20.96 02:17:00 INFO - PROCESS | 1663 | Values: 108.0 122.0 119.0 120.0 122.0 119.0 150.0 179.0 118.0 120.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:126.50 stddev:24.17 (19.1%) stddev-sans-first:23.94 02:17:00 INFO - PROCESS | 1663 | Values: 153.0 110.0 107.0 180.0 146.0 114.0 123.0 112.0 130.0 109.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:207.40 Median:197.50 stddev:28.93 (14.6%) stddev-sans-first:30.44 02:17:00 INFO - PROCESS | 1663 | Values: 197.0 198.0 194.0 196.0 200.0 196.0 189.0 186.0 240.0 278.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:75.10 Median:72.00 stddev:18.60 (25.8%) stddev-sans-first:19.60 02:17:00 INFO - PROCESS | 1663 | Values: 81.0 51.0 64.0 115.0 87.0 63.0 60.0 64.0 80.0 86.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:66.00 stddev:18.55 (28.1%) stddev-sans-first:19.58 02:17:00 INFO - PROCESS | 1663 | Values: 90.0 70.0 118.0 107.0 98.0 62.0 86.0 102.0 103.0 117.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:83.00 stddev:24.14 (29.1%) stddev-sans-first:24.50 02:17:00 INFO - PROCESS | 1663 | Values: 89.0 77.0 121.0 139.0 123.0 135.0 137.0 89.0 90.0 90.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:126.00 stddev:18.25 (14.5%) stddev-sans-first:18.78 02:17:00 INFO - PROCESS | 1663 | Values: 97.0 96.0 105.0 156.0 115.0 103.0 121.0 97.0 99.0 107.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:115.10 Median:83.50 stddev:28.46 (34.1%) stddev-sans-first:29.42 02:17:00 INFO - PROCESS | 1663 | Values: 97.0 92.0 89.0 78.0 147.0 146.0 89.0 140.0 146.0 127.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:69.00 stddev:4.90 (7.1%) stddev-sans-first:5.17 02:17:00 INFO - PROCESS | 1663 | Values: 68.0 66.0 67.0 67.0 70.0 69.0 69.0 67.0 70.0 83.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.00 stddev:10.03 (15.7%) stddev-sans-first:9.99 02:17:00 INFO - PROCESS | 1663 | Values: 55.0 63.0 60.0 72.0 65.0 63.0 63.0 49.0 73.0 85.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:11.73 (13.3%) stddev-sans-first:12.25 02:17:00 INFO - PROCESS | 1663 | Values: 84.0 82.0 96.0 70.0 98.0 92.0 105.0 103.0 75.0 94.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:157.00 Median:158.00 stddev:22.55 (14.3%) stddev-sans-first:20.94 02:17:00 INFO - PROCESS | 1663 | Values: 126.0 136.0 144.0 169.0 156.0 156.0 161.0 152.0 210.0 160.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:178.50 stddev:28.95 (16.2%) stddev-sans-first:30.38 02:17:00 INFO - PROCESS | 1663 | Values: 171.0 167.0 186.0 243.0 162.0 164.0 151.0 200.0 218.0 169.0 02:17:00 INFO - PROCESS | 1663 | 02:17:00 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:80.00 stddev:11.06 (13.8%) stddev-sans-first:10.01 02:17:00 INFO - PROCESS | 1663 | Values: 59.0 80.0 59.0 79.0 86.0 84.0 90.0 80.0 66.0 71.0 02:17:00 INFO - PROCESS | 1663 | -------- Summary: end -------- 02:17:00 INFO - PROCESS | 1663 | 02:17:01 INFO - TEST-INFO | 1663: exit 0 02:17:01 INFO - TEST-OK | kraken | took 62376ms 02:17:01 INFO - SUITE-END | took 1179s 02:17:01 INFO - Completed test suite (00:19:39) 02:17:01 INFO - javascript benchmark 02:17:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7573.215599128073, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2917.504024315867, 3028.1975276551716, 3476.72186225102, 3520.7711498752597, 3521.6478352164777, 5948.791792287271, 6004.849878753028, 6084.604500707451, 6094.17728606638, 6121.816345509631, 5664.745086471108, 6094.786682466114, 6132.540059495534, 6135.171751813504, 6141.846453838656, 5365.651232669884, 5406.0, 5458.61789674723, 5459.017376872162, 5486.945130548704, 5499.945000550003, 5502.147167189092, 5514.338279406476, 5520.1167813149905, 5531.529819965308, 5305.0, 5331.093714068598, 5519.586031047687, 5525.392206857243, 5527.944720552783, 5392.1911713242935, 5410.053240682904, 5452.263944367499, 5456.290682211326, 5496.615236933416, 5319.840404787863, 5478.150886612541, 5481.0, 5495.560355171577, 5520.972395137998, 6107.4503294703245, 6110.511159107261, 6154.230721159855, 6168.1056246843955, 6180.227471566054, 6238.844028899269, 6304.243490781136, 6311.274203466614, 6329.354367864388, 6435.935640643581, 6425.871482570369, 6452.967525195993, 6465.159529261213, 6483.481321494269, 6513.348665133496, 6190.288116866528, 6198.783042593487, 6204.844878878019, 6212.689365531751, 6233.501319894398, 6411.487081033506, 6472.514561407913, 6542.672866356663, 6642.966785166043, 6653.334666533405, 6297.464715499143, 6307.400796924285, 6319.0, 6371.9681401593625, 6419.807405777834, 6467.353264673495, 6494.090827284184, 6503.512236582181, 6508.381703738138, 6510.3489651034515, 4827.565519103297, 5252.29094072303, 5371.435999220103, 6304.250336339646, 6468.126802881645, 6062.060380641008, 6265.624062556261, 6309.936900631027, 6339.0, 6359.3958573936325, 4697.741624210633, 5029.2958985742025, 5058.317127187856, 5073.34046573943, 5078.984203159383, 3836.9232615348096, 4571.26859702446, 4624.1445332613575, 4625.653076019312, 4659.091477161988, 5456.854060647309, 6056.273247210363, 6088.360722124202, 6097.146399504073, 6157.507399408126, 6258.530610204253, 6297.937020629735, 6542.21493420783, 6550.181227346582, 6562.639054852029, 5086.898262034739, 6064.787732429344, 6071.6660583667435, 6108.297545782203, 6116.204893363834, 5724.227229324071, 5741.224934633855, 5747.540196784331, 5750.281214848144, 5763.711814409263, 6385.233771947396, 6467.870642587216, 6714.4292735116105, 6720.798376048726, 6747.055412242192, 6349.587276826992, 6402.743890244338, 6415.230172379344, 6446.613203207822, 6453.51598630114, 6692.799216023527, 6704.027915952257, 6715.4627629790475, 6724.630145342053, 6741.629210393476, 6182.969085154546, 6432.6140431572385, 6445.8388540285, 6452.257990331172, 6452.612843229421, 6285.717142728679, 6315.115883776183, 6346.174997250328, 6401.935980640134, 6436.613803171825, 6330.715117819801, 6338.556301059066, 6338.904916426165, 6340.778072767431, 6351.301356850835, 6274.341194174546, 6305.779297724557, 6321.367863213826, 6349.238091429058, 6357.364263573606, 6012.158297838394, 6034.24571928509, 6165.0, 6187.628742275478, 6210.4100110489435, 6295.244570651551, 6348.873022539616, 6354.777582784581, 6363.172787537591, 6377.904331435125, 6034.758609655564, 6301.40136687014, 6307.526935479766, 6320.810375688737, 6332.0], "value": 5905.820924637075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9080542408084, 801.2388231180379, 824.4517395931706, 963.8650588917557, 967.3470407474953, 39043.0, 39859.0, 41306.0, 41319.0, 41445.79277103618, 39569.0, 39755.40366894491, 39856.40215396771, 39858.80070599643, 39946.0, 7289.854202915939, 7393.889091663629, 9033.232175265077, 10712.303700259497, 11151.72120696985, 10756.515956781963, 10842.891571084267, 10884.183686223525, 10895.564177432892, 10928.344299342025, 10914.945425272903, 10937.289076210021, 10937.507812148433, 10938.234323597351, 10944.960228778253, 10176.592936282539, 10837.18721095921, 10870.61952831651, 10906.291091079054, 10918.781624367468, 8989.775255618597, 9167.587458564381, 10657.946710266477, 10666.36001839892, 10667.0, 28527.85736071327, 34762.60949562014, 34778.0, 35060.474092888624, 35147.1213219669, 3798.8480460781534, 3831.214601006787, 3836.5779764225913, 3844.115853353744, 3850.2876967761053, 20449.0, 22823.88588057049, 23379.883100584557, 24415.755842441704, 25506.872465637553, 2695.892164313425, 3078.707522785332, 3086.3672947046025, 3109.5491153782573, 3156.4949608062598, 295381.0, 298010.0, 349064.0, 351437.2428137843, 355750.0, 35172.824135879666, 39053.41419878704, 43985.56014439878, 44153.77923110364, 44165.558344416146, 37965.62034379676, 37966.72199668029, 37999.05002374963, 38015.42976855349, 38081.23837523234, 13551.59345219645, 13632.250226237455, 13752.862471375158, 13763.931180344034, 13797.551257118059, 9916.20670346385, 12114.69713257158, 12146.635600931986, 12153.93923030397, 12154.574589889311, 11945.402729863472, 11946.283223006474, 11956.940215298868, 12009.879901201051, 12056.578019769442, 4769.880752981134, 5496.835094947158, 5570.108782594765, 5585.8603534911135, 5619.297587801525, 1030.8093002794508, 1080.68660088575, 1090.907272881814, 1147.9942600286945, 1195.7369378736664, 22590.548189036457, 25472.72636368174, 26112.477750444883, 26329.605055924178, 26729.0, 1112.9833052504218, 1194.6774370919977, 1231.335079057299, 1274.4774642396574, 1295.6436979830432, 11124.55501779936, 11204.76747557768, 12704.0, 13677.589672309847, 13894.652633684238, 410986.0, 412598.0, 413546.86453135684, 415990.0, 416920.0, 55289.44710552924, 55418.44581554214, 55786.0, 55840.441595584336, 55890.72054639701, 1407.7958695989025, 1445.4290555230625, 1453.5639308207496, 1454.0911930043724, 1461.4154338264566, 25071.247862564152, 25838.354041149123, 26095.608565871906, 26112.8694356527, 26129.869350653124, 43062.56937430711, 43151.784241078596, 43169.3524597125, 43179.704608861786, 43231.9192020202, 398468.0, 400002.0, 400034.0, 400374.0, 400629.0, 29176.0, 30395.848020759753, 31104.911328104314, 31217.0, 31414.685853141174, 38597.6140238594, 38787.0, 39005.0, 39810.40284395794, 40263.597364027155, 28070.71929280681, 28199.71800282053, 28334.866605335556, 28544.57183142213, 29291.974780882567, 28335.57496637511, 28384.43231135407, 28784.568231476962, 29031.0, 29169.854150729112, 32412.0, 33403.99788006364, 33455.83272083624, 33486.832565837016, 33684.66315336815, 28644.28389290201, 28833.84664613392, 28898.422031559672, 29086.27284317909, 29559.55660665135, 22942.885285573466, 23029.76970230276, 23394.76605233926, 23494.76505234926, 23523.764762352843], "value": 17844.43664197642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.25261371859165, 404.0847480456765, 407.2445613387165, 424.8725382385284, 431.5986132896405, 20039.59920801585, 20304.578679492442, 20917.47706307343, 21207.575848483022, 21413.0, 20802.791972080275, 21227.257046003393, 21414.03636836342, 21471.785282147175, 21845.67231491525, 6275.4038366355235, 6570.835729106787, 6609.834754131137, 6613.404793568578, 6618.8676226475445, 5371.946280537203, 6525.119108920282, 6948.861022779542, 7263.491555591111, 7347.448941329421, 7306.963465182694, 7308.634568271592, 7335.633218339061, 7357.632118394085, 7360.595167265798, 7126.287371262884, 7270.0, 7303.780886573385, 7343.118825740892, 7353.48525603208, 6865.828354291133, 7143.642817859139, 7226.024486694281, 7233.168185658611, 7235.746748863817, 24192.153274635304, 24365.756342436525, 24672.25983220506, 24894.0, 24939.251822445174, 2845.1891211004763, 2962.7185417385313, 2970.3168271297504, 2979.463696534623, 2984.910452686423, 14746.778798318033, 15517.456889008943, 15566.143862087582, 16030.118343491104, 16204.918975405048, 1952.9902350488298, 1987.153055496224, 2010.5074256807177, 2015.7379540659767, 2019.707142464349, 143785.0, 151394.48605513913, 162487.1875640626, 174830.12584937122, 177270.0, 16157.353705851869, 19650.410487685393, 20549.89725051365, 20930.953452327627, 21168.894155529124, 31080.067597972098, 31218.375632487223, 31479.685203148132, 31521.36957260842, 31561.684383156335, 10171.237157213238, 10280.588776449007, 10444.895551044392, 10503.05472507478, 10572.788544229072, 8658.696945606873, 8765.956170219108, 8777.078406767325, 8903.332250081141, 8927.508987005776, 9254.259659227246, 9364.719058428258, 9406.294527910433, 9457.952710236543, 9472.957974622786, 3466.8959931202103, 4072.226277007359, 4133.21468920904, 4148.875533733993, 4169.415622063597, 778.8364443466935, 802.6869520886859, 875.5403413207989, 889.235257678396, 921.2215677752289, 14480.927595361956, 17613.463788682202, 17684.29262829498, 21074.946252687303, 21161.0, 841.8232171243985, 926.7312479381039, 935.6912218967724, 939.7556635274741, 948.3835506920557, 8861.778455538662, 10416.479176041168, 10730.624428144978, 10853.565857365775, 10878.945605271923, 711717.0, 733570.3321483465, 769092.0, 769320.4601930976, 770122.2249937641, 165525.0, 167683.0, 169409.0, 172359.0, 175075.24924750588, 988.4217732626494, 1152.8749028748964, 1185.887340702632, 1199.4482538032428, 1212.2302338015425, 17979.460616181535, 18159.63802714828, 18482.075896205406, 18505.074746262362, 18760.624787504446, 48031.0, 64986.025209620944, 66966.66616832723, 67198.66400667965, 67793.66103169453, 92119.53940230524, 93072.06927930634, 94429.0, 94871.52564237134, 94908.0, 9008.459492430475, 9692.806143877224, 11601.535938562363, 11925.165238433226, 11987.34069626179, 12771.297578633264, 12787.552435664707, 12976.351182441029, 13056.086073974731, 13144.0, 10792.08267297257, 10956.34261944286, 11120.11039116885, 11169.88830111721, 11228.214025018171, 10319.535620897228, 10333.0, 10346.430946298025, 10412.271141020055, 10652.09457196147, 10937.125029997422, 11347.092232621206, 11444.256123351955, 11557.768844623228, 11587.0, 11426.657200284004, 11631.47658355359, 11908.285502869856, 11968.940155299168, 11978.58074967372, 10163.898361016296, 10403.323783954018, 10603.681889543326, 10933.961273678988, 11310.20828542027], "value": 11450.024607856849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.1191285228863, 1513.3341329814887, 1538.1770752647342, 1564.139723152266, 1565.7103435864367, 10568.841467377995, 11215.38315392653, 11253.662390128298, 11301.152413568974, 11417.714557136076, 11162.497687604056, 11286.717832054203, 11334.206605537616, 11341.0, 11344.0, 2411.40920474484, 2454.3250606083293, 2464.8890799913956, 2465.864377459239, 2468.4816188600416, 2270.398344438725, 2272.522770218256, 2466.1738317663603, 2468.395243165427, 2479.6280557916275, 2392.4616961183683, 2437.1104546840365, 2444.64552639868, 2469.0370755405315, 2475.62865570165, 2370.798482129021, 2426.2478631624253, 2428.890699918508, 2437.305367970129, 2444.3155916343453, 2412.819038572114, 2418.1899063813644, 2425.527022230648, 2426.8543887366814, 2443.535728211652, 11160.16298777595, 11337.43312834355, 11339.489722962404, 11352.716182095432, 11412.42937853104, 5851.531877449794, 5941.702914854283, 5976.581639285252, 6037.7584896604085, 6068.362821903725, 2719.225020869043, 3163.7627177961745, 3380.6619338066243, 3404.914877128067, 3492.8253587320787, 1111.6720567432626, 1190.2263528706324, 1195.6831439668495, 1244.8817362350562, 1255.4978008796463, 13882.028258021943, 14007.229602371866, 15014.099154050791, 15428.305726242346, 15625.296861641253, 3866.207427477417, 4014.5383280922483, 4704.529547045337, 4855.854324370204, 4902.0, 10235.130013948898, 11191.776164476827, 11737.413129343498, 11817.350045747566, 11818.822717659243, 5761.48146666802, 5922.052471604523, 5929.080992446177, 5935.139404786281, 5968.7015649217365, 5248.7900483980975, 5342.5993050521365, 5383.703896285742, 5408.188771684278, 5470.64440811346, 3978.980105099456, 4008.0981779100052, 4027.939580906289, 4085.632293093636, 4095.037666148453, 907.03626648307, 950.7242899559051, 1076.4552866636402, 1079.1312993040679, 1090.929089609173, 949.5632009275672, 954.7994921066515, 977.5014742481244, 977.7408986618552, 1004.7136566078779, 5854.853628659318, 6734.0572319875255, 6799.626020568916, 6903.482238832108, 6980.616066116412, 960.3613596958085, 992.4987881119988, 1011.8077565262577, 1012.8430093335545, 1029.613894789454, 4077.1641813428178, 4174.979125104355, 4247.723897946624, 4291.527931927485, 4315.4605674290715, 12796.808047879289, 13423.3959471824, 13442.260675662737, 13449.529266475822, 13495.797563036562, 11082.335059896432, 13007.609771706864, 13251.403686834115, 13385.0, 13891.374888130058, 9993.450360230258, 10177.287589868785, 10186.08325250731, 10211.846822297523, 10280.640177593748, 6882.208546017272, 6912.27421120775, 6913.51605387618, 6966.686499107654, 7161.892571611325, 12162.878371216175, 12187.87812121903, 12375.938120309342, 12408.379581021094, 12434.12961092751, 11163.330200188015, 12704.0, 12764.936175319064, 12783.424745886643, 12975.610731678065, 9255.722328329892, 9459.621615135318, 9478.38390504615, 9502.192313653417, 9516.524173791144, 10205.049128953027, 10283.7429064271, 10340.12108970746, 10410.791784164427, 10427.478626068818, 8717.259032982014, 8812.47125172466, 8836.381453298207, 8933.553322333728, 9054.049324820799, 8627.396082274181, 8679.435836670596, 8679.86980195285, 8772.56137193125, 8787.209151176425, 7483.550986940801, 7885.842283154419, 7909.8813517796125, 7973.8405231896195, 8032.799180020546, 5034.270030845433, 5097.898042039064, 5230.215467679878, 6027.728752206073, 6255.78104766331, 5978.910316345171, 6006.189164462917, 6038.426349496791, 6050.667213303311, 6178.969105154445], "value": 5151.391592536172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.8991050606924, 344.6949449736982, 373.99626003739974, 378.96778773804226, 386.7196282695045, 4241.681873859461, 4556.134334476447, 4953.628477864157, 5020.899582008362, 5173.275741396207, 4251.8511852085185, 4695.5539223773685, 5198.896022079556, 5210.374755029392, 5211.86970325742, 3996.8601098961544, 4102.282100632392, 4227.450431443908, 4306.375575541545, 4317.395564620955, 3878.886007126123, 4251.80866860992, 4255.893602659943, 4281.571842815709, 4291.334843099325, 4286.207051695431, 4293.076988447483, 4299.333603291495, 4343.9149208379995, 4350.195213885426, 3921.5882332355263, 4060.654844338235, 4229.302165142748, 4297.033167537279, 4366.161994703452, 3403.8937345362856, 3654.7076233901225, 3896.337622604164, 3916.784576848272, 3923.7645741255615, 3787.712177859541, 4683.92269777953, 4881.902361952741, 4983.579679791278, 4991.851874068984, 4590.472095709003, 4697.95302046982, 4894.632902532288, 4929.0, 4945.972151417902, 4677.438707355105, 5297.589596733477, 5470.753816078286, 5499.587530935196, 5519.454552725243, 3655.8903232903053, 3814.7520411173186, 4150.896227594334, 4403.383526306319, 4502.369668246448, 5152.716600586966, 5214.661047031931, 5689.317281926195, 5830.883382332372, 5849.941500585025, 3939.527256729211, 4501.527339629357, 4556.521565235603, 4576.656750743708, 4590.472095709036, 3909.843606255775, 4188.727732697365, 4611.930821037688, 4712.764361781898, 4738.763061846894, 4386.495553011445, 4778.307145463888, 4885.6335774817035, 4947.6289278304275, 4985.700857948535, 5524.806631767869, 5526.226328314039, 5537.390887002426, 5584.794006367462, 5626.887462250814, 1448.2758620689656, 1464.985350146506, 1471.2051297417133, 1564.9921750391175, 1579.3287852662572, 967.6322997260996, 1094.9233553651327, 1181.4092953523239, 1182.4864173857477, 1210.5339444314002, 4376.934345984812, 4487.304467807495, 4715.434147902273, 4827.517248275144, 5168.3539557555305, 5137.306463627438, 5239.5112321647675, 5266.393749906315, 5513.5037846594, 5566.276384070126, 4312.439382880206, 4533.909321813545, 4794.9280760787915, 4807.78364973577, 5165.457626949192, 3001.6737028802854, 3016.3062495626127, 3018.1589230569334, 3029.2881172924344, 3045.0, 5461.105614024574, 5587.525060369914, 5678.205051292823, 5963.373845746221, 6072.210612620331, 4881.658283920163, 5235.476452354734, 5696.686682232434, 5725.799597014085, 5936.168936348915, 5421.674699518042, 5646.6894320811925, 5709.34342550612, 5780.16187652788, 5972.835297117021, 5277.656952298242, 5736.766595182056, 5770.394108618535, 5810.593258472036, 5855.912161317498, 4715.434147902273, 4994.825181118644, 5118.488151184852, 5637.718114094361, 5681.965804278843, 5919.6152250103605, 5935.614185077956, 5982.49148822355, 6010.055073014279, 6038.51691864641, 3844.8462061518344, 4017.799110044428, 4479.3057076153245, 4572.542745725401, 4590.150822097922, 4620.422447194101, 5661.05625074967, 5700.287464066992, 5741.0, 5796.275465566804, 5062.658645294236, 5475.315585551806, 5479.6164268500825, 5593.406593406594, 5628.521575665951, 4627.991206134273, 4789.0, 5093.337866077386, 5273.6572122811895, 5564.777408903598, 4698.043564039971, 5265.394479634738, 5303.231031500333, 5509.851158048285, 5564.777408903598, 4807.826834289492, 5241.764120614505, 5345.438728933406, 5645.266115405136, 5697.8860422790485, 4550.453945526558, 5120.846374608767, 5185.377754669313, 5479.4520547944885, 5528.004959107399], "value": 4197.774436809536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.4992405468062, 701.0780823217468, 730.5032577847063, 765.9333508839028, 849.1762989899797, 14158.433662653482, 15511.379544818194, 16048.679026419464, 16215.675686486278, 16246.43137490188, 12698.682532936682, 12757.872421275784, 15037.849621503781, 15113.471028514005, 15210.923945380286, 925.3799954030799, 946.7017889364828, 951.5480146930222, 951.9476428796413, 954.0745476887408, 892.2727976699002, 937.2221056523069, 938.3478482454697, 953.4946478366477, 954.2890546542835, 840.7603832907622, 978.3054031637511, 984.1241295247236, 984.2273815055183, 986.0189111833699, 975.1808480876027, 978.5792109392922, 981.5582987655583, 981.9607215711363, 982.3909176310661, 717.8061923280737, 726.836461796097, 727.6943683652878, 728.5191773429564, 729.1141263365037, 14065.36705848229, 15786.21068946548, 16123.113228772412, 16146.677066458722, 16720.74918876218, 12150.635480935585, 12157.756844863054, 12187.817182742267, 12360.258384496869, 12584.68538286541, 11588.478518466689, 11719.882801171965, 11825.053995680411, 11883.346415947119, 11934.761304773856, 3308.884189053396, 3390.6439823818637, 3609.043603445089, 3642.3990041643096, 3669.3028324618504, 55382.615434614054, 71054.64472677655, 79672.20327796706, 82255.17744822535, 91452.99999999933, 9192.264618830477, 9454.43273403598, 10674.946625266824, 11126.332420054661, 11223.60717374888, 22522.436939076328, 22753.772462275498, 22781.544369112526, 22814.97332620036, 22882.771172288398, 7947.046354437504, 7983.5209887406945, 8060.31487323584, 8081.353491720648, 8143.470674406145, 4258.190943720683, 4274.0, 4299.849505267363, 4446.1330040642415, 4544.909101818012, 3491.755577109578, 3535.7524973251625, 3555.591107022674, 3577.2487777567003, 3584.1577229351083, 656.2944834303144, 658.6574981009848, 661.3551787007725, 661.8940969444866, 705.8941158826217, 666.8799616069155, 674.3559900295206, 708.7413094220675, 715.3061530315586, 728.5228175545027, 8786.604602792762, 10424.5830166794, 10433.530491127918, 10650.840237396445, 10685.893141068489, 562.8846086552247, 576.9048107062372, 581.2995340614634, 590.9231799865989, 607.0620890723842, 3840.30874442603, 4477.238869392146, 4932.557261765238, 5003.124453220672, 5007.248912663057, 94344.52827735817, 94518.0, 95129.0, 95535.52232238794, 95853.52073239589, 82587.5870620655, 82799.17200828035, 83443.0, 83705.0, 84228.0, 70433.6478317605, 70600.64699676468, 70909.64545177344, 71538.64230678813, 72375.27624723685, 7936.444448888753, 9617.807643846943, 9725.610975560898, 9762.267829912644, 9981.750456238362, 46862.0, 47801.760991194824, 47958.0, 48433.54699359025, 49402.50597493979, 60432.0, 60915.08627370504, 62159.0, 62299.377006229355, 62518.0, 11031.338119712522, 11263.211575189986, 11628.709282268012, 11651.475683594428, 11972.461239244429, 12402.875971240534, 12471.189372690746, 13023.544175953795, 13417.262050587311, 13499.730005400033, 11845.822312665145, 12014.519419223134, 12125.878741212828, 12319.384030798603, 12398.070144739, 11757.235779674636, 11941.16411851162, 12041.638750837488, 12237.877621223673, 12396.628101156979, 11609.825852612386, 11783.587574434854, 11923.761524769283, 12023.75952480963, 12299.446524906221, 8798.516081615573, 8865.911340886767, 8941.865872012055, 8944.852373047768, 9231.307651925998, 9358.210799456321, 9696.0788725071, 9820.361676491006, 10258.230632702427, 10322.0], "value": 7229.515141191928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 122.0, 119.0, 120.0, 122.0, 119.0, 150.0, 179.0, 118.0, 120.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 110.0, 107.0, 180.0, 146.0, 114.0, 123.0, 112.0, 130.0, 109.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 198.0, 194.0, 196.0, 200.0, 196.0, 189.0, 186.0, 240.0, 278.0], "value": 207.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 51.0, 64.0, 115.0, 87.0, 63.0, 60.0, 64.0, 80.0, 86.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 118.0, 107.0, 98.0, 62.0, 86.0, 102.0, 103.0, 117.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 77.0, 121.0, 139.0, 123.0, 135.0, 137.0, 89.0, 90.0, 90.0], "value": 109.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 105.0, 156.0, 115.0, 103.0, 121.0, 97.0, 99.0, 107.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 89.0, 78.0, 147.0, 146.0, 89.0, 140.0, 146.0, 127.0], "value": 115.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 70.0, 69.0, 69.0, 67.0, 70.0, 83.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 60.0, 72.0, 65.0, 63.0, 63.0, 49.0, 73.0, 85.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 96.0, 70.0, 98.0, 92.0, 105.0, 103.0, 75.0, 94.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 136.0, 144.0, 169.0, 156.0, 156.0, 161.0, 152.0, 210.0, 160.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 186.0, 243.0, 162.0, 164.0, 151.0, 200.0, 218.0, 169.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 80.0, 59.0, 79.0, 86.0, 84.0, 90.0, 80.0, 66.0, 71.0], "value": 75.4, "unit": "score"}]}]} 02:17:01 INFO - Return code: 0 02:17:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:17:01 ERROR - # TBPL SUCCESS # 02:17:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:17:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:17:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:17:01 INFO - 2017-04-04 02:17:01.944 screenresolution[1668:14549] starting screenresolution argv=screenresolution get 02:17:01 INFO - 2017-04-04 02:17:01.947 screenresolution[1668:14549] Display 0: 1600x1200x32@60 02:17:01 INFO - 2017-04-04 02:17:01.953 screenresolution[1669:14552] starting screenresolution argv=screenresolution list 02:17:01 INFO - Available Modes on Display 0 02:17:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:17:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:17:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:17:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:17:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:17:02 INFO - Intel Iris: 02:17:02 INFO - Chipset Model: Intel Iris 02:17:02 INFO - Type: GPU 02:17:02 INFO - Bus: Built-In 02:17:02 INFO - VRAM (Dynamic, Max): 1536 MB 02:17:02 INFO - Vendor: Intel (0x8086) 02:17:02 INFO - Device ID: 0x0a2e 02:17:02 INFO - Revision ID: 0x0009 02:17:02 INFO - Displays: 02:17:02 INFO - Display: 02:17:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:17:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:17:02 INFO - Display Serial Number: 1600x1200 60 02:17:02 INFO - Main Display: Yes 02:17:02 INFO - Mirror: Off 02:17:02 INFO - Online: Yes 02:17:02 INFO - Rotation: Supported 02:17:02 INFO - Return code: 0 02:17:02 INFO - Running post-action listener: _resource_record_post_action 02:17:02 INFO - [mozharness: 2017-04-04 09:17:02.190051Z] Finished run-tests step (success) 02:17:02 INFO - Running post-run listener: _resource_record_post_run 02:17:02 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 35135488; Write bytes: 511869952; Read time: 319; Write time: 1752 02:17:02 INFO - TinderboxPrint: CPU usage
54.5% 02:17:02 INFO - TinderboxPrint: I/O read bytes / time
35,135,488 / 319 02:17:02 INFO - TinderboxPrint: I/O write bytes / time
511,869,952 / 1,752 02:17:02 INFO - TinderboxPrint: CPU idle
2,185.9 (45.5%) 02:17:02 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 02:17:02 INFO - TinderboxPrint: CPU user
1,653.6 (34.4%) 02:17:02 INFO - TinderboxPrint: Swap in / out
239,419,392 / 0 02:17:02 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201765376; Write bytes: 199221248; Read time: 15688; Write time: 381 02:17:02 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 33284096; Write bytes: 301868032; Read time: 299; Write time: 1342 02:17:02 INFO - Running post-run listener: _upload_blobber_files 02:17:02 INFO - Blob upload gear active. 02:17:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:17:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:17:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:04 INFO - (blobuploader) - INFO - Done attempting. 02:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:05 INFO - (blobuploader) - INFO - Done attempting. 02:17:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:17:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:06 INFO - (blobuploader) - INFO - Done attempting. 02:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:10 INFO - (blobuploader) - INFO - Done attempting. 02:17:10 INFO - (blobuploader) - INFO - Iteration through files over. 02:17:10 INFO - Return code: 0 02:17:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:17:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:17:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d20460799d55f3a130f10f4662c9c23e0dd0f2a49e796d6b73bfad0ca650c4c7e9dcac1a87e43d5eac2e6288f0d2ace38f93e2748b2be8ebdd90d6bcd051f41b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ffcf73fa727ed87f2b1d5a2f453c63539364913f8ffc169e73510fac4a36dcf2a7c3e18b7ef876273ff689034d79f37ee7b9e39559dbc1f2bdd09048265897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad499a5b2ceb80026e7941c13f92d10fd11a07ff7a112030e1577342554ee9fdcbefe0f78ce82ac6473bce6ddaa6bc9374e196513aabd56c8c54e78adf97637a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290e19b0fc28c5548a9a4affa15cd8e59921977165a8564742ea64807d1a0c9387b890005a99e798dc69c823a9b5c8edcab33d5aae6dcb1214904fbdfd3aedb4"} 02:17:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:17:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:17:10 INFO - Contents: 02:17:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d20460799d55f3a130f10f4662c9c23e0dd0f2a49e796d6b73bfad0ca650c4c7e9dcac1a87e43d5eac2e6288f0d2ace38f93e2748b2be8ebdd90d6bcd051f41b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ffcf73fa727ed87f2b1d5a2f453c63539364913f8ffc169e73510fac4a36dcf2a7c3e18b7ef876273ff689034d79f37ee7b9e39559dbc1f2bdd09048265897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad499a5b2ceb80026e7941c13f92d10fd11a07ff7a112030e1577342554ee9fdcbefe0f78ce82ac6473bce6ddaa6bc9374e196513aabd56c8c54e78adf97637a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290e19b0fc28c5548a9a4affa15cd8e59921977165a8564742ea64807d1a0c9387b890005a99e798dc69c823a9b5c8edcab33d5aae6dcb1214904fbdfd3aedb4"} 02:17:10 INFO - Running post-run listener: copy_logs_to_upload_dir 02:17:10 INFO - Copying logs to upload dir... 02:17:10 INFO - mkdir: /builds/slave/test/build/upload/logs 02:17:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.252210 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-04 02:17:10.943979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:10.947909) ========= 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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d20460799d55f3a130f10f4662c9c23e0dd0f2a49e796d6b73bfad0ca650c4c7e9dcac1a87e43d5eac2e6288f0d2ace38f93e2748b2be8ebdd90d6bcd051f41b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ffcf73fa727ed87f2b1d5a2f453c63539364913f8ffc169e73510fac4a36dcf2a7c3e18b7ef876273ff689034d79f37ee7b9e39559dbc1f2bdd09048265897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad499a5b2ceb80026e7941c13f92d10fd11a07ff7a112030e1577342554ee9fdcbefe0f78ce82ac6473bce6ddaa6bc9374e196513aabd56c8c54e78adf97637a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290e19b0fc28c5548a9a4affa15cd8e59921977165a8564742ea64807d1a0c9387b890005a99e798dc69c823a9b5c8edcab33d5aae6dcb1214904fbdfd3aedb4"} build_url:https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d20460799d55f3a130f10f4662c9c23e0dd0f2a49e796d6b73bfad0ca650c4c7e9dcac1a87e43d5eac2e6288f0d2ace38f93e2748b2be8ebdd90d6bcd051f41b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41ffcf73fa727ed87f2b1d5a2f453c63539364913f8ffc169e73510fac4a36dcf2a7c3e18b7ef876273ff689034d79f37ee7b9e39559dbc1f2bdd09048265897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad499a5b2ceb80026e7941c13f92d10fd11a07ff7a112030e1577342554ee9fdcbefe0f78ce82ac6473bce6ddaa6bc9374e196513aabd56c8c54e78adf97637a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290e19b0fc28c5548a9a4affa15cd8e59921977165a8564742ea64807d1a0c9387b890005a99e798dc69c823a9b5c8edcab33d5aae6dcb1214904fbdfd3aedb4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:10.983204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:10.983598) ========= 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.6Q3EPDqo9G/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.m5pfSUDVY7/Listeners TMPDIR=/var/folders/99/84w0k_014gv77_6qrv0b4tn000000w/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.004800 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:11.032607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 02:17:11.032963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 02:17:11.033382) ========= ========= Total master_lag: 0.19 =========