builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1491586950.39 results: success (0) buildid: 20170407090522 builduid: 398a9b5f86af4d1fb7e63d31172a30f9 revision: 2e7b7b293fdc1444430855ffb1b3d88925c9d5ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.388351) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.388831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.389157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.414608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.415000) ========= 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.7sjNOCmQIs/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.cWAPegPazC/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-07 10:42:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.57M=0.002s 2017-04-07 10:42:30 (7.57 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.188552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.626965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.627293) ========= 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.7sjNOCmQIs/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.cWAPegPazC/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.021371 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:30.675792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 10:42:30.676127) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e7b7b293fdc1444430855ffb1b3d88925c9d5ad --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 2e7b7b293fdc1444430855ffb1b3d88925c9d5ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7sjNOCmQIs/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.cWAPegPazC/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-07 10:42:30,767 truncating revision to first 12 chars 2017-04-07 10:42:30,767 Setting DEBUG logging. 2017-04-07 10:42:30,767 attempt 1/10 2017-04-07 10:42:30,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2e7b7b293fdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-07 10:42:32,616 unpacking tar archive at: mozilla-aurora-2e7b7b293fdc/testing/mozharness/ program finished with exit code 0 elapsedTime=2.095279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-07 10:42:32.794640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:32.794965) ========= script_repo_revision: 2e7b7b293fdc1444430855ffb1b3d88925c9d5ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:32.795384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:32.795652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-07 10:42:32.815198) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-07 10:42:32.815515) ========= /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.7sjNOCmQIs/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.cWAPegPazC/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:42:33 INFO - MultiFileLogger online at 20170407 10:42:33 in /builds/slave/test 10:42:33 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 10:42:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:42:33 INFO - {'append_to_log': False, 10:42:33 INFO - 'base_work_dir': '/builds/slave/test', 10:42:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:42:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:42:33 INFO - 'branch': 'Mozilla-Aurora', 10:42:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:42:33 INFO - 'config_files': ('talos/mac_config.py',), 10:42:33 INFO - 'default_actions': ('clobber', 10:42:33 INFO - 'read-buildbot-config', 10:42:33 INFO - 'download-and-extract', 10:42:33 INFO - 'populate-webroot', 10:42:33 INFO - 'create-virtualenv', 10:42:33 INFO - 'install', 10:42:33 INFO - 'run-tests'), 10:42:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:42:33 INFO - 'download_minidump_stackwalk': True, 10:42:33 INFO - 'download_symbols': 'ondemand', 10:42:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:42:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:42:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:42:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:42:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:42:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:42:33 INFO - 'gecko_profile': False, 10:42:33 INFO - 'gecko_profile_interval': 0, 10:42:33 INFO - 'installer_path': 'installer.exe', 10:42:33 INFO - 'log_level': 'info', 10:42:33 INFO - 'log_name': 'talos', 10:42:33 INFO - 'log_to_console': True, 10:42:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:42:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:42:33 INFO - 'opt_config_files': (), 10:42:33 INFO - 'pip_index': False, 10:42:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:42:33 INFO - 'cmd': ('bash', 10:42:33 INFO - '-c', 10:42:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:42:33 INFO - 'enabled': True, 10:42:33 INFO - 'halt_on_failure': False, 10:42:33 INFO - 'name': 'check_screen_resolution'},), 10:42:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:42:33 INFO - 'cmd': ('bash', 10:42:33 INFO - '-c', 10:42:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:42:33 INFO - 'enabled': True, 10:42:33 INFO - 'halt_on_failure': False, 10:42:33 INFO - 'name': 'check_screen_resolution'},), 10:42:33 INFO - 'run_cmd_checks_enabled': True, 10:42:33 INFO - 'suite': 'dromaeojs-e10s', 10:42:33 INFO - 'system_bits': '32', 10:42:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:42:33 INFO - 'title': 't-yosemite-r7-0086', 10:42:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:42:33 INFO - 'use_talos_json': True, 10:42:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:42:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:42:33 INFO - 'work_dir': 'build'} 10:42:33 INFO - [mozharness: 2017-04-07 17:42:33.028717Z] Running clobber step. 10:42:33 INFO - Running pre-action listener: _resource_record_pre_action 10:42:33 INFO - Running main action method: clobber 10:42:33 INFO - rmtree: /builds/slave/test/build 10:42:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:42:35 INFO - Running post-action listener: _resource_record_post_action 10:42:35 INFO - [mozharness: 2017-04-07 17:42:35.229045Z] Finished clobber step (success) 10:42:35 INFO - [mozharness: 2017-04-07 17:42:35.229189Z] Running read-buildbot-config step. 10:42:35 INFO - Running pre-action listener: _resource_record_pre_action 10:42:35 INFO - Running main action method: read_buildbot_config 10:42:35 INFO - Using buildbot properties: 10:42:35 INFO - { 10:42:35 INFO - "project": "", 10:42:35 INFO - "product": "firefox", 10:42:35 INFO - "script_repo_revision": "production", 10:42:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:42:35 INFO - "repository": "", 10:42:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:42:35 INFO - "buildid": "20170407090522", 10:42:35 INFO - "pgo_build": "False", 10:42:35 INFO - "basedir": "/builds/slave/test", 10:42:35 INFO - "buildnumber": 20, 10:42:35 INFO - "slavename": "t-yosemite-r7-0086", 10:42:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:42:35 INFO - "platform": "yosemite_r7", 10:42:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:42:35 INFO - "branch": "mozilla-aurora", 10:42:35 INFO - "repo_path": "releases/mozilla-aurora", 10:42:35 INFO - "revision": "2e7b7b293fdc1444430855ffb1b3d88925c9d5ad", 10:42:35 INFO - "stage_platform": "macosx64", 10:42:35 INFO - "builduid": "398a9b5f86af4d1fb7e63d31172a30f9", 10:42:35 INFO - "slavebuilddir": "test" 10:42:35 INFO - } 10:42:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 10:42:35 INFO - Running post-action listener: _resource_record_post_action 10:42:35 INFO - [mozharness: 2017-04-07 17:42:35.232664Z] Finished read-buildbot-config step (success) 10:42:35 INFO - [mozharness: 2017-04-07 17:42:35.232766Z] Running download-and-extract step. 10:42:35 INFO - Running pre-action listener: _resource_record_pre_action 10:42:35 INFO - Running main action method: download_and_extract 10:42:35 INFO - mkdir: /builds/slave/test/build/tests 10:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:42:35 INFO - trying https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 10:42:35 INFO - Downloading https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 10:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 10:42:36 INFO - Downloaded 1199 bytes. 10:42:36 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 10:42:36 INFO - Using the following test package requirements: 10:42:36 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 10:42:36 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 10:42:36 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 10:42:36 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'jsshell-mac.zip'], 10:42:36 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 10:42:36 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 10:42:36 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 10:42:36 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 10:42:36 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 10:42:36 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 10:42:36 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 10:42:36 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:42:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 10:42:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:42:36 INFO - Fetch https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 10:42:37 INFO - Expected file size: 51790708 10:42:37 INFO - Obtained file size: 51790708 10:42:53 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:42:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 10:42:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:42:53 INFO - Fetch https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 10:42:55 INFO - Expected file size: 51790708 10:42:55 INFO - Obtained file size: 51790708 10:43:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 10:43:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:43:11 INFO - Fetch https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 10:43:12 INFO - Expected file size: 14404424 10:43:12 INFO - Obtained file size: 14404424 10:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:13 INFO - trying https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:43:13 INFO - Downloading https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 10:43:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 10:43:15 INFO - Downloaded 74677344 bytes. 10:43:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:43:15 INFO - mkdir: /builds/slave/test/properties 10:43:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:43:15 INFO - Writing to file /builds/slave/test/properties/build_url 10:43:15 INFO - Contents: 10:43:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 10:43:15 INFO - Running post-action listener: _resource_record_post_action 10:43:15 INFO - Running post-action listener: set_extra_try_arguments 10:43:15 INFO - [mozharness: 2017-04-07 17:43:15.706202Z] Finished download-and-extract step (success) 10:43:15 INFO - [mozharness: 2017-04-07 17:43:15.706347Z] Running populate-webroot step. 10:43:15 INFO - Running pre-action listener: _resource_record_pre_action 10:43:15 INFO - Running main action method: populate_webroot 10:43:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:43:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:43:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:43:15 INFO - '--tppagecycles', 10:43:15 INFO - '7'], 10:43:15 INFO - 'tests': ['tsvgm']}}, 10:43:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:43:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:43:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:43:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:43:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:43:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:43:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['damp', 'tps']}, 10:43:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'tests': ['damp', 'tps']}, 10:43:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['dromaeo_dom']}, 10:43:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:43:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['basic_compositor_video']}, 10:43:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:43:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['a11yr', 10:43:15 INFO - 'ts_paint', 10:43:15 INFO - 'tpaint', 10:43:15 INFO - 'sessionrestore', 10:43:15 INFO - 'sessionrestore_no_auto_restore', 10:43:15 INFO - 'tabpaint']}, 10:43:15 INFO - 'other-e10s': {'tests': ['a11yr', 10:43:15 INFO - 'ts_paint', 10:43:15 INFO - 'tpaint', 10:43:15 INFO - 'sessionrestore', 10:43:15 INFO - 'sessionrestore_no_auto_restore', 10:43:15 INFO - 'tabpaint']}, 10:43:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:43:15 INFO - 'ts_paint', 10:43:15 INFO - 'tpaint', 10:43:15 INFO - 'sessionrestore', 10:43:15 INFO - 'sessionrestore_no_auto_restore', 10:43:15 INFO - 'tabpaint']}, 10:43:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:43:15 INFO - 'ts_paint', 10:43:15 INFO - 'tpaint', 10:43:15 INFO - 'sessionrestore', 10:43:15 INFO - 'sessionrestore_no_auto_restore', 10:43:15 INFO - 'tabpaint']}, 10:43:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['a11yr', 10:43:15 INFO - 'ts_paint', 10:43:15 INFO - 'tpaint', 10:43:15 INFO - 'sessionrestore', 10:43:15 INFO - 'sessionrestore_no_auto_restore', 10:43:15 INFO - 'tabpaint']}, 10:43:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['a11yr', 10:43:15 INFO - 'ts_paint', 10:43:15 INFO - 'tpaint', 10:43:15 INFO - 'sessionrestore', 10:43:15 INFO - 'sessionrestore_no_auto_restore', 10:43:15 INFO - 'tabpaint']}, 10:43:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['tsvgx', 10:43:15 INFO - 'tsvgr_opacity', 10:43:15 INFO - 'tart', 10:43:15 INFO - 'tscrollx', 10:43:15 INFO - 'cart', 10:43:15 INFO - 'tsvg_static']}, 10:43:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:43:15 INFO - 'tsvgr_opacity', 10:43:15 INFO - 'tart', 10:43:15 INFO - 'tscrollx', 10:43:15 INFO - 'cart', 10:43:15 INFO - 'tsvg_static']}, 10:43:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'talos_options': ['--disable-e10s'], 10:43:15 INFO - 'tests': ['tp5o']}, 10:43:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:43:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'talos_options': ['--disable-e10s', 10:43:15 INFO - '--xperf_path', 10:43:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:43:15 INFO - 'tests': ['tp5n']}, 10:43:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:43:15 INFO - 'talos_options': ['--xperf_path', 10:43:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:43:15 INFO - 'tests': ['tp5n']}}, 10:43:15 INFO - 'talos.zip': {'path': '', 10:43:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:43:15 INFO - Running post-action listener: _resource_record_post_action 10:43:15 INFO - [mozharness: 2017-04-07 17:43:15.724626Z] Finished populate-webroot step (success) 10:43:15 INFO - [mozharness: 2017-04-07 17:43:15.724765Z] Running create-virtualenv step. 10:43:15 INFO - Running pre-action listener: _resource_record_pre_action 10:43:15 INFO - Running main action method: create_virtualenv 10:43:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:43:15 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 10:43:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:43:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:43:15 INFO - Using real prefix '/tools/python27' 10:43:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:43:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:43:19 INFO - Installing pip.................done. 10:43:19 INFO - Return code: 0 10:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:43:19 INFO - Reading from file tmpfile_stdout 10:43:19 INFO - Output received: 10:43:19 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) 10:43:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:43:19 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')]} 10:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:19 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')]} 10:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:19 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:19 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 10:43:19 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 10:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:19 INFO - 'HOME': '/Users/cltbld', 10:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:19 INFO - 'LOGNAME': 'cltbld', 10:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:19 INFO - 'MOZ_NO_REMOTE': '1', 10:43:19 INFO - 'NO_EM_RESTART': '1', 10:43:19 INFO - 'PAGER': '/bin/cat', 10:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:19 INFO - 'PWD': '/builds/slave/test', 10:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:19 INFO - 'SHELL': '/bin/bash', 10:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:19 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:19 INFO - 'USER': 'cltbld', 10:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:19 INFO - 'XPC_FLAGS': '0x0', 10:43:19 INFO - 'XPC_SERVICE_NAME': '0', 10:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:19 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 10:43:19 INFO - Cleaning up... 10:43:19 INFO - Return code: 0 10:43:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:43:19 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')]} 10:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:19 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')]} 10:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:19 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:19 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 10:43:19 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 10:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:19 INFO - 'HOME': '/Users/cltbld', 10:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:19 INFO - 'LOGNAME': 'cltbld', 10:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:19 INFO - 'MOZ_NO_REMOTE': '1', 10:43:19 INFO - 'NO_EM_RESTART': '1', 10:43:19 INFO - 'PAGER': '/bin/cat', 10:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:19 INFO - 'PWD': '/builds/slave/test', 10:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:19 INFO - 'SHELL': '/bin/bash', 10:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:19 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:19 INFO - 'USER': 'cltbld', 10:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:19 INFO - 'XPC_FLAGS': '0x0', 10:43:19 INFO - 'XPC_SERVICE_NAME': '0', 10:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:20 INFO - Downloading/unpacking psutil>=3.1.1 10:43:20 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 10:43:20 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 10:43:20 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 10:43:20 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 10:43:20 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 10:43:20 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 10:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:43:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:43:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:43:24 INFO - Installing collected packages: psutil 10:43:24 INFO - Running setup.py install for psutil 10:43:24 INFO - building 'psutil._psutil_osx' extension 10:43:24 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 10:43:24 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 10:43:24 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 10:43:24 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 10:43:24 INFO - building 'psutil._psutil_posix' extension 10:43:24 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 10:43:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:43:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:43:24 INFO - ^ 10:43:24 INFO - 1 warning generated. 10:43:24 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 10:43:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:43:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:43:24 INFO - Successfully installed psutil 10:43:24 INFO - Cleaning up... 10:43:24 INFO - Return code: 0 10:43:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:43:24 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')]} 10:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:43: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 mozsystemmonitor==0.3 10:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:25 INFO - 'HOME': '/Users/cltbld', 10:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:25 INFO - 'LOGNAME': 'cltbld', 10:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:25 INFO - 'MOZ_NO_REMOTE': '1', 10:43:25 INFO - 'NO_EM_RESTART': '1', 10:43:25 INFO - 'PAGER': '/bin/cat', 10:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:25 INFO - 'PWD': '/builds/slave/test', 10:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:25 INFO - 'SHELL': '/bin/bash', 10:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:25 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:25 INFO - 'USER': 'cltbld', 10:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:25 INFO - 'XPC_FLAGS': '0x0', 10:43:25 INFO - 'XPC_SERVICE_NAME': '0', 10:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:43:25 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 10:43:25 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 10:43:25 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 10:43:25 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 10:43:25 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 10:43:25 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 10:43:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:43:29 INFO - Installing collected packages: mozsystemmonitor 10:43:29 INFO - Running setup.py install for mozsystemmonitor 10:43:29 INFO - Successfully installed mozsystemmonitor 10:43:29 INFO - Cleaning up... 10:43:29 INFO - Return code: 0 10:43:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:43:29 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')]} 10:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:29 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')]} 10:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:29 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:29 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 10:43:29 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 10:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:29 INFO - 'HOME': '/Users/cltbld', 10:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:29 INFO - 'LOGNAME': 'cltbld', 10:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:29 INFO - 'MOZ_NO_REMOTE': '1', 10:43:29 INFO - 'NO_EM_RESTART': '1', 10:43:29 INFO - 'PAGER': '/bin/cat', 10:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:29 INFO - 'PWD': '/builds/slave/test', 10:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:29 INFO - 'SHELL': '/bin/bash', 10:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:29 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:29 INFO - 'USER': 'cltbld', 10:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:29 INFO - 'XPC_FLAGS': '0x0', 10:43:29 INFO - 'XPC_SERVICE_NAME': '0', 10:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:43:29 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 10:43:29 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 10:43:29 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 10:43:29 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 10:43:29 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 10:43:29 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 10:43:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:43:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:43:32 INFO - warning: no files found matching '*.txt' 10:43:32 INFO - no previously-included directories found matching 'build' 10:43:32 INFO - no previously-included directories found matching 'dist' 10:43:32 INFO - no previously-included directories found matching '.git*' 10:43:32 INFO - Installing collected packages: jsonschema, functools32 10:43:32 INFO - Running setup.py install for functools32 10:43:32 INFO - warning: no files found matching '*.txt' 10:43:32 INFO - no previously-included directories found matching 'build' 10:43:32 INFO - no previously-included directories found matching 'dist' 10:43:32 INFO - no previously-included directories found matching '.git*' 10:43:32 INFO - Successfully installed jsonschema functools32 10:43:32 INFO - Cleaning up... 10:43:32 INFO - Return code: 0 10:43:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:43:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:32 INFO - 'HOME': '/Users/cltbld', 10:43:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:32 INFO - 'LOGNAME': 'cltbld', 10:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:32 INFO - 'MOZ_NO_REMOTE': '1', 10:43:32 INFO - 'NO_EM_RESTART': '1', 10:43:32 INFO - 'PAGER': '/bin/cat', 10:43:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:32 INFO - 'PWD': '/builds/slave/test', 10:43:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:32 INFO - 'SHELL': '/bin/bash', 10:43:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:32 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:32 INFO - 'USER': 'cltbld', 10:43:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:32 INFO - 'XPC_FLAGS': '0x0', 10:43:32 INFO - 'XPC_SERVICE_NAME': '0', 10:43:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:43:33 INFO - Cleaning up... 10:43:33 INFO - Return code: 0 10:43:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:43: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')]} 10:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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', '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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:43: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 blobuploader==1.2.4 10:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:33 INFO - 'HOME': '/Users/cltbld', 10:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:33 INFO - 'LOGNAME': 'cltbld', 10:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:33 INFO - 'MOZ_NO_REMOTE': '1', 10:43:33 INFO - 'NO_EM_RESTART': '1', 10:43:33 INFO - 'PAGER': '/bin/cat', 10:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:33 INFO - 'PWD': '/builds/slave/test', 10:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:33 INFO - 'SHELL': '/bin/bash', 10:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:33 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:33 INFO - 'USER': 'cltbld', 10:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:33 INFO - 'XPC_FLAGS': '0x0', 10:43:33 INFO - 'XPC_SERVICE_NAME': '0', 10:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:43:33 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 10:43:33 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 10:43:33 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 10:43:33 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 10:43:33 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 10:43:33 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 10:43:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:43:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:43:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43:37 INFO - Downloading docopt-0.6.1.tar.gz 10:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:43:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:43:37 INFO - Running setup.py install for blobuploader 10:43:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:43:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:43:37 INFO - Running setup.py install for requests 10:43:38 INFO - Running setup.py install for docopt 10:43:38 INFO - Successfully installed blobuploader requests docopt 10:43:38 INFO - Cleaning up... 10:43:38 INFO - Return code: 0 10:43:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:38 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:38 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 10:43:38 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 10:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:38 INFO - 'HOME': '/Users/cltbld', 10:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:38 INFO - 'LOGNAME': 'cltbld', 10:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:38 INFO - 'MOZ_NO_REMOTE': '1', 10:43:38 INFO - 'NO_EM_RESTART': '1', 10:43:38 INFO - 'PAGER': '/bin/cat', 10:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:38 INFO - 'PWD': '/builds/slave/test', 10:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:38 INFO - 'SHELL': '/bin/bash', 10:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:38 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:38 INFO - 'USER': 'cltbld', 10:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:38 INFO - 'XPC_FLAGS': '0x0', 10:43:38 INFO - 'XPC_SERVICE_NAME': '0', 10:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:43:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8mJuDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:43:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-tL8HQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:43:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LltGiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:43:38 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Cul3e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-aOQw_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-70NbBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jIc5QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Lfpl0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-g8kA1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-s0kvxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-zkZV2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-0b1zt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:43:39 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-2xzpKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:43:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-GTQphQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:43:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-OrFeOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:43:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-slPiYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:43:40 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Lk2xS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:43:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:43:40 INFO - Running setup.py install for manifestparser 10:43:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:43:40 INFO - Running setup.py install for mozcrash 10:43:40 INFO - Running setup.py install for mozdebug 10:43:40 INFO - Running setup.py install for mozdevice 10:43:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Running setup.py install for mozfile 10:43:41 INFO - Running setup.py install for mozhttpd 10:43:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Running setup.py install for mozinfo 10:43:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Running setup.py install for mozInstall 10:43:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Running setup.py install for mozleak 10:43:41 INFO - Running setup.py install for mozlog 10:43:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:43:41 INFO - Running setup.py install for moznetwork 10:43:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:43:42 INFO - Running setup.py install for mozprocess 10:43:42 INFO - Running setup.py install for mozprofile 10:43:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:43:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:43:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:43:42 INFO - Running setup.py install for mozrunner 10:43:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:43:42 INFO - Running setup.py install for mozscreenshot 10:43:42 INFO - Running setup.py install for moztest 10:43:42 INFO - Running setup.py install for mozversion 10:43:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:43:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:43:43 INFO - Cleaning up... 10:43:43 INFO - Return code: 0 10:43:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:43 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:43 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 10:43:43 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 10:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:43 INFO - 'HOME': '/Users/cltbld', 10:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:43 INFO - 'LOGNAME': 'cltbld', 10:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:43 INFO - 'MOZ_NO_REMOTE': '1', 10:43:43 INFO - 'NO_EM_RESTART': '1', 10:43:43 INFO - 'PAGER': '/bin/cat', 10:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:43 INFO - 'PWD': '/builds/slave/test', 10:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:43 INFO - 'SHELL': '/bin/bash', 10:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:43 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:43 INFO - 'USER': 'cltbld', 10:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:43 INFO - 'XPC_FLAGS': '0x0', 10:43:43 INFO - 'XPC_SERVICE_NAME': '0', 10:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-03gJkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:43:43 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)) 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-qDXHyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:43:43 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)) 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ytE2JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:43:43 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)) 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-cHtZao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:43:43 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)) 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-SXNz2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:43:43 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)) 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Xv6f3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:43:43 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)) 10:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:43:43 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-g5GjnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-LUrTtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-pac7MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Xpyuz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gqwQ1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-jtkJ66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-YIPwxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FVAl0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-ytaqm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:43:44 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)) 10:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:43:44 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-eH_EjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:43:45 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)) 10:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:43:45 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-dotKyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:43:45 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)) 10:43:45 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)) 10:43:45 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)) 10:43:45 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)) 10:43:45 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)) 10:43:45 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)) 10:43:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:47 INFO - Downloading blessings-1.6.tar.gz 10:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:43:47 INFO - Installing collected packages: blessings 10:43:47 INFO - Running setup.py install for blessings 10:43:48 INFO - Successfully installed blessings 10:43:48 INFO - Cleaning up... 10:43:48 INFO - Return code: 0 10:43:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:43:48 INFO - Reading from file tmpfile_stdout 10:43:48 INFO - Current package versions: 10:43:48 INFO - blessings == 1.6 10:43:48 INFO - blobuploader == 1.2.4 10:43:48 INFO - docopt == 0.6.1 10:43:48 INFO - functools32 == 3.2.3-2 10:43:48 INFO - jsonschema == 2.5.1 10:43:48 INFO - manifestparser == 1.1 10:43:48 INFO - mozInstall == 1.12 10:43:48 INFO - mozcrash == 1.0 10:43:48 INFO - mozdebug == 0.1 10:43:48 INFO - mozdevice == 0.49 10:43:48 INFO - mozfile == 1.2 10:43:48 INFO - mozhttpd == 0.7 10:43:48 INFO - mozinfo == 0.9 10:43:48 INFO - mozleak == 0.1 10:43:48 INFO - mozlog == 3.4 10:43:48 INFO - moznetwork == 0.27 10:43:48 INFO - mozprocess == 0.25 10:43:48 INFO - mozprofile == 0.28 10:43:48 INFO - mozrunner == 6.13 10:43:48 INFO - mozscreenshot == 0.1 10:43:48 INFO - mozsystemmonitor == 0.3 10:43:48 INFO - moztest == 0.8 10:43:48 INFO - mozversion == 1.4 10:43:48 INFO - psutil == 3.1.1 10:43:48 INFO - requests == 1.2.3 10:43:48 INFO - wsgiref == 0.1.2 10:43:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:43:48 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')]} 10:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:48 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')]} 10:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:48 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:48 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 10:43:48 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 10:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:48 INFO - 'HOME': '/Users/cltbld', 10:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:48 INFO - 'LOGNAME': 'cltbld', 10:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:48 INFO - 'MOZ_NO_REMOTE': '1', 10:43:48 INFO - 'NO_EM_RESTART': '1', 10:43:48 INFO - 'PAGER': '/bin/cat', 10:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:48 INFO - 'PWD': '/builds/slave/test', 10:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:48 INFO - 'SHELL': '/bin/bash', 10:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:48 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:48 INFO - 'USER': 'cltbld', 10:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:48 INFO - 'XPC_FLAGS': '0x0', 10:43:48 INFO - 'XPC_SERVICE_NAME': '0', 10:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 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)) 10:43:48 INFO - Cleaning up... 10:43:48 INFO - Return code: 0 10:43:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:43:48 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')]} 10:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:48 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')]} 10:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:48 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 0x10b1b6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30d9bed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, '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.7sjNOCmQIs/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.cWAPegPazC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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 10:43:48 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 10:43:48 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 10:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:43:48 INFO - 'HOME': '/Users/cltbld', 10:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:43:48 INFO - 'LOGNAME': 'cltbld', 10:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:48 INFO - 'MOZ_NO_REMOTE': '1', 10:43:48 INFO - 'NO_EM_RESTART': '1', 10:43:48 INFO - 'PAGER': '/bin/cat', 10:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:43:48 INFO - 'PWD': '/builds/slave/test', 10:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:43:48 INFO - 'SHELL': '/bin/bash', 10:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:43:48 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:43:48 INFO - 'USER': 'cltbld', 10:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:48 INFO - 'XPC_FLAGS': '0x0', 10:43:48 INFO - 'XPC_SERVICE_NAME': '0', 10:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:43:48 INFO - Cleaning up... 10:43:48 INFO - Return code: 0 10:43:48 INFO - Running post-action listener: _resource_record_post_action 10:43:48 INFO - Running post-action listener: _start_resource_monitoring 10:43:48 INFO - Starting resource monitoring. 10:43:48 INFO - [mozharness: 2017-04-07 17:43:48.962561Z] Finished create-virtualenv step (success) 10:43:48 INFO - [mozharness: 2017-04-07 17:43:48.963570Z] Running install step. 10:43:48 INFO - Running pre-action listener: _resource_record_pre_action 10:43:48 INFO - Running main action method: install 10:43:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:43:49 INFO - Reading from file tmpfile_stdout 10:43:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:43:49 INFO - Reading from file tmpfile_stdout 10:43:49 INFO - Output received: 10:43:49 INFO - Usage: mozinstall [options] installer 10:43:49 INFO - Options: 10:43:49 INFO - -h, --help show this help message and exit 10:43:49 INFO - -d DEST, --destination=DEST 10:43:49 INFO - Directory to install application into. [default: 10:43:49 INFO - "/builds/slave/test"] 10:43:49 INFO - --app=APP Application being installed. [default: firefox] 10:43:49 INFO - mkdir: /builds/slave/test/build/application 10:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:44:09 INFO - Reading from file tmpfile_stdout 10:44:09 INFO - Output received: 10:44:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:44:09 INFO - Running post-action listener: _resource_record_post_action 10:44:09 INFO - [mozharness: 2017-04-07 17:44:09.576432Z] Finished install step (success) 10:44:09 INFO - [mozharness: 2017-04-07 17:44:09.576585Z] Running run-tests step. 10:44:09 INFO - Running pre-action listener: _resource_record_pre_action 10:44:09 INFO - Running main action method: run_tests 10:44:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:44:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:44:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:44:09 INFO - 2017-04-07 10:44:09.591 screenresolution[1896:11563] starting screenresolution argv=screenresolution get 10:44:09 INFO - 2017-04-07 10:44:09.593 screenresolution[1896:11563] Display 0: 1600x1200x32@60 10:44:09 INFO - 2017-04-07 10:44:09.599 screenresolution[1897:11565] starting screenresolution argv=screenresolution list 10:44:09 INFO - Available Modes on Display 0 10:44:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:44:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:44:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:44:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:44:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:44:09 INFO - Intel Iris: 10:44:09 INFO - Chipset Model: Intel Iris 10:44:09 INFO - Type: GPU 10:44:09 INFO - Bus: Built-In 10:44:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:44:09 INFO - Vendor: Intel (0x8086) 10:44:09 INFO - Device ID: 0x0a2e 10:44:09 INFO - Revision ID: 0x0009 10:44:09 INFO - Displays: 10:44:09 INFO - Display: 10:44:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:44:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:44:09 INFO - Display Serial Number: 1600x1200 60 10:44:09 INFO - Main Display: Yes 10:44:09 INFO - Mirror: Off 10:44:09 INFO - Online: Yes 10:44:09 INFO - Rotation: Supported 10:44:09 INFO - Return code: 0 10:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:44:09 INFO - Python 2.7.3 10:44:09 INFO - Return code: 0 10:44:09 INFO - grabbing minidump binary from tooltool 10:44:09 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')]} 10:44:09 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 0x10af94d30>, '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 0x10aebbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af89be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:44:09 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 10:44:09 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 10:44:09 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 10:44:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:44:09 INFO - Return code: 0 10:44:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:44:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:44:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:44:09 INFO - ENV: RUST_BACKTRACE is now 1 10:44:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:44:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:44:09 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/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 10:44:09 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/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --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 10:44:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7sjNOCmQIs/Render', 10:44:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:09 INFO - 'HOME': '/Users/cltbld', 10:44:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:09 INFO - 'LOGNAME': 'cltbld', 10:44:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:44:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:09 INFO - 'MOZ_NO_REMOTE': '1', 10:44:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:44:09 INFO - 'NO_EM_RESTART': '1', 10:44:09 INFO - 'PAGER': '/bin/cat', 10:44:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:09 INFO - 'PWD': '/builds/slave/test', 10:44:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:44:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:09 INFO - 'RUST_BACKTRACE': '1', 10:44:09 INFO - 'SHELL': '/bin/bash', 10:44:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cWAPegPazC/Listeners', 10:44:09 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 10:44:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:09 INFO - 'USER': 'cltbld', 10:44:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:09 INFO - 'XPC_FLAGS': '0x0', 10:44:09 INFO - 'XPC_SERVICE_NAME': '0', 10:44:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:09 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/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--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 10:44:10 INFO - mozversion application_buildid: 20170407090522 10:44:10 INFO - mozversion application_changeset: 2e7b7b293fdc1444430855ffb1b3d88925c9d5ad 10:44:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:44:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:44:10 INFO - mozversion application_name: Firefox 10:44:10 INFO - mozversion application_remotingname: firefox-dev 10:44:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:44:10 INFO - mozversion application_vendor: Mozilla 10:44:10 INFO - mozversion application_version: 54.0a2 10:44:10 INFO - mozversion platform_buildid: 20170407090522 10:44:10 INFO - mozversion platform_changeset: 2e7b7b293fdc1444430855ffb1b3d88925c9d5ad 10:44:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:44:10 INFO - mozversion platform_version: 54.0a2 10:44:10 INFO - using testdate: 1491587050 10:44:10 INFO - actual date: 1491587050 10:44:10 INFO - starting webserver on 'localhost:49720' 10:44:10 INFO - SUITE-START | Running 2 tests 10:44:10 INFO - TEST-START | dromaeo_css 10:44:10 INFO - operating with platform_type : mac_ 10:44:10 INFO - Initialising browser for dromaeo_css test... 10:44:10 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpKaH_yd/profile http://localhost:49720/getInfo.html) 10:44:13 INFO - PROCESS | 1907 | 2017-04-07 10:44:13.294 plugin-container[1909:11735] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3b, name = 'com.apple.tsm.portname' 10:44:13 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:44:13 INFO - PROCESS | 1907 | 2017-04-07 10:44:13.297 plugin-container[1909:11735] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 10:44:13 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:44:13 INFO - PROCESS | 1907 | 2017-04-07 10:44:13.297 plugin-container[1909:11735] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:44:13 INFO - PROCESS | 1907 | __metrics Screen width/height:1600/1200 10:44:13 INFO - PROCESS | 1907 | colorDepth:24 10:44:13 INFO - PROCESS | 1907 | Browser inner width/height: 1024/689 10:44:13 INFO - PROCESS | 1907 | __metrics 10:44:13 ERROR - PROCESS | 1907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 10:44:14 INFO - TEST-INFO | 1907: exit 0 10:44:14 INFO - Browser initialized. 10:44:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:44:14 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpKaH_yd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:44:16 INFO - PROCESS | 1910 | 2017-04-07 10:44:16.775 plugin-container[1911:11863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 10:44:16 INFO - PROCESS | 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:44:16 INFO - PROCESS | 1910 | 2017-04-07 10:44:16.776 plugin-container[1911:11863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 10:44:16 INFO - PROCESS | 1910 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:44:16 INFO - PROCESS | 1910 | 2017-04-07 10:44:16.776 plugin-container[1911:11863] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:44:26 INFO - PROCESS | 1910 | RSS: Main: 220553216 10:44:26 INFO - PROCESS | 1910 | 10:47:30 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49720/tests/dromaeo/cssquery-ext.html) 10:47:31 INFO - PROCESS | 1910 | RSS: Main: 244645888 10:47:31 INFO - PROCESS | 1910 | 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | A coding exception was thrown and uncaught in a Task. 10:49:14 INFO - PROCESS | 1910 | 10:49:14 ERROR - PROCESS | 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:49:14 INFO - PROCESS | 1910 | Full stack: 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | A coding exception was thrown and uncaught in a Task. 10:49:14 INFO - PROCESS | 1910 | 10:49:14 ERROR - PROCESS | 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:49:14 INFO - PROCESS | 1910 | Full stack: 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | A coding exception was thrown and uncaught in a Task. 10:49:14 INFO - PROCESS | 1910 | 10:49:14 ERROR - PROCESS | 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:49:14 INFO - PROCESS | 1910 | Full stack: 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | ************************* 10:49:14 INFO - PROCESS | 1910 | A coding exception was thrown and uncaught in a Task. 10:49:14 INFO - PROCESS | 1910 | 10:49:14 ERROR - PROCESS | 1910 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:49:14 INFO - PROCESS | 1910 | Full stack: 10:49:14 INFO - PROCESS | 1910 | ************************* 10:50:34 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-ext.html (next: http://localhost:49720/tests/dromaeo/cssquery-jquery.html) 10:50:34 INFO - PROCESS | 1910 | RSS: Main: 250916864 10:50:34 INFO - PROCESS | 1910 | 10:53:36 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49720/tests/dromaeo/cssquery-mootools.html) 10:53:37 INFO - PROCESS | 1910 | RSS: Main: 257343488 10:53:37 INFO - PROCESS | 1910 | 10:56:39 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49720/tests/dromaeo/cssquery-prototype.html) 10:56:39 INFO - PROCESS | 1910 | RSS: Main: 253501440 10:56:39 INFO - PROCESS | 1910 | 10:59:42 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49720/tests/dromaeo/cssquery-yui.html) 10:59:43 INFO - PROCESS | 1910 | RSS: Main: 259493888 10:59:43 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-yui.html (next: http://localhost:49720/tests/dromaeo/cssquery-dojo.html) 11:02:46 INFO - PROCESS | 1910 | RSS: Main: 255725568 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | __start_tp_report 11:02:46 INFO - PROCESS | 1910 | _x_x_mozilla_page_load 11:02:46 INFO - PROCESS | 1910 | _x_x_mozilla_page_load_details 11:02:46 INFO - PROCESS | 1910 | |i|pagename|runs| 11:02:46 INFO - PROCESS | 1910 | |0;dojo.html;3395.847186876591;3435.381631306364;3438.4842273658946;3439.914002149946;3445.328161008601;5910.143029260755;5958.433948774865;5978.163057172;5986.491148252393;6001.789937352182;5988.520918326534;6040.244969378828;6041.546883983697;6053.757849686007;6077.11881777142;4491.708038977472;5469.206964990094;5470.255733459507;5536.058869992091;5562.471565201299;5515.972420137894;5528.861778455531;5530.557555395559;5532.695701736403;5543.667379957195;5343.946560534403;5396.973015134939;5531.197976293435;5538.47384498472;5543.6119471637;4138.399932009872;5451.727413629303;5455.536279416255;5458.399576046631;5507.862303442446;5319;5394.865128371783;5406.432324605938;5433.483819037185;5438.510534051954;6035.245594300713;6037.63774173551;6077.3314935357075;6099.176611157482;6191.907121393183;6287.779927702554;6298.748050077991;6300.117983482316;6311.274203466614;6325.936740632581;5396.460353964611;5499.230107784913;6309.905351419732;6453.322401147906;6454.290028096905;6175.96912015446;6200.162977997958;6200.62796232223;6207;6207.224096987877;6232.657203853832;6354.618722876642;6543.640099794462;6593.538452308292;6604.537682362285;6319.115323854664;6375.521835862329;6377.7767778127545;6388.968055159788;6399.9040014399825;6506.577072490273;6533.738650453929;6533.738650454024;6541.247756507967;6556.7705130321165;6167.629942203482;6228.875422491525;6241.313455519889;6425.1968503937005;6449.742010319628;6290.779822706183;6303.873922521524;6316.115743795872;6337.397947195009;6354.3010268870385;5015;5052.014857102829;5063.772130254074;5069.847904562869;5116.053530096944;4586.908261834811;4605.148047611203;4607.170709272296;4623.4451865775645;4629.791659375336;6154.015357542772;6166.260048794084;6178.845528861814;6183.96908015457;6190.071489276645;6240.625562466175;6288.899442597527;6367.267764207083;6411.935880641227;6427.55007149495;6186.381361863778;6195.132681424514;6198.690065496708;6206;6214.347493513206;5697.572682048863;5719.799807006735;5724.284464441945;5725.8568535786935;5738.397468265772;6339.3343698912795;6385;6582.341765823571;6615.073889655549;6750.2237242715755;5125.1799712045895;6437.613743175237;6454.741810327534;6469.935300646934;6505.21937367519;6570.671466426564;6625.271220165681;6731.394174524316;6737.831554211184;6755;5414.431484694208;6244.968775156095;6246.656433896179;6408.295087540274;6421.614703117828;5729.570282228766;6129.295131059986;6428.19647544057;6436.066770318372;6460.806175814733;6313.905291420724;6329.5252856036905;6335.556511044183;6342;6362.695647392181;6117.694115294128;6135.202044401795;6283.120363149254;6334.113224148715;6360.904586431115;5978.073398623221;6061.242344706911;6232.5948813328805;6258.374162583706;6266.811995640138;6315.842103947438;6353.14232578596;6354.142190804368;6356.141920840627;6368;4693.460252071056;6026.457618814327;6034.2155519782145;6078.088286757022;6309.7160627770945 11:02:46 INFO - PROCESS | 1910 | |1;ext.html;738.9912769070218;777.2266594738235;830.6262182018094;940.7601061729258;945.0266225787441;37901.43147852781;38485;39521.4071788923;39564.20871582567;39586.8020659897;38478.807605961934;38645.03387415316;38669.61330386695;38719.41920871189;38817.41773873387;7783.649735761905;10450.21623378246;10732.570697172103;10891.128709703205;10901.890981090168;10536;10597.629082982097;10610.151187904949;10617.256792024562;10630.840537391945;10624.043836054754;10625.840612390783;10626.096781773558;10647.30792498489;10659;10571.788564228711;10583.629572964948;10602.575896964112;10638.308509946906;10644.946775266151;10362.585496580128;10411.687649370531;10418;10423.322484038514;10447.529861156267;27947.301317467023;33299;33423.6657633423;33525.161870953176;33531;3762.3415902217275;3819.350979512476;3822.9808850955847;3824.426336049587;3834.4631751554803;20580.691289630668;24696.641684707334;24797.014273519566;25132;25970.87014564934;3096.4426403247408;3097.4424603571574;3121.4849549824253;3130.4365214261425;3135.106494649037;341362;348537;349395;349556;349721;43784.56215437805;43822.78088609537;43833;43982.78008609937;44000;45684.086318274116;45948;46119.76940115278;46163;46280.53719462762;13736.45054197841;13796.379162937692;13998;14010;14056.297185140702;11911.821322680167;11971;11976.880231197576;11986.880131198577;12023.977961873165;11379.487923043484;11736.589219377282;11775.411229438494;11807.822882656767;11862.288262704265;4881.926771098437;5684.715764211773;5758.62568933018;5794.21778059965;5799.710014499258;961.9519024048769;1066.8186408310605;1098.774751176007;1113.2541197397763;1114.2311804854623;26490.47019059608;26650.600240996402;26877.865610671823;26951.460970780474;26969.865150674123;1129.497373668726;1154.2151337090859;1161.79668558002;1167.2121318110242;1205.7829590673587;13758.449662013607;13819.378127984264;13921.373538190806;13963.79054314186;14006.71986560263;184479;184900;184936.07531962253;185628.14371856378;185703;47235.29147062797;48550;54121;54486.72756636271;54546.727266363414;1398.2309729648653;1425.5937057938438;1427.1651084115701;1427.7929700193622;1433.2117335465452;20135.39593812188;22799;26251;26322;26649.267797593093;31304.843475782476;38627.42058869063;38775;38776.03059923412;38840.6115938837;456494;458309;458423;458539;459841;25526.617100743133;25670.61494077628;27977.72022279751;28751.42497150087;29926.401471970876;38016.809915950245;38714.80642596769;38774.2245155101;38796;38852;26829.463410731285;27370.178894632398;27830.860845695643;28028.71971280261;28183;22298.665520017537;27369.31576710598;27417.45165096727;28232;28345.574816377357;31693.841530792197;31956.520652190702;32030.679693203703;32260.83869580637;32451.837740811145;22799.430014249778;25632.8718356407;25737.42625737486;26564.601530976663;26573.468530629667;21410.57178856445;22261;22523.662145068163;22552.323430297118;22704.772952270265 11:02:46 INFO - PROCESS | 1910 | |2;jquery.html;415.6778496665086;430.63180980261865;431.7248102499826;440.14611653392416;444.5709889956192;18601.627967440643;20172.293969711045;20846;20857.53997220195;20917.95410229488;16103.436379726712;20790.688139677917;21158.084950058572;21459;21477.785222147773;6419.711112999927;6746.62893540855;6777.864442711143;6781.694823732919;6791.524593278473;6365.968170159143;6609.570377925444;6659.966700166492;6667.766628168015;6692.263850976388;6365.108884756138;6647.900281495781;6659.500537459686;6676.5660232085;6686.231083425396;6715.7313707451885;6717.59694418334;6733.39399454049;6752.5948443093575;6759.290274521154;6267.715118400717;6334.651594162319;6457.12828768115;6472.805815825533;6575.309592492815;20216.39350819478;24360.756392436026;24644.50710985788;24844.254672359857;25038.874805626037;2840.8721607527505;2859.642544681915;2867.3978464522474;2880;2908.3746994396097;12897.484100636057;15961.04233745979;16207.02757834522;16230.675386492323;16514.42199523023;2020.5150763816725;2082.3544701142696;2089.8223650989685;2093.235968871351;2095.172406899266;102951;126986;129000;130855;132769.33615331957;19797.703034454495;20823.06296216674;20882.373528793858;20970.895145524173;21057.473563161042;27387.45225095487;33119.503207451904;33569.99290021303;33753.49369759455;33953.49069763956;8587.92650918635;9809.117179453884;10533.315334503233;10542.947285263524;10662.733431664115;8611.741647750578;8658.826823463496;8671.655893336543;8793.20861122502;8810.383273170944;9894.455804930654;9903;9977.201823854075;10051.889103288246;10119.898801012043;3661.0664280608275;3740.532433445819;3744.4008958566496;3870.767753934773;4373.813093453274;812.2202685421943;832.7418500264937;892.607252808762;915.4964769376816;949.0746522140857;20541.97290135487;21270.893645531673;21334.63613069182;21341;21460.463488412915;946.8059047895165;951.1202138022302;951.3483263964207;967.5984466446487;967.6322997261136;9621.711348659412;10538.420386878643;10692.499462926837;11218;11327.660170194908;652540.7372963105;709360;710744;714687;741493;120364;124764.37617812035;128821.35589322181;137111.31444342714;162995;1319.195290872567;1352.7767918293569;1381.5786185213606;1389.2220356600135;1390.0755997261708;18036;19132.426027219204;19174.808251917304;19200.80799192046;19284.903575482032;59845.40154598398;59912;60630;61002.084968724615;61370.69314653398;83009;84395.57802210949;85927.41471804313;86605;86811;9610.759731006501;10792.136629069499;10807.757107932688;10925.617603383844;11219.439028048728;10362;11991.82012269834;12053.758924821279;12171.96538294255;12296.692582685504;9602.423854568748;9662.323637345318;9925.647585545401;10282.07461328484;10582.365058096539;9582.712518624452;9789.314747967574;9836.754081148028;9907;10071.899281007389;10339.224558158017;10456.529456174338;10580.735481613021;10712.196585256293;10751.408672523086;10757.13942884583;10779.892201078203;10875.51060202277;11153.386563739072;11175.49710263024;8371.204735550113;10143.239257055602;10163.136133428445;10334.948325258325;10656.200784941006 11:02:46 INFO - PROCESS | 1910 | |3;mootools.html;1493.313075985047;1535.1403214200056;1553.819097485911;1559.563322269764;1569.4663814303137;9512.762180945463;9720.173785228246;10845.023947844693;11522.481488333015;11553.65339039829;10819.729506762334;11117.94379533943;11355.545778168864;11360.829587556193;11368.658940231786;2379.1078345620435;2433.6592876997233;2444.755524447559;2448.8979959018425;2454.4109413740753;2391.4977854650456;2422.4307287787356;2423.7697418745192;2428.5749993751024;2429.0890915906534;2351.423901144222;2393.44950661348;2402.0631953538136;2447.1068060158004;2454.3250606083293;2375.869327187021;2380.8809559521956;2388.22382725614;2390.8326417150806;2397.940051498709;2349.0721165139844;2365.976340236593;2377.21865417462;2379.940501487459;2381.1784934197676;11323;11443.198976071679;11456.599019034295;11471.024962878166;11504.712382190428;5837;5936.881262374728;6017.458428741391;6055.545834062463;6056.909146362808;3451.7411194160286;3529.3823580873245;3590.120420496969;3673.9081522961874;3715.052661571282;1195.4620420810584;1200.873908239631;1234.2471092633486;1248.2260998181187;1259.225576270596;13199.538016169388;15746.606334841606;15919.283632236577;15952.920235398864;16076.035437873765;4907.411110666742;5014.84955451337;5027.723475208899;5051.797928082836;5073.619478539124;11441.855814418657;13157.473701051851;13177.934110329386;13199.274039927705;13251.469941202244;4751.859553707154;5016.272640467185;5961.105834124916;5963.522918166536;6053.273607167168;4193.91612167761;4909.631777616622;5056.974715126401;5346.1713434417725;5419.620626556182;4076.3076923076924;4166.854160104382;4198.202341555095;4219.746815191098;4234.70357075008;1168.894799468052;1169.33369947824;1169.368540987857;1185.6917201527492;1195.2708847602955;858.5020688000944;921.530019689963;931.1200915135267;939.3377668743519;958.736347504428;6560.245571759308;6660.467162626978;6669.1330127083165;6785.59286442815;6793.082933803972;792.528445574882;969.9369540979955;1026.9537870795682;1033.132168978047;1052.5684469367675;4157.958420415817;4224.176285624274;4271.295236286041;4371.912561748747;4383.211022016068;13255.867441325656;13747.931260343834;13748.65628359279;13767.31163441824;13790.793138102936;10979;13693.383797729126;13697.794533082011;13714.794278085838;13809.24049177305;10225.642102526375;10463.006014428616;10470.633527826642;10495.737606559744;10510.581071555394;5931.228940237914;6549.869002619826;6804.795856124324;6904.896426553706;7023.859522809413;12068.155229133876;12267.509299627915;12396.31820249895;12406.565770198;12407.627771166879;11758.529658813552;12433.875661243272;12444.191127576678;12537.122401432178;12654;8131.146229645802;8326.250637442417;9134;9449.055094490495;9628.374155679858;10504.527296271533;10544.630937917136;10553.155747540332;10603.310784798963;10685.57257709714;8875.556222188994;8917.910820891968;8946.731598052069;9041.141091596288;9097.590608422504;8631.309495240492;8737.301015918583;8742.519161446182;8754.47473151613;8834.734957951272;7773.222677732181;7775.105862825847;7870.72452464161;7916.208379162038;8041.155678653891;5992.221011268682;6043.697815109315;6047.909281360695;6072.14989901423;6096.116063170727;5891.1752354671235;6092.116643086816;6170.382961703974;6196.659183744938;6220.253569571681 11:02:46 INFO - PROCESS | 1910 | |4;prototype.html;354.39398628345526;366.79142226364127;381.62219402791237;387.33958600585987;394.528538396616;3950.940735888964;4508.526604706508;4806.134895718769;4927.753612319383;5084.720340381277;4653.511381304965;5003.924941125877;5071.7827721346885;5092.567131793793;5131.692098474095;3839.3856982882676;4251.3622956556455;4287.635550978155;4317.244482215599;4325.956740432587;4060.634542891139;4290.506591741942;4291.678124140686;4309;4312.97843510782;3517.9648203517895;3977.9171142364607;4287.485501739796;4297.871063868089;4329.653627709776;4166.91666166675;4311.719738217006;4316.338209789238;4322.351647252937;4373.431453910971;3999.340108882031;4007.6593489553425;4016.895353777705;4027.637512623878;4092.324766413568;4187.539370669224;4307.590778876001;4512.796924138422;4925.435623429944;5043.672161309503;4486.596206341413;4500.829784256084;4942.481039490837;5013.824516141917;5049.671771334852;5564.137558678412;5579.6652200868075;5589.456797157283;5593.084840611588;5609.803656872031;4048.8419033154187;4278.256525540152;4391.650467000171;4415.918100065473;4435.334699795057;5165.845024649229;5349.866253343658;5640.717964101778;5835.649861008311;5897.14491398749;3938.960610393917;4318.913621727611;4488.842890498817;4501.617362524156;4513.751743654065;4265.53079161292;4404.185225733249;4464.682918539039;4598.540145985375;4599.333096701027;4078.57174996627;4818.951810481921;4858.611311095104;4920.72935988524;4939.654224204343;4655.32050897904;5470.452954704578;5497.725113744297;5508.228847961289;5616.652003519126;1390.5411214299256;1439.755241608929;1448.7681970884607;1510.2901636230954;1570.0658108425469;1039.927205095651;1087.342157994418;1180.689434727452;1192.6183621241119;1211.4064108586729;4639.675222734444;4747.430308363018;5200.583953283804;5241.528262456397;5243.764030618631;5744.041818463495;5761.925706745568;5788.131780232999;5797.536197104221;5806.970965145232;4300.1399720056115;4479.664025198058;4884.28794116474;5120.718360490208;5220.112580861262;2590.3394634368115;2672.371992581742;2688.9647485718137;2831.830090194595;3006.7972810875826;5319.787208511616;5972.970135149297;6023.7471765247155;6045.879082418327;6063.7574497020505;5114.488551144856;5196.792128314825;5196.92204616931;5238.057149713089;5527.668339899619;5464.9453505465235;5723.771049157987;5956.400983075895;5965.850853728692;6034.9094763577705;5386.326709161355;5396.541293989898;5431.728413579226;5747.74135163927;5805.883882322414;4884.5603895649565;5096.949030509648;5695.117256825199;5722.656640601577;5725.255716756961;5769.68266745333;5850.3857095006115;5933.525317974638;5973.522118230618;6047.52267446229;4185.309423945015;4371.169477799208;4565.6119229865835;4593.908121837611;4624.0058387445515;4867.878303042452;5395.298611180521;5512.7519261634125;5731.277643119485;5829.183914251923;4835.709857408567;5105.9662866335175;5397.7840886365675;5553.805931724699;5611.382747897646;4625.560571745679;4975.850724478271;5050.797968081236;5185.974070129776;5451.073317536107;4591.609713174417;4750.857474275777;4967.428745694291;4993.851414174687;5464.754086066057;5220.530152286161;5383.515483606494;5567.916481252703;5586.692731899784;5619.943800561942;4968.950310496994;5137.563307118788;5468.972655136698;5490.917636235539;5512.641678290898 11:02:46 INFO - PROCESS | 1910 | |5;yui.html;689.4381079420269;707.6214225389415;755.1240560949299;768.0476209500222;824.4682179993906;14940.25298735063;15881.682366352667;15957;15960.122193279365;15960.840391596095;14045.36795844187;14975.700485990274;15142.545723628282;15177.241137943087;15247.542573722778;940.6613619097119;951.286535098676;970.1947383671571;975.1321324021626;975.8438649816031;941.7174847545743;978.2663002747939;979.5689896445576;981.793823297105;988.6193815381095;1022.5245260953656;1023.7850051489196;1025.3027941000116;1026.8203064463726;1028.0798685176762;1008.1078245752525;1022.0852337158276;1022.4734261855151;1022.4785359466688;1023.6570748799161;765.5751058162717;766.5247546521136;767.0258771360341;769.9114601820806;770.0105364606454;15693.686126277411;15940.123293218869;16005.439809606723;16685.416010439698;16964.74552881708;11826.172167948247;12221.185184445721;12750.872491275153;14062.156270623795;14159.292035398188;12623.242605443702;12866.228026318451;12880.514386435367;13231.630455280814;13261.138026028373;3676.963230367689;4462.709923854972;4508.211063063951;4528.773561321921;4570.520095390003;96613.51693241559;105215.68277217154;108432;109386;111920;10524.421156836295;10823.567057317776;10908;10948.4525773711;11410.030147437395;21474.78525214759;22193.889030554743;22312.442188945406;22347.55304893893;22516.774832251467;7597.506162099446;7636.320129216219;7808.297253247121;7869.527828330319;8216.383771217183;4253.76604286761;4282.8715138545895;4294.334378171388;4490.685652004328;4569;3472;3479.6520347965;3524.9823750881596;3528.259065596202;3561.2521370511963;465.5530690537055;492.6624215255598;561.7752898840497;562.6624025584616;565.926429564154;660.3066779881202;673.7170388436869;696.9024336592881;699.7166147710185;730.375528922774;10283.898749606651;10324.845127323097;10340.482975851177;10511.84232236517;10551.366917984791;699.4264702943537;700.726716580534;701.6561884676472;711.4806191480145;712.771912987839;4802.73584952831;5049.31834202378;5071.847844564669;5074.720890350993;5092.439831618519;102961.48519257356;104679.4766026165;105905;106338;109212;91184.54407727919;92431;93001;94654;96062;81245.59377203076;81561.59219203866;82214.58892705498;82854.17145828585;84072.57963710265;9734.230227188767;9764.75987150577;9830.655927042519;9848.852267216142;9856.605735770776;36736.448953265186;37401;48399.51600484091;49118.26322605092;49719.00561988667;59069;60398.69800651145;60607.09089363575;61460;61917;10310.536025878704;11135.888641113484;11297.491612877604;11384.43077846121;11531.596394126502;12395.876041239471;12575.434105465092;12814.871851281741;12882.09825312219;13179.945604351436;11732.530698771954;11906.404679765803;12058.939705301418;12195;12487;11775;12061.51753929833;12128.151029427856;12311.445984930879;12389;11634.185607007767;12017.819732703842;12273.509059637872;12403.193792403465;12537.623871283877;8670.56935605618;8701.869471958053;8819.470831750115;8841.955790221007;8976.640934362553;9576;10002.399856008662;10100.646477373257;10124.443155626512;10131.392116473035 11:02:46 INFO - PROCESS | 1910 | __end_tp_report 11:02:46 INFO - PROCESS | 1910 | __start_cc_report 11:02:46 INFO - PROCESS | 1910 | _x_x_mozilla_cycle_collect,419 11:02:46 INFO - PROCESS | 1910 | __end_cc_report 11:02:46 INFO - PROCESS | 1910 | __startTimestamp1491588166820__endTimestamp 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | ------- Summary: start ------- 11:02:46 INFO - PROCESS | 1910 | Number of tests: 6 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | [#0] dojo.html Cycles:165 Average:5933.14 Median:6195.13 stddev:683.77 (11.0%) stddev-sans-first:656.26 11:02:46 INFO - PROCESS | 1910 | Values: 3395.8 3435.4 3438.5 3439.9 3445.3 5910.1 5958.4 5978.2 5986.5 6001.8 5988.5 6040.2 6041.5 6053.8 6077.1 4491.7 5469.2 5470.3 5536.1 5562.5 5516.0 5528.9 5530.6 5532.7 5543.7 5343.9 5397.0 5531.2 5538.5 5543.6 4138.4 5451.7 5455.5 5458.4 5507.9 5319.0 5394.9 5406.4 5433.5 5438.5 6035.2 6037.6 6077.3 6099.2 6191.9 6287.8 6298.7 6300.1 6311.3 6325.9 5396.5 5499.2 6309.9 6453.3 6454.3 6176.0 6200.2 6200.6 6207.0 6207.2 6232.7 6354.6 6543.6 6593.5 6604.5 6319.1 6375.5 6377.8 6389.0 6399.9 6506.6 6533.7 6533.7 6541.2 6556.8 6167.6 6228.9 6241.3 6425.2 6449.7 6290.8 6303.9 6316.1 6337.4 6354.3 5015.0 5052.0 5063.8 5069.8 5116.1 4586.9 4605.1 4607.2 4623.4 4629.8 6154.0 6166.3 6178.8 6184.0 6190.1 6240.6 6288.9 6367.3 6411.9 6427.6 6186.4 6195.1 6198.7 6206.0 6214.3 5697.6 5719.8 5724.3 5725.9 5738.4 6339.3 6385.0 6582.3 6615.1 6750.2 5125.2 6437.6 6454.7 6469.9 6505.2 6570.7 6625.3 6731.4 6737.8 6755.0 5414.4 6245.0 6246.7 6408.3 6421.6 5729.6 6129.3 6428.2 6436.1 6460.8 6313.9 6329.5 6335.6 6342.0 6362.7 6117.7 6135.2 6283.1 6334.1 6360.9 5978.1 6061.2 6232.6 6258.4 6266.8 6315.8 6353.1 6354.1 6356.1 6368.0 4693.5 6026.5 6034.2 6078.1 6309.7 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | [#1] ext.html Cycles:180 Average:46582.11 Median:26960.66 stddev:92820.96 (344.3%) stddev-sans-first:93017.53 11:02:46 INFO - PROCESS | 1910 | Values: 739.0 777.2 830.6 940.8 945.0 37901.4 38485.0 39521.4 39564.2 39586.8 38478.8 38645.0 38669.6 38719.4 38817.4 7783.6 10450.2 10732.6 10891.1 10901.9 10536.0 10597.6 10610.2 10617.3 10630.8 10624.0 10625.8 10626.1 10647.3 10659.0 10571.8 10583.6 10602.6 10638.3 10644.9 10362.6 10411.7 10418.0 10423.3 10447.5 27947.3 33299.0 33423.7 33525.2 33531.0 3762.3 3819.4 3823.0 3824.4 3834.5 20580.7 24696.6 24797.0 25132.0 25970.9 3096.4 3097.4 3121.5 3130.4 3135.1 341362.0 348537.0 349395.0 349556.0 349721.0 43784.6 43822.8 43833.0 43982.8 44000.0 45684.1 45948.0 46119.8 46163.0 46280.5 13736.5 13796.4 13998.0 14010.0 14056.3 11911.8 11971.0 11976.9 11986.9 12024.0 11379.5 11736.6 11775.4 11807.8 11862.3 4881.9 5684.7 5758.6 5794.2 5799.7 962.0 1066.8 1098.8 1113.3 1114.2 26490.5 26650.6 26877.9 26951.5 26969.9 1129.5 1154.2 1161.8 1167.2 1205.8 13758.4 13819.4 13921.4 13963.8 14006.7 184479.0 184900.0 184936.1 185628.1 185703.0 47235.3 48550.0 54121.0 54486.7 54546.7 1398.2 1425.6 1427.2 1427.8 1433.2 20135.4 22799.0 26251.0 26322.0 26649.3 31304.8 38627.4 38775.0 38776.0 38840.6 456494.0 458309.0 458423.0 458539.0 459841.0 25526.6 25670.6 27977.7 28751.4 29926.4 38016.8 38714.8 38774.2 38796.0 38852.0 26829.5 27370.2 27830.9 28028.7 28183.0 22298.7 27369.3 27417.5 28232.0 28345.6 31693.8 31956.5 32030.7 32260.8 32451.8 22799.4 25632.9 25737.4 26564.6 26573.5 21410.6 22261.0 22523.7 22552.3 22704.8 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | [#2] jquery.html Cycles:180 Average:40076.33 Median:15114.16 stddev:117166.54 (775.2%) stddev-sans-first:117457.38 11:02:46 INFO - PROCESS | 1910 | Values: 415.7 430.6 431.7 440.1 444.6 18601.6 20172.3 20846.0 20857.5 20918.0 16103.4 20790.7 21158.1 21459.0 21477.8 6419.7 6746.6 6777.9 6781.7 6791.5 6366.0 6609.6 6660.0 6667.8 6692.3 6365.1 6647.9 6659.5 6676.6 6686.2 6715.7 6717.6 6733.4 6752.6 6759.3 6267.7 6334.7 6457.1 6472.8 6575.3 20216.4 24360.8 24644.5 24844.3 25038.9 2840.9 2859.6 2867.4 2880.0 2908.4 12897.5 15961.0 16207.0 16230.7 16514.4 2020.5 2082.4 2089.8 2093.2 2095.2 102951.0 126986.0 129000.0 130855.0 132769.3 19797.7 20823.1 20882.4 20970.9 21057.5 27387.5 33119.5 33570.0 33753.5 33953.5 8587.9 9809.1 10533.3 10542.9 10662.7 8611.7 8658.8 8671.7 8793.2 8810.4 9894.5 9903.0 9977.2 10051.9 10119.9 3661.1 3740.5 3744.4 3870.8 4373.8 812.2 832.7 892.6 915.5 949.1 20542.0 21270.9 21334.6 21341.0 21460.5 946.8 951.1 951.3 967.6 967.6 9621.7 10538.4 10692.5 11218.0 11327.7 652540.7 709360.0 710744.0 714687.0 741493.0 120364.0 124764.4 128821.4 137111.3 162995.0 1319.2 1352.8 1381.6 1389.2 1390.1 18036.0 19132.4 19174.8 19200.8 19284.9 59845.4 59912.0 60630.0 61002.1 61370.7 83009.0 84395.6 85927.4 86605.0 86811.0 9610.8 10792.1 10807.8 10925.6 11219.4 10362.0 11991.8 12053.8 12172.0 12296.7 9602.4 9662.3 9925.6 10282.1 10582.4 9582.7 9789.3 9836.8 9907.0 10071.9 10339.2 10456.5 10580.7 10712.2 10751.4 10757.1 10779.9 10875.5 11153.4 11175.5 8371.2 10143.2 10163.1 10334.9 10656.2 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | [#3] mootools.html Cycles:180 Average:6819.41 Median:2439.21 stddev:4261.72 (174.7%) stddev-sans-first:4254.89 11:02:46 INFO - PROCESS | 1910 | Values: 1493.3 1535.1 1553.8 1559.6 1569.5 9512.8 9720.2 10845.0 11522.5 11553.7 10819.7 11117.9 11355.5 11360.8 11368.7 2379.1 2433.7 2444.8 2448.9 2454.4 2391.5 2422.4 2423.8 2428.6 2429.1 2351.4 2393.4 2402.1 2447.1 2454.3 2375.9 2380.9 2388.2 2390.8 2397.9 2349.1 2366.0 2377.2 2379.9 2381.2 11323.0 11443.2 11456.6 11471.0 11504.7 5837.0 5936.9 6017.5 6055.5 6056.9 3451.7 3529.4 3590.1 3673.9 3715.1 1195.5 1200.9 1234.2 1248.2 1259.2 13199.5 15746.6 15919.3 15952.9 16076.0 4907.4 5014.8 5027.7 5051.8 5073.6 11441.9 13157.5 13177.9 13199.3 13251.5 4751.9 5016.3 5961.1 5963.5 6053.3 4193.9 4909.6 5057.0 5346.2 5419.6 4076.3 4166.9 4198.2 4219.7 4234.7 1168.9 1169.3 1169.4 1185.7 1195.3 858.5 921.5 931.1 939.3 958.7 6560.2 6660.5 6669.1 6785.6 6793.1 792.5 969.9 1027.0 1033.1 1052.6 4158.0 4224.2 4271.3 4371.9 4383.2 13255.9 13747.9 13748.7 13767.3 13790.8 10979.0 13693.4 13697.8 13714.8 13809.2 10225.6 10463.0 10470.6 10495.7 10510.6 5931.2 6549.9 6804.8 6904.9 7023.9 12068.2 12267.5 12396.3 12406.6 12407.6 11758.5 12433.9 12444.2 12537.1 12654.0 8131.1 8326.3 9134.0 9449.1 9628.4 10504.5 10544.6 10553.2 10603.3 10685.6 8875.6 8917.9 8946.7 9041.1 9097.6 8631.3 8737.3 8742.5 8754.5 8834.7 7773.2 7775.1 7870.7 7916.2 8041.2 5992.2 6043.7 6047.9 6072.1 6096.1 5891.2 6092.1 6170.4 6196.7 6220.3 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | [#4] prototype.html Cycles:180 Average:4597.90 Median:4926.59 stddev:1295.58 (26.3%) stddev-sans-first:1259.46 11:02:46 INFO - PROCESS | 1910 | Values: 354.4 366.8 381.6 387.3 394.5 3950.9 4508.5 4806.1 4927.8 5084.7 4653.5 5003.9 5071.8 5092.6 5131.7 3839.4 4251.4 4287.6 4317.2 4326.0 4060.6 4290.5 4291.7 4309.0 4313.0 3518.0 3977.9 4287.5 4297.9 4329.7 4166.9 4311.7 4316.3 4322.4 4373.4 3999.3 4007.7 4016.9 4027.6 4092.3 4187.5 4307.6 4512.8 4925.4 5043.7 4486.6 4500.8 4942.5 5013.8 5049.7 5564.1 5579.7 5589.5 5593.1 5609.8 4048.8 4278.3 4391.7 4415.9 4435.3 5165.8 5349.9 5640.7 5835.6 5897.1 3939.0 4318.9 4488.8 4501.6 4513.8 4265.5 4404.2 4464.7 4598.5 4599.3 4078.6 4819.0 4858.6 4920.7 4939.7 4655.3 5470.5 5497.7 5508.2 5616.7 1390.5 1439.8 1448.8 1510.3 1570.1 1039.9 1087.3 1180.7 1192.6 1211.4 4639.7 4747.4 5200.6 5241.5 5243.8 5744.0 5761.9 5788.1 5797.5 5807.0 4300.1 4479.7 4884.3 5120.7 5220.1 2590.3 2672.4 2689.0 2831.8 3006.8 5319.8 5973.0 6023.7 6045.9 6063.8 5114.5 5196.8 5196.9 5238.1 5527.7 5464.9 5723.8 5956.4 5965.9 6034.9 5386.3 5396.5 5431.7 5747.7 5805.9 4884.6 5096.9 5695.1 5722.7 5725.3 5769.7 5850.4 5933.5 5973.5 6047.5 4185.3 4371.2 4565.6 4593.9 4624.0 4867.9 5395.3 5512.8 5731.3 5829.2 4835.7 5106.0 5397.8 5553.8 5611.4 4625.6 4975.9 5050.8 5186.0 5451.1 4591.6 4750.9 4967.4 4993.9 5464.8 5220.5 5383.5 5567.9 5586.7 5619.9 4969.0 5137.6 5469.0 5490.9 5512.6 11:02:46 INFO - PROCESS | 1910 | 11:02:46 INFO - PROCESS | 1910 | [#5] yui.html Cycles:180 Average:20298.08 Median:3526.62 stddev:29825.33 (845.7%) stddev-sans-first:29872.66 11:02:46 INFO - PROCESS | 1910 | Values: 689.4 707.6 755.1 768.0 824.5 14940.3 15881.7 15957.0 15960.1 15960.8 14045.4 14975.7 15142.5 15177.2 15247.5 940.7 951.3 970.2 975.1 975.8 941.7 978.3 979.6 981.8 988.6 1022.5 1023.8 1025.3 1026.8 1028.1 1008.1 1022.1 1022.5 1022.5 1023.7 765.6 766.5 767.0 769.9 770.0 15693.7 15940.1 16005.4 16685.4 16964.7 11826.2 12221.2 12750.9 14062.2 14159.3 12623.2 12866.2 12880.5 13231.6 13261.1 3677.0 4462.7 4508.2 4528.8 4570.5 96613.5 105215.7 108432.0 109386.0 111920.0 10524.4 10823.6 10908.0 10948.5 11410.0 21474.8 22193.9 22312.4 22347.6 22516.8 7597.5 7636.3 7808.3 7869.5 8216.4 4253.8 4282.9 4294.3 4490.7 4569.0 3472.0 3479.7 3525.0 3528.3 3561.3 465.6 492.7 561.8 562.7 565.9 660.3 673.7 696.9 699.7 730.4 10283.9 10324.8 10340.5 10511.8 10551.4 699.4 700.7 701.7 711.5 712.8 4802.7 5049.3 5071.8 5074.7 5092.4 102961.5 104679.5 105905.0 106338.0 109212.0 91184.5 92431.0 93001.0 94654.0 96062.0 81245.6 81561.6 82214.6 82854.2 84072.6 9734.2 9764.8 9830.7 9848.9 9856.6 36736.4 37401.0 48399.5 49118.3 49719.0 59069.0 60398.7 60607.1 61460.0 61917.0 10310.5 11135.9 11297.5 11384.4 11531.6 12395.9 12575.4 12814.9 12882.1 13179.9 11732.5 11906.4 12058.9 12195.0 12487.0 11775.0 12061.5 12128.2 12311.4 12389.0 11634.2 12017.8 12273.5 12403.2 12537.6 8670.6 8701.9 8819.5 8842.0 8976.6 9576.0 10002.4 10100.6 10124.4 10131.4 11:02:46 INFO - PROCESS | 1910 | -------- Summary: end -------- 11:02:46 INFO - PROCESS | 1910 | 11:02:47 INFO - TEST-INFO | 1910: exit 0 11:02:47 INFO - TEST-OK | dromaeo_css | took 1117317ms 11:02:47 INFO - TEST-START | kraken 11:02:47 INFO - operating with platform_type : mac_ 11:02:47 INFO - Initialising browser for kraken test... 11:02:47 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpMRONDg/profile http://localhost:49720/getInfo.html) 11:02:50 INFO - PROCESS | 1916 | 2017-04-07 11:02:50.427 plugin-container[1917:14111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 11:02:50 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:50 INFO - PROCESS | 1916 | 2017-04-07 11:02:50.429 plugin-container[1917:14111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 11:02:50 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:50 INFO - PROCESS | 1916 | 2017-04-07 11:02:50.429 plugin-container[1917:14111] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:02:50 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 11:02:50 INFO - PROCESS | 1916 | colorDepth:24 11:02:50 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 11:02:50 INFO - PROCESS | 1916 | __metrics 11:02:50 ERROR - PROCESS | 1916 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 11:02:51 INFO - TEST-INFO | 1916: exit 0 11:02:51 INFO - Browser initialized. 11:02:51 INFO - Running cycle 1/1 for kraken test... 11:02:51 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpMRONDg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:53 INFO - PROCESS | 1918 | 2017-04-07 11:02:53.713 plugin-container[1919:14229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 11:02:53 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:53 INFO - PROCESS | 1918 | 2017-04-07 11:02:53.714 plugin-container[1919:14229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.CFPasteboardClient' 11:02:53 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:02:53 INFO - PROCESS | 1918 | 2017-04-07 11:02:53.714 plugin-container[1919:14229] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:03:03 INFO - PROCESS | 1918 | RSS: Main: 221167616 11:03:03 INFO - PROCESS | 1918 | 11:03:06 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-beat-detection) 11:03:07 INFO - PROCESS | 1918 | RSS: Main: 235663360 11:03:07 INFO - PROCESS | 1918 | 11:03:10 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-dft) 11:03:10 INFO - PROCESS | 1918 | RSS: Main: 243601408 11:03:10 INFO - PROCESS | 1918 | 11:03:14 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-fft) 11:03:14 INFO - PROCESS | 1918 | RSS: Main: 247345152 11:03:14 INFO - PROCESS | 1918 | 11:03:16 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-oscillator) 11:03:17 INFO - PROCESS | 1918 | RSS: Main: 248717312 11:03:17 INFO - PROCESS | 1918 | 11:03:19 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:03:19 INFO - PROCESS | 1918 | RSS: Main: 248778752 11:03:19 INFO - PROCESS | 1918 | 11:03:22 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-darkroom) 11:03:23 INFO - PROCESS | 1918 | RSS: Main: 252809216 11:03:23 INFO - PROCESS | 1918 | 11:03:27 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-desaturate) 11:03:27 INFO - PROCESS | 1918 | RSS: Main: 252542976 11:03:27 INFO - PROCESS | 1918 | 11:03:30 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49720/tests/kraken/driver.html?testName=json-parse-financial) 11:03:31 INFO - PROCESS | 1918 | RSS: Main: 252063744 11:03:31 INFO - PROCESS | 1918 | 11:03:33 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:03:33 INFO - PROCESS | 1918 | RSS: Main: 252035072 11:03:33 INFO - PROCESS | 1918 | 11:03:35 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:03:36 INFO - PROCESS | 1918 | RSS: Main: 252026880 11:03:36 INFO - PROCESS | 1918 | 11:03:38 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:03:39 INFO - PROCESS | 1918 | RSS: Main: 252084224 11:03:39 INFO - PROCESS | 1918 | 11:03:42 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:03:43 INFO - PROCESS | 1918 | RSS: Main: 252735488 11:03:43 INFO - PROCESS | 1918 | 11:03:45 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:03:46 INFO - PROCESS | 1918 | RSS: Main: 252215296 11:03:46 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49720/tests/kraken/driver.html?testName=ai-astar) 11:03:48 INFO - PROCESS | 1918 | RSS: Main: 254119936 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | __start_tp_report 11:03:48 INFO - PROCESS | 1918 | _x_x_mozilla_page_load 11:03:48 INFO - PROCESS | 1918 | _x_x_mozilla_page_load_details 11:03:48 INFO - PROCESS | 1918 | |i|pagename|runs| 11:03:48 INFO - PROCESS | 1918 | |0;ai-astar;108;121;120;120;116;143;150;178;99;180 11:03:48 INFO - PROCESS | 1918 | |1;audio-beat-detection;134;113;109;148;129;115;101;141;119;111 11:03:48 INFO - PROCESS | 1918 | |2;audio-dft;217;280;242;200;198;205;200;204;195;198 11:03:48 INFO - PROCESS | 1918 | |3;audio-fft;83;61;61;86;64;63;62;62;77;61 11:03:48 INFO - PROCESS | 1918 | |4;audio-oscillator;88;70;84;73;72;70;83;71;72;83 11:03:48 INFO - PROCESS | 1918 | |5;imaging-gaussian-blur;90;90;90;89;91;124;135;134;89;89 11:03:48 INFO - PROCESS | 1918 | |6;imaging-darkroom;98;97;118;155;107;96;158;154;103;154 11:03:48 INFO - PROCESS | 1918 | |7;imaging-desaturate;101;95;143;92;92;92;123;93;144;102 11:03:48 INFO - PROCESS | 1918 | |8;json-parse-financial;66;65;64;65;70;73;99;100;102;88 11:03:48 INFO - PROCESS | 1918 | |9;json-stringify-tinderbox;56;61;57;68;62;57;58;56;59;59 11:03:48 INFO - PROCESS | 1918 | |10;stanford-crypto-aes;87;84;88;84;88;86;104;104;106;103 11:03:48 INFO - PROCESS | 1918 | |11;stanford-crypto-ccm;152;172;151;150;142;150;173;150;203;187 11:03:48 INFO - PROCESS | 1918 | |12;stanford-crypto-pbkdf2;172;174;171;168;174;166;168;170;169;167 11:03:48 INFO - PROCESS | 1918 | |13;stanford-crypto-sha256-iterative;69;67;66;65;66;67;68;68;64;67 11:03:48 INFO - PROCESS | 1918 | __end_tp_report 11:03:48 INFO - PROCESS | 1918 | __start_cc_report 11:03:48 INFO - PROCESS | 1918 | _x_x_mozilla_cycle_collect,1006 11:03:48 INFO - PROCESS | 1918 | __end_cc_report 11:03:48 INFO - PROCESS | 1918 | __startTimestamp1491588228527__endTimestamp 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | ------- Summary: start ------- 11:03:48 INFO - PROCESS | 1918 | Number of tests: 14 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#0] ai-astar Cycles:10 Average:133.50 Median:146.50 stddev:28.23 (19.3%) stddev-sans-first:28.39 11:03:48 INFO - PROCESS | 1918 | Values: 108.0 121.0 120.0 120.0 116.0 143.0 150.0 178.0 99.0 180.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:124.00 stddev:15.28 (12.3%) stddev-sans-first:15.57 11:03:48 INFO - PROCESS | 1918 | Values: 134.0 113.0 109.0 148.0 129.0 115.0 101.0 141.0 119.0 111.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#2] audio-dft Cycles:10 Average:213.90 Median:204.50 stddev:27.07 (13.2%) stddev-sans-first:28.69 11:03:48 INFO - PROCESS | 1918 | Values: 217.0 280.0 242.0 200.0 198.0 205.0 200.0 204.0 195.0 198.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#3] audio-fft Cycles:10 Average:68.00 Median:63.50 stddev:9.94 (15.7%) stddev-sans-first:8.94 11:03:48 INFO - PROCESS | 1918 | Values: 83.0 61.0 61.0 86.0 64.0 63.0 62.0 62.0 77.0 61.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:78.00 stddev:7.00 (9.0%) stddev-sans-first:6.08 11:03:48 INFO - PROCESS | 1918 | Values: 88.0 70.0 84.0 73.0 72.0 70.0 83.0 71.0 72.0 83.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#5] imaging-gaussian-blur Cycles:10 Average:102.10 Median:89.50 stddev:20.16 (22.5%) stddev-sans-first:20.90 11:03:48 INFO - PROCESS | 1918 | Values: 90.0 90.0 90.0 89.0 91.0 124.0 135.0 134.0 89.0 89.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#6] imaging-darkroom Cycles:10 Average:124.00 Median:156.50 stddev:27.63 (17.7%) stddev-sans-first:27.66 11:03:48 INFO - PROCESS | 1918 | Values: 98.0 97.0 118.0 155.0 107.0 96.0 158.0 154.0 103.0 154.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:92.00 stddev:21.06 (22.9%) stddev-sans-first:22.20 11:03:48 INFO - PROCESS | 1918 | Values: 101.0 95.0 143.0 92.0 92.0 92.0 123.0 93.0 144.0 102.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#8] json-parse-financial Cycles:10 Average:79.20 Median:68.00 stddev:16.17 (23.8%) stddev-sans-first:16.43 11:03:48 INFO - PROCESS | 1918 | Values: 66.0 65.0 64.0 65.0 70.0 73.0 99.0 100.0 102.0 88.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:3.65 (6.2%) stddev-sans-first:3.67 11:03:48 INFO - PROCESS | 1918 | Values: 56.0 61.0 57.0 68.0 62.0 57.0 58.0 56.0 59.0 59.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:85.00 stddev:9.47 (11.1%) stddev-sans-first:9.75 11:03:48 INFO - PROCESS | 1918 | Values: 87.0 84.0 88.0 84.0 88.0 86.0 104.0 104.0 106.0 103.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#11] stanford-crypto-ccm Cycles:10 Average:163.00 Median:162.00 stddev:19.92 (12.3%) stddev-sans-first:20.72 11:03:48 INFO - PROCESS | 1918 | Values: 152.0 172.0 151.0 150.0 142.0 150.0 173.0 150.0 203.0 187.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:2.81 (1.6%) stddev-sans-first:2.87 11:03:48 INFO - PROCESS | 1918 | Values: 172.0 174.0 171.0 168.0 174.0 166.0 168.0 170.0 169.0 167.0 11:03:48 INFO - PROCESS | 1918 | 11:03:48 INFO - PROCESS | 1918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.33 11:03:48 INFO - PROCESS | 1918 | Values: 69.0 67.0 66.0 65.0 66.0 67.0 68.0 68.0 64.0 67.0 11:03:48 INFO - PROCESS | 1918 | -------- Summary: end -------- 11:03:48 INFO - PROCESS | 1918 | 11:03:49 INFO - TEST-INFO | 1918: exit 0 11:03:49 INFO - TEST-OK | kraken | took 62023ms 11:03:49 INFO - SUITE-END | took 1179s 11:03:49 INFO - Completed test suite (00:19:39) 11:03:49 INFO - javascript benchmark 11:03:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7568.127364740809, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3395.847186876591, 3435.381631306364, 3438.4842273658946, 3439.914002149946, 3445.328161008601, 5910.143029260755, 5958.433948774865, 5978.163057172, 5986.491148252393, 6001.789937352182, 5988.520918326534, 6040.244969378828, 6041.546883983697, 6053.757849686007, 6077.11881777142, 4491.708038977472, 5469.206964990094, 5470.255733459507, 5536.058869992091, 5562.471565201299, 5515.972420137894, 5528.861778455531, 5530.557555395559, 5532.695701736403, 5543.667379957195, 5343.946560534403, 5396.973015134939, 5531.197976293435, 5538.47384498472, 5543.6119471637, 4138.399932009872, 5451.727413629303, 5455.536279416255, 5458.399576046631, 5507.862303442446, 5319.0, 5394.865128371783, 5406.432324605938, 5433.483819037185, 5438.510534051954, 6035.245594300713, 6037.63774173551, 6077.3314935357075, 6099.176611157482, 6191.907121393183, 6287.779927702554, 6298.748050077991, 6300.117983482316, 6311.274203466614, 6325.936740632581, 5396.460353964611, 5499.230107784913, 6309.905351419732, 6453.322401147906, 6454.290028096905, 6175.96912015446, 6200.162977997958, 6200.62796232223, 6207.0, 6207.224096987877, 6232.657203853832, 6354.618722876642, 6543.640099794462, 6593.538452308292, 6604.537682362285, 6319.115323854664, 6375.521835862329, 6377.7767778127545, 6388.968055159788, 6399.9040014399825, 6506.577072490273, 6533.738650453929, 6533.738650454024, 6541.247756507967, 6556.7705130321165, 6167.629942203482, 6228.875422491525, 6241.313455519889, 6425.1968503937005, 6449.742010319628, 6290.779822706183, 6303.873922521524, 6316.115743795872, 6337.397947195009, 6354.3010268870385, 5015.0, 5052.014857102829, 5063.772130254074, 5069.847904562869, 5116.053530096944, 4586.908261834811, 4605.148047611203, 4607.170709272296, 4623.4451865775645, 4629.791659375336, 6154.015357542772, 6166.260048794084, 6178.845528861814, 6183.96908015457, 6190.071489276645, 6240.625562466175, 6288.899442597527, 6367.267764207083, 6411.935880641227, 6427.55007149495, 6186.381361863778, 6195.132681424514, 6198.690065496708, 6206.0, 6214.347493513206, 5697.572682048863, 5719.799807006735, 5724.284464441945, 5725.8568535786935, 5738.397468265772, 6339.3343698912795, 6385.0, 6582.341765823571, 6615.073889655549, 6750.2237242715755, 5125.1799712045895, 6437.613743175237, 6454.741810327534, 6469.935300646934, 6505.21937367519, 6570.671466426564, 6625.271220165681, 6731.394174524316, 6737.831554211184, 6755.0, 5414.431484694208, 6244.968775156095, 6246.656433896179, 6408.295087540274, 6421.614703117828, 5729.570282228766, 6129.295131059986, 6428.19647544057, 6436.066770318372, 6460.806175814733, 6313.905291420724, 6329.5252856036905, 6335.556511044183, 6342.0, 6362.695647392181, 6117.694115294128, 6135.202044401795, 6283.120363149254, 6334.113224148715, 6360.904586431115, 5978.073398623221, 6061.242344706911, 6232.5948813328805, 6258.374162583706, 6266.811995640138, 6315.842103947438, 6353.14232578596, 6354.142190804368, 6356.141920840627, 6368.0, 4693.460252071056, 6026.457618814327, 6034.2155519782145, 6078.088286757022, 6309.7160627770945], "value": 5890.755011175318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.9912769070218, 777.2266594738235, 830.6262182018094, 940.7601061729258, 945.0266225787441, 37901.43147852781, 38485.0, 39521.4071788923, 39564.20871582567, 39586.8020659897, 38478.807605961934, 38645.03387415316, 38669.61330386695, 38719.41920871189, 38817.41773873387, 7783.649735761905, 10450.21623378246, 10732.570697172103, 10891.128709703205, 10901.890981090168, 10536.0, 10597.629082982097, 10610.151187904949, 10617.256792024562, 10630.840537391945, 10624.043836054754, 10625.840612390783, 10626.096781773558, 10647.30792498489, 10659.0, 10571.788564228711, 10583.629572964948, 10602.575896964112, 10638.308509946906, 10644.946775266151, 10362.585496580128, 10411.687649370531, 10418.0, 10423.322484038514, 10447.529861156267, 27947.301317467023, 33299.0, 33423.6657633423, 33525.161870953176, 33531.0, 3762.3415902217275, 3819.350979512476, 3822.9808850955847, 3824.426336049587, 3834.4631751554803, 20580.691289630668, 24696.641684707334, 24797.014273519566, 25132.0, 25970.87014564934, 3096.4426403247408, 3097.4424603571574, 3121.4849549824253, 3130.4365214261425, 3135.106494649037, 341362.0, 348537.0, 349395.0, 349556.0, 349721.0, 43784.56215437805, 43822.78088609537, 43833.0, 43982.78008609937, 44000.0, 45684.086318274116, 45948.0, 46119.76940115278, 46163.0, 46280.53719462762, 13736.45054197841, 13796.379162937692, 13998.0, 14010.0, 14056.297185140702, 11911.821322680167, 11971.0, 11976.880231197576, 11986.880131198577, 12023.977961873165, 11379.487923043484, 11736.589219377282, 11775.411229438494, 11807.822882656767, 11862.288262704265, 4881.926771098437, 5684.715764211773, 5758.62568933018, 5794.21778059965, 5799.710014499258, 961.9519024048769, 1066.8186408310605, 1098.774751176007, 1113.2541197397763, 1114.2311804854623, 26490.47019059608, 26650.600240996402, 26877.865610671823, 26951.460970780474, 26969.865150674123, 1129.497373668726, 1154.2151337090859, 1161.79668558002, 1167.2121318110242, 1205.7829590673587, 13758.449662013607, 13819.378127984264, 13921.373538190806, 13963.79054314186, 14006.71986560263, 184479.0, 184900.0, 184936.07531962253, 185628.14371856378, 185703.0, 47235.29147062797, 48550.0, 54121.0, 54486.72756636271, 54546.727266363414, 1398.2309729648653, 1425.5937057938438, 1427.1651084115701, 1427.7929700193622, 1433.2117335465452, 20135.39593812188, 22799.0, 26251.0, 26322.0, 26649.267797593093, 31304.843475782476, 38627.42058869063, 38775.0, 38776.03059923412, 38840.6115938837, 456494.0, 458309.0, 458423.0, 458539.0, 459841.0, 25526.617100743133, 25670.61494077628, 27977.72022279751, 28751.42497150087, 29926.401471970876, 38016.809915950245, 38714.80642596769, 38774.2245155101, 38796.0, 38852.0, 26829.463410731285, 27370.178894632398, 27830.860845695643, 28028.71971280261, 28183.0, 22298.665520017537, 27369.31576710598, 27417.45165096727, 28232.0, 28345.574816377357, 31693.841530792197, 31956.520652190702, 32030.679693203703, 32260.83869580637, 32451.837740811145, 22799.430014249778, 25632.8718356407, 25737.42625737486, 26564.601530976663, 26573.468530629667, 21410.57178856445, 22261.0, 22523.662145068163, 22552.323430297118, 22704.772952270265], "value": 17378.7170440899, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.6778496665086, 430.63180980261865, 431.7248102499826, 440.14611653392416, 444.5709889956192, 18601.627967440643, 20172.293969711045, 20846.0, 20857.53997220195, 20917.95410229488, 16103.436379726712, 20790.688139677917, 21158.084950058572, 21459.0, 21477.785222147773, 6419.711112999927, 6746.62893540855, 6777.864442711143, 6781.694823732919, 6791.524593278473, 6365.968170159143, 6609.570377925444, 6659.966700166492, 6667.766628168015, 6692.263850976388, 6365.108884756138, 6647.900281495781, 6659.500537459686, 6676.5660232085, 6686.231083425396, 6715.7313707451885, 6717.59694418334, 6733.39399454049, 6752.5948443093575, 6759.290274521154, 6267.715118400717, 6334.651594162319, 6457.12828768115, 6472.805815825533, 6575.309592492815, 20216.39350819478, 24360.756392436026, 24644.50710985788, 24844.254672359857, 25038.874805626037, 2840.8721607527505, 2859.642544681915, 2867.3978464522474, 2880.0, 2908.3746994396097, 12897.484100636057, 15961.04233745979, 16207.02757834522, 16230.675386492323, 16514.42199523023, 2020.5150763816725, 2082.3544701142696, 2089.8223650989685, 2093.235968871351, 2095.172406899266, 102951.0, 126986.0, 129000.0, 130855.0, 132769.33615331957, 19797.703034454495, 20823.06296216674, 20882.373528793858, 20970.895145524173, 21057.473563161042, 27387.45225095487, 33119.503207451904, 33569.99290021303, 33753.49369759455, 33953.49069763956, 8587.92650918635, 9809.117179453884, 10533.315334503233, 10542.947285263524, 10662.733431664115, 8611.741647750578, 8658.826823463496, 8671.655893336543, 8793.20861122502, 8810.383273170944, 9894.455804930654, 9903.0, 9977.201823854075, 10051.889103288246, 10119.898801012043, 3661.0664280608275, 3740.532433445819, 3744.4008958566496, 3870.767753934773, 4373.813093453274, 812.2202685421943, 832.7418500264937, 892.607252808762, 915.4964769376816, 949.0746522140857, 20541.97290135487, 21270.893645531673, 21334.63613069182, 21341.0, 21460.463488412915, 946.8059047895165, 951.1202138022302, 951.3483263964207, 967.5984466446487, 967.6322997261136, 9621.711348659412, 10538.420386878643, 10692.499462926837, 11218.0, 11327.660170194908, 652540.7372963105, 709360.0, 710744.0, 714687.0, 741493.0, 120364.0, 124764.37617812035, 128821.35589322181, 137111.31444342714, 162995.0, 1319.195290872567, 1352.7767918293569, 1381.5786185213606, 1389.2220356600135, 1390.0755997261708, 18036.0, 19132.426027219204, 19174.808251917304, 19200.80799192046, 19284.903575482032, 59845.40154598398, 59912.0, 60630.0, 61002.084968724615, 61370.69314653398, 83009.0, 84395.57802210949, 85927.41471804313, 86605.0, 86811.0, 9610.759731006501, 10792.136629069499, 10807.757107932688, 10925.617603383844, 11219.439028048728, 10362.0, 11991.82012269834, 12053.758924821279, 12171.96538294255, 12296.692582685504, 9602.423854568748, 9662.323637345318, 9925.647585545401, 10282.07461328484, 10582.365058096539, 9582.712518624452, 9789.314747967574, 9836.754081148028, 9907.0, 10071.899281007389, 10339.224558158017, 10456.529456174338, 10580.735481613021, 10712.196585256293, 10751.408672523086, 10757.13942884583, 10779.892201078203, 10875.51060202277, 11153.386563739072, 11175.49710263024, 8371.204735550113, 10143.239257055602, 10163.136133428445, 10334.948325258325, 10656.200784941006], "value": 11138.704542435567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.313075985047, 1535.1403214200056, 1553.819097485911, 1559.563322269764, 1569.4663814303137, 9512.762180945463, 9720.173785228246, 10845.023947844693, 11522.481488333015, 11553.65339039829, 10819.729506762334, 11117.94379533943, 11355.545778168864, 11360.829587556193, 11368.658940231786, 2379.1078345620435, 2433.6592876997233, 2444.755524447559, 2448.8979959018425, 2454.4109413740753, 2391.4977854650456, 2422.4307287787356, 2423.7697418745192, 2428.5749993751024, 2429.0890915906534, 2351.423901144222, 2393.44950661348, 2402.0631953538136, 2447.1068060158004, 2454.3250606083293, 2375.869327187021, 2380.8809559521956, 2388.22382725614, 2390.8326417150806, 2397.940051498709, 2349.0721165139844, 2365.976340236593, 2377.21865417462, 2379.940501487459, 2381.1784934197676, 11323.0, 11443.198976071679, 11456.599019034295, 11471.024962878166, 11504.712382190428, 5837.0, 5936.881262374728, 6017.458428741391, 6055.545834062463, 6056.909146362808, 3451.7411194160286, 3529.3823580873245, 3590.120420496969, 3673.9081522961874, 3715.052661571282, 1195.4620420810584, 1200.873908239631, 1234.2471092633486, 1248.2260998181187, 1259.225576270596, 13199.538016169388, 15746.606334841606, 15919.283632236577, 15952.920235398864, 16076.035437873765, 4907.411110666742, 5014.84955451337, 5027.723475208899, 5051.797928082836, 5073.619478539124, 11441.855814418657, 13157.473701051851, 13177.934110329386, 13199.274039927705, 13251.469941202244, 4751.859553707154, 5016.272640467185, 5961.105834124916, 5963.522918166536, 6053.273607167168, 4193.91612167761, 4909.631777616622, 5056.974715126401, 5346.1713434417725, 5419.620626556182, 4076.3076923076924, 4166.854160104382, 4198.202341555095, 4219.746815191098, 4234.70357075008, 1168.894799468052, 1169.33369947824, 1169.368540987857, 1185.6917201527492, 1195.2708847602955, 858.5020688000944, 921.530019689963, 931.1200915135267, 939.3377668743519, 958.736347504428, 6560.245571759308, 6660.467162626978, 6669.1330127083165, 6785.59286442815, 6793.082933803972, 792.528445574882, 969.9369540979955, 1026.9537870795682, 1033.132168978047, 1052.5684469367675, 4157.958420415817, 4224.176285624274, 4271.295236286041, 4371.912561748747, 4383.211022016068, 13255.867441325656, 13747.931260343834, 13748.65628359279, 13767.31163441824, 13790.793138102936, 10979.0, 13693.383797729126, 13697.794533082011, 13714.794278085838, 13809.24049177305, 10225.642102526375, 10463.006014428616, 10470.633527826642, 10495.737606559744, 10510.581071555394, 5931.228940237914, 6549.869002619826, 6804.795856124324, 6904.896426553706, 7023.859522809413, 12068.155229133876, 12267.509299627915, 12396.31820249895, 12406.565770198, 12407.627771166879, 11758.529658813552, 12433.875661243272, 12444.191127576678, 12537.122401432178, 12654.0, 8131.146229645802, 8326.250637442417, 9134.0, 9449.055094490495, 9628.374155679858, 10504.527296271533, 10544.630937917136, 10553.155747540332, 10603.310784798963, 10685.57257709714, 8875.556222188994, 8917.910820891968, 8946.731598052069, 9041.141091596288, 9097.590608422504, 8631.309495240492, 8737.301015918583, 8742.519161446182, 8754.47473151613, 8834.734957951272, 7773.222677732181, 7775.105862825847, 7870.72452464161, 7916.208379162038, 8041.155678653891, 5992.221011268682, 6043.697815109315, 6047.909281360695, 6072.14989901423, 6096.116063170727, 5891.1752354671235, 6092.116643086816, 6170.382961703974, 6196.659183744938, 6220.253569571681], "value": 5209.051147877172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.39398628345526, 366.79142226364127, 381.62219402791237, 387.33958600585987, 394.528538396616, 3950.940735888964, 4508.526604706508, 4806.134895718769, 4927.753612319383, 5084.720340381277, 4653.511381304965, 5003.924941125877, 5071.7827721346885, 5092.567131793793, 5131.692098474095, 3839.3856982882676, 4251.3622956556455, 4287.635550978155, 4317.244482215599, 4325.956740432587, 4060.634542891139, 4290.506591741942, 4291.678124140686, 4309.0, 4312.97843510782, 3517.9648203517895, 3977.9171142364607, 4287.485501739796, 4297.871063868089, 4329.653627709776, 4166.91666166675, 4311.719738217006, 4316.338209789238, 4322.351647252937, 4373.431453910971, 3999.340108882031, 4007.6593489553425, 4016.895353777705, 4027.637512623878, 4092.324766413568, 4187.539370669224, 4307.590778876001, 4512.796924138422, 4925.435623429944, 5043.672161309503, 4486.596206341413, 4500.829784256084, 4942.481039490837, 5013.824516141917, 5049.671771334852, 5564.137558678412, 5579.6652200868075, 5589.456797157283, 5593.084840611588, 5609.803656872031, 4048.8419033154187, 4278.256525540152, 4391.650467000171, 4415.918100065473, 4435.334699795057, 5165.845024649229, 5349.866253343658, 5640.717964101778, 5835.649861008311, 5897.14491398749, 3938.960610393917, 4318.913621727611, 4488.842890498817, 4501.617362524156, 4513.751743654065, 4265.53079161292, 4404.185225733249, 4464.682918539039, 4598.540145985375, 4599.333096701027, 4078.57174996627, 4818.951810481921, 4858.611311095104, 4920.72935988524, 4939.654224204343, 4655.32050897904, 5470.452954704578, 5497.725113744297, 5508.228847961289, 5616.652003519126, 1390.5411214299256, 1439.755241608929, 1448.7681970884607, 1510.2901636230954, 1570.0658108425469, 1039.927205095651, 1087.342157994418, 1180.689434727452, 1192.6183621241119, 1211.4064108586729, 4639.675222734444, 4747.430308363018, 5200.583953283804, 5241.528262456397, 5243.764030618631, 5744.041818463495, 5761.925706745568, 5788.131780232999, 5797.536197104221, 5806.970965145232, 4300.1399720056115, 4479.664025198058, 4884.28794116474, 5120.718360490208, 5220.112580861262, 2590.3394634368115, 2672.371992581742, 2688.9647485718137, 2831.830090194595, 3006.7972810875826, 5319.787208511616, 5972.970135149297, 6023.7471765247155, 6045.879082418327, 6063.7574497020505, 5114.488551144856, 5196.792128314825, 5196.92204616931, 5238.057149713089, 5527.668339899619, 5464.9453505465235, 5723.771049157987, 5956.400983075895, 5965.850853728692, 6034.9094763577705, 5386.326709161355, 5396.541293989898, 5431.728413579226, 5747.74135163927, 5805.883882322414, 4884.5603895649565, 5096.949030509648, 5695.117256825199, 5722.656640601577, 5725.255716756961, 5769.68266745333, 5850.3857095006115, 5933.525317974638, 5973.522118230618, 6047.52267446229, 4185.309423945015, 4371.169477799208, 4565.6119229865835, 4593.908121837611, 4624.0058387445515, 4867.878303042452, 5395.298611180521, 5512.7519261634125, 5731.277643119485, 5829.183914251923, 4835.709857408567, 5105.9662866335175, 5397.7840886365675, 5553.805931724699, 5611.382747897646, 4625.560571745679, 4975.850724478271, 5050.797968081236, 5185.974070129776, 5451.073317536107, 4591.609713174417, 4750.857474275777, 4967.428745694291, 4993.851414174687, 5464.754086066057, 5220.530152286161, 5383.515483606494, 5567.916481252703, 5586.692731899784, 5619.943800561942, 4968.950310496994, 5137.563307118788, 5468.972655136698, 5490.917636235539, 5512.641678290898], "value": 4217.031194228663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.4381079420269, 707.6214225389415, 755.1240560949299, 768.0476209500222, 824.4682179993906, 14940.25298735063, 15881.682366352667, 15957.0, 15960.122193279365, 15960.840391596095, 14045.36795844187, 14975.700485990274, 15142.545723628282, 15177.241137943087, 15247.542573722778, 940.6613619097119, 951.286535098676, 970.1947383671571, 975.1321324021626, 975.8438649816031, 941.7174847545743, 978.2663002747939, 979.5689896445576, 981.793823297105, 988.6193815381095, 1022.5245260953656, 1023.7850051489196, 1025.3027941000116, 1026.8203064463726, 1028.0798685176762, 1008.1078245752525, 1022.0852337158276, 1022.4734261855151, 1022.4785359466688, 1023.6570748799161, 765.5751058162717, 766.5247546521136, 767.0258771360341, 769.9114601820806, 770.0105364606454, 15693.686126277411, 15940.123293218869, 16005.439809606723, 16685.416010439698, 16964.74552881708, 11826.172167948247, 12221.185184445721, 12750.872491275153, 14062.156270623795, 14159.292035398188, 12623.242605443702, 12866.228026318451, 12880.514386435367, 13231.630455280814, 13261.138026028373, 3676.963230367689, 4462.709923854972, 4508.211063063951, 4528.773561321921, 4570.520095390003, 96613.51693241559, 105215.68277217154, 108432.0, 109386.0, 111920.0, 10524.421156836295, 10823.567057317776, 10908.0, 10948.4525773711, 11410.030147437395, 21474.78525214759, 22193.889030554743, 22312.442188945406, 22347.55304893893, 22516.774832251467, 7597.506162099446, 7636.320129216219, 7808.297253247121, 7869.527828330319, 8216.383771217183, 4253.76604286761, 4282.8715138545895, 4294.334378171388, 4490.685652004328, 4569.0, 3472.0, 3479.6520347965, 3524.9823750881596, 3528.259065596202, 3561.2521370511963, 465.5530690537055, 492.6624215255598, 561.7752898840497, 562.6624025584616, 565.926429564154, 660.3066779881202, 673.7170388436869, 696.9024336592881, 699.7166147710185, 730.375528922774, 10283.898749606651, 10324.845127323097, 10340.482975851177, 10511.84232236517, 10551.366917984791, 699.4264702943537, 700.726716580534, 701.6561884676472, 711.4806191480145, 712.771912987839, 4802.73584952831, 5049.31834202378, 5071.847844564669, 5074.720890350993, 5092.439831618519, 102961.48519257356, 104679.4766026165, 105905.0, 106338.0, 109212.0, 91184.54407727919, 92431.0, 93001.0, 94654.0, 96062.0, 81245.59377203076, 81561.59219203866, 82214.58892705498, 82854.17145828585, 84072.57963710265, 9734.230227188767, 9764.75987150577, 9830.655927042519, 9848.852267216142, 9856.605735770776, 36736.448953265186, 37401.0, 48399.51600484091, 49118.26322605092, 49719.00561988667, 59069.0, 60398.69800651145, 60607.09089363575, 61460.0, 61917.0, 10310.536025878704, 11135.888641113484, 11297.491612877604, 11384.43077846121, 11531.596394126502, 12395.876041239471, 12575.434105465092, 12814.871851281741, 12882.09825312219, 13179.945604351436, 11732.530698771954, 11906.404679765803, 12058.939705301418, 12195.0, 12487.0, 11775.0, 12061.51753929833, 12128.151029427856, 12311.445984930879, 12389.0, 11634.185607007767, 12017.819732703842, 12273.509059637872, 12403.193792403465, 12537.623871283877, 8670.56935605618, 8701.869471958053, 8819.470831750115, 8841.955790221007, 8976.640934362553, 9576.0, 10002.399856008662, 10100.646477373257, 10124.443155626512, 10131.392116473035], "value": 7500.740742700485, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 120.0, 120.0, 116.0, 143.0, 150.0, 178.0, 99.0, 180.0], "value": 133.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 113.0, 109.0, 148.0, 129.0, 115.0, 101.0, 141.0, 119.0, 111.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 280.0, 242.0, 200.0, 198.0, 205.0, 200.0, 204.0, 195.0, 198.0], "value": 213.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 61.0, 86.0, 64.0, 63.0, 62.0, 62.0, 77.0, 61.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 84.0, 73.0, 72.0, 70.0, 83.0, 71.0, 72.0, 83.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 89.0, 91.0, 124.0, 135.0, 134.0, 89.0, 89.0], "value": 102.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 97.0, 118.0, 155.0, 107.0, 96.0, 158.0, 154.0, 103.0, 154.0], "value": 124.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 143.0, 92.0, 92.0, 92.0, 123.0, 93.0, 144.0, 102.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 70.0, 73.0, 99.0, 100.0, 102.0, 88.0], "value": 79.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 57.0, 68.0, 62.0, 57.0, 58.0, 56.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 84.0, 88.0, 86.0, 104.0, 104.0, 106.0, 103.0], "value": 93.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 172.0, 151.0, 150.0, 142.0, 150.0, 173.0, 150.0, 203.0, 187.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 171.0, 168.0, 174.0, 166.0, 168.0, 170.0, 169.0, 167.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 65.0, 66.0, 67.0, 68.0, 68.0, 64.0, 67.0], "value": 66.7, "unit": "score"}]}]} 11:03:49 INFO - Return code: 0 11:03:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:03:49 ERROR - # TBPL SUCCESS # 11:03:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:03:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:03:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:03:49 INFO - 2017-04-07 11:03:49.874 screenresolution[1923:14616] starting screenresolution argv=screenresolution get 11:03:49 INFO - 2017-04-07 11:03:49.877 screenresolution[1923:14616] Display 0: 1600x1200x32@60 11:03:49 INFO - 2017-04-07 11:03:49.883 screenresolution[1924:14619] starting screenresolution argv=screenresolution list 11:03:49 INFO - Available Modes on Display 0 11:03:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:03:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:03:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:03:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:03:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:03:50 INFO - Intel Iris: 11:03:50 INFO - Chipset Model: Intel Iris 11:03:50 INFO - Type: GPU 11:03:50 INFO - Bus: Built-In 11:03:50 INFO - VRAM (Dynamic, Max): 1536 MB 11:03:50 INFO - Vendor: Intel (0x8086) 11:03:50 INFO - Device ID: 0x0a2e 11:03:50 INFO - Revision ID: 0x0009 11:03:50 INFO - Displays: 11:03:50 INFO - Display: 11:03:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:03:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:03:50 INFO - Display Serial Number: 1600x1200 60 11:03:50 INFO - Main Display: Yes 11:03:50 INFO - Mirror: Off 11:03:50 INFO - Online: Yes 11:03:50 INFO - Rotation: Supported 11:03:50 INFO - Return code: 0 11:03:50 INFO - Running post-action listener: _resource_record_post_action 11:03:50 INFO - [mozharness: 2017-04-07 18:03:50.123612Z] Finished run-tests step (success) 11:03:50 INFO - Running post-run listener: _resource_record_post_run 11:03:50 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 565248; Write bytes: 510797312; Read time: 13; Write time: 1723 11:03:50 INFO - TinderboxPrint: CPU usage
54.8% 11:03:50 INFO - TinderboxPrint: I/O read bytes / time
565,248 / 13 11:03:50 INFO - TinderboxPrint: I/O write bytes / time
510,797,312 / 1,723 11:03:50 INFO - TinderboxPrint: CPU idle
2,170.3 (45.2%) 11:03:50 INFO - TinderboxPrint: CPU system
969.7 (20.2%) 11:03:50 INFO - TinderboxPrint: CPU user
1,661.6 (34.6%) 11:03:50 INFO - TinderboxPrint: Swap in / out
208,498,688 / 0 11:03:50 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201480704; Write bytes: 200513024; Read time: 15938; Write time: 430 11:03:50 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 565248; Write bytes: 299499520; Read time: 13; Write time: 1262 11:03:50 INFO - Running post-run listener: _upload_blobber_files 11:03:50 INFO - Blob upload gear active. 11:03:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:03:50 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:03:50 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:03:50 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:03:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:03:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:03:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:03:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:03:52 INFO - (blobuploader) - INFO - Done attempting. 11:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:03:53 INFO - (blobuploader) - INFO - Done attempting. 11:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:03:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:03:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:03:54 INFO - (blobuploader) - INFO - Done attempting. 11:03:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:03:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:03:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:03:57 INFO - (blobuploader) - INFO - Done attempting. 11:03:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:03:57 INFO - Return code: 0 11:03:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:03:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:03:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad3652304d51072c48efb46a52e0577109bafe354e6d7855343017d42f771c58ff50316518b7301dbcf2aeb14e4030d8cbecaa9eb45dda594654b6248e277faa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ac5670641a467a83657c49b66f2ce29861f95fb691274927414ef0377f1f39332ec8c3096fb9cfa8ed438e2e865b8af29fcc2b89649cc481e9d8bde95923339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e1f9a0935168c1e6a3322b79a77ded1ec9d06d46b81904fdfcc02ae67f77e9490edd8ef5499413c0bde2181df721fb5e80c993e9c521b0d977aca604b362099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9ce2d94a0fef801d830b416db2bff0cc07c215dd8e8270c375aa1506a234b275a4960cddaa69a0f6c5e4050e61bccf0a80caf771c25b5f9066f1d931e18493a"} 11:03:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:03:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:03:57 INFO - Contents: 11:03:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad3652304d51072c48efb46a52e0577109bafe354e6d7855343017d42f771c58ff50316518b7301dbcf2aeb14e4030d8cbecaa9eb45dda594654b6248e277faa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ac5670641a467a83657c49b66f2ce29861f95fb691274927414ef0377f1f39332ec8c3096fb9cfa8ed438e2e865b8af29fcc2b89649cc481e9d8bde95923339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e1f9a0935168c1e6a3322b79a77ded1ec9d06d46b81904fdfcc02ae67f77e9490edd8ef5499413c0bde2181df721fb5e80c993e9c521b0d977aca604b362099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9ce2d94a0fef801d830b416db2bff0cc07c215dd8e8270c375aa1506a234b275a4960cddaa69a0f6c5e4050e61bccf0a80caf771c25b5f9066f1d931e18493a"} 11:03:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:03:57 INFO - Copying logs to upload dir... 11:03:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:03:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.265573 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-07 11:03:57.127326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 11:03:57.132662) ========= 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.7sjNOCmQIs/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.cWAPegPazC/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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/ad3652304d51072c48efb46a52e0577109bafe354e6d7855343017d42f771c58ff50316518b7301dbcf2aeb14e4030d8cbecaa9eb45dda594654b6248e277faa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ac5670641a467a83657c49b66f2ce29861f95fb691274927414ef0377f1f39332ec8c3096fb9cfa8ed438e2e865b8af29fcc2b89649cc481e9d8bde95923339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e1f9a0935168c1e6a3322b79a77ded1ec9d06d46b81904fdfcc02ae67f77e9490edd8ef5499413c0bde2181df721fb5e80c993e9c521b0d977aca604b362099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9ce2d94a0fef801d830b416db2bff0cc07c215dd8e8270c375aa1506a234b275a4960cddaa69a0f6c5e4050e61bccf0a80caf771c25b5f9066f1d931e18493a"} build_url:https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/CoiRBp-gQ8eW_qbIrs0bsQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad3652304d51072c48efb46a52e0577109bafe354e6d7855343017d42f771c58ff50316518b7301dbcf2aeb14e4030d8cbecaa9eb45dda594654b6248e277faa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ac5670641a467a83657c49b66f2ce29861f95fb691274927414ef0377f1f39332ec8c3096fb9cfa8ed438e2e865b8af29fcc2b89649cc481e9d8bde95923339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e1f9a0935168c1e6a3322b79a77ded1ec9d06d46b81904fdfcc02ae67f77e9490edd8ef5499413c0bde2181df721fb5e80c993e9c521b0d977aca604b362099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9ce2d94a0fef801d830b416db2bff0cc07c215dd8e8270c375aa1506a234b275a4960cddaa69a0f6c5e4050e61bccf0a80caf771c25b5f9066f1d931e18493a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-07 11:03:57.172134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 11:03:57.172605) ========= 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.7sjNOCmQIs/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.cWAPegPazC/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/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.006678 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-07 11:03:57.228267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 11:03:57.228612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-07 11:03:57.228958) ========= ========= Total master_lag: 0.20 =========