builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0368 starttime: 1485371933.51 results: success (0) buildid: 20170125103331 builduid: 2743ab4aedc34f168f712b2c61417c21 revision: ec143b1f00bd49f6a540db3031cd7fe9a956768e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.510344) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.510811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.511085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.539605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.539943) ========= 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.hBo2tBhWwm/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.T8tjukUzMm/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 11:18:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 68.3M=0s 2017-01-25 11:18:53 (68.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.703972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.707308) ========= 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.hBo2tBhWwm/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.T8tjukUzMm/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.025791 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:53.756481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:18:53.756834) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ec143b1f00bd49f6a540db3031cd7fe9a956768e --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 ec143b1f00bd49f6a540db3031cd7fe9a956768e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hBo2tBhWwm/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.T8tjukUzMm/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 11:18:53,873 truncating revision to first 12 chars 2017-01-25 11:18:53,873 Setting DEBUG logging. 2017-01-25 11:18:53,873 attempt 1/10 2017-01-25 11:18:53,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ec143b1f00bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 11:18:54,951 unpacking tar archive at: mozilla-aurora-ec143b1f00bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.352210 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:18:55.138665) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:55.139011) ========= script_repo_revision: ec143b1f00bd49f6a540db3031cd7fe9a956768e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:55.139432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:55.139701) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:18:55.159763) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-25 11:18:55.160184) ========= /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.hBo2tBhWwm/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.T8tjukUzMm/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:18:55 INFO - MultiFileLogger online at 20170125 11:18:55 in /builds/slave/test 11:18:55 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 11:18:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:55 INFO - {'append_to_log': False, 11:18:55 INFO - 'base_work_dir': '/builds/slave/test', 11:18:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:18:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:55 INFO - 'branch': 'Mozilla-Aurora', 11:18:55 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:55 INFO - 'config_files': ('talos/mac_config.py',), 11:18:55 INFO - 'default_actions': ('clobber', 11:18:55 INFO - 'read-buildbot-config', 11:18:55 INFO - 'download-and-extract', 11:18:55 INFO - 'populate-webroot', 11:18:55 INFO - 'create-virtualenv', 11:18:55 INFO - 'install', 11:18:55 INFO - 'run-tests'), 11:18:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:55 INFO - 'download_minidump_stackwalk': True, 11:18:55 INFO - 'download_symbols': 'ondemand', 11:18:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:55 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:55 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:55 INFO - 'installer_path': 'installer.exe', 11:18:55 INFO - 'log_level': 'info', 11:18:55 INFO - 'log_name': 'talos', 11:18:55 INFO - 'log_to_console': True, 11:18:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:18:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:18:55 INFO - 'opt_config_files': (), 11:18:55 INFO - 'pip_index': False, 11:18:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:18:55 INFO - 'cmd': ('bash', 11:18:55 INFO - '-c', 11:18:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:18:55 INFO - 'enabled': True, 11:18:55 INFO - 'halt_on_failure': False, 11:18:55 INFO - 'name': 'check_screen_resolution'},), 11:18:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:18:55 INFO - 'cmd': ('bash', 11:18:55 INFO - '-c', 11:18:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:18:55 INFO - 'enabled': True, 11:18:55 INFO - 'halt_on_failure': False, 11:18:55 INFO - 'name': 'check_screen_resolution'},), 11:18:55 INFO - 'run_cmd_checks_enabled': True, 11:18:55 INFO - 'sps_profile': False, 11:18:55 INFO - 'sps_profile_interval': 0, 11:18:55 INFO - 'suite': 'dromaeojs-e10s', 11:18:55 INFO - 'system_bits': '32', 11:18:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:55 INFO - 'title': 't-yosemite-r7-0368', 11:18:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:55 INFO - 'use_talos_json': True, 11:18:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:55 INFO - 'work_dir': 'build'} 11:18:55 INFO - [mozharness: 2017-01-25 19:18:55.379866Z] Running clobber step. 11:18:55 INFO - Running pre-action listener: _resource_record_pre_action 11:18:55 INFO - Running main action method: clobber 11:18:55 INFO - rmtree: /builds/slave/test/build 11:18:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:57 INFO - Running post-action listener: _resource_record_post_action 11:18:57 INFO - [mozharness: 2017-01-25 19:18:57.836743Z] Finished clobber step (success) 11:18:57 INFO - [mozharness: 2017-01-25 19:18:57.836867Z] Running read-buildbot-config step. 11:18:57 INFO - Running pre-action listener: _resource_record_pre_action 11:18:57 INFO - Running main action method: read_buildbot_config 11:18:57 INFO - Using buildbot properties: 11:18:57 INFO - { 11:18:57 INFO - "project": "", 11:18:57 INFO - "product": "firefox", 11:18:57 INFO - "script_repo_revision": "production", 11:18:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 11:18:57 INFO - "repository": "", 11:18:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 11:18:57 INFO - "buildid": "20170125103331", 11:18:57 INFO - "pgo_build": "False", 11:18:57 INFO - "basedir": "/builds/slave/test", 11:18:57 INFO - "buildnumber": 34, 11:18:57 INFO - "slavename": "t-yosemite-r7-0368", 11:18:57 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:18:57 INFO - "platform": "yosemite_r7", 11:18:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:18:57 INFO - "branch": "mozilla-aurora", 11:18:57 INFO - "repo_path": "releases/mozilla-aurora", 11:18:57 INFO - "revision": "ec143b1f00bd49f6a540db3031cd7fe9a956768e", 11:18:57 INFO - "stage_platform": "macosx64", 11:18:57 INFO - "builduid": "2743ab4aedc34f168f712b2c61417c21", 11:18:57 INFO - "slavebuilddir": "test" 11:18:57 INFO - } 11:18:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:18:57 INFO - Running post-action listener: _resource_record_post_action 11:18:57 INFO - [mozharness: 2017-01-25 19:18:57.840235Z] Finished read-buildbot-config step (success) 11:18:57 INFO - [mozharness: 2017-01-25 19:18:57.840376Z] Running download-and-extract step. 11:18:57 INFO - Running pre-action listener: _resource_record_pre_action 11:18:57 INFO - Running main action method: download_and_extract 11:18:57 INFO - mkdir: /builds/slave/test/build/tests 11:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:57 INFO - trying https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:18:57 INFO - Downloading https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 11:18:59 INFO - Downloaded 1199 bytes. 11:18:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:18:59 INFO - Using the following test package requirements: 11:18:59 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:18:59 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:18:59 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:18:59 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'jsshell-mac.zip'], 11:18:59 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:18:59 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:18:59 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:18:59 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:18:59 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:18:59 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:18:59 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:18:59 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:18:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:18:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:18:59 INFO - Fetch https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:19:00 INFO - Expected file size: 16349682 11:19:00 INFO - Obtained file size: 16349682 11:19:06 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:19:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:19:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:19:06 INFO - Fetch https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:19:08 INFO - Expected file size: 16349682 11:19:08 INFO - Obtained file size: 16349682 11:19:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:19:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:19:14 INFO - Fetch https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:19:15 INFO - Expected file size: 14403485 11:19:15 INFO - Obtained file size: 14403485 11:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:15 INFO - trying https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:19:15 INFO - Downloading https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 11:19:20 INFO - Downloaded 73891264 bytes. 11:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:19:20 INFO - mkdir: /builds/slave/test/properties 11:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:19:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:19:20 INFO - Contents: 11:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:19:21 INFO - Running post-action listener: _resource_record_post_action 11:19:21 INFO - Running post-action listener: set_extra_try_arguments 11:19:21 INFO - [mozharness: 2017-01-25 19:19:21.557137Z] Finished download-and-extract step (success) 11:19:21 INFO - [mozharness: 2017-01-25 19:19:21.557264Z] Running populate-webroot step. 11:19:21 INFO - Running pre-action listener: _resource_record_pre_action 11:19:21 INFO - Running main action method: populate_webroot 11:19:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:19:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:19:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:19:21 INFO - '--tppagecycles', 11:19:21 INFO - '7'], 11:19:21 INFO - 'tests': ['tsvgm']}}, 11:19:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:19:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:19:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:19:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:19:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['damp', 'tps']}, 11:19:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'tests': ['damp', 'tps']}, 11:19:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['dromaeo_dom']}, 11:19:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:19:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['basic_compositor_video']}, 11:19:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:19:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['a11yr', 11:19:21 INFO - 'ts_paint', 11:19:21 INFO - 'tpaint', 11:19:21 INFO - 'sessionrestore', 11:19:21 INFO - 'sessionrestore_no_auto_restore', 11:19:21 INFO - 'tabpaint']}, 11:19:21 INFO - 'other-e10s': {'tests': ['a11yr', 11:19:21 INFO - 'ts_paint', 11:19:21 INFO - 'tpaint', 11:19:21 INFO - 'sessionrestore', 11:19:21 INFO - 'sessionrestore_no_auto_restore', 11:19:21 INFO - 'tabpaint']}, 11:19:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:19:21 INFO - 'ts_paint', 11:19:21 INFO - 'tpaint', 11:19:21 INFO - 'sessionrestore', 11:19:21 INFO - 'sessionrestore_no_auto_restore', 11:19:21 INFO - 'tabpaint']}, 11:19:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:19:21 INFO - 'ts_paint', 11:19:21 INFO - 'tpaint', 11:19:21 INFO - 'sessionrestore', 11:19:21 INFO - 'sessionrestore_no_auto_restore', 11:19:21 INFO - 'tabpaint']}, 11:19:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['a11yr', 11:19:21 INFO - 'ts_paint', 11:19:21 INFO - 'tpaint', 11:19:21 INFO - 'sessionrestore', 11:19:21 INFO - 'sessionrestore_no_auto_restore', 11:19:21 INFO - 'tabpaint']}, 11:19:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['a11yr', 11:19:21 INFO - 'ts_paint', 11:19:21 INFO - 'tpaint', 11:19:21 INFO - 'sessionrestore', 11:19:21 INFO - 'sessionrestore_no_auto_restore', 11:19:21 INFO - 'tabpaint']}, 11:19:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['tsvgx', 11:19:21 INFO - 'tsvgr_opacity', 11:19:21 INFO - 'tart', 11:19:21 INFO - 'tscrollx', 11:19:21 INFO - 'cart', 11:19:21 INFO - 'tsvg_static']}, 11:19:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:19:21 INFO - 'tsvgr_opacity', 11:19:21 INFO - 'tart', 11:19:21 INFO - 'tscrollx', 11:19:21 INFO - 'cart', 11:19:21 INFO - 'tsvg_static']}, 11:19:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'talos_options': ['--disable-e10s'], 11:19:21 INFO - 'tests': ['tp5o']}, 11:19:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:19:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'talos_options': ['--disable-e10s', 11:19:21 INFO - '--xperf_path', 11:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:21 INFO - 'tests': ['tp5n']}, 11:19:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:19:21 INFO - 'talos_options': ['--xperf_path', 11:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:21 INFO - 'tests': ['tp5n']}}, 11:19:21 INFO - 'talos.zip': {'path': '', 11:19:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:19:21 INFO - Running post-action listener: _resource_record_post_action 11:19:21 INFO - [mozharness: 2017-01-25 19:19:21.576302Z] Finished populate-webroot step (success) 11:19:21 INFO - [mozharness: 2017-01-25 19:19:21.576417Z] Running create-virtualenv step. 11:19:21 INFO - Running pre-action listener: _resource_record_pre_action 11:19:21 INFO - Running main action method: create_virtualenv 11:19:21 INFO - Creating virtualenv /builds/slave/test/build/venv 11:19:21 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 11:19:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:19:21 INFO - Using real prefix '/tools/python27' 11:19:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:19:22 INFO - Installing distribute.............................................................................................................................................................................................done. 11:19:25 INFO - Installing pip.................done. 11:19:25 INFO - Return code: 0 11:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:19:25 INFO - Reading from file tmpfile_stdout 11:19:25 INFO - Output received: 11:19:25 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) 11:19:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:25 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:25 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 11:19:25 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 11:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:25 INFO - 'HOME': '/Users/cltbld', 11:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:25 INFO - 'LOGNAME': 'cltbld', 11:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:25 INFO - 'MOZ_NO_REMOTE': '1', 11:19:25 INFO - 'NO_EM_RESTART': '1', 11:19:25 INFO - 'PAGER': '/bin/cat', 11:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:25 INFO - 'PWD': '/builds/slave/test', 11:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:25 INFO - 'SHELL': '/bin/bash', 11:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:25 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:25 INFO - 'USER': 'cltbld', 11:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:25 INFO - 'XPC_FLAGS': '0x0', 11:19:25 INFO - 'XPC_SERVICE_NAME': '0', 11:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:25 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 11:19:25 INFO - Cleaning up... 11:19:25 INFO - Return code: 0 11:19:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:25 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:25 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 11:19:25 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 11:19:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:25 INFO - 'HOME': '/Users/cltbld', 11:19:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:25 INFO - 'LOGNAME': 'cltbld', 11:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:25 INFO - 'MOZ_NO_REMOTE': '1', 11:19:25 INFO - 'NO_EM_RESTART': '1', 11:19:25 INFO - 'PAGER': '/bin/cat', 11:19:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:25 INFO - 'PWD': '/builds/slave/test', 11:19:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:25 INFO - 'SHELL': '/bin/bash', 11:19:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:25 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:25 INFO - 'USER': 'cltbld', 11:19:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:25 INFO - 'XPC_FLAGS': '0x0', 11:19:25 INFO - 'XPC_SERVICE_NAME': '0', 11:19:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:26 INFO - Downloading/unpacking psutil>=3.1.1 11:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:29 INFO - Installing collected packages: psutil 11:19:29 INFO - Running setup.py install for psutil 11:19:29 INFO - building 'psutil._psutil_osx' extension 11:19:29 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 11:19:30 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 11:19:30 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 11:19:30 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 11:19:30 INFO - building 'psutil._psutil_posix' extension 11:19:30 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 11:19:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:19:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:19:30 INFO - ^ 11:19:30 INFO - 1 warning generated. 11:19:30 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 11:19:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:30 INFO - Successfully installed psutil 11:19:30 INFO - Cleaning up... 11:19:30 INFO - Return code: 0 11:19:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:30 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:30 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 11:19:30 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 11:19:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:30 INFO - 'HOME': '/Users/cltbld', 11:19:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:30 INFO - 'LOGNAME': 'cltbld', 11:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:30 INFO - 'MOZ_NO_REMOTE': '1', 11:19:30 INFO - 'NO_EM_RESTART': '1', 11:19:30 INFO - 'PAGER': '/bin/cat', 11:19:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:30 INFO - 'PWD': '/builds/slave/test', 11:19:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:30 INFO - 'SHELL': '/bin/bash', 11:19:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:30 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:30 INFO - 'USER': 'cltbld', 11:19:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:30 INFO - 'XPC_FLAGS': '0x0', 11:19:30 INFO - 'XPC_SERVICE_NAME': '0', 11:19:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:19:30 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 11:19:30 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 11:19:30 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 11:19:30 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 11:19:30 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 11:19:30 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 11:19:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:19:33 INFO - Installing collected packages: mozsystemmonitor 11:19:33 INFO - Running setup.py install for mozsystemmonitor 11:19:33 INFO - Successfully installed mozsystemmonitor 11:19:33 INFO - Cleaning up... 11:19:33 INFO - Return code: 0 11:19:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:19:33 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')]} 11:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:33 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')]} 11:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:33 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:33 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 11:19:33 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 11:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:33 INFO - 'HOME': '/Users/cltbld', 11:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:33 INFO - 'LOGNAME': 'cltbld', 11:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:33 INFO - 'MOZ_NO_REMOTE': '1', 11:19:33 INFO - 'NO_EM_RESTART': '1', 11:19:33 INFO - 'PAGER': '/bin/cat', 11:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:33 INFO - 'PWD': '/builds/slave/test', 11:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:33 INFO - 'SHELL': '/bin/bash', 11:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:33 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:33 INFO - 'USER': 'cltbld', 11:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:33 INFO - 'XPC_FLAGS': '0x0', 11:19:33 INFO - 'XPC_SERVICE_NAME': '0', 11:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:34 INFO - Downloading/unpacking jsonschema==2.5.1 11:19:34 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 11:19:34 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 11:19:34 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 11:19:34 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 11:19:34 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 11:19:34 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 11:19:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:19:36 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 11:19:36 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 11:19:36 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 11:19:36 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 11:19:36 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 11:19:36 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 11:19:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:37 INFO - warning: no files found matching '*.txt' 11:19:37 INFO - no previously-included directories found matching 'build' 11:19:37 INFO - no previously-included directories found matching 'dist' 11:19:37 INFO - no previously-included directories found matching '.git*' 11:19:37 INFO - Installing collected packages: jsonschema, functools32 11:19:37 INFO - Running setup.py install for functools32 11:19:37 INFO - warning: no files found matching '*.txt' 11:19:37 INFO - no previously-included directories found matching 'build' 11:19:37 INFO - no previously-included directories found matching 'dist' 11:19:37 INFO - no previously-included directories found matching '.git*' 11:19:37 INFO - Successfully installed jsonschema functools32 11:19:37 INFO - Cleaning up... 11:19:37 INFO - Return code: 0 11:19:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:19:37 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')]} 11:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 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')]} 11:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:37 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 11:19:37 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 11:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:37 INFO - 'HOME': '/Users/cltbld', 11:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:37 INFO - 'LOGNAME': 'cltbld', 11:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:37 INFO - 'MOZ_NO_REMOTE': '1', 11:19:37 INFO - 'NO_EM_RESTART': '1', 11:19:37 INFO - 'PAGER': '/bin/cat', 11:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:37 INFO - 'PWD': '/builds/slave/test', 11:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:37 INFO - 'SHELL': '/bin/bash', 11:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:37 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:37 INFO - 'USER': 'cltbld', 11:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:37 INFO - 'XPC_FLAGS': '0x0', 11:19:37 INFO - 'XPC_SERVICE_NAME': '0', 11:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:19:37 INFO - Cleaning up... 11:19:37 INFO - Return code: 0 11:19:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:19:37 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')]} 11:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 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')]} 11:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:37 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 11:19:37 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 11:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:37 INFO - 'HOME': '/Users/cltbld', 11:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:37 INFO - 'LOGNAME': 'cltbld', 11:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:37 INFO - 'MOZ_NO_REMOTE': '1', 11:19:37 INFO - 'NO_EM_RESTART': '1', 11:19:37 INFO - 'PAGER': '/bin/cat', 11:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:37 INFO - 'PWD': '/builds/slave/test', 11:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:37 INFO - 'SHELL': '/bin/bash', 11:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:37 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:37 INFO - 'USER': 'cltbld', 11:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:37 INFO - 'XPC_FLAGS': '0x0', 11:19:37 INFO - 'XPC_SERVICE_NAME': '0', 11:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:19:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19:41 INFO - Downloading docopt-0.6.1.tar.gz 11:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:42 INFO - Running setup.py install for blobuploader 11:19:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:19:42 INFO - Running setup.py install for requests 11:19:42 INFO - Running setup.py install for docopt 11:19:42 INFO - Successfully installed blobuploader requests docopt 11:19:42 INFO - Cleaning up... 11:19:42 INFO - Return code: 0 11:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:42 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')]} 11:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:42 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')]} 11:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:42 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:42 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 11:19:42 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 11:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:42 INFO - 'HOME': '/Users/cltbld', 11:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:42 INFO - 'LOGNAME': 'cltbld', 11:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:42 INFO - 'MOZ_NO_REMOTE': '1', 11:19:42 INFO - 'NO_EM_RESTART': '1', 11:19:42 INFO - 'PAGER': '/bin/cat', 11:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:42 INFO - 'PWD': '/builds/slave/test', 11:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:42 INFO - 'SHELL': '/bin/bash', 11:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:42 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:42 INFO - 'USER': 'cltbld', 11:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:42 INFO - 'XPC_FLAGS': '0x0', 11:19:42 INFO - 'XPC_SERVICE_NAME': '0', 11:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-e_d_fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-r9IA4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-x_o8ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-a7nPQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-PupgRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-SRHuhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-MlddUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-OEjUk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-TsWNWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-7AGWYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-rGKLMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-RStnN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-q19uya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-h9hzXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-9bfYGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-6tdTpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-04mwN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:45 INFO - Running setup.py install for manifestparser 11:19:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:19:45 INFO - Running setup.py install for mozcrash 11:19:45 INFO - Running setup.py install for mozdebug 11:19:45 INFO - Running setup.py install for mozdevice 11:19:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:19:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:19:45 INFO - Running setup.py install for mozfile 11:19:45 INFO - Running setup.py install for mozhttpd 11:19:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:19:45 INFO - Running setup.py install for mozinfo 11:19:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Running setup.py install for mozInstall 11:19:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Running setup.py install for mozleak 11:19:46 INFO - Running setup.py install for mozlog 11:19:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Running setup.py install for moznetwork 11:19:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Running setup.py install for mozprocess 11:19:46 INFO - Running setup.py install for mozprofile 11:19:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:19:46 INFO - Running setup.py install for mozrunner 11:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:19:47 INFO - Running setup.py install for mozscreenshot 11:19:47 INFO - Running setup.py install for moztest 11:19:47 INFO - Running setup.py install for mozversion 11:19:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:19:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:47 INFO - Cleaning up... 11:19:47 INFO - Return code: 0 11:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:47 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:47 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 11:19:47 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 11:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:47 INFO - 'HOME': '/Users/cltbld', 11:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:47 INFO - 'LOGNAME': 'cltbld', 11:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:47 INFO - 'MOZ_NO_REMOTE': '1', 11:19:47 INFO - 'NO_EM_RESTART': '1', 11:19:47 INFO - 'PAGER': '/bin/cat', 11:19:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:47 INFO - 'PWD': '/builds/slave/test', 11:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:47 INFO - 'SHELL': '/bin/bash', 11:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:47 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:47 INFO - 'USER': 'cltbld', 11:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:47 INFO - 'XPC_FLAGS': '0x0', 11:19:47 INFO - 'XPC_SERVICE_NAME': '0', 11:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:47 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-xio_d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-yGrlpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-fTWJER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-66Jfsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-lEzPSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-sZ2EU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-zaPMCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-dVpQtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-jyqgpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-z6svaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:48 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)) 11:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:48 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-CdzAkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:49 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)) 11:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:49 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-Q9WkE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:49 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-tz5y5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:49 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)) 11:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:49 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-_kmKsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:49 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)) 11:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:49 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-GS4epT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:49 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)) 11:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:49 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-1dqpgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:49 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)) 11:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:49 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-tgI_AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:49 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)) 11:19:49 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)) 11:19:49 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)) 11:19:49 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)) 11:19:49 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)) 11:19:49 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)) 11:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:49 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 11:19:49 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 11:19:49 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 11:19:49 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 11:19:49 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 11:19:49 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 11:19:52 INFO - Downloading blessings-1.6.tar.gz 11:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:52 INFO - Installing collected packages: blessings 11:19:52 INFO - Running setup.py install for blessings 11:19:52 INFO - Successfully installed blessings 11:19:52 INFO - Cleaning up... 11:19:53 INFO - Return code: 0 11:19:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:53 INFO - Reading from file tmpfile_stdout 11:19:53 INFO - Current package versions: 11:19:53 INFO - blessings == 1.6 11:19:53 INFO - blobuploader == 1.2.4 11:19:53 INFO - docopt == 0.6.1 11:19:53 INFO - functools32 == 3.2.3-2 11:19:53 INFO - jsonschema == 2.5.1 11:19:53 INFO - manifestparser == 1.1 11:19:53 INFO - mozInstall == 1.12 11:19:53 INFO - mozcrash == 1.0 11:19:53 INFO - mozdebug == 0.1 11:19:53 INFO - mozdevice == 0.49 11:19:53 INFO - mozfile == 1.2 11:19:53 INFO - mozhttpd == 0.7 11:19:53 INFO - mozinfo == 0.9 11:19:53 INFO - mozleak == 0.1 11:19:53 INFO - mozlog == 3.4 11:19:53 INFO - moznetwork == 0.27 11:19:53 INFO - mozprocess == 0.24 11:19:53 INFO - mozprofile == 0.28 11:19:53 INFO - mozrunner == 6.13 11:19:53 INFO - mozscreenshot == 0.1 11:19:53 INFO - mozsystemmonitor == 0.3 11:19:53 INFO - moztest == 0.8 11:19:53 INFO - mozversion == 1.4 11:19:53 INFO - psutil == 3.1.1 11:19:53 INFO - requests == 1.2.3 11:19:53 INFO - wsgiref == 0.1.2 11:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:53 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 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:53 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 11:19:53 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 11:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:53 INFO - 'HOME': '/Users/cltbld', 11:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:53 INFO - 'LOGNAME': 'cltbld', 11:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:53 INFO - 'MOZ_NO_REMOTE': '1', 11:19:53 INFO - 'NO_EM_RESTART': '1', 11:19:53 INFO - 'PAGER': '/bin/cat', 11:19:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:53 INFO - 'PWD': '/builds/slave/test', 11:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:53 INFO - 'SHELL': '/bin/bash', 11:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:53 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:53 INFO - 'USER': 'cltbld', 11:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:53 INFO - 'XPC_FLAGS': '0x0', 11:19:53 INFO - 'XPC_SERVICE_NAME': '0', 11:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 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)) 11:19:53 INFO - Cleaning up... 11:19:53 INFO - Return code: 0 11:19:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105dcbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105dce768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e1bc779b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, '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.hBo2tBhWwm/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.T8tjukUzMm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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 11:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:19:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:19:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:53 INFO - 'HOME': '/Users/cltbld', 11:19:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:53 INFO - 'LOGNAME': 'cltbld', 11:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:53 INFO - 'MOZ_NO_REMOTE': '1', 11:19:53 INFO - 'NO_EM_RESTART': '1', 11:19:53 INFO - 'PAGER': '/bin/cat', 11:19:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:53 INFO - 'PWD': '/builds/slave/test', 11:19:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:53 INFO - 'SHELL': '/bin/bash', 11:19:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:19:53 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:19:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:53 INFO - 'USER': 'cltbld', 11:19:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:53 INFO - 'XPC_FLAGS': '0x0', 11:19:53 INFO - 'XPC_SERVICE_NAME': '0', 11:19:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:19:54 INFO - Cleaning up... 11:19:54 INFO - Return code: 0 11:19:54 INFO - Running post-action listener: _resource_record_post_action 11:19:54 INFO - Running post-action listener: _start_resource_monitoring 11:19:54 INFO - Starting resource monitoring. 11:19:54 INFO - [mozharness: 2017-01-25 19:19:54.187707Z] Finished create-virtualenv step (success) 11:19:54 INFO - [mozharness: 2017-01-25 19:19:54.188620Z] Running install step. 11:19:54 INFO - Running pre-action listener: _resource_record_pre_action 11:19:54 INFO - Running main action method: install 11:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:54 INFO - Reading from file tmpfile_stdout 11:19:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:54 INFO - Reading from file tmpfile_stdout 11:19:54 INFO - Output received: 11:19:54 INFO - Usage: mozinstall [options] installer 11:19:54 INFO - Options: 11:19:54 INFO - -h, --help show this help message and exit 11:19:54 INFO - -d DEST, --destination=DEST 11:19:54 INFO - Directory to install application into. [default: 11:19:54 INFO - "/builds/slave/test"] 11:19:54 INFO - --app=APP Application being installed. [default: firefox] 11:19:54 INFO - mkdir: /builds/slave/test/build/application 11:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:20:14 INFO - Reading from file tmpfile_stdout 11:20:14 INFO - Output received: 11:20:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:20:14 INFO - Running post-action listener: _resource_record_post_action 11:20:14 INFO - [mozharness: 2017-01-25 19:20:14.334464Z] Finished install step (success) 11:20:14 INFO - [mozharness: 2017-01-25 19:20:14.334635Z] Running run-tests step. 11:20:14 INFO - Running pre-action listener: _resource_record_pre_action 11:20:14 INFO - Running main action method: run_tests 11:20:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:20:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:20:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:20:14 INFO - 2017-01-25 11:20:14.349 screenresolution[1623:7304] starting screenresolution argv=screenresolution get 11:20:14 INFO - 2017-01-25 11:20:14.351 screenresolution[1623:7304] Display 0: 1600x1200x32@60 11:20:14 INFO - 2017-01-25 11:20:14.357 screenresolution[1624:7307] starting screenresolution argv=screenresolution list 11:20:14 INFO - Available Modes on Display 0 11:20:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:20:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:20:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:20:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:20:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:20:14 INFO - Intel Iris: 11:20:14 INFO - Chipset Model: Intel Iris 11:20:14 INFO - Type: GPU 11:20:14 INFO - Bus: Built-In 11:20:14 INFO - VRAM (Dynamic, Max): 1536 MB 11:20:14 INFO - Vendor: Intel (0x8086) 11:20:14 INFO - Device ID: 0x0a2e 11:20:14 INFO - Revision ID: 0x0009 11:20:14 INFO - Displays: 11:20:14 INFO - Display: 11:20:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:20:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:20:14 INFO - Display Serial Number: 1600x1200 60 11:20:14 INFO - Main Display: Yes 11:20:14 INFO - Mirror: Off 11:20:14 INFO - Online: Yes 11:20:14 INFO - Rotation: Supported 11:20:14 INFO - Return code: 0 11:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:14 INFO - Python 2.7.3 11:20:14 INFO - Return code: 0 11:20:14 INFO - grabbing minidump binary from tooltool 11:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:14 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 0x105ba9d30>, '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 0x105ad0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b9ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:14 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 11:20:14 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 11:20:14 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 11:20:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:14 INFO - Return code: 0 11:20:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:20:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:20:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:14 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/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0368', '--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 11:20:14 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/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0368 --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 11:20:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hBo2tBhWwm/Render', 11:20:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:20:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:20:14 INFO - 'HOME': '/Users/cltbld', 11:20:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:20:14 INFO - 'LOGNAME': 'cltbld', 11:20:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:14 INFO - 'MOZ_NO_REMOTE': '1', 11:20:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:14 INFO - 'NO_EM_RESTART': '1', 11:20:14 INFO - 'PAGER': '/bin/cat', 11:20:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:14 INFO - 'PWD': '/builds/slave/test', 11:20:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:20:14 INFO - 'SHELL': '/bin/bash', 11:20:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T8tjukUzMm/Listeners', 11:20:14 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 11:20:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:20:14 INFO - 'USER': 'cltbld', 11:20:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:20:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:14 INFO - 'XPC_FLAGS': '0x0', 11:20:14 INFO - 'XPC_SERVICE_NAME': '0', 11:20:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:20:14 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/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0368', '--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 11:20:14 INFO - mozversion application_buildid: 20170125103331 11:20:14 INFO - mozversion application_changeset: ec143b1f00bd49f6a540db3031cd7fe9a956768e 11:20:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:20:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:14 INFO - mozversion application_name: Firefox 11:20:14 INFO - mozversion application_remotingname: firefox-dev 11:20:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:20:14 INFO - mozversion application_vendor: Mozilla 11:20:14 INFO - mozversion application_version: 53.0a2 11:20:14 INFO - mozversion platform_buildid: 20170125103331 11:20:14 INFO - mozversion platform_changeset: ec143b1f00bd49f6a540db3031cd7fe9a956768e 11:20:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:20:14 INFO - mozversion platform_version: 53.0a2 11:20:14 INFO - using testdate: 1485372014 11:20:14 INFO - actual date: 1485372014 11:20:14 INFO - starting webserver on 'localhost:49241' 11:20:14 INFO - SUITE-START | Running 2 tests 11:20:14 INFO - TEST-START | dromaeo_css 11:20:14 INFO - operating with platform_type : mac_ 11:20:14 INFO - Initialising browser for dromaeo_css test... 11:20:14 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpZ_5wf6/profile http://localhost:49241/getInfo.html) 11:20:18 INFO - PROCESS | 1634 | 2017-01-25 11:20:18.101 plugin-container[1636:7485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 11:20:18 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:20:18 INFO - PROCESS | 1634 | 2017-01-25 11:20:18.127 plugin-container[1636:7485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 11:20:18 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:20:18 INFO - PROCESS | 1634 | 2017-01-25 11:20:18.127 plugin-container[1636:7485] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:20:18 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 11:20:18 INFO - PROCESS | 1634 | colorDepth:24 11:20:18 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 11:20:18 INFO - PROCESS | 1634 | __metrics 11:20:18 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 11:20:18 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 11:20:18 INFO - TEST-INFO | 1634: exit 0 11:20:18 INFO - Browser initialized. 11:20:18 INFO - Running cycle 1/1 for dromaeo_css test... 11:20:18 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpZ_5wf6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:21 INFO - PROCESS | 1637 | 2017-01-25 11:20:21.647 plugin-container[1638:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 11:20:21 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:20:21 INFO - PROCESS | 1637 | 2017-01-25 11:20:21.650 plugin-container[1638:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 11:20:21 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:20:21 INFO - PROCESS | 1637 | 2017-01-25 11:20:21.650 plugin-container[1638:7612] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:20:31 INFO - PROCESS | 1637 | RSS: Main: 218267648 11:20:31 INFO - PROCESS | 1637 | 11:23:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 11:23:35 INFO - PROCESS | 1637 | RSS: Main: 238686208 11:23:35 INFO - PROCESS | 1637 | 11:25:19 INFO - PROCESS | 1637 | ************************* 11:25:19 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 11:25:19 INFO - PROCESS | 1637 | 11:25:19 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:25:19 INFO - PROCESS | 1637 | Full stack: 11:25:19 INFO - PROCESS | 1637 | ************************* 11:26:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 11:26:38 INFO - PROCESS | 1637 | RSS: Main: 249229312 11:26:38 INFO - PROCESS | 1637 | 11:29:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 11:29:41 INFO - PROCESS | 1637 | RSS: Main: 255553536 11:29:41 INFO - PROCESS | 1637 | 11:32:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 11:32:43 INFO - PROCESS | 1637 | RSS: Main: 252887040 11:32:43 INFO - PROCESS | 1637 | 11:35:46 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 11:35:47 INFO - PROCESS | 1637 | RSS: Main: 256897024 11:35:47 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 11:38:49 INFO - PROCESS | 1637 | RSS: Main: 258306048 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | __start_tp_report 11:38:49 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 11:38:49 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 11:38:49 INFO - PROCESS | 1637 | |i|pagename|runs| 11:38:49 INFO - PROCESS | 1637 | |0;dojo.html;2871.353945362293;3377.915552111195;3388.356212319659;3399.0482664853844;3413.624501304856;5710.143478478225;5710.400407957167;5775;5824.126381042845;5867.178594996704;4416.873697207207;5284.260203571494;5824.446677565625;5855.092460668592;5861.3552509223955;5232.3459567554055;5265.236540701596;5285.7885684572575;5343.866403339928;5363.141897296433;5357.678539287655;5364.946350536484;5370.2750128732705;5379.462053794628;5394.676319420828;5314.043472175007;5352.839414817562;5361.249425080492;5364.517193452589;5369.40936496985;5214.765335559909;5242.580593552507;5310.522053015208;5313.973430132824;5379.139337705968;5231.659942103751;5312.9734351328;5353.330833645794;5356.491133342326;5394.811181608664;5920.585559010871;5971.014782560872;5974.940250597482;5986.102084687288;5986.221791167164;5544.667319960775;6164.476019538344;6216.316205217422;6234.594751341148;6242.719077641472;6150.292716337589;6232.470240029603;6274.2784579773;6274.403931626488;6298.1812364392335;5993.101034844764;6002.519798416116;6009.609375390585;6015.892731544521;6045.33501314855;6156.415140561639;6162.383761623892;6294.213223347082;6325.430711236011;6334.3032266450655;6158.784442544579;6177.382261773877;6186.566940314135;6212.844678883064;6315.5263355247625;5499.697516636624;6272.560920735505;6278.340774218733;6283.6858157091965;6297.2128483939505;6130.887362651087;6196.039613859859;6301.9286721257495;6302.1492098566105;6333.240011198685;6182.6599537024995;6236.345183755731;6253.280872699606;6268.905966410507;6274;5040.47075057121;5046.268291097844;5047.4447810740785;5063.443021267658;5070.188769796815;4524.728516289033;4537.909241815211;4541.455025396974;4549.363089167519;4602.470715867718;5722.170285308607;5722.941255867678;5818.185454036438;5824.388439213822;5847.736851841677;6213.906791398133;6257.530685198628;6282.748690052346;6298.118263443122;6316.115743795872;5739.569532285095;5826.79606213789;5887.411258874078;5892.734826932799;5901.29184497863;5487.725613719378;5516.227728118067;5522.91715624266;5582.218489411485;5591.944080559224;6368.681565921778;6374.681265936777;6378.489720822416;6382.234131904202;6385.45723613498;5635.182898479779;6198.442140207403;6264.655443950626;6267.4045965633195;6274.215723034621;5754.56840736938;6057;6226.972549529277;6227.314995350417;6271.839709653728;6238.6880655967925;6245.344238855037;6263.530235232467;6289.528285378524;6322.557420980671;6121.387861213843;6196.969015155076;6223.906641400292;6265.122882796321;6299.96850015747;5165.405978312542;6121;6127.250613123855;6155.292141403616;6240.032794916795;6209.59637623553;6224.06639004153;6224.408681175281;6237.688115594293;6242.875142497034;5958.553108516792;5990.281166260077;6010.699465026819;6051.12258722474;6063.636181829104;5104.642675012862;5144.794208231779;6002.969985150221;6128.86980888409;6178.783742568989;6054.878902422015;6061.545384096298;6087.512998959984;6096.055111457731;6102.694865256808 11:38:49 INFO - PROCESS | 1637 | |1;ext.html;430.27069117845224;460.0683615678251;460.4267686730021;472.0605994071796;534.5029122915687;39273;42798.572014279845;42910.35634465478;42916.356254656166;43008;43593.128137437234;44308.3353749694;44338.33492497615;44446.11107777851;44446.777766111125;7452.701891924316;7567;7591.24087591242;7626.847463050735;8478.830423391528;8464.365172612048;11202.775944481145;11457.312561246352;11468;11637.30176189427;11458.828117578243;11517.308961462297;11522;11525.2508586942;11542.307461552291;11368.261063030917;11447.771044579145;11449.713757156096;11453.541858325658;11465.942670286595;11321.377324247163;11413.258138220988;11420;11432.771344573144;11433.59982400612;41654.1669166618;42080.94797630053;42113.947151321154;42149;42194.578054219375;3957.3668213085766;4016.2168377166463;4016.3373043448087;4104.261232978063;4205.243056249874;30336.938207162642;30488.54267185994;30896.845515772504;30974.53538196929;31370.52944205816;2596.5456045192204;3164.6677098904743;3230.1601583588435;3232.531282963957;3234.8059116453087;435723;516651;518525.9999999962;518606;518694;57398;57585.42414575884;57625.13562296569;57640.71179644159;57672.711636442385;55847.44152558504;61163;61476.077858832155;61624.383756161864;61937.070943935876;15957.122358270175;16235.675286494205;16237.675246495004;16255.10596917181;16266.18669066542;10243.641472548425;11392.373419462008;11666.416679166008;12557.372131393393;12673.112882098165;15713.057216567042;18533.81466185321;18544.443666690022;18566;18654.626907462047;7291.197968223491;7531.510451820724;7898.328642065374;8007.599620018976;8079.717209897743;737.1485933746532;763.6258233465562;896.6547879066607;897.4929165021741;936.4662142578665;29148.562771558445;29750;30733.846330768203;30948;31304;1030.2324768047852;1054.4095306628312;1056.413690401819;1070.261519551507;1084.924055316136;13401.731965360637;13816.93091534556;14014.579562613138;14977;15024.501356191327;635597;636078;638851;639061;639103;52314.738426307624;52708.73645631747;53037;53169;53296.73351633217;1426.892983026277;1431.5633731711719;1463.4292625875703;1463.780432935047;1464.6265202373327;27133.457330852878;27384.7676854546;28975;29954.400911981204;30191.547126792677;53760.46239537554;54261.72869135787;54345.45654543562;54387;54484.45515544794;545472;549114;549554;551139;551382;40386.59613403946;40678.38982415207;41212.793936030124;41254.79372603118;41269.1746165069;39982.600608978544;43721.56278437175;44352.778236108614;45146;45199;35051.82474087613;36728.63271367252;36773.08067298339;36836;37371;36954.815225923696;37079;37838.24323513569;37841.81079094587;38082.809585951894;31914;34136.82931585326;35886.820565897004;36143.63856361508;36518.08704782402;30350.696493034786;33428.83285583654;33454.665453346126;33468.832655836566;33702.662973370934;24693.62959555572;25031.74968250294;25084.874575627004;25091.121810737266;25394.873025634755 11:38:49 INFO - PROCESS | 1637 | |2;jquery.html;326.50045430491326;359.98200089995504;398.22743876878855;406.5101552629082;429.56184691614556;19103.52241193971;20337.898310508463;20858.687119693215;21086.261980830674;21104.788952110473;20669.896650516763;20862.269820556285;21316.786832131675;21440.571188576218;21636.2427315044;5750.108733146369;5859.355470898197;5880.823835232949;5933.732982015819;5969.910451343233;4204.726692764961;4412.624926881219;5808.273965754281;5940.6435613863305;5951.226340575719;6272.937270627303;6523;6588.8023359299295;6633.834154146137;6638.6680665966505;6402.711877965503;6547.770828020996;6621.073049773036;6631;6643.6346000969925;5768.653880767168;5801.129830525413;5819.67991760453;5830.650160990312;5839.824805255849;25377.49245015108;25406.61890071632;25415;25423.74576254251;25457.872710636515;2783.2067860659613;2793.8044336896423;2793.8603069846426;2796.356837927268;2828.3070647691243;10355.792884142274;12500.74998500025;14991.100533967996;15363.615909602238;15497.380104795795;1852.4627857921187;1890.206113432348;1902.2676269636152;1907.7996810334853;1908.1413363986123;149247.0150596982;149822.50177498194;151177;152190.47809521985;152302.23848880795;12046;12120.27278363301;12137.696557585954;12194.817077743663;12305.015598752077;12945.352732363344;15666.843331566766;15683.843161568466;15683.902126851239;15693.607659808597;8752.824943501095;9025.05236950124;9031;9065.954670226607;9091.181793638605;8796.91203087961;8797.956010219908;8812.986506551828;8956.776080597907;8969.641214351483;4806.255030470283;4816.903661926742;4881.926771098437;4891.119598472309;4897.951020489821;1680.5630536060712;1787.320818089118;2042.611903738285;2091.9581608368053;2095.3923362225087;1001.8096561653408;1020.505055048301;1034.002187888691;1044.1594516414207;1075.3386667199616;18749.34377296788;20317.695234571493;20538.38384848457;20939.16243350249;21325.008464280712;811.1199348706601;1033.3851358441716;1041.1982773264544;1068.503146037081;1068.6687126990657;10628.468576571295;11042.227044106836;11044.779104417867;11045.558177672803;11058.447077646086;713185;715778;737764;760026;767484;144651;147065.81919209944;147798;152352;157974;861.8233262181363;866.3026263857529;1026.5637104230673;1055.7835643693024;1063.8882917293727;19001.904990475512;19100.044997749777;19317.61364772725;19355.4193374199;19589.412317630493;53908.19137713016;61770;61904.452388690646;62455.6877215611;63088.68455657876;83780.58109709657;89349.55325223332;92437.76467823863;92967.53516232646;95890.56164157404;7307.903814427878;7468.738594149178;7551.697932082655;7691.884621730566;7807.375409967075;7774.611269436393;10830.025297723243;11787.882121178678;13321.13412628176;13352.732945341233;10491.475426228812;11109.444527773741;11307.717307067389;11367.431628418712;11381.943090284496;10519.368837869752;11060.225784195029;11170.664880053286;11240.606578769704;11421.885781142082;9137.680181193626;10850.67447976562;11438.428078596204;11671;11940.283582985048;6521.380468855451;7397.445191610543;8172.610656188581;8246.958765206136;8485.660573576988;11007.284526505751;11373.772524549628;11462.254953428;11601.419929003685;11624.651260461862 11:38:49 INFO - PROCESS | 1637 | |3;mootools.html;1308.5747132182041;1442.4590778458078;1454.6654269518003;1455.352368196153;1461.0649184521903;7427.071616047994;7674.57789821561;8075.4347195696255;8476.703315383962;8517.488950662964;8004.759857204279;8144.877826832602;8317;8371.455855369397;8384.580770961458;2258.378945789913;2286.2798218561184;2297.517521320525;2300.2409204962323;2306.123673004256;1958.6572349838793;2045.3250427358935;2323.453988312745;2342.4495243617735;2344.4490544721975;2080.990719501041;2247.5729611373868;2308.203669733939;2309.722833260011;2312.7802858728396;2264.252796577142;2278.9886050569726;2282.2354511238755;2290.8510946788406;2292.9337857896076;2297.7242730872235;2298.9655155172686;2322.6516022596575;2322.953540929189;2323.6630688550067;6734.46124310054;8069.9509063821915;8254.215849494289;8281.337493000545;8397.412181147321;5035.395752509722;5193.221016847466;5199.14214154664;5207.270982062514;5211.166213405875;3387.1870751019824;3453.620101788801;3484.703800176988;3514.2221122928518;3559.430491121434;1212.8423304970386;1213.8907498325104;1250.3310728760162;1258.2199036597276;1270.9324167699176;10732.624358147428;10744.140468762558;10777.730556736144;10782.56869725218;10804.891951080468;4383.49589797171;4642.094791515622;4701.553352431513;4712.293156026555;4714.339992401066;9520.285978551636;9591.808163836684;9614.278929080347;9617.086376794194;9623.518824058909;4916.72957987307;4977.477364876709;4986.326845875833;5000.599952003831;5027;4461.7992190351515;4540.069285796404;4554.681172317973;4597.4712908015335;4710.646701497401;3871.7870517121264;3903.33643280643;3954.367301231789;3958.782266975344;3977.025628720982;1169.7952858249942;1262.665393670678;1265.1397050006085;1265.9177153484993;1276.3554405025402;821.8191997760483;905.5924833824805;906.8957069937042;936.1200471556715;950.7640067911825;5603.299587551556;5646.71766411686;5649.180868774005;5652.152177173457;5740.885182296414;1010.2524132142162;1020.7750699161037;1022.3284929140908;1027.0499787696351;1033.751899544104;3786.678132358725;3823.9617603823604;3850.0567360996174;3853.807309634507;3869;8414.410991230556;9580.856287155699;9934.304598678023;9935.950320248352;9952.203823694088;9880.209583233323;9886.653967111117;9888.505574721235;9892.60429582823;9913.553890074963;7461.552306861606;7683.462157649023;7850.332721718603;7917.2874441300555;7917.960410198028;5713.514351280188;5721.713914304351;5864;5872.911906321494;5889.528837692888;8903.287736981156;8983.820323593362;9195.724128276162;9319.068093190626;9321.394109382869;9110;9210.355275130676;9319.301052421231;9350.205232555309;9491.810163796823;6422.518311126778;6967.930320696931;7266.6729997151315;7903.960480197792;7909.406794490551;7825.921740782519;8075.919240807517;8084.717034903751;8097.1093179749005;8104.068032176375;6918.515703900679;7001.964990175016;7070.68181931804;7113.324234197743;7242.275772422716;6978.616176110363;7035.613041282779;7045.26024767392;7079.185893622093;7114.004039434587;6315.210598675166;6382.808515744535;6388.8083357499345;6460.773872914426;6479.31967143462;5056.6713163644245;5057.797688092435;5071.264666623245;5082.669626474268;5143.665661731976;4946.678465899705;4996.425411077773;5001.42483614389;5031;5169.379674439091 11:38:49 INFO - PROCESS | 1637 | |4;prototype.html;351.4552443712245;363.41308786310117;363.4403019350201;370.1191165027235;371.76950290819696;4676.672632915697;5168.612354073445;5385.730713464331;5414.566834653228;5446.428125046872;4339.327404252346;5357.223202635615;5375.354957405107;5378.139497680372;5399.325084364455;3825.5026846509913;3889;3955.9208815823667;3999.4000899865036;4238.046439551107;3418.5043168740517;4160.2811459493005;4170.791460426966;4185.351270553069;4196.05588742532;3528.894133176009;4172.582741725833;4199.286121359376;4200.432941552897;4228.429162063113;4212.157568486285;4212.53662097169;4224.894377640553;4225.112726327459;4241.003364209409;2847.824675486838;3203;3297.3405318936307;3427.3488037272837;3497.3529896969144;4749.41157069398;4876.683015603974;5280.313559237313;5301.416844147141;5340.599455040849;4356.085222103362;4624.144533261324;4673.836415725467;4679.3916790816975;4849.8902977205025;5099.566536844372;5457.816873250692;5480.424555421703;5666.546676265889;5740.167675687002;3838.775428639928;3853;3870.9225815483533;3893.9026524336837;3894.435306880515;5982.8504287392725;5985.221921150222;6003.009503431928;6009.99500249875;6051.909221361683;3650.5984341722387;3902.375619900802;3918.8432462701744;3935.842566297373;3936.2127574484643;3985.362342025262;3993.0217096811466;3994.320965435883;4008.8396464141692;4025.8993525162105;4655.557722016403;4668.253079507331;4678.836240731558;4686.695364801277;4713.2458806590785;4921.384826896638;5615.410381909841;5733.598648094677;5784.4504772046585;5877.676727779927;1299.5841330774062;1302.9022823288292;1305.7127431964952;1306.5623016289649;1309.9607011789662;835.9467071489845;872.8428882801156;877.7798859585182;880.6257340630335;882.2941646682629;4078.7960601969785;4730.546700908356;4781.163296423112;5001.9499805002215;5219.739013049332;5542.115680668511;5833.649981001154;5840.912386314124;5865.824025279248;5891.793787217427;4334.631556317749;4512.9097418052115;5136.794528218904;5260.763265653055;5320.627556071116;2626.8817903194404;2785.5821626756147;2932.4574953633646;2933.0467598030727;2952.7342539171577;5008.071892321483;5221.590170653978;5546;5635.239242702182;5822.446867547576;4823.469418363977;5275.393329767049;5608.915866262009;5766.163906233573;5772.365039845614;5326.307580014573;5439.891202175934;5591.743760864774;5680;5840.766369345263;4755.643326750438;5063.924041139459;5093.714554112651;5202.97398513005;5578.497935185853;5103.285540024325;5164.32863727713;5221.295125158207;5280.392754833243;5517.275838808869;5368.785248590013;5489.85895500763;5555.583331250254;5726.74229659658;5732.426757324234;3457.9654203457644;3550.8934731958084;3706.573744019472;3716.461113138526;3756.7933763643264;4759.595434388116;5257.2902658140665;5352.759125839424;5806.2451881255165;5873.207117039145;5688.431156884444;5704.885902282014;5710.486056254957;5713.457221563945;5761.308642962871;5237.926225123917;5261.763220655156;5350.143976963667;5686.346070201815;5745.931464672798;4645.117427688729;5250.322335608791;5504.669719816824;5561.972190139023;5576.637518561281;4800.495947925418;4845.442774081026;5091;5441.863953401196;5678.375378708256;4926.852194434173;5360.65155764874;5373.9731301343245;5587.312373833251;5593.608447408642 11:38:49 INFO - PROCESS | 1637 | |5;yui.html;650.7592190889371;686.4131167851484;759.2559291893944;810.5096416667916;834.4951304460799;14567.344469498872;15345.462908798194;15444.459443919464;15477.92261038696;15541;14098.929505352484;14190.21953792541;14227.644308892282;14238.572842814707;14298.642533936656;691.9031335612993;710.1123595505618;847.8389106069827;868.3530769576658;877.903430622631;752.0824593995317;878.2052242720348;885.7342797160858;886.1847100667369;890.6570970176497;882.6954700628273;949.2500924269854;949.4018768176074;949.8717673114145;953.1040821627682;934.6915517879083;936.4240991790068;939.976500587484;943.2548286853378;946.3990366117531;711.3029231353303;712.6436781609195;712.857428514294;713.1513498936301;715.5241764226782;15155;15525.146116963675;15586.766198507032;16069.839301607068;16322.591935201595;12371.628851134481;14286.428542858273;14787.704245915129;14905.180215088165;15000.249987500581;11382.544698212061;11506.424678766029;11882.227655202385;11931.343776092312;12105.97099246565;3659.1583935694675;3778.565464971536;3796.126890815128;3833.9424908626393;3931.331673615492;90351.54824225837;105667;105833.47083264611;106173;106540;10832.837507437394;10895.073918716998;10913.290636108628;11399.943000285111;11446.656600302003;23342.766572334058;23704.64443033356;23740.169094081622;23867;24006.639900401507;7136.536125151953;7534.811629709301;7933.841323173504;7953.403494737918;8187.140350263256;4293.3130699088;4334.544872788375;4423.270160423558;4436.179306828247;4446.288593825037;3573.0888623400865;3666.871659491905;3677.7609455385314;3683.576388715332;3730.9813450933116;589.5990726306068;649.6167261315846;659.2747977225014;672.6972862212024;686.7630667419733;686.5194363945259;696.3558708195001;705.5272967112047;706.5057403591368;746.8431629357896;10192.643257485952;10354.844677329846;10356.482175891175;10566.894331056592;10662.413567253876;559.5859064292475;715.492000679513;725.6045455226808;728.7012324946746;730.8611363840853;4125.731827431207;4553.408056952575;5042.84871453857;5045.672031317952;5055.368078990126;89720.5513972426;93527.53236233775;94374.52812735892;94468.0553194473;95626.52186739021;84372;84842.30315393658;84845;85980;86599.56700216584;62725.372746271954;64980.67509662421;65468.01797973034;74767;75050;9887.406755594688;10282.948585257025;11053.668389948314;11174.608888688857;11300.152488563226;39732.2053558933;45963;46640.7667961658;48131;48264;42842.1431571373;50517;62890;65749;66102;11202.775944480902;11491.942540287246;11594.362310073027;12873.8068928968;13117.016223783063;11250.549978000789;14169.858301416854;14239.216843073731;14911;15267.694646107238;12526.248425094524;12800.487980480677;13363.331833408485;13758.65603359884;14082.22547759842;13578;13726.588202353945;14062.78905816434;14187.787183192055;14664.633384165481;12929.870701293243;13202.207867527979;13875.514356997457;14394.35225414838;14484.782728259295;11033;11126.443677816238;11177.552897883994;11573.479193436147;11632.476538555617;11083.50124244427;11185;11448.885511144781;11451.885481145415;11469.369184694922 11:38:49 INFO - PROCESS | 1637 | __end_tp_report 11:38:49 INFO - PROCESS | 1637 | __start_cc_report 11:38:49 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,366 11:38:49 INFO - PROCESS | 1637 | __end_cc_report 11:38:49 INFO - PROCESS | 1637 | __startTimestamp1485373129797__endTimestamp 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | ------- Summary: start ------- 11:38:49 INFO - PROCESS | 1637 | Number of tests: 6 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5779.25 Median:6009.61 stddev:641.94 (10.7%) stddev-sans-first:602.02 11:38:49 INFO - PROCESS | 1637 | Values: 2871.4 3377.9 3388.4 3399.0 3413.6 5710.1 5710.4 5775.0 5824.1 5867.2 4416.9 5284.3 5824.4 5855.1 5861.4 5232.3 5265.2 5285.8 5343.9 5363.1 5357.7 5364.9 5370.3 5379.5 5394.7 5314.0 5352.8 5361.2 5364.5 5369.4 5214.8 5242.6 5310.5 5314.0 5379.1 5231.7 5313.0 5353.3 5356.5 5394.8 5920.6 5971.0 5974.9 5986.1 5986.2 5544.7 6164.5 6216.3 6234.6 6242.7 6150.3 6232.5 6274.3 6274.4 6298.2 5993.1 6002.5 6009.6 6015.9 6045.3 6156.4 6162.4 6294.2 6325.4 6334.3 6158.8 6177.4 6186.6 6212.8 6315.5 5499.7 6272.6 6278.3 6283.7 6297.2 6130.9 6196.0 6301.9 6302.1 6333.2 6182.7 6236.3 6253.3 6268.9 6274.0 5040.5 5046.3 5047.4 5063.4 5070.2 4524.7 4537.9 4541.5 4549.4 4602.5 5722.2 5722.9 5818.2 5824.4 5847.7 6213.9 6257.5 6282.7 6298.1 6316.1 5739.6 5826.8 5887.4 5892.7 5901.3 5487.7 5516.2 5522.9 5582.2 5591.9 6368.7 6374.7 6378.5 6382.2 6385.5 5635.2 6198.4 6264.7 6267.4 6274.2 5754.6 6057.0 6227.0 6227.3 6271.8 6238.7 6245.3 6263.5 6289.5 6322.6 6121.4 6197.0 6223.9 6265.1 6300.0 5165.4 6121.0 6127.3 6155.3 6240.0 6209.6 6224.1 6224.4 6237.7 6242.9 5958.6 5990.3 6010.7 6051.1 6063.6 5104.6 5144.8 6003.0 6128.9 6178.8 6054.9 6061.5 6087.5 6096.1 6102.7 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69879.57 Median:37604.62 stddev:151085.27 (401.8%) stddev-sans-first:151419.12 11:38:49 INFO - PROCESS | 1637 | Values: 430.3 460.1 460.4 472.1 534.5 39273.0 42798.6 42910.4 42916.4 43008.0 43593.1 44308.3 44338.3 44446.1 44446.8 7452.7 7567.0 7591.2 7626.8 8478.8 8464.4 11202.8 11457.3 11468.0 11637.3 11458.8 11517.3 11522.0 11525.3 11542.3 11368.3 11447.8 11449.7 11453.5 11465.9 11321.4 11413.3 11420.0 11432.8 11433.6 41654.2 42080.9 42113.9 42149.0 42194.6 3957.4 4016.2 4016.3 4104.3 4205.2 30336.9 30488.5 30896.8 30974.5 31370.5 2596.5 3164.7 3230.2 3232.5 3234.8 435723.0 516651.0 518526.0 518606.0 518694.0 57398.0 57585.4 57625.1 57640.7 57672.7 55847.4 61163.0 61476.1 61624.4 61937.1 15957.1 16235.7 16237.7 16255.1 16266.2 10243.6 11392.4 11666.4 12557.4 12673.1 15713.1 18533.8 18544.4 18566.0 18654.6 7291.2 7531.5 7898.3 8007.6 8079.7 737.1 763.6 896.7 897.5 936.5 29148.6 29750.0 30733.8 30948.0 31304.0 1030.2 1054.4 1056.4 1070.3 1084.9 13401.7 13816.9 14014.6 14977.0 15024.5 635597.0 636078.0 638851.0 639061.0 639103.0 52314.7 52708.7 53037.0 53169.0 53296.7 1426.9 1431.6 1463.4 1463.8 1464.6 27133.5 27384.8 28975.0 29954.4 30191.5 53760.5 54261.7 54345.5 54387.0 54484.5 545472.0 549114.0 549554.0 551139.0 551382.0 40386.6 40678.4 41212.8 41254.8 41269.2 39982.6 43721.6 44352.8 45146.0 45199.0 35051.8 36728.6 36773.1 36836.0 37371.0 36954.8 37079.0 37838.2 37841.8 38082.8 31914.0 34136.8 35886.8 36143.6 36518.1 30350.7 33428.8 33454.7 33468.8 33702.7 24693.6 25031.7 25084.9 25091.1 25394.9 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:41227.89 Median:21210.79 stddev:123563.34 (582.5%) stddev-sans-first:123871.80 11:38:49 INFO - PROCESS | 1637 | Values: 326.5 360.0 398.2 406.5 429.6 19103.5 20337.9 20858.7 21086.3 21104.8 20669.9 20862.3 21316.8 21440.6 21636.2 5750.1 5859.4 5880.8 5933.7 5969.9 4204.7 4412.6 5808.3 5940.6 5951.2 6272.9 6523.0 6588.8 6633.8 6638.7 6402.7 6547.8 6621.1 6631.0 6643.6 5768.7 5801.1 5819.7 5830.7 5839.8 25377.5 25406.6 25415.0 25423.7 25457.9 2783.2 2793.8 2793.9 2796.4 2828.3 10355.8 12500.7 14991.1 15363.6 15497.4 1852.5 1890.2 1902.3 1907.8 1908.1 149247.0 149822.5 151177.0 152190.5 152302.2 12046.0 12120.3 12137.7 12194.8 12305.0 12945.4 15666.8 15683.8 15683.9 15693.6 8752.8 9025.1 9031.0 9066.0 9091.2 8796.9 8798.0 8813.0 8956.8 8969.6 4806.3 4816.9 4881.9 4891.1 4898.0 1680.6 1787.3 2042.6 2092.0 2095.4 1001.8 1020.5 1034.0 1044.2 1075.3 18749.3 20317.7 20538.4 20939.2 21325.0 811.1 1033.4 1041.2 1068.5 1068.7 10628.5 11042.2 11044.8 11045.6 11058.4 713185.0 715778.0 737764.0 760026.0 767484.0 144651.0 147065.8 147798.0 152352.0 157974.0 861.8 866.3 1026.6 1055.8 1063.9 19001.9 19100.0 19317.6 19355.4 19589.4 53908.2 61770.0 61904.5 62455.7 63088.7 83780.6 89349.6 92437.8 92967.5 95890.6 7307.9 7468.7 7551.7 7691.9 7807.4 7774.6 10830.0 11787.9 13321.1 13352.7 10491.5 11109.4 11307.7 11367.4 11381.9 10519.4 11060.2 11170.7 11240.6 11421.9 9137.7 10850.7 11438.4 11671.0 11940.3 6521.4 7397.4 8172.6 8247.0 8485.7 11007.3 11373.8 11462.3 11601.4 11624.7 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5429.85 Median:5181.30 stddev:2932.04 (56.6%) stddev-sans-first:2923.90 11:38:49 INFO - PROCESS | 1637 | Values: 1308.6 1442.5 1454.7 1455.4 1461.1 7427.1 7674.6 8075.4 8476.7 8517.5 8004.8 8144.9 8317.0 8371.5 8384.6 2258.4 2286.3 2297.5 2300.2 2306.1 1958.7 2045.3 2323.5 2342.4 2344.4 2081.0 2247.6 2308.2 2309.7 2312.8 2264.3 2279.0 2282.2 2290.9 2292.9 2297.7 2299.0 2322.7 2323.0 2323.7 6734.5 8070.0 8254.2 8281.3 8397.4 5035.4 5193.2 5199.1 5207.3 5211.2 3387.2 3453.6 3484.7 3514.2 3559.4 1212.8 1213.9 1250.3 1258.2 1270.9 10732.6 10744.1 10777.7 10782.6 10804.9 4383.5 4642.1 4701.6 4712.3 4714.3 9520.3 9591.8 9614.3 9617.1 9623.5 4916.7 4977.5 4986.3 5000.6 5027.0 4461.8 4540.1 4554.7 4597.5 4710.6 3871.8 3903.3 3954.4 3958.8 3977.0 1169.8 1262.7 1265.1 1265.9 1276.4 821.8 905.6 906.9 936.1 950.8 5603.3 5646.7 5649.2 5652.2 5740.9 1010.3 1020.8 1022.3 1027.0 1033.8 3786.7 3824.0 3850.1 3853.8 3869.0 8414.4 9580.9 9934.3 9936.0 9952.2 9880.2 9886.7 9888.5 9892.6 9913.6 7461.6 7683.5 7850.3 7917.3 7918.0 5713.5 5721.7 5864.0 5872.9 5889.5 8903.3 8983.8 9195.7 9319.1 9321.4 9110.0 9210.4 9319.3 9350.2 9491.8 6422.5 6967.9 7266.7 7904.0 7909.4 7825.9 8075.9 8084.7 8097.1 8104.1 6918.5 7002.0 7070.7 7113.3 7242.3 6978.6 7035.6 7045.3 7079.2 7114.0 6315.2 6382.8 6388.8 6460.8 6479.3 5056.7 5057.8 5071.3 5082.7 5143.7 4946.7 4996.4 5001.4 5031.0 5169.4 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4515.40 Median:5092.36 stddev:1370.11 (26.9%) stddev-sans-first:1337.84 11:38:49 INFO - PROCESS | 1637 | Values: 351.5 363.4 363.4 370.1 371.8 4676.7 5168.6 5385.7 5414.6 5446.4 4339.3 5357.2 5375.4 5378.1 5399.3 3825.5 3889.0 3955.9 3999.4 4238.0 3418.5 4160.3 4170.8 4185.4 4196.1 3528.9 4172.6 4199.3 4200.4 4228.4 4212.2 4212.5 4224.9 4225.1 4241.0 2847.8 3203.0 3297.3 3427.3 3497.4 4749.4 4876.7 5280.3 5301.4 5340.6 4356.1 4624.1 4673.8 4679.4 4849.9 5099.6 5457.8 5480.4 5666.5 5740.2 3838.8 3853.0 3870.9 3893.9 3894.4 5982.9 5985.2 6003.0 6010.0 6051.9 3650.6 3902.4 3918.8 3935.8 3936.2 3985.4 3993.0 3994.3 4008.8 4025.9 4655.6 4668.3 4678.8 4686.7 4713.2 4921.4 5615.4 5733.6 5784.5 5877.7 1299.6 1302.9 1305.7 1306.6 1310.0 835.9 872.8 877.8 880.6 882.3 4078.8 4730.5 4781.2 5001.9 5219.7 5542.1 5833.6 5840.9 5865.8 5891.8 4334.6 4512.9 5136.8 5260.8 5320.6 2626.9 2785.6 2932.5 2933.0 2952.7 5008.1 5221.6 5546.0 5635.2 5822.4 4823.5 5275.4 5608.9 5766.2 5772.4 5326.3 5439.9 5591.7 5680.0 5840.8 4755.6 5063.9 5093.7 5203.0 5578.5 5103.3 5164.3 5221.3 5280.4 5517.3 5368.8 5489.9 5555.6 5726.7 5732.4 3458.0 3550.9 3706.6 3716.5 3756.8 4759.6 5257.3 5352.8 5806.2 5873.2 5688.4 5704.9 5710.5 5713.5 5761.3 5237.9 5261.8 5350.1 5686.3 5745.9 4645.1 5250.3 5504.7 5562.0 5576.6 4800.5 4845.4 5091.0 5441.9 5678.4 4926.9 5360.7 5374.0 5587.3 5593.6 11:38:49 INFO - PROCESS | 1637 | 11:38:49 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19505.48 Median:3815.03 stddev:27181.20 (712.5%) stddev-sans-first:27220.58 11:38:49 INFO - PROCESS | 1637 | Values: 650.8 686.4 759.3 810.5 834.5 14567.3 15345.5 15444.5 15477.9 15541.0 14098.9 14190.2 14227.6 14238.6 14298.6 691.9 710.1 847.8 868.4 877.9 752.1 878.2 885.7 886.2 890.7 882.7 949.3 949.4 949.9 953.1 934.7 936.4 940.0 943.3 946.4 711.3 712.6 712.9 713.2 715.5 15155.0 15525.1 15586.8 16069.8 16322.6 12371.6 14286.4 14787.7 14905.2 15000.2 11382.5 11506.4 11882.2 11931.3 12106.0 3659.2 3778.6 3796.1 3833.9 3931.3 90351.5 105667.0 105833.5 106173.0 106540.0 10832.8 10895.1 10913.3 11399.9 11446.7 23342.8 23704.6 23740.2 23867.0 24006.6 7136.5 7534.8 7933.8 7953.4 8187.1 4293.3 4334.5 4423.3 4436.2 4446.3 3573.1 3666.9 3677.8 3683.6 3731.0 589.6 649.6 659.3 672.7 686.8 686.5 696.4 705.5 706.5 746.8 10192.6 10354.8 10356.5 10566.9 10662.4 559.6 715.5 725.6 728.7 730.9 4125.7 4553.4 5042.8 5045.7 5055.4 89720.6 93527.5 94374.5 94468.1 95626.5 84372.0 84842.3 84845.0 85980.0 86599.6 62725.4 64980.7 65468.0 74767.0 75050.0 9887.4 10282.9 11053.7 11174.6 11300.2 39732.2 45963.0 46640.8 48131.0 48264.0 42842.1 50517.0 62890.0 65749.0 66102.0 11202.8 11491.9 11594.4 12873.8 13117.0 11250.5 14169.9 14239.2 14911.0 15267.7 12526.2 12800.5 13363.3 13758.7 14082.2 13578.0 13726.6 14062.8 14187.8 14664.6 12929.9 13202.2 13875.5 14394.4 14484.8 11033.0 11126.4 11177.6 11573.5 11632.5 11083.5 11185.0 11448.9 11451.9 11469.4 11:38:49 INFO - PROCESS | 1637 | -------- Summary: end -------- 11:38:49 INFO - PROCESS | 1637 | 11:38:50 INFO - TEST-INFO | 1637: exit 0 11:38:50 INFO - TEST-OK | dromaeo_css | took 1115468ms 11:38:50 INFO - TEST-START | kraken 11:38:50 INFO - operating with platform_type : mac_ 11:38:50 INFO - Initialising browser for kraken test... 11:38:50 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpm4IyAS/profile http://localhost:49241/getInfo.html) 11:38:53 INFO - PROCESS | 1650 | 2017-01-25 11:38:53.303 plugin-container[1651:9996] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 11:38:53 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:53 INFO - PROCESS | 1650 | 2017-01-25 11:38:53.305 plugin-container[1651:9996] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 11:38:53 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:53 INFO - PROCESS | 1650 | 2017-01-25 11:38:53.305 plugin-container[1651:9996] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:38:53 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 11:38:53 INFO - PROCESS | 1650 | colorDepth:24 11:38:53 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 11:38:53 INFO - PROCESS | 1650 | __metrics 11:38:53 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 11:38:53 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 11:38:54 INFO - TEST-INFO | 1650: exit 0 11:38:54 INFO - Browser initialized. 11:38:54 INFO - Running cycle 1/1 for kraken test... 11:38:54 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpm4IyAS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:56 INFO - PROCESS | 1652 | 2017-01-25 11:38:56.697 plugin-container[1653:10128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 11:38:56 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:56 INFO - PROCESS | 1652 | 2017-01-25 11:38:56.698 plugin-container[1653:10128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 11:38:56 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:56 INFO - PROCESS | 1652 | 2017-01-25 11:38:56.698 plugin-container[1653:10128] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:39:06 INFO - PROCESS | 1652 | RSS: Main: 218349568 11:39:06 INFO - PROCESS | 1652 | 11:39:09 INFO - PROCESS | 1652 | 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) 11:39:10 INFO - PROCESS | 1652 | RSS: Main: 232644608 11:39:10 INFO - PROCESS | 1652 | 11:39:13 INFO - PROCESS | 1652 | 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) 11:39:13 INFO - PROCESS | 1652 | RSS: Main: 240508928 11:39:13 INFO - PROCESS | 1652 | 11:39:16 INFO - PROCESS | 1652 | 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) 11:39:17 INFO - PROCESS | 1652 | RSS: Main: 244289536 11:39:17 INFO - PROCESS | 1652 | 11:39:19 INFO - PROCESS | 1652 | 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) 11:39:20 INFO - PROCESS | 1652 | RSS: Main: 244539392 11:39:20 INFO - PROCESS | 1652 | 11:39:22 INFO - PROCESS | 1652 | 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) 11:39:22 INFO - PROCESS | 1652 | RSS: Main: 244666368 11:39:22 INFO - PROCESS | 1652 | 11:39:25 INFO - PROCESS | 1652 | 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) 11:39:26 INFO - PROCESS | 1652 | RSS: Main: 250044416 11:39:26 INFO - PROCESS | 1652 | 11:39:29 INFO - PROCESS | 1652 | 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) 11:39:30 INFO - PROCESS | 1652 | RSS: Main: 249225216 11:39:30 INFO - PROCESS | 1652 | 11:39:32 INFO - PROCESS | 1652 | 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) 11:39:33 INFO - PROCESS | 1652 | RSS: Main: 249712640 11:39:33 INFO - PROCESS | 1652 | 11:39:35 INFO - PROCESS | 1652 | 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) 11:39:35 INFO - PROCESS | 1652 | RSS: Main: 248483840 11:39:35 INFO - PROCESS | 1652 | 11:39:37 INFO - PROCESS | 1652 | 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) 11:39:38 INFO - PROCESS | 1652 | RSS: Main: 248623104 11:39:38 INFO - PROCESS | 1652 | 11:39:40 INFO - PROCESS | 1652 | 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) 11:39:41 INFO - PROCESS | 1652 | RSS: Main: 248647680 11:39:41 INFO - PROCESS | 1652 | 11:39:44 INFO - PROCESS | 1652 | 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) 11:39:45 INFO - PROCESS | 1652 | RSS: Main: 249053184 11:39:45 INFO - PROCESS | 1652 | 11:39:48 INFO - PROCESS | 1652 | 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) 11:39:48 INFO - PROCESS | 1652 | RSS: Main: 249225216 11:39:48 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | 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) 11:39:50 INFO - PROCESS | 1652 | RSS: Main: 251109376 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | __start_tp_report 11:39:50 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 11:39:50 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 11:39:50 INFO - PROCESS | 1652 | |i|pagename|runs| 11:39:50 INFO - PROCESS | 1652 | |0;ai-astar;106;119;121;119;134;176;159;118;119;119 11:39:50 INFO - PROCESS | 1652 | |1;audio-beat-detection;146;116;114;145;113;115;114;99;166;144 11:39:50 INFO - PROCESS | 1652 | |2;audio-dft;193;195;195;195;193;195;203;191;196;196 11:39:50 INFO - PROCESS | 1652 | |3;audio-fft;80;60;59;88;71;86;82;84;97;60 11:39:50 INFO - PROCESS | 1652 | |4;audio-oscillator;85;64;87;103;102;103;94;70;69;82 11:39:50 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;89;88;89;88;92;102;91;88;90;89 11:39:50 INFO - PROCESS | 1652 | |6;imaging-darkroom;142;128;152;112;95;95;95;100;106;91 11:39:50 INFO - PROCESS | 1652 | |7;imaging-desaturate;92;97;92;93;93;95;93;97;91;91 11:39:50 INFO - PROCESS | 1652 | |8;json-parse-financial;61;58;60;60;63;64;64;64;64;61 11:39:50 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;72;83;70;106;111;101;83;71;70;70 11:39:50 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;85;85;95;104;106;109;83;87;86 11:39:50 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;143;149;152;163;135;163;156;160;201;171 11:39:50 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;172;216;228;215;228;183;174;207;168;170 11:39:50 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;62;78;89;85;87;83;88;60;72;87 11:39:50 INFO - PROCESS | 1652 | __end_tp_report 11:39:50 INFO - PROCESS | 1652 | __start_cc_report 11:39:50 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,939 11:39:50 INFO - PROCESS | 1652 | __end_cc_report 11:39:50 INFO - PROCESS | 1652 | __startTimestamp1485373190969__endTimestamp 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | ------- Summary: start ------- 11:39:50 INFO - PROCESS | 1652 | Number of tests: 14 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:129.00 Median:120.00 stddev:21.73 (18.1%) stddev-sans-first:21.39 11:39:50 INFO - PROCESS | 1652 | Values: 106.0 119.0 121.0 119.0 134.0 176.0 159.0 118.0 119.0 119.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:144.50 stddev:21.29 (14.7%) stddev-sans-first:21.46 11:39:50 INFO - PROCESS | 1652 | Values: 146.0 116.0 114.0 145.0 113.0 115.0 114.0 99.0 166.0 144.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:195.20 Median:195.00 stddev:3.16 (1.6%) stddev-sans-first:3.24 11:39:50 INFO - PROCESS | 1652 | Values: 193.0 195.0 195.0 195.0 193.0 195.0 203.0 191.0 196.0 196.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:76.70 Median:83.00 stddev:13.43 (16.2%) stddev-sans-first:14.19 11:39:50 INFO - PROCESS | 1652 | Values: 80.0 60.0 59.0 88.0 71.0 86.0 82.0 84.0 97.0 60.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:76.00 stddev:14.70 (19.3%) stddev-sans-first:15.59 11:39:50 INFO - PROCESS | 1652 | Values: 85.0 64.0 87.0 103.0 102.0 103.0 94.0 70.0 69.0 82.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:89.00 stddev:4.22 (4.7%) stddev-sans-first:4.44 11:39:50 INFO - PROCESS | 1652 | Values: 89.0 88.0 89.0 88.0 92.0 102.0 91.0 88.0 90.0 89.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:121.50 stddev:21.71 (17.9%) stddev-sans-first:20.05 11:39:50 INFO - PROCESS | 1652 | Values: 142.0 128.0 152.0 112.0 95.0 95.0 95.0 100.0 106.0 91.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:93.00 stddev:2.22 (2.4%) stddev-sans-first:2.30 11:39:50 INFO - PROCESS | 1652 | Values: 92.0 97.0 92.0 93.0 93.0 95.0 93.0 97.0 91.0 91.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:63.50 stddev:2.18 (3.4%) stddev-sans-first:2.29 11:39:50 INFO - PROCESS | 1652 | Values: 61.0 58.0 60.0 60.0 63.0 64.0 64.0 64.0 64.0 61.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:83.70 Median:70.50 stddev:16.34 (23.2%) stddev-sans-first:16.78 11:39:50 INFO - PROCESS | 1652 | Values: 72.0 83.0 70.0 106.0 111.0 101.0 83.0 71.0 70.0 70.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:85.50 stddev:10.06 (11.8%) stddev-sans-first:10.38 11:39:50 INFO - PROCESS | 1652 | Values: 86.0 85.0 85.0 95.0 104.0 106.0 109.0 83.0 87.0 86.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:159.30 Median:161.50 stddev:18.04 (11.2%) stddev-sans-first:18.15 11:39:50 INFO - PROCESS | 1652 | Values: 143.0 149.0 152.0 163.0 135.0 163.0 156.0 160.0 201.0 171.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.10 Median:211.00 stddev:24.99 (11.8%) stddev-sans-first:24.93 11:39:50 INFO - PROCESS | 1652 | Values: 172.0 216.0 228.0 215.0 228.0 183.0 174.0 207.0 168.0 170.0 11:39:50 INFO - PROCESS | 1652 | 11:39:50 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:86.00 stddev:10.86 (12.6%) stddev-sans-first:9.59 11:39:50 INFO - PROCESS | 1652 | Values: 62.0 78.0 89.0 85.0 87.0 83.0 88.0 60.0 72.0 87.0 11:39:50 INFO - PROCESS | 1652 | -------- Summary: end -------- 11:39:50 INFO - PROCESS | 1652 | 11:39:51 INFO - TEST-INFO | 1652: exit 0 11:39:51 INFO - TEST-OK | kraken | took 61431ms 11:39:51 INFO - SUITE-END | took 1176s 11:39:52 INFO - Completed test suite (00:19:37) 11:39:52 INFO - javascript benchmark 11:39:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.221805406439, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2871.353945362293, 3377.915552111195, 3388.356212319659, 3399.0482664853844, 3413.624501304856, 5710.143478478225, 5710.400407957167, 5775.0, 5824.126381042845, 5867.178594996704, 4416.873697207207, 5284.260203571494, 5824.446677565625, 5855.092460668592, 5861.3552509223955, 5232.3459567554055, 5265.236540701596, 5285.7885684572575, 5343.866403339928, 5363.141897296433, 5357.678539287655, 5364.946350536484, 5370.2750128732705, 5379.462053794628, 5394.676319420828, 5314.043472175007, 5352.839414817562, 5361.249425080492, 5364.517193452589, 5369.40936496985, 5214.765335559909, 5242.580593552507, 5310.522053015208, 5313.973430132824, 5379.139337705968, 5231.659942103751, 5312.9734351328, 5353.330833645794, 5356.491133342326, 5394.811181608664, 5920.585559010871, 5971.014782560872, 5974.940250597482, 5986.102084687288, 5986.221791167164, 5544.667319960775, 6164.476019538344, 6216.316205217422, 6234.594751341148, 6242.719077641472, 6150.292716337589, 6232.470240029603, 6274.2784579773, 6274.403931626488, 6298.1812364392335, 5993.101034844764, 6002.519798416116, 6009.609375390585, 6015.892731544521, 6045.33501314855, 6156.415140561639, 6162.383761623892, 6294.213223347082, 6325.430711236011, 6334.3032266450655, 6158.784442544579, 6177.382261773877, 6186.566940314135, 6212.844678883064, 6315.5263355247625, 5499.697516636624, 6272.560920735505, 6278.340774218733, 6283.6858157091965, 6297.2128483939505, 6130.887362651087, 6196.039613859859, 6301.9286721257495, 6302.1492098566105, 6333.240011198685, 6182.6599537024995, 6236.345183755731, 6253.280872699606, 6268.905966410507, 6274.0, 5040.47075057121, 5046.268291097844, 5047.4447810740785, 5063.443021267658, 5070.188769796815, 4524.728516289033, 4537.909241815211, 4541.455025396974, 4549.363089167519, 4602.470715867718, 5722.170285308607, 5722.941255867678, 5818.185454036438, 5824.388439213822, 5847.736851841677, 6213.906791398133, 6257.530685198628, 6282.748690052346, 6298.118263443122, 6316.115743795872, 5739.569532285095, 5826.79606213789, 5887.411258874078, 5892.734826932799, 5901.29184497863, 5487.725613719378, 5516.227728118067, 5522.91715624266, 5582.218489411485, 5591.944080559224, 6368.681565921778, 6374.681265936777, 6378.489720822416, 6382.234131904202, 6385.45723613498, 5635.182898479779, 6198.442140207403, 6264.655443950626, 6267.4045965633195, 6274.215723034621, 5754.56840736938, 6057.0, 6226.972549529277, 6227.314995350417, 6271.839709653728, 6238.6880655967925, 6245.344238855037, 6263.530235232467, 6289.528285378524, 6322.557420980671, 6121.387861213843, 6196.969015155076, 6223.906641400292, 6265.122882796321, 6299.96850015747, 5165.405978312542, 6121.0, 6127.250613123855, 6155.292141403616, 6240.032794916795, 6209.59637623553, 6224.06639004153, 6224.408681175281, 6237.688115594293, 6242.875142497034, 5958.553108516792, 5990.281166260077, 6010.699465026819, 6051.12258722474, 6063.636181829104, 5104.642675012862, 5144.794208231779, 6002.969985150221, 6128.86980888409, 6178.783742568989, 6054.878902422015, 6061.545384096298, 6087.512998959984, 6096.055111457731, 6102.694865256808], "value": 5739.204917296968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.27069117845224, 460.0683615678251, 460.4267686730021, 472.0605994071796, 534.5029122915687, 39273.0, 42798.572014279845, 42910.35634465478, 42916.356254656166, 43008.0, 43593.128137437234, 44308.3353749694, 44338.33492497615, 44446.11107777851, 44446.777766111125, 7452.701891924316, 7567.0, 7591.24087591242, 7626.847463050735, 8478.830423391528, 8464.365172612048, 11202.775944481145, 11457.312561246352, 11468.0, 11637.30176189427, 11458.828117578243, 11517.308961462297, 11522.0, 11525.2508586942, 11542.307461552291, 11368.261063030917, 11447.771044579145, 11449.713757156096, 11453.541858325658, 11465.942670286595, 11321.377324247163, 11413.258138220988, 11420.0, 11432.771344573144, 11433.59982400612, 41654.1669166618, 42080.94797630053, 42113.947151321154, 42149.0, 42194.578054219375, 3957.3668213085766, 4016.2168377166463, 4016.3373043448087, 4104.261232978063, 4205.243056249874, 30336.938207162642, 30488.54267185994, 30896.845515772504, 30974.53538196929, 31370.52944205816, 2596.5456045192204, 3164.6677098904743, 3230.1601583588435, 3232.531282963957, 3234.8059116453087, 435723.0, 516651.0, 518525.9999999962, 518606.0, 518694.0, 57398.0, 57585.42414575884, 57625.13562296569, 57640.71179644159, 57672.711636442385, 55847.44152558504, 61163.0, 61476.077858832155, 61624.383756161864, 61937.070943935876, 15957.122358270175, 16235.675286494205, 16237.675246495004, 16255.10596917181, 16266.18669066542, 10243.641472548425, 11392.373419462008, 11666.416679166008, 12557.372131393393, 12673.112882098165, 15713.057216567042, 18533.81466185321, 18544.443666690022, 18566.0, 18654.626907462047, 7291.197968223491, 7531.510451820724, 7898.328642065374, 8007.599620018976, 8079.717209897743, 737.1485933746532, 763.6258233465562, 896.6547879066607, 897.4929165021741, 936.4662142578665, 29148.562771558445, 29750.0, 30733.846330768203, 30948.0, 31304.0, 1030.2324768047852, 1054.4095306628312, 1056.413690401819, 1070.261519551507, 1084.924055316136, 13401.731965360637, 13816.93091534556, 14014.579562613138, 14977.0, 15024.501356191327, 635597.0, 636078.0, 638851.0, 639061.0, 639103.0, 52314.738426307624, 52708.73645631747, 53037.0, 53169.0, 53296.73351633217, 1426.892983026277, 1431.5633731711719, 1463.4292625875703, 1463.780432935047, 1464.6265202373327, 27133.457330852878, 27384.7676854546, 28975.0, 29954.400911981204, 30191.547126792677, 53760.46239537554, 54261.72869135787, 54345.45654543562, 54387.0, 54484.45515544794, 545472.0, 549114.0, 549554.0, 551139.0, 551382.0, 40386.59613403946, 40678.38982415207, 41212.793936030124, 41254.79372603118, 41269.1746165069, 39982.600608978544, 43721.56278437175, 44352.778236108614, 45146.0, 45199.0, 35051.82474087613, 36728.63271367252, 36773.08067298339, 36836.0, 37371.0, 36954.815225923696, 37079.0, 37838.24323513569, 37841.81079094587, 38082.809585951894, 31914.0, 34136.82931585326, 35886.820565897004, 36143.63856361508, 36518.08704782402, 30350.696493034786, 33428.83285583654, 33454.665453346126, 33468.832655836566, 33702.662973370934, 24693.62959555572, 25031.74968250294, 25084.874575627004, 25091.121810737266, 25394.873025634755], "value": 20187.775217001705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.50045430491326, 359.98200089995504, 398.22743876878855, 406.5101552629082, 429.56184691614556, 19103.52241193971, 20337.898310508463, 20858.687119693215, 21086.261980830674, 21104.788952110473, 20669.896650516763, 20862.269820556285, 21316.786832131675, 21440.571188576218, 21636.2427315044, 5750.108733146369, 5859.355470898197, 5880.823835232949, 5933.732982015819, 5969.910451343233, 4204.726692764961, 4412.624926881219, 5808.273965754281, 5940.6435613863305, 5951.226340575719, 6272.937270627303, 6523.0, 6588.8023359299295, 6633.834154146137, 6638.6680665966505, 6402.711877965503, 6547.770828020996, 6621.073049773036, 6631.0, 6643.6346000969925, 5768.653880767168, 5801.129830525413, 5819.67991760453, 5830.650160990312, 5839.824805255849, 25377.49245015108, 25406.61890071632, 25415.0, 25423.74576254251, 25457.872710636515, 2783.2067860659613, 2793.8044336896423, 2793.8603069846426, 2796.356837927268, 2828.3070647691243, 10355.792884142274, 12500.74998500025, 14991.100533967996, 15363.615909602238, 15497.380104795795, 1852.4627857921187, 1890.206113432348, 1902.2676269636152, 1907.7996810334853, 1908.1413363986123, 149247.0150596982, 149822.50177498194, 151177.0, 152190.47809521985, 152302.23848880795, 12046.0, 12120.27278363301, 12137.696557585954, 12194.817077743663, 12305.015598752077, 12945.352732363344, 15666.843331566766, 15683.843161568466, 15683.902126851239, 15693.607659808597, 8752.824943501095, 9025.05236950124, 9031.0, 9065.954670226607, 9091.181793638605, 8796.91203087961, 8797.956010219908, 8812.986506551828, 8956.776080597907, 8969.641214351483, 4806.255030470283, 4816.903661926742, 4881.926771098437, 4891.119598472309, 4897.951020489821, 1680.5630536060712, 1787.320818089118, 2042.611903738285, 2091.9581608368053, 2095.3923362225087, 1001.8096561653408, 1020.505055048301, 1034.002187888691, 1044.1594516414207, 1075.3386667199616, 18749.34377296788, 20317.695234571493, 20538.38384848457, 20939.16243350249, 21325.008464280712, 811.1199348706601, 1033.3851358441716, 1041.1982773264544, 1068.503146037081, 1068.6687126990657, 10628.468576571295, 11042.227044106836, 11044.779104417867, 11045.558177672803, 11058.447077646086, 713185.0, 715778.0, 737764.0, 760026.0, 767484.0, 144651.0, 147065.81919209944, 147798.0, 152352.0, 157974.0, 861.8233262181363, 866.3026263857529, 1026.5637104230673, 1055.7835643693024, 1063.8882917293727, 19001.904990475512, 19100.044997749777, 19317.61364772725, 19355.4193374199, 19589.412317630493, 53908.19137713016, 61770.0, 61904.452388690646, 62455.6877215611, 63088.68455657876, 83780.58109709657, 89349.55325223332, 92437.76467823863, 92967.53516232646, 95890.56164157404, 7307.903814427878, 7468.738594149178, 7551.697932082655, 7691.884621730566, 7807.375409967075, 7774.611269436393, 10830.025297723243, 11787.882121178678, 13321.13412628176, 13352.732945341233, 10491.475426228812, 11109.444527773741, 11307.717307067389, 11367.431628418712, 11381.943090284496, 10519.368837869752, 11060.225784195029, 11170.664880053286, 11240.606578769704, 11421.885781142082, 9137.680181193626, 10850.67447976562, 11438.428078596204, 11671.0, 11940.283582985048, 6521.380468855451, 7397.445191610543, 8172.610656188581, 8246.958765206136, 8485.660573576988, 11007.284526505751, 11373.772524549628, 11462.254953428, 11601.419929003685, 11624.651260461862], "value": 10090.858011903856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.5747132182041, 1442.4590778458078, 1454.6654269518003, 1455.352368196153, 1461.0649184521903, 7427.071616047994, 7674.57789821561, 8075.4347195696255, 8476.703315383962, 8517.488950662964, 8004.759857204279, 8144.877826832602, 8317.0, 8371.455855369397, 8384.580770961458, 2258.378945789913, 2286.2798218561184, 2297.517521320525, 2300.2409204962323, 2306.123673004256, 1958.6572349838793, 2045.3250427358935, 2323.453988312745, 2342.4495243617735, 2344.4490544721975, 2080.990719501041, 2247.5729611373868, 2308.203669733939, 2309.722833260011, 2312.7802858728396, 2264.252796577142, 2278.9886050569726, 2282.2354511238755, 2290.8510946788406, 2292.9337857896076, 2297.7242730872235, 2298.9655155172686, 2322.6516022596575, 2322.953540929189, 2323.6630688550067, 6734.46124310054, 8069.9509063821915, 8254.215849494289, 8281.337493000545, 8397.412181147321, 5035.395752509722, 5193.221016847466, 5199.14214154664, 5207.270982062514, 5211.166213405875, 3387.1870751019824, 3453.620101788801, 3484.703800176988, 3514.2221122928518, 3559.430491121434, 1212.8423304970386, 1213.8907498325104, 1250.3310728760162, 1258.2199036597276, 1270.9324167699176, 10732.624358147428, 10744.140468762558, 10777.730556736144, 10782.56869725218, 10804.891951080468, 4383.49589797171, 4642.094791515622, 4701.553352431513, 4712.293156026555, 4714.339992401066, 9520.285978551636, 9591.808163836684, 9614.278929080347, 9617.086376794194, 9623.518824058909, 4916.72957987307, 4977.477364876709, 4986.326845875833, 5000.599952003831, 5027.0, 4461.7992190351515, 4540.069285796404, 4554.681172317973, 4597.4712908015335, 4710.646701497401, 3871.7870517121264, 3903.33643280643, 3954.367301231789, 3958.782266975344, 3977.025628720982, 1169.7952858249942, 1262.665393670678, 1265.1397050006085, 1265.9177153484993, 1276.3554405025402, 821.8191997760483, 905.5924833824805, 906.8957069937042, 936.1200471556715, 950.7640067911825, 5603.299587551556, 5646.71766411686, 5649.180868774005, 5652.152177173457, 5740.885182296414, 1010.2524132142162, 1020.7750699161037, 1022.3284929140908, 1027.0499787696351, 1033.751899544104, 3786.678132358725, 3823.9617603823604, 3850.0567360996174, 3853.807309634507, 3869.0, 8414.410991230556, 9580.856287155699, 9934.304598678023, 9935.950320248352, 9952.203823694088, 9880.209583233323, 9886.653967111117, 9888.505574721235, 9892.60429582823, 9913.553890074963, 7461.552306861606, 7683.462157649023, 7850.332721718603, 7917.2874441300555, 7917.960410198028, 5713.514351280188, 5721.713914304351, 5864.0, 5872.911906321494, 5889.528837692888, 8903.287736981156, 8983.820323593362, 9195.724128276162, 9319.068093190626, 9321.394109382869, 9110.0, 9210.355275130676, 9319.301052421231, 9350.205232555309, 9491.810163796823, 6422.518311126778, 6967.930320696931, 7266.6729997151315, 7903.960480197792, 7909.406794490551, 7825.921740782519, 8075.919240807517, 8084.717034903751, 8097.1093179749005, 8104.068032176375, 6918.515703900679, 7001.964990175016, 7070.68181931804, 7113.324234197743, 7242.275772422716, 6978.616176110363, 7035.613041282779, 7045.26024767392, 7079.185893622093, 7114.004039434587, 6315.210598675166, 6382.808515744535, 6388.8083357499345, 6460.773872914426, 6479.31967143462, 5056.6713163644245, 5057.797688092435, 5071.264666623245, 5082.669626474268, 5143.665661731976, 4946.678465899705, 4996.425411077773, 5001.42483614389, 5031.0, 5169.379674439091], "value": 4430.8546949710735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4552443712245, 363.41308786310117, 363.4403019350201, 370.1191165027235, 371.76950290819696, 4676.672632915697, 5168.612354073445, 5385.730713464331, 5414.566834653228, 5446.428125046872, 4339.327404252346, 5357.223202635615, 5375.354957405107, 5378.139497680372, 5399.325084364455, 3825.5026846509913, 3889.0, 3955.9208815823667, 3999.4000899865036, 4238.046439551107, 3418.5043168740517, 4160.2811459493005, 4170.791460426966, 4185.351270553069, 4196.05588742532, 3528.894133176009, 4172.582741725833, 4199.286121359376, 4200.432941552897, 4228.429162063113, 4212.157568486285, 4212.53662097169, 4224.894377640553, 4225.112726327459, 4241.003364209409, 2847.824675486838, 3203.0, 3297.3405318936307, 3427.3488037272837, 3497.3529896969144, 4749.41157069398, 4876.683015603974, 5280.313559237313, 5301.416844147141, 5340.599455040849, 4356.085222103362, 4624.144533261324, 4673.836415725467, 4679.3916790816975, 4849.8902977205025, 5099.566536844372, 5457.816873250692, 5480.424555421703, 5666.546676265889, 5740.167675687002, 3838.775428639928, 3853.0, 3870.9225815483533, 3893.9026524336837, 3894.435306880515, 5982.8504287392725, 5985.221921150222, 6003.009503431928, 6009.99500249875, 6051.909221361683, 3650.5984341722387, 3902.375619900802, 3918.8432462701744, 3935.842566297373, 3936.2127574484643, 3985.362342025262, 3993.0217096811466, 3994.320965435883, 4008.8396464141692, 4025.8993525162105, 4655.557722016403, 4668.253079507331, 4678.836240731558, 4686.695364801277, 4713.2458806590785, 4921.384826896638, 5615.410381909841, 5733.598648094677, 5784.4504772046585, 5877.676727779927, 1299.5841330774062, 1302.9022823288292, 1305.7127431964952, 1306.5623016289649, 1309.9607011789662, 835.9467071489845, 872.8428882801156, 877.7798859585182, 880.6257340630335, 882.2941646682629, 4078.7960601969785, 4730.546700908356, 4781.163296423112, 5001.9499805002215, 5219.739013049332, 5542.115680668511, 5833.649981001154, 5840.912386314124, 5865.824025279248, 5891.793787217427, 4334.631556317749, 4512.9097418052115, 5136.794528218904, 5260.763265653055, 5320.627556071116, 2626.8817903194404, 2785.5821626756147, 2932.4574953633646, 2933.0467598030727, 2952.7342539171577, 5008.071892321483, 5221.590170653978, 5546.0, 5635.239242702182, 5822.446867547576, 4823.469418363977, 5275.393329767049, 5608.915866262009, 5766.163906233573, 5772.365039845614, 5326.307580014573, 5439.891202175934, 5591.743760864774, 5680.0, 5840.766369345263, 4755.643326750438, 5063.924041139459, 5093.714554112651, 5202.97398513005, 5578.497935185853, 5103.285540024325, 5164.32863727713, 5221.295125158207, 5280.392754833243, 5517.275838808869, 5368.785248590013, 5489.85895500763, 5555.583331250254, 5726.74229659658, 5732.426757324234, 3457.9654203457644, 3550.8934731958084, 3706.573744019472, 3716.461113138526, 3756.7933763643264, 4759.595434388116, 5257.2902658140665, 5352.759125839424, 5806.2451881255165, 5873.207117039145, 5688.431156884444, 5704.885902282014, 5710.486056254957, 5713.457221563945, 5761.308642962871, 5237.926225123917, 5261.763220655156, 5350.143976963667, 5686.346070201815, 5745.931464672798, 4645.117427688729, 5250.322335608791, 5504.669719816824, 5561.972190139023, 5576.637518561281, 4800.495947925418, 4845.442774081026, 5091.0, 5441.863953401196, 5678.375378708256, 4926.852194434173, 5360.65155764874, 5373.9731301343245, 5587.312373833251, 5593.608447408642], "value": 4091.5282333829796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.7592190889371, 686.4131167851484, 759.2559291893944, 810.5096416667916, 834.4951304460799, 14567.344469498872, 15345.462908798194, 15444.459443919464, 15477.92261038696, 15541.0, 14098.929505352484, 14190.21953792541, 14227.644308892282, 14238.572842814707, 14298.642533936656, 691.9031335612993, 710.1123595505618, 847.8389106069827, 868.3530769576658, 877.903430622631, 752.0824593995317, 878.2052242720348, 885.7342797160858, 886.1847100667369, 890.6570970176497, 882.6954700628273, 949.2500924269854, 949.4018768176074, 949.8717673114145, 953.1040821627682, 934.6915517879083, 936.4240991790068, 939.976500587484, 943.2548286853378, 946.3990366117531, 711.3029231353303, 712.6436781609195, 712.857428514294, 713.1513498936301, 715.5241764226782, 15155.0, 15525.146116963675, 15586.766198507032, 16069.839301607068, 16322.591935201595, 12371.628851134481, 14286.428542858273, 14787.704245915129, 14905.180215088165, 15000.249987500581, 11382.544698212061, 11506.424678766029, 11882.227655202385, 11931.343776092312, 12105.97099246565, 3659.1583935694675, 3778.565464971536, 3796.126890815128, 3833.9424908626393, 3931.331673615492, 90351.54824225837, 105667.0, 105833.47083264611, 106173.0, 106540.0, 10832.837507437394, 10895.073918716998, 10913.290636108628, 11399.943000285111, 11446.656600302003, 23342.766572334058, 23704.64443033356, 23740.169094081622, 23867.0, 24006.639900401507, 7136.536125151953, 7534.811629709301, 7933.841323173504, 7953.403494737918, 8187.140350263256, 4293.3130699088, 4334.544872788375, 4423.270160423558, 4436.179306828247, 4446.288593825037, 3573.0888623400865, 3666.871659491905, 3677.7609455385314, 3683.576388715332, 3730.9813450933116, 589.5990726306068, 649.6167261315846, 659.2747977225014, 672.6972862212024, 686.7630667419733, 686.5194363945259, 696.3558708195001, 705.5272967112047, 706.5057403591368, 746.8431629357896, 10192.643257485952, 10354.844677329846, 10356.482175891175, 10566.894331056592, 10662.413567253876, 559.5859064292475, 715.492000679513, 725.6045455226808, 728.7012324946746, 730.8611363840853, 4125.731827431207, 4553.408056952575, 5042.84871453857, 5045.672031317952, 5055.368078990126, 89720.5513972426, 93527.53236233775, 94374.52812735892, 94468.0553194473, 95626.52186739021, 84372.0, 84842.30315393658, 84845.0, 85980.0, 86599.56700216584, 62725.372746271954, 64980.67509662421, 65468.01797973034, 74767.0, 75050.0, 9887.406755594688, 10282.948585257025, 11053.668389948314, 11174.608888688857, 11300.152488563226, 39732.2053558933, 45963.0, 46640.7667961658, 48131.0, 48264.0, 42842.1431571373, 50517.0, 62890.0, 65749.0, 66102.0, 11202.775944480902, 11491.942540287246, 11594.362310073027, 12873.8068928968, 13117.016223783063, 11250.549978000789, 14169.858301416854, 14239.216843073731, 14911.0, 15267.694646107238, 12526.248425094524, 12800.487980480677, 13363.331833408485, 13758.65603359884, 14082.22547759842, 13578.0, 13726.588202353945, 14062.78905816434, 14187.787183192055, 14664.633384165481, 12929.870701293243, 13202.207867527979, 13875.514356997457, 14394.35225414838, 14484.782728259295, 11033.0, 11126.443677816238, 11177.552897883994, 11573.479193436147, 11632.476538555617, 11083.50124244427, 11185.0, 11448.885511144781, 11451.885481145415, 11469.369184694922], "value": 7506.021979705413, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 121.0, 119.0, 134.0, 176.0, 159.0, 118.0, 119.0, 119.0], "value": 129.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 114.0, 145.0, 113.0, 115.0, 114.0, 99.0, 166.0, 144.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 195.0, 195.0, 195.0, 193.0, 195.0, 203.0, 191.0, 196.0, 196.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 88.0, 71.0, 86.0, 82.0, 84.0, 97.0, 60.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 64.0, 87.0, 103.0, 102.0, 103.0, 94.0, 70.0, 69.0, 82.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 92.0, 102.0, 91.0, 88.0, 90.0, 89.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 128.0, 152.0, 112.0, 95.0, 95.0, 95.0, 100.0, 106.0, 91.0], "value": 111.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 92.0, 93.0, 93.0, 95.0, 93.0, 97.0, 91.0, 91.0], "value": 93.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 60.0, 60.0, 63.0, 64.0, 64.0, 64.0, 64.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 70.0, 106.0, 111.0, 101.0, 83.0, 71.0, 70.0, 70.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 95.0, 104.0, 106.0, 109.0, 83.0, 87.0, 86.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 149.0, 152.0, 163.0, 135.0, 163.0, 156.0, 160.0, 201.0, 171.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 216.0, 228.0, 215.0, 228.0, 183.0, 174.0, 207.0, 168.0, 170.0], "value": 196.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 78.0, 89.0, 85.0, 87.0, 83.0, 88.0, 60.0, 72.0, 87.0], "value": 79.1, "unit": "score"}]}]} 11:39:52 INFO - Return code: 0 11:39:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:39:52 ERROR - # TBPL SUCCESS # 11:39:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:39:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:39:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:39:52 INFO - 2017-01-25 11:39:52.259 screenresolution[1657:10522] starting screenresolution argv=screenresolution get 11:39:52 INFO - 2017-01-25 11:39:52.262 screenresolution[1657:10522] Display 0: 1600x1200x32@60 11:39:52 INFO - 2017-01-25 11:39:52.268 screenresolution[1658:10525] starting screenresolution argv=screenresolution list 11:39:52 INFO - Available Modes on Display 0 11:39:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:39:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:39:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:39:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:39:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:39:52 INFO - Intel Iris: 11:39:52 INFO - Chipset Model: Intel Iris 11:39:52 INFO - Type: GPU 11:39:52 INFO - Bus: Built-In 11:39:52 INFO - VRAM (Dynamic, Max): 1536 MB 11:39:52 INFO - Vendor: Intel (0x8086) 11:39:52 INFO - Device ID: 0x0a2e 11:39:52 INFO - Revision ID: 0x0009 11:39:52 INFO - Displays: 11:39:52 INFO - Display: 11:39:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:39:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:39:52 INFO - Display Serial Number: 1600x1200 60 11:39:52 INFO - Main Display: Yes 11:39:52 INFO - Mirror: Off 11:39:52 INFO - Online: Yes 11:39:52 INFO - Rotation: Supported 11:39:52 INFO - Return code: 0 11:39:52 INFO - Running post-action listener: _resource_record_post_action 11:39:52 INFO - [mozharness: 2017-01-25 19:39:52.505140Z] Finished run-tests step (success) 11:39:52 INFO - Running post-run listener: _resource_record_post_run 11:39:52 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38713856; Write bytes: 508636160; Read time: 247; Write time: 1608 11:39:52 INFO - TinderboxPrint: CPU usage
54.5% 11:39:52 INFO - TinderboxPrint: I/O read bytes / time
38,713,856 / 247 11:39:52 INFO - TinderboxPrint: I/O write bytes / time
508,636,160 / 1,608 11:39:52 INFO - TinderboxPrint: CPU idle
2,181.2 (45.5%) 11:39:52 INFO - TinderboxPrint: CPU system
969.6 (20.2%) 11:39:52 INFO - TinderboxPrint: CPU user
1,638.9 (34.2%) 11:39:52 INFO - TinderboxPrint: Swap in / out
246,222,848 / 0 11:39:52 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207354368; Write bytes: 199688192; Read time: 15871; Write time: 422 11:39:52 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35289600; Write bytes: 298871808; Read time: 224; Write time: 1151 11:39:52 INFO - Running post-run listener: _upload_blobber_files 11:39:52 INFO - Blob upload gear active. 11:39:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:52 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 11:39:52 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'] 11:39:52 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 11:39:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:54 INFO - (blobuploader) - INFO - Done attempting. 11:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:56 INFO - (blobuploader) - INFO - Done attempting. 11:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:57 INFO - (blobuploader) - INFO - Done attempting. 11:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:59 INFO - (blobuploader) - INFO - Done attempting. 11:39:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:59 INFO - Return code: 0 11:39:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a943e39f69e4727fa44b1b185131a25daf16f96d16c78531d349b8f1bfa5824e9cd43f429f4b7b25d97a3747e628cd0db1877007d6826aa1009d022c05e638", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92b2f18a1db989fcba2bc9efc35520a491abac82e0557db4d107d12111aa23827e6f86a386381b44c5e0210bf646bb33ea6184ecee119f1ae34ce435b29ddc50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a38d6e7e9a54023e3bd4309169a32dc4f4ad1ec8b7b8f21b3a085dafc3bcff95705fdab1b36c8676df14f7d7d51200f787a87df837860e4c6bd315fa72910b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/676ae3ea598a25c30f407a8d86e662f18783b2ef60ef88fb5d3465e6b54e3082b1a15e1d337389f55072c78ae17376b89f3761e56319f5dedc6cbf19dd8f0c68"} 11:39:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:59 INFO - Contents: 11:39:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a943e39f69e4727fa44b1b185131a25daf16f96d16c78531d349b8f1bfa5824e9cd43f429f4b7b25d97a3747e628cd0db1877007d6826aa1009d022c05e638", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92b2f18a1db989fcba2bc9efc35520a491abac82e0557db4d107d12111aa23827e6f86a386381b44c5e0210bf646bb33ea6184ecee119f1ae34ce435b29ddc50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a38d6e7e9a54023e3bd4309169a32dc4f4ad1ec8b7b8f21b3a085dafc3bcff95705fdab1b36c8676df14f7d7d51200f787a87df837860e4c6bd315fa72910b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/676ae3ea598a25c30f407a8d86e662f18783b2ef60ef88fb5d3465e6b54e3082b1a15e1d337389f55072c78ae17376b89f3761e56319f5dedc6cbf19dd8f0c68"} 11:39:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:59 INFO - Copying logs to upload dir... 11:39:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.757753 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-25 11:39:59.968681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 11:39:59.971752) ========= 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.hBo2tBhWwm/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.T8tjukUzMm/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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/36a943e39f69e4727fa44b1b185131a25daf16f96d16c78531d349b8f1bfa5824e9cd43f429f4b7b25d97a3747e628cd0db1877007d6826aa1009d022c05e638", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92b2f18a1db989fcba2bc9efc35520a491abac82e0557db4d107d12111aa23827e6f86a386381b44c5e0210bf646bb33ea6184ecee119f1ae34ce435b29ddc50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a38d6e7e9a54023e3bd4309169a32dc4f4ad1ec8b7b8f21b3a085dafc3bcff95705fdab1b36c8676df14f7d7d51200f787a87df837860e4c6bd315fa72910b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/676ae3ea598a25c30f407a8d86e662f18783b2ef60ef88fb5d3465e6b54e3082b1a15e1d337389f55072c78ae17376b89f3761e56319f5dedc6cbf19dd8f0c68"} build_url:https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010892 build_url: 'https://queue.taskcluster.net/v1/task/M6r5_wvXQuqY5My28Qa_iQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a943e39f69e4727fa44b1b185131a25daf16f96d16c78531d349b8f1bfa5824e9cd43f429f4b7b25d97a3747e628cd0db1877007d6826aa1009d022c05e638", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92b2f18a1db989fcba2bc9efc35520a491abac82e0557db4d107d12111aa23827e6f86a386381b44c5e0210bf646bb33ea6184ecee119f1ae34ce435b29ddc50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a38d6e7e9a54023e3bd4309169a32dc4f4ad1ec8b7b8f21b3a085dafc3bcff95705fdab1b36c8676df14f7d7d51200f787a87df837860e4c6bd315fa72910b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/676ae3ea598a25c30f407a8d86e662f18783b2ef60ef88fb5d3465e6b54e3082b1a15e1d337389f55072c78ae17376b89f3761e56319f5dedc6cbf19dd8f0c68"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 11:40:00.008780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:40:00.009112) ========= 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.hBo2tBhWwm/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.T8tjukUzMm/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.005225 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:40:00.061397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 11:40:00.061735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 11:40:00.062501) ========= ========= Total master_lag: 0.20 =========