builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0248 starttime: 1493917346.52 results: success (0) buildid: 20170504085243 builduid: 664d4f1ca55d47e980f54aaf520e46b6 revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:26.518737) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:26.519394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:26.519899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:26.549289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:26.549580) ========= 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.FkbXL1Q7VF/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.fp7II4cf42/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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-05-04 10:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 181M=0s 2017-05-04 10:02:27 (181 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.579209 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:27.154610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:27.154935) ========= 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.FkbXL1Q7VF/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.fp7II4cf42/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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.029808 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:27.207925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 10:02:27.208305) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FkbXL1Q7VF/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.fp7II4cf42/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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-05-04 10:02:27,309 truncating revision to first 12 chars 2017-05-04 10:02:27,310 Setting DEBUG logging. 2017-05-04 10:02:27,310 attempt 1/10 2017-05-04 10:02:27,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b255199db9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 10:02:28,680 unpacking tar archive at: mozilla-central-0b255199db9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.638848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 10:02:28.871461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:28.871833) ========= script_repo_revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:28.872281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:28.872604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:02:28.893331) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-04 10:02:28.894030) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FkbXL1Q7VF/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.fp7II4cf42/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:02:29 INFO - MultiFileLogger online at 20170504 10:02:29 in /builds/slave/test 10:02:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:02:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:29 INFO - {'append_to_log': False, 10:02:29 INFO - 'base_work_dir': '/builds/slave/test', 10:02:29 INFO - 'blob_upload_branch': 'Firefox', 10:02:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:29 INFO - 'branch': 'Firefox', 10:02:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:29 INFO - 'config_files': ('talos/mac_config.py',), 10:02:29 INFO - 'default_actions': ('clobber', 10:02:29 INFO - 'read-buildbot-config', 10:02:29 INFO - 'download-and-extract', 10:02:29 INFO - 'populate-webroot', 10:02:29 INFO - 'create-virtualenv', 10:02:29 INFO - 'install', 10:02:29 INFO - 'run-tests'), 10:02:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:29 INFO - 'download_minidump_stackwalk': True, 10:02:29 INFO - 'download_symbols': 'ondemand', 10:02:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:29 INFO - 'gecko_profile': False, 10:02:29 INFO - 'gecko_profile_interval': 0, 10:02:29 INFO - 'installer_path': 'installer.exe', 10:02:29 INFO - 'log_level': 'info', 10:02:29 INFO - 'log_name': 'talos', 10:02:29 INFO - 'log_to_console': True, 10:02:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:02:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:02:29 INFO - 'opt_config_files': (), 10:02:29 INFO - 'pip_index': False, 10:02:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:29 INFO - 'cmd': ('bash', 10:02:29 INFO - '-c', 10:02:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:29 INFO - 'enabled': True, 10:02:29 INFO - 'halt_on_failure': False, 10:02:29 INFO - 'name': 'check_screen_resolution'},), 10:02:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:29 INFO - 'cmd': ('bash', 10:02:29 INFO - '-c', 10:02:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:29 INFO - 'enabled': True, 10:02:29 INFO - 'halt_on_failure': False, 10:02:29 INFO - 'name': 'check_screen_resolution'},), 10:02:29 INFO - 'run_cmd_checks_enabled': True, 10:02:29 INFO - 'suite': 'dromaeojs-e10s', 10:02:29 INFO - 'system_bits': '32', 10:02:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:29 INFO - 'title': 't-yosemite-r7-0248', 10:02:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:29 INFO - 'use_talos_json': True, 10:02:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:29 INFO - 'work_dir': 'build'} 10:02:29 INFO - [mozharness: 2017-05-04 17:02:29.101617Z] Running clobber step. 10:02:29 INFO - Running pre-action listener: _resource_record_pre_action 10:02:29 INFO - Running main action method: clobber 10:02:29 INFO - rmtree: /builds/slave/test/build 10:02:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:31 INFO - Running post-action listener: _resource_record_post_action 10:02:31 INFO - [mozharness: 2017-05-04 17:02:31.506449Z] Finished clobber step (success) 10:02:31 INFO - [mozharness: 2017-05-04 17:02:31.506581Z] Running read-buildbot-config step. 10:02:31 INFO - Running pre-action listener: _resource_record_pre_action 10:02:31 INFO - Running main action method: read_buildbot_config 10:02:31 INFO - Using buildbot properties: 10:02:31 INFO - { 10:02:31 INFO - "project": "", 10:02:31 INFO - "product": "firefox", 10:02:31 INFO - "script_repo_revision": "production", 10:02:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:02:31 INFO - "repository": "", 10:02:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:02:31 INFO - "buildid": "20170504085243", 10:02:31 INFO - "pgo_build": "False", 10:02:31 INFO - "basedir": "/builds/slave/test", 10:02:31 INFO - "buildnumber": 211, 10:02:31 INFO - "slavename": "t-yosemite-r7-0248", 10:02:31 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:02:31 INFO - "platform": "yosemite_r7", 10:02:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:02:31 INFO - "branch": "mozilla-central", 10:02:31 INFO - "repo_path": "mozilla-central", 10:02:31 INFO - "revision": "0b255199db9d6a6f189b89b7906f99155bde3726", 10:02:31 INFO - "stage_platform": "macosx64", 10:02:31 INFO - "builduid": "664d4f1ca55d47e980f54aaf520e46b6", 10:02:31 INFO - "slavebuilddir": "test" 10:02:31 INFO - } 10:02:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:02:31 INFO - Running post-action listener: _resource_record_post_action 10:02:31 INFO - [mozharness: 2017-05-04 17:02:31.509907Z] Finished read-buildbot-config step (success) 10:02:31 INFO - [mozharness: 2017-05-04 17:02:31.510045Z] Running download-and-extract step. 10:02:31 INFO - Running pre-action listener: _resource_record_pre_action 10:02:31 INFO - Running main action method: download_and_extract 10:02:31 INFO - mkdir: /builds/slave/test/build/tests 10:02:31 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:02:31 INFO - trying https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:02:31 INFO - Downloading https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:02:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:02:32 INFO - Downloaded 1325 bytes. 10:02:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:02:32 INFO - Using the following test package requirements: 10:02:32 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:02:32 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:02:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:02:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:02:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'jsshell-mac.zip'], 10:02:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:02:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:02:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:02:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:02:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:02:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:02:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:02:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:02:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:02:32 INFO - Fetch https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:02:34 INFO - Content-Length response header: 52700604 10:02:34 INFO - Bytes received: 52700604 10:02:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:02:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:02:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:02:50 INFO - Fetch https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:02:52 INFO - Content-Length response header: 52700604 10:02:52 INFO - Bytes received: 52700604 10:03:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:03:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:03:07 INFO - Fetch https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:03:09 INFO - Content-Length response header: 14408809 10:03:09 INFO - Bytes received: 14408809 10:03: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:03:09 INFO - trying https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:03:09 INFO - Downloading https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:03:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:03:11 INFO - Downloaded 70877286 bytes. 10:03:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:03:11 INFO - mkdir: /builds/slave/test/properties 10:03:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:11 INFO - Contents: 10:03:11 INFO - build_url:https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:03:12 INFO - Running post-action listener: _resource_record_post_action 10:03:12 INFO - Running post-action listener: set_extra_try_arguments 10:03:12 INFO - [mozharness: 2017-05-04 17:03:12.451810Z] Finished download-and-extract step (success) 10:03:12 INFO - [mozharness: 2017-05-04 17:03:12.451960Z] Running populate-webroot step. 10:03:12 INFO - Running pre-action listener: _resource_record_pre_action 10:03:12 INFO - Running main action method: populate_webroot 10:03:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:12 INFO - '--tppagecycles', 10:03:12 INFO - '7'], 10:03:12 INFO - 'tests': ['tsvgm']}}, 10:03:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['damp', 'tps']}, 10:03:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'tests': ['damp', 'tps']}, 10:03:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['dromaeo_dom']}, 10:03:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:03:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:03:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['a11yr', 10:03:12 INFO - 'ts_paint', 10:03:12 INFO - 'tpaint', 10:03:12 INFO - 'sessionrestore', 10:03:12 INFO - 'sessionrestore_no_auto_restore', 10:03:12 INFO - 'tabpaint']}, 10:03:12 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:12 INFO - 'ts_paint', 10:03:12 INFO - 'tpaint', 10:03:12 INFO - 'sessionrestore', 10:03:12 INFO - 'sessionrestore_no_auto_restore', 10:03:12 INFO - 'tabpaint']}, 10:03:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:12 INFO - 'ts_paint', 10:03:12 INFO - 'tpaint', 10:03:12 INFO - 'sessionrestore', 10:03:12 INFO - 'sessionrestore_no_auto_restore', 10:03:12 INFO - 'tabpaint']}, 10:03:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:12 INFO - 'ts_paint', 10:03:12 INFO - 'tpaint', 10:03:12 INFO - 'sessionrestore', 10:03:12 INFO - 'sessionrestore_no_auto_restore', 10:03:12 INFO - 'tabpaint']}, 10:03:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['a11yr', 10:03:12 INFO - 'ts_paint', 10:03:12 INFO - 'tpaint', 10:03:12 INFO - 'sessionrestore', 10:03:12 INFO - 'sessionrestore_no_auto_restore', 10:03:12 INFO - 'tabpaint']}, 10:03:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['a11yr', 10:03:12 INFO - 'ts_paint', 10:03:12 INFO - 'tpaint', 10:03:12 INFO - 'sessionrestore', 10:03:12 INFO - 'sessionrestore_no_auto_restore', 10:03:12 INFO - 'tabpaint']}, 10:03:12 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:03:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:03:12 INFO - 'bloom_basic_ref']}, 10:03:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['tsvgx', 10:03:12 INFO - 'tsvgr_opacity', 10:03:12 INFO - 'tart', 10:03:12 INFO - 'tscrollx', 10:03:12 INFO - 'cart', 10:03:12 INFO - 'tsvg_static']}, 10:03:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:12 INFO - 'tsvgr_opacity', 10:03:12 INFO - 'tart', 10:03:12 INFO - 'tscrollx', 10:03:12 INFO - 'cart', 10:03:12 INFO - 'tsvg_static']}, 10:03:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'talos_options': ['--disable-e10s'], 10:03:12 INFO - 'tests': ['tp5o']}, 10:03:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:03:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'talos_options': ['--disable-e10s', 10:03:12 INFO - '--xperf_path', 10:03:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:12 INFO - 'tests': ['tp5n']}, 10:03:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:03:12 INFO - 'talos_options': ['--xperf_path', 10:03:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:12 INFO - 'tests': ['tp5n']}}, 10:03:12 INFO - 'talos.zip': {'path': '', 10:03:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:12 INFO - Running post-action listener: _resource_record_post_action 10:03:12 INFO - [mozharness: 2017-05-04 17:03:12.471273Z] Finished populate-webroot step (success) 10:03:12 INFO - [mozharness: 2017-05-04 17:03:12.471387Z] Running create-virtualenv step. 10:03:12 INFO - Running pre-action listener: _resource_record_pre_action 10:03:12 INFO - Running main action method: create_virtualenv 10:03:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:12 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:03:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:12 INFO - Using real prefix '/tools/python27' 10:03:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:13 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:16 INFO - Installing pip.................done. 10:03:16 INFO - Return code: 0 10:03:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:03:16 INFO - Reading from file tmpfile_stdout 10:03:16 INFO - Output received: 10:03:16 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:03:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:16 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:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:16 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:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:16 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:16 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:03:16 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:03:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:16 INFO - 'HOME': '/Users/cltbld', 10:03:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:16 INFO - 'LOGNAME': 'cltbld', 10:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:16 INFO - 'MOZ_NO_REMOTE': '1', 10:03:16 INFO - 'NO_EM_RESTART': '1', 10:03:16 INFO - 'PAGER': '/bin/cat', 10:03:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:16 INFO - 'PWD': '/builds/slave/test', 10:03:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:16 INFO - 'SHELL': '/bin/bash', 10:03:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:16 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:16 INFO - 'USER': 'cltbld', 10:03:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:16 INFO - 'XPC_FLAGS': '0x0', 10:03:16 INFO - 'XPC_SERVICE_NAME': '0', 10:03:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:16 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:03:16 INFO - Cleaning up... 10:03:16 INFO - Return code: 0 10:03:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03:16 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:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:16 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:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:16 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:16 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:03:16 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:03:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:16 INFO - 'HOME': '/Users/cltbld', 10:03:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:16 INFO - 'LOGNAME': 'cltbld', 10:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:16 INFO - 'MOZ_NO_REMOTE': '1', 10:03:16 INFO - 'NO_EM_RESTART': '1', 10:03:16 INFO - 'PAGER': '/bin/cat', 10:03:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:16 INFO - 'PWD': '/builds/slave/test', 10:03:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:16 INFO - 'SHELL': '/bin/bash', 10:03:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:16 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:16 INFO - 'USER': 'cltbld', 10:03:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:16 INFO - 'XPC_FLAGS': '0x0', 10:03:16 INFO - 'XPC_SERVICE_NAME': '0', 10:03:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:16 INFO - Downloading/unpacking psutil>=3.1.1 10:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:19 INFO - Installing collected packages: psutil 10:03:19 INFO - Running setup.py install for psutil 10:03:19 INFO - building 'psutil._psutil_osx' extension 10:03:19 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:03:20 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:03:20 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:03:20 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:03:20 INFO - building 'psutil._psutil_posix' extension 10:03:20 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:03:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:03:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:03:20 INFO - ^ 10:03:20 INFO - 1 warning generated. 10:03:20 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:03:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:20 INFO - Successfully installed psutil 10:03:20 INFO - Cleaning up... 10:03:20 INFO - Return code: 0 10:03:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:03:20 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:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:20 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:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:20 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:20 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:03:20 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:03:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:20 INFO - 'HOME': '/Users/cltbld', 10:03:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:20 INFO - 'LOGNAME': 'cltbld', 10:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:20 INFO - 'MOZ_NO_REMOTE': '1', 10:03:20 INFO - 'NO_EM_RESTART': '1', 10:03:20 INFO - 'PAGER': '/bin/cat', 10:03:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:20 INFO - 'PWD': '/builds/slave/test', 10:03:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:20 INFO - 'SHELL': '/bin/bash', 10:03:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:20 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:20 INFO - 'USER': 'cltbld', 10:03:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:20 INFO - 'XPC_FLAGS': '0x0', 10:03:20 INFO - 'XPC_SERVICE_NAME': '0', 10:03:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03: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:03: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:03: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:03: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:03: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:03: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:03:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:03:22 INFO - Installing collected packages: mozsystemmonitor 10:03:22 INFO - Running setup.py install for mozsystemmonitor 10:03:22 INFO - Successfully installed mozsystemmonitor 10:03:22 INFO - Cleaning up... 10:03:22 INFO - Return code: 0 10:03:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:22 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:22 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:03:22 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:03:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:22 INFO - 'HOME': '/Users/cltbld', 10:03:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:22 INFO - 'LOGNAME': 'cltbld', 10:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:22 INFO - 'MOZ_NO_REMOTE': '1', 10:03:22 INFO - 'NO_EM_RESTART': '1', 10:03:22 INFO - 'PAGER': '/bin/cat', 10:03:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:22 INFO - 'PWD': '/builds/slave/test', 10:03:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:22 INFO - 'SHELL': '/bin/bash', 10:03:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:22 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:22 INFO - 'USER': 'cltbld', 10:03:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:22 INFO - 'XPC_FLAGS': '0x0', 10:03:22 INFO - 'XPC_SERVICE_NAME': '0', 10:03:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:22 INFO - Downloading/unpacking jsonschema==2.5.1 10:03:22 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:03:22 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:03:22 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:03:22 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:03:22 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:03:22 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:03:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:24 INFO - warning: no files found matching '*.txt' 10:03:24 INFO - no previously-included directories found matching 'build' 10:03:24 INFO - no previously-included directories found matching 'dist' 10:03:24 INFO - no previously-included directories found matching '.git*' 10:03:24 INFO - Installing collected packages: jsonschema, functools32 10:03:24 INFO - Running setup.py install for functools32 10:03:24 INFO - warning: no files found matching '*.txt' 10:03:24 INFO - no previously-included directories found matching 'build' 10:03:24 INFO - no previously-included directories found matching 'dist' 10:03:24 INFO - no previously-included directories found matching '.git*' 10:03:24 INFO - Successfully installed jsonschema functools32 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:03: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:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:24 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:03:24 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:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:24 INFO - 'HOME': '/Users/cltbld', 10:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PAGER': '/bin/cat', 10:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:24 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - 'XPC_FLAGS': '0x0', 10:03:24 INFO - 'XPC_SERVICE_NAME': '0', 10:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:03: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:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:24 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:24 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:03:24 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:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:24 INFO - 'HOME': '/Users/cltbld', 10:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PAGER': '/bin/cat', 10:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:24 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - 'XPC_FLAGS': '0x0', 10:03:24 INFO - 'XPC_SERVICE_NAME': '0', 10:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:03: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:03: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:03: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:03: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:03: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:03: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:03:26 INFO - Downloading blobuploader-1.2.4.tar.gz 10:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:03:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:03:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:03:27 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:03:27 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:03:27 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:03:27 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:03:27 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:03:27 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:03:27 INFO - Downloading docopt-0.6.1.tar.gz 10:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:03:27 INFO - Installing collected packages: blobuploader, requests, docopt 10:03:27 INFO - Running setup.py install for blobuploader 10:03:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:03:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:03:27 INFO - Running setup.py install for requests 10:03:28 INFO - Running setup.py install for docopt 10:03:28 INFO - Successfully installed blobuploader requests docopt 10:03:28 INFO - Cleaning up... 10:03:28 INFO - Return code: 0 10:03:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:28 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:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:28 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:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:28 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:28 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:03:28 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:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:28 INFO - 'HOME': '/Users/cltbld', 10:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:28 INFO - 'LOGNAME': 'cltbld', 10:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:28 INFO - 'MOZ_NO_REMOTE': '1', 10:03:28 INFO - 'NO_EM_RESTART': '1', 10:03:28 INFO - 'PAGER': '/bin/cat', 10:03:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:28 INFO - 'PWD': '/builds/slave/test', 10:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:28 INFO - 'SHELL': '/bin/bash', 10:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:28 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:28 INFO - 'USER': 'cltbld', 10:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:28 INFO - 'XPC_FLAGS': '0x0', 10:03:28 INFO - 'XPC_SERVICE_NAME': '0', 10:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-cdteRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-7yiZW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-RQBPQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:28 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-a4ZIZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-OexAaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-LJ3to6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-pYUI8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-wAoX8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-cybeev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-eFF01L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-0VjiVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-KSXPbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-gvaImv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:29 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-3vxtx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:30 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-vZxp9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:30 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-KYFBrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:30 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-sW5iha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:03:30 INFO - Running setup.py install for manifestparser 10:03:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:03:30 INFO - Running setup.py install for mozcrash 10:03:30 INFO - Running setup.py install for mozdebug 10:03:30 INFO - Running setup.py install for mozdevice 10:03:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:03:30 INFO - Running setup.py install for mozfile 10:03:31 INFO - Running setup.py install for mozhttpd 10:03:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Running setup.py install for mozinfo 10:03:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Running setup.py install for mozInstall 10:03:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Running setup.py install for mozleak 10:03:31 INFO - Running setup.py install for mozlog 10:03:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:03:31 INFO - Running setup.py install for moznetwork 10:03:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:03:32 INFO - Running setup.py install for mozprocess 10:03:32 INFO - Running setup.py install for mozprofile 10:03:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:03:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:03:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:03:32 INFO - Running setup.py install for mozrunner 10:03:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:03:32 INFO - Running setup.py install for mozscreenshot 10:03:32 INFO - Running setup.py install for moztest 10:03:32 INFO - Running setup.py install for mozversion 10:03:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:03:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:03:32 INFO - Cleaning up... 10:03:32 INFO - Return code: 0 10:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03: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:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03: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:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:32 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:32 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:03:32 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:03:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:32 INFO - 'HOME': '/Users/cltbld', 10:03:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:32 INFO - 'LOGNAME': 'cltbld', 10:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:32 INFO - 'MOZ_NO_REMOTE': '1', 10:03:32 INFO - 'NO_EM_RESTART': '1', 10:03:32 INFO - 'PAGER': '/bin/cat', 10:03:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:32 INFO - 'PWD': '/builds/slave/test', 10:03:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:32 INFO - 'SHELL': '/bin/bash', 10:03:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:32 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:32 INFO - 'USER': 'cltbld', 10:03:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:32 INFO - 'XPC_FLAGS': '0x0', 10:03:32 INFO - 'XPC_SERVICE_NAME': '0', 10:03:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-19ue52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:33 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-8VxLN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:33 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-h5ETc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:33 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-qZ4cal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-a9DjIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:33 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-9_gWMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:33 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-94UOHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:33 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:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:33 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-ToYvrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-njKW4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-pgm52n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-mYG0vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-XixTo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-egcHo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Ay26jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-tGAlLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-hIperz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:34 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:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:34 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-I5fNON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:35 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:03:35 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:03:35 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:03:35 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:03:35 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:35 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:03:35 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:03:35 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:03:35 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:03:35 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:03:35 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:03:35 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:03:36 INFO - Downloading blessings-1.6.tar.gz 10:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:03:36 INFO - Installing collected packages: blessings 10:03:36 INFO - Running setup.py install for blessings 10:03:36 INFO - Successfully installed blessings 10:03:36 INFO - Cleaning up... 10:03:36 INFO - Return code: 0 10:03:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:36 INFO - Reading from file tmpfile_stdout 10:03:36 INFO - Current package versions: 10:03:36 INFO - blessings == 1.6 10:03:36 INFO - blobuploader == 1.2.4 10:03:36 INFO - docopt == 0.6.1 10:03:36 INFO - functools32 == 3.2.3-2 10:03:36 INFO - jsonschema == 2.5.1 10:03:36 INFO - manifestparser == 1.1 10:03:36 INFO - mozInstall == 1.12 10:03:36 INFO - mozcrash == 1.0 10:03:36 INFO - mozdebug == 0.1 10:03:36 INFO - mozdevice == 0.50 10:03:36 INFO - mozfile == 1.2 10:03:36 INFO - mozhttpd == 0.7 10:03:36 INFO - mozinfo == 0.9 10:03:36 INFO - mozleak == 0.1 10:03:36 INFO - mozlog == 3.4 10:03:36 INFO - moznetwork == 0.27 10:03:36 INFO - mozprocess == 0.25 10:03:36 INFO - mozprofile == 0.28 10:03:36 INFO - mozrunner == 6.13 10:03:36 INFO - mozscreenshot == 0.1 10:03:36 INFO - mozsystemmonitor == 0.3 10:03:36 INFO - moztest == 0.8 10:03:36 INFO - mozversion == 1.4 10:03:36 INFO - psutil == 3.1.1 10:03:36 INFO - requests == 1.2.3 10:03:36 INFO - wsgiref == 0.1.2 10:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:36 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:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:36 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:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:36 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 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:36 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:03:36 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:03:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:36 INFO - 'HOME': '/Users/cltbld', 10:03:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:36 INFO - 'LOGNAME': 'cltbld', 10:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:36 INFO - 'MOZ_NO_REMOTE': '1', 10:03:36 INFO - 'NO_EM_RESTART': '1', 10:03:36 INFO - 'PAGER': '/bin/cat', 10:03:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:36 INFO - 'PWD': '/builds/slave/test', 10:03:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:36 INFO - 'SHELL': '/bin/bash', 10:03:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:36 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:36 INFO - 'USER': 'cltbld', 10:03:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:36 INFO - 'XPC_FLAGS': '0x0', 10:03:36 INFO - 'XPC_SERVICE_NAME': '0', 10:03:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 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:03:37 INFO - Cleaning up... 10:03:37 INFO - Return code: 0 10:03:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102153b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102156768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95fadc7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, '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.FkbXL1Q7VF/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.fp7II4cf42/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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:03:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:03:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:37 INFO - 'HOME': '/Users/cltbld', 10:03:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:37 INFO - 'LOGNAME': 'cltbld', 10:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:37 INFO - 'MOZ_NO_REMOTE': '1', 10:03:37 INFO - 'NO_EM_RESTART': '1', 10:03:37 INFO - 'PAGER': '/bin/cat', 10:03:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:37 INFO - 'PWD': '/builds/slave/test', 10:03:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:37 INFO - 'SHELL': '/bin/bash', 10:03:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:37 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:37 INFO - 'USER': 'cltbld', 10:03:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:37 INFO - 'XPC_FLAGS': '0x0', 10:03:37 INFO - 'XPC_SERVICE_NAME': '0', 10:03:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:03:37 INFO - Cleaning up... 10:03:37 INFO - Return code: 0 10:03:37 INFO - Running post-action listener: _resource_record_post_action 10:03:37 INFO - Running post-action listener: _start_resource_monitoring 10:03:37 INFO - Starting resource monitoring. 10:03:37 INFO - [mozharness: 2017-05-04 17:03:37.476026Z] Finished create-virtualenv step (success) 10:03:37 INFO - [mozharness: 2017-05-04 17:03:37.476987Z] Running install step. 10:03:37 INFO - Running pre-action listener: _resource_record_pre_action 10:03:37 INFO - Running main action method: install 10:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:37 INFO - Reading from file tmpfile_stdout 10:03:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:37 INFO - Reading from file tmpfile_stdout 10:03:37 INFO - Output received: 10:03:37 INFO - Usage: mozinstall [options] installer 10:03:37 INFO - Options: 10:03:37 INFO - -h, --help show this help message and exit 10:03:37 INFO - -d DEST, --destination=DEST 10:03:37 INFO - Directory to install application into. [default: 10:03:37 INFO - "/builds/slave/test"] 10:03:37 INFO - --app=APP Application being installed. [default: firefox] 10:03:37 INFO - mkdir: /builds/slave/test/build/application 10:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:03:57 INFO - Reading from file tmpfile_stdout 10:03:57 INFO - Output received: 10:03:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:03:57 INFO - Running post-action listener: _resource_record_post_action 10:03:57 INFO - [mozharness: 2017-05-04 17:03:57.560537Z] Finished install step (success) 10:03:57 INFO - [mozharness: 2017-05-04 17:03:57.560682Z] Running run-tests step. 10:03:57 INFO - Running pre-action listener: _resource_record_pre_action 10:03:57 INFO - Running main action method: run_tests 10:03:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:03:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:03:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:03:57 INFO - 2017-05-04 10:03:57.575 screenresolution[1628:8039] starting screenresolution argv=screenresolution get 10:03:57 INFO - 2017-05-04 10:03:57.577 screenresolution[1628:8039] Display 0: 1600x1200x32@60 10:03:57 INFO - 2017-05-04 10:03:57.583 screenresolution[1629:8041] starting screenresolution argv=screenresolution list 10:03:57 INFO - Available Modes on Display 0 10:03:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:03:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:03:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:03:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:03:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:03:57 INFO - Intel Iris: 10:03:57 INFO - Chipset Model: Intel Iris 10:03:57 INFO - Type: GPU 10:03:57 INFO - Bus: Built-In 10:03:57 INFO - VRAM (Dynamic, Max): 1536 MB 10:03:57 INFO - Vendor: Intel (0x8086) 10:03:57 INFO - Device ID: 0x0a2e 10:03:57 INFO - Revision ID: 0x0009 10:03:57 INFO - Displays: 10:03:57 INFO - Display: 10:03:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:03:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:03:57 INFO - Display Serial Number: 1600x1200 60 10:03:57 INFO - Main Display: Yes 10:03:57 INFO - Mirror: Off 10:03:57 INFO - Online: Yes 10:03:57 INFO - Rotation: Supported 10:03:57 INFO - Return code: 0 10:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:57 INFO - Python 2.7.3 10:03:57 INFO - Return code: 0 10:03:57 INFO - grabbing minidump binary from tooltool 10:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:03:57 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 0x101f31d30>, '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 0x101e57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f26be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:57 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:03:57 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:03:57 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:03:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:57 INFO - Return code: 0 10:03:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:03:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:57 INFO - ENV: RUST_BACKTRACE is now 1 10:03:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:03:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--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:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0248 --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:03:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FkbXL1Q7VF/Render', 10:03:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:57 INFO - 'HOME': '/Users/cltbld', 10:03:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:57 INFO - 'LOGNAME': 'cltbld', 10:03:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:57 INFO - 'MOZ_NO_REMOTE': '1', 10:03:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:57 INFO - 'NO_EM_RESTART': '1', 10:03:57 INFO - 'PAGER': '/bin/cat', 10:03:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:57 INFO - 'PWD': '/builds/slave/test', 10:03:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:57 INFO - 'RUST_BACKTRACE': '1', 10:03:57 INFO - 'SHELL': '/bin/bash', 10:03:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fp7II4cf42/Listeners', 10:03:57 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 10:03:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:57 INFO - 'USER': 'cltbld', 10:03:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:57 INFO - 'XPC_FLAGS': '0x0', 10:03:57 INFO - 'XPC_SERVICE_NAME': '0', 10:03:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--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:03:58 INFO - mozversion application_buildid: 20170504085243 10:03:58 INFO - mozversion application_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:03:58 INFO - mozversion application_display_name: Nightly 10:03:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:58 INFO - mozversion application_name: Firefox 10:03:58 INFO - mozversion application_remotingname: firefox 10:03:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:03:58 INFO - mozversion application_vendor: Mozilla 10:03:58 INFO - mozversion application_version: 55.0a1 10:03:58 INFO - mozversion platform_buildid: 20170504085243 10:03:58 INFO - mozversion platform_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:03:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:03:58 INFO - mozversion platform_version: 55.0a1 10:03:58 INFO - using testdate: 1493917438 10:03:58 INFO - actual date: 1493917438 10:03:58 INFO - starting webserver on 'localhost:49243' 10:03:58 INFO - SUITE-START | Running 2 tests 10:03:58 INFO - TEST-START | dromaeo_css 10:03:58 INFO - operating with platform_type : mac_ 10:03:58 INFO - Initialising browser for dromaeo_css test... 10:03:58 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp4Zk12j/profile http://localhost:49243/getInfo.html) 10:04:01 INFO - PID 1639 | 2017-05-04 10:04:01.124 plugin-container[1641:8228] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a43, name = 'com.apple.tsm.portname' 10:04:01 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:01 INFO - PID 1639 | 2017-05-04 10:04:01.153 plugin-container[1641:8228] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0f, name = 'com.apple.CFPasteboardClient' 10:04:01 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:01 INFO - PID 1639 | 2017-05-04 10:04:01.153 plugin-container[1641:8228] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:04:01 INFO - PID 1639 | __metrics Screen width/height:1600/1200 10:04:01 INFO - PID 1639 | colorDepth:24 10:04:01 INFO - PID 1639 | Browser inner width/height: 1024/691 10:04:01 INFO - PID 1639 | __metrics 10:04:01 INFO - PID 1639 | 2017-05-04 10:04:01.794 plugin-container[1642:8282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 10:04:01 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:01 INFO - PID 1639 | 2017-05-04 10:04:01.794 plugin-container[1642:8282] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 10:04:01 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:01 INFO - PID 1639 | 2017-05-04 10:04:01.794 plugin-container[1642:8282] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:04:02 INFO - TEST-INFO | 1639: exit 0 10:04:02 INFO - Browser initialized. 10:04:02 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:02 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp4Zk12j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:04 INFO - PID 1643 | 2017-05-04 10:04:04.945 plugin-container[1644:8392] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9433, name = 'com.apple.tsm.portname' 10:04:04 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:04 INFO - PID 1643 | 2017-05-04 10:04:04.946 plugin-container[1644:8392] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 10:04:04 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:04 INFO - PID 1643 | 2017-05-04 10:04:04.946 plugin-container[1644:8392] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:04:05 INFO - PID 1643 | 2017-05-04 10:04:05.305 plugin-container[1645:8435] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 10:04:05 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:05 INFO - PID 1643 | 2017-05-04 10:04:05.305 plugin-container[1645:8435] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 10:04:05 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:04:05 INFO - PID 1643 | 2017-05-04 10:04:05.305 plugin-container[1645:8435] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:04:14 INFO - PID 1643 | RSS: Main: 233021440 10:04:14 INFO - PID 1643 | 10:07:19 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:07:20 INFO - PID 1643 | RSS: Main: 255225856 10:07:20 INFO - PID 1643 | 10:10:22 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:10:23 INFO - PID 1643 | RSS: Main: 258129920 10:10:23 INFO - PID 1643 | 10:13:25 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:13:25 INFO - PID 1643 | RSS: Main: 267767808 10:13:25 INFO - PID 1643 | 10:16:27 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:16:28 INFO - PID 1643 | RSS: Main: 260726784 10:16:28 INFO - PID 1643 | 10:19:30 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:19:31 INFO - PID 1643 | RSS: Main: 264331264 10:19:31 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:22:33 INFO - PID 1643 | RSS: Main: 271265792 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | __start_tp_report 10:22:33 INFO - PID 1643 | _x_x_mozilla_page_load 10:22:33 INFO - PID 1643 | _x_x_mozilla_page_load_details 10:22:33 INFO - PID 1643 | |i|pagename|runs| 10:22:33 INFO - PID 1643 | |0;dojo.html;3594.9101272468183;3630.636936306369;3652.41561350184;3671.3024525340184;3676.466912297718;6125.9986145235725;6178.505719542437;6223.626582405059;6244.094606282087;6284.937150628492;4426.89327668083;6179.876402471959;6219.906701399483;6234.345393733661;6287.2140982377205;4450.5104438511735;5385.67685938843;5446.128619420893;5498.3127109111365;5498.670079795225;5061.19020956647;5069.315642388286;5600.887982240352;5626.493615574597;5647.181158731982;4593.563611456906;5408.486193811582;5497.147942068986;5539.307586551681;5664.150377443375;5444.809431669913;5446.2919820423485;5496.532794712454;5513.228148059275;5543.944560554383;5403.648762830443;5501.257330260443;5536.916946245809;5542.667439953575;5543.528800052;6057.3336932937345;6282.560220784547;6285.842853928642;6307.5269354798575;6319.5576309658345;6524.967375163142;6599.10912026875;6703.664816759143;6783.152105986752;6801.965990170067;6858.142732158481;6887.966804979294;6890.2420733719255;6904.551204171763;6911.5853048817235;6281.152044474029;6296.244450665949;6351.04734289851;6352.809415717536;6365.395287447685;6793.660316984131;6892.586444813327;6906.758263460755;7073.964630176919;7080.504364694525;6632.1709786276715;6646;6687.565308254948;6692.431143352772;6713.899291510631;6809.591424514545;6834.794956151323;6857.417119544794;6857.862842743117;6874.931250687529;6494.9675251624385;6709.6980635871505;6712.798616041527;6774.695138718769;6789.287124851919;5815.76736930518;6551.279359270477;6567.44176744982;6579.440747536513;6616.636085015371;5391.137418013099;5394.487523685244;5397.7571009304675;5410.431904650034;5434.347878254634;4745.5966242869745;4770.737609431445;4784.736839473792;4791.544803243686;4811.158047341702;6122.733612273343;6365.9496183130195;6396.424321810966;6397.488200943913;6448.838779030468;6943.89584156238;6945.0971373721095;6948.5483443576;6960.895586566206;6975.755848545276;6478.611283323015;6499.220093588705;6513.478921686348;6518.217813862367;6518.837029074311;5845.298564172326;5935.228420305332;5961.403859614091;5967.492763115097;6082.57421980466;6165.013597824327;6890.724371025303;7054.6825392857445;7158.856822863618;7160.498765086394;6649.534532582673;6704.631245281556;6877.449804015567;6897.448204143757;6913.170419549686;6925.065116209247;7069.752558660422;7159.248278930637;7168.462365322517;7173.390261827803;6510.837229069311;6595.967020164869;6767.1879374475375;6777.423918966943;6787.728490860508;6791.490638202055;6804.149481314836;6861.931380686329;6869.072675188786;6890.621015844176;6661.833454163685;6670.39966403026;6685.866282674417;6688.498362622726;6710.966445167743;6322.49420046386;6458.644774537445;6684.565503242274;6686.662667466623;6693.732250710112;5492.5605951524585;6277.623342599459;6438.8390290243115;6509.381608747161;6538.476921846146;6573.934260657332;6623.602583844985;6654.334566543307;6668.832954233087;6671.966640166768;5419.891602168013;6516.087747715229;6527.5430719849155;6538.346165383424;6539.836504087246 10:22:33 INFO - PID 1643 | |1;ext.html;772.1660606544932;810.7243537197354;831.1480732249444;1211.4548453196057;1263.5514392390696;36873.81563092184;37614.623853761455;37805.81097094514;37984;38497.80751096244;30823.075307740746;37315;37323.44014839773;37400.81299593498;37480.56376335536;7856.96071519643;7985.680572777111;8264.173582641717;8367.2469477747;8437.873431898526;7219.747308844191;8325.209105135002;8436.072032076467;8468.957655211716;8469.449485783434;8436.704715334965;8447.36644751643;8489.066202717697;8501.447405918627;8512.74461766148;8395.24442800151;8434.608289632233;8461.450005749606;8467.153284671545;8493.938257717786;8303.626336814857;8346.499210047356;8385.161483851565;8387.538685372301;8411.873821892677;37429.81285093584;37446.812765936265;37470.812645936596;37476.812615936746;37567;3636.0364503406618;3663.56037275526;3663.578688450809;3664.8534058637624;3674.503941967827;30728.2317942051;30762.615682294352;30802.691973080207;30825.537616935762;30834.38331233385;3122.765792565544;3141.4502462069045;3160.5259211118287;3162.683731626842;3170.889018884328;246658;251793;291282.9999999979;309211;309875;48763.02473950501;48789.75605121952;49001;49047.77380565443;49059.5094049055;49041;49174.50825491771;49188.50811491911;49308;49351.753241233564;14030.508932187324;14142.85857141436;14232.85767142336;14236.85763142376;14248.501302454364;11645.417729113511;11653.41732913351;11657.125715571197;11662.533498660128;11671.88328116708;13327.000474964416;13408.731825363438;13463.192208467523;13478.39347229377;13586.320683965761;5479.123340265618;5591.6365436246515;5949.524038076944;5994.220751302303;6016.789412370634;954.231843366097;1000.1398797034544;1022.8158931392272;1049.7375656085978;1088.385062439719;18102.90948545275;25007.249782506555;25116.372090697878;25218.117365892107;25458.745412546006;1134.7276653603076;1142.6058009986707;1165.65613144121;1169.8011338072547;1178.4461303187488;11171.497282622302;12768.936155319165;16792.90846095;16880;16941.237644306035;342943;344717;345698.54301456665;345726;345875;56855.14717279244;57056.714716426155;57397.71301143467;57479.13781293284;57587.71206143942;1221.3526830779701;1530.800995870552;1531.3568301313253;1543.9536813895602;1556.5563814312866;22963.540729185657;29419.85290073536;30722.385552289277;30797.8460107707;31380.05859824209;39607.80196099001;39887;39907.80046099867;40021;40097;235300;301271.86009538494;301453;301531;301943;34850.9544713659;36167.63832361748;37399.813000934824;37475.43786843145;37708;46671.76664116658;46705.53294467012;47459;48157;48555.757221213666;31202.751889924148;31760.841195793873;32372.514412284305;32607.836960815042;32892;32307.838460807547;32965;33005.17487062843;33138.67445302258;33298.833505832314;38777.418338724376;39556;39900.40149397819;40097;40178;24492.67584918459;30834.845825770728;30973.845130774203;33422.66577334293;33881.814136505105;21494.032768525765;25367.238982830546;25986;26383;26726.331841704112 10:22:33 INFO - PID 1643 | |2;jquery.html;368.44181065685484;398.6770715720265;406.77424029663524;457.29119864210463;459.71957106165235;17340.913295433536;19577.412677619675;21173.364799056013;22035.33893983181;22151.667724984098;21542.461438464044;21965.34103976879;22254.554908901813;22411.43971400716;22496.100155993783;5996.130561068642;6248.125262463259;6250.218722659668;6256.906146407808;6259;5929.347771745126;6095.664738439384;6107.5113990880845;6201.782937597185;6215.502759779207;6150.938490615082;6151.784687535937;6172.9074063889075;6184.25788905332;6184.876302473948;5911.497522710575;6054.273487181523;6072.301685306202;6116.388361163915;6123.8162855114415;5134.871628209287;5413.188021796723;5422.91865622016;5436.401995780461;5447.291852059247;23826.285211443683;24367.756322436726;26052.218433447026;26311.868440657865;26811.463770724476;1940.922363105474;2234.307364716943;2250.63989761639;2276.704028476304;2279.886005699708;16740.330386784637;16932.915335423244;17463;17484.47546573605;17669.469915902544;1866.188208129468;2098.8666120295024;2150.602138604363;2165.7184566006476;2174.0977494339986;121792;141926;154628.22685886497;154993;174809.26716595568;10093.69718908434;11735.706607334885;12382.876171238353;12421.44103515344;12463.937680311541;15801.288941997638;15976.360945562279;16027.43903963379;16070.919645401931;16080.919595402182;8762.86855697165;8985.415947963362;9009.729708108767;9032.63869445228;9119.726408207764;8471.364647651451;8533.615987280587;8549.316054715608;8675.913240867636;8716.389852710376;6386.776462823779;7654.502457340255;7665.3101220890385;7686.423518236043;7759.672098370466;2197.3627647982225;2210.7015552900475;2211.557688462282;2228.754836967932;2387.4747555537756;937.1331518345503;954.9092836180552;965.2712202287228;984.5864736810556;1002.1181360402799;14799.630009249855;18847.81152188488;20383.592328153354;20440.386788396372;20442.897785510977;998.026923749353;999;1001.3741411617739;1019.8266294729914;1025.1337619711333;9362.62549498026;10164.085232329126;10231.641892533726;10250.794984100425;10444.425556594308;530954;540271;547186;554668;560519;113322;117479.41260293644;136341.3182934079;138934;140902;1205.6081773423673;1247.1519366830642;1264.7344057747791;1272.2175861844898;1274.2736640115045;19637.803621963598;19903.10436030411;21056.68414973746;21090.894545527175;21125.788742112996;56512.71743641255;57365;57907;58728.70635646794;59131.70434147802;62768.686156568925;80133.59933200297;81194.78207827006;81527.18472815196;82502.58748706218;7007.614581198083;7185.353318201387;8625.39622226438;8760.91239087601;8808;13373.53192638253;13470.461181552628;13626.727465450835;13755.449782008607;13798.655033623838;11371.521702178663;11759.176857619885;11813.936745692929;11839.99360054405;11882.108841836724;9133.725988220363;9930.652427165303;10374.792504149724;10777.245592808427;11227.045701115496;11628.534858605899;11751.236169648946;11768.528933883264;11852.762944740884;12005.279683219034;8367.916320836957;8525;8535.573221339033;8749.868751968854;8902.955485222532;9724.805503889742;11602.94198529002;11608.593699220486;11753.177277590486;11884.881151188723 10:22:33 INFO - PID 1643 | |3;mootools.html;1374.587623712886;1416.1007760072357;1432.8853691704664;1438.4102517967629;1451.0278113663842;11272;11554.653360399181;11684.824727629093;11825.408729563509;11854.525818967242;11551.768964620724;11602.941985290083;11732.941335293312;11736.53053877846;11737.589184378548;2147.377260594426;2444.217850287904;2497.4880149569294;2499.5000999800113;2499.7500249975037;2477.2072936660275;2525.393905462694;2527.936801579957;2528.84826910386;2534.4804315115357;2445.193086281523;2465.926022219336;2488.664030355897;2496.2885577610386;2501.8874150663173;2444.4377793107506;2461.433870209844;2479.4049428137296;2487.7139129000216;2502.587073132931;2128.8403369747175;2305.054927479742;2388.8088952883727;2477.0834791127218;2497.5754121799337;9795.951020244924;11895.04839612829;11970.461329240205;12012.579559715368;12030.4586293617;6604.966975165142;6842.281560436182;6856.211535673362;6861.725530978805;6865.622390768505;4035.435039094529;4347.869563913087;4401.2517871961845;4419.977900110511;4438.622717069053;1210.7941649919446;1274.1654216488214;1292.4377895615437;1327.6548097494624;1335.5926442435054;16034.839651603568;16646.75029874553;16662.250198741087;16758.83241167585;16816.411425600167;4700.600448961808;5481.75332110056;5583.134614134816;5655.802046928337;5762.30852297727;11638;11698.06415486759;11719.003884669899;11726.179167458196;11738.413079345999;6517.087607734921;6536.542442029012;6536.542442029012;6551.082848401227;6562.278149403562;5959.553033522503;6131.14164017038;6238.1266622672865;6257.155284036688;6258.468030217483;4257.808398622069;4363.672724545671;4390.692651514363;4395.428594282723;4407.493138289074;1261.8927391171853;1269.9365031748375;1277.7316763479587;1279.8720127987126;1295.33290355467;750.6659536506203;805.295366554265;830.1076342931373;840.970566030186;863.7149740585592;6197.783077592263;6916.896246556305;7018.473614478935;7040.718371265092;7074.434045276365;459.76092431935206;475.4603524999151;526.1318823940529;612.4946918792015;958.4201558057275;3804.923901521954;3855.8264878080554;3857.8812144478347;3986.9601303986587;4473.306637471197;12080.395980200954;14514.927425363017;14802.963792534634;15006.624834379229;15014.699706005818;14795.408183672533;14932.40270389194;14938.626534336729;14942.62643433901;15022.023568468014;8266;8381.203785640477;8478.23695867375;8584.141585841491;8704.782380440412;7032.261612530815;7053.506254562131;7246.855062898818;7351.081114860643;7368.521046131984;12367.381630918599;12596.685082872635;13262.27057511846;13354.799678005033;13667.863321367056;13668.863311366758;13906.58280251594;14002.929985350009;14045.174127363378;14094.577162685136;9218.539073046455;9397.953010235178;9437.811243775224;9480.194183494481;9504.714858554255;10457.215708821717;10615;10727.624533141303;10798.190135739695;10839.67480975572;8714.38999270045;9131.13254240846;9197.218236449977;9220.124088211609;9257.953710231675;8372.497650141011;8868.911310887066;8946.776330591787;8996.370254082152;9013.414128081653;8306.6677332906;8341.916580834357;8358.70744523963;8446.577671116542;8463.830723385621;6162.501373996918;6185.195924529782;6196.442320191204;6205.503559715122;6212.378762123752;6138.662373569497;6183.443490085914;6282;6303.936960630518;6348.523860710373 10:22:33 INFO - PID 1643 | |4;prototype.html;397.21351723587316;404.7976011994003;405.3939360655819;406.81008051449504;418.2346306259547;6351.6189028658255;6356.552727200026;6416.486681065509;6436.645984470852;6442.967785161073;4713.858187214318;6144.3855614438535;6145.631262124276;6200.658963756991;6253.312135665074;4177.958220417788;4411.250087485119;4517.531802164293;4746.620270378378;4762.809487620491;3938.5076865391825;4027.617376349242;4522.186006518826;4563.885902852422;4573.050382503284;3521.735869809762;3711.1464363196483;4282.850100246492;4528.6377089832895;4539.54604539545;3353.6814002669707;4515.525869783674;4519.728816271001;4540.387047748544;4542.4776150742755;3380.577427821522;3859.0931131184147;3886.630770076838;3890.455336252927;3892.8832135035996;5250.820909322627;5954.523638108984;6113.694315284218;6169.845753856144;6181.887260293145;4524.502304746476;4796.904061918777;5288.603354748371;5399.271098401705;5487.259220005288;6677.565958212701;6704.865902681968;6715.731370745213;6755.088063111466;6760.256371799098;4398.450193725785;4422.933655995163;4423.469183697976;4444.377787109807;4445.577670121365;5870.530357571384;6293.9370606293805;6330.87338253237;7041.225465198824;7080.929190708079;3975.8470043687585;4492.887677808016;4504.144212599595;4531.524189960072;4533.093381323749;4043.8786836394956;4574.702644328108;4596.080783843245;4597.39091318036;4604.447466304065;5269.5233240376965;5371.811986580529;5424.5660347172925;5458.399576046631;5471.699056551928;5535.252740880011;6673.666316684146;6747.779875533132;6769.559978601375;6820.761273355508;1549.7675348697785;1555.8599726024713;1556.5797234746556;1561.6252099496267;1562.1642421304548;814.6497006287353;866.9596484218963;970.2335155227291;1012.2711647613706;1027.2295778166376;6400.7119679614525;6473.352664733489;6495.285518592951;6506;6526.738930442729;6034.668093254913;6173.876522469615;6853.059490792814;6944.930550694529;6965.895511567331;5901.970490147608;6397.977587593717;6411.839704007344;6425.132607098076;6458.514541655446;3570.2680950405106;3621.927561448809;3653.6529029742132;3654.634536546377;3677.9448308274864;6912.343327383891;7113.430925526049;7220.169680486812;7243;7290.7083716651805;6309.422644338915;6855.937329713903;6981.406580440618;7146.892231704094;7224.855502889913;6154.169187159766;7040.225575186725;7158.928410715826;7170.999999999895;7236.204017558064;5423.376311724044;5883.852903677443;6417.197850268716;6959.164900212007;7059.5764254144915;5666.631668941505;5691.943080569141;6602.834929126618;6867.519273650796;6971.6165610891885;6682.665866706742;6775.322467753185;7179.676914538963;7201.739695553152;7298.23368546295;4404.317330813729;4412.602865742098;4468.419105516392;4506.616937560344;4515.909681806411;5534.640248383842;6502.544821862424;6746.392824645805;6939.097917270722;7139.464540159613;6765.458763299022;6769.93230067693;6774.4580433564215;6791.422729067887;6824.952514245806;5210.791568337224;5787.710614469175;5995.940040599538;6637.800865974028;6856.41720453767;5626.2685850839125;6613.900791488035;6690.665466726741;6695.832604184934;6715.656868626392;5057.570106540838;5707.800226992035;6331.271903730945;6594.505412094208;6773.491988101011;6297.716602752978;6587.835304117244;6633.469322454289;6658.235567574499;6684.732610695518 10:22:33 INFO - PID 1643 | |5;yui.html;813.2924355810444;841.3017195727547;856.4261944497187;877.8237162202647;878.1613559051104;14515.274236288196;15075.698486030273;16478.835211647896;16897.49307520775;16905.661886762256;12615.684607884807;13404.932975335134;17352.82647173528;17746;17757.02336371499;816.897887764028;1010.4240582867768;1011.5650270383732;1015.9992407478628;1017.8371460566311;947.0245646983618;1009.8081364540714;1013.807376598444;1021.325924889573;1022.8772547294335;1076.9461526923662;1078.094400703409;1079.0827796373098;1081.5133190064464;1082.0477979378136;1056.8203405421098;1071.9088877445427;1074.9032587067202;1076.2304951959347;1077.380506208929;781.4178437064367;790.9723159689383;793.0998316910291;793.670626689923;800.2237829305623;16682.58293542659;17041.914790426094;17164;17172.22724977379;17854.5536361592;15570.688586228325;16712.665746684997;16825.326986920507;16988.74516882248;17657.470275891745;14219.786703199461;14267;14269.072510286798;14341.56975290743;14488.20314882681;3504.7371447141313;3515.5254040704435;3524.6827785499427;3537.4693795930557;3544.7518673692853;121131.36605901924;134723.32638336744;137587;140879;140901.886471703;13608.523701670394;13987.300634968415;14081.225532595805;14202.644933876736;14205;21784.782152178275;25541.698947842026;25959.961601535728;26157.607635885477;26206;8036.598170091472;8064.435489515678;8096.595170241464;8104.554249516215;8113.310368618615;3798.5441746990537;3802.6007269236334;3838.3858582626644;3853.807309634507;3879.922401551953;4372.584604462571;4453.1761624099645;4465.687401881902;4474.731516109044;4480.887977800516;943.8820147481565;967.4533888353058;979.0356498848629;983.331334692416;999.2855108597242;571.8106338815254;665.1519312876121;674.6019848289533;677.140032159165;695.9443244540424;9057.501837398875;10333.534990925276;10896.61861834832;11464.082873370111;12660.936695316648;527.5568522441091;585;658.9062156819656;661.5865084322298;696.2237105627189;5534.422689533544;5540.806071787549;5727.427257274239;5747.339056008529;5847.035239185487;115360.42319788347;116110;116634;116682.41658791821;117466;101836;102281;105431;105753;106100;65081.69836603241;77022.84465733019;82518;82756;83709.58145209234;12099.455524501242;12689.4289756963;12719.364031798557;12719.491220351452;12788.552400665933;33914.830425847715;33966.49050264199;38835;41542.58457415387;41638.791806040776;53081.46918530765;53239.6690082751;54246;54494.45505544894;54504;15711.842881571038;15986.760198596798;16118.597035074217;16251.837481625033;16256.756148658016;17710.734338985185;17956.461306160836;18030.5492362692;18083.638327233646;18209.635807284045;15186.924065379602;15929.123898185711;16186.433474828324;17005.979641221566;17032.23354949055;16346.591335216715;16747.832521675115;17519.912400437915;17793.555161121076;17817.287308507515;16122.838771612604;16377.263023164225;16647.66704665924;16901.91549042247;17170.914145429193;10401.219908507044;11784.58753943608;12048.156629035884;12180.634580962585;12245.510179592717;13178.934105329412;13218.537351192663;13303.46786128544;13358.465661373437;13488.190708557519 10:22:33 INFO - PID 1643 | __end_tp_report 10:22:33 INFO - PID 1643 | __start_cc_report 10:22:33 INFO - PID 1643 | _x_x_mozilla_cycle_collect,412 10:22:33 INFO - PID 1643 | __end_cc_report 10:22:33 INFO - PID 1643 | __startTimestamp1493918553576__endTimestamp 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | ------- Summary: start ------- 10:22:33 INFO - PID 1643 | Number of tests: 6 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6217.93 Median:6510.84 stddev:780.98 (12.0%) stddev-sans-first:755.78 10:22:33 INFO - PID 1643 | Values: 3594.9 3630.6 3652.4 3671.3 3676.5 6126.0 6178.5 6223.6 6244.1 6284.9 4426.9 6179.9 6219.9 6234.3 6287.2 4450.5 5385.7 5446.1 5498.3 5498.7 5061.2 5069.3 5600.9 5626.5 5647.2 4593.6 5408.5 5497.1 5539.3 5664.2 5444.8 5446.3 5496.5 5513.2 5543.9 5403.6 5501.3 5536.9 5542.7 5543.5 6057.3 6282.6 6285.8 6307.5 6319.6 6525.0 6599.1 6703.7 6783.2 6802.0 6858.1 6888.0 6890.2 6904.6 6911.6 6281.2 6296.2 6351.0 6352.8 6365.4 6793.7 6892.6 6906.8 7074.0 7080.5 6632.2 6646.0 6687.6 6692.4 6713.9 6809.6 6834.8 6857.4 6857.9 6874.9 6495.0 6709.7 6712.8 6774.7 6789.3 5815.8 6551.3 6567.4 6579.4 6616.6 5391.1 5394.5 5397.8 5410.4 5434.3 4745.6 4770.7 4784.7 4791.5 4811.2 6122.7 6365.9 6396.4 6397.5 6448.8 6943.9 6945.1 6948.5 6960.9 6975.8 6478.6 6499.2 6513.5 6518.2 6518.8 5845.3 5935.2 5961.4 5967.5 6082.6 6165.0 6890.7 7054.7 7158.9 7160.5 6649.5 6704.6 6877.4 6897.4 6913.2 6925.1 7069.8 7159.2 7168.5 7173.4 6510.8 6596.0 6767.2 6777.4 6787.7 6791.5 6804.1 6861.9 6869.1 6890.6 6661.8 6670.4 6685.9 6688.5 6711.0 6322.5 6458.6 6684.6 6686.7 6693.7 5492.6 6277.6 6438.8 6509.4 6538.5 6573.9 6623.6 6654.3 6668.8 6672.0 5419.9 6516.1 6527.5 6538.3 6539.8 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:46205.01 Median:345800.50 stddev:80567.83 (23.3%) stddev-sans-first:80721.63 10:22:33 INFO - PID 1643 | Values: 772.2 810.7 831.1 1211.5 1263.6 36873.8 37614.6 37805.8 37984.0 38497.8 30823.1 37315.0 37323.4 37400.8 37480.6 7857.0 7985.7 8264.2 8367.2 8437.9 7219.7 8325.2 8436.1 8469.0 8469.4 8436.7 8447.4 8489.1 8501.4 8512.7 8395.2 8434.6 8461.5 8467.2 8493.9 8303.6 8346.5 8385.2 8387.5 8411.9 37429.8 37446.8 37470.8 37476.8 37567.0 3636.0 3663.6 3663.6 3664.9 3674.5 30728.2 30762.6 30802.7 30825.5 30834.4 3122.8 3141.5 3160.5 3162.7 3170.9 246658.0 251793.0 291283.0 309211.0 309875.0 48763.0 48789.8 49001.0 49047.8 49059.5 49041.0 49174.5 49188.5 49308.0 49351.8 14030.5 14142.9 14232.9 14236.9 14248.5 11645.4 11653.4 11657.1 11662.5 11671.9 13327.0 13408.7 13463.2 13478.4 13586.3 5479.1 5591.6 5949.5 5994.2 6016.8 954.2 1000.1 1022.8 1049.7 1088.4 18102.9 25007.2 25116.4 25218.1 25458.7 1134.7 1142.6 1165.7 1169.8 1178.4 11171.5 12768.9 16792.9 16880.0 16941.2 342943.0 344717.0 345698.5 345726.0 345875.0 56855.1 57056.7 57397.7 57479.1 57587.7 1221.4 1530.8 1531.4 1544.0 1556.6 22963.5 29419.9 30722.4 30797.8 31380.1 39607.8 39887.0 39907.8 40021.0 40097.0 235300.0 301271.9 301453.0 301531.0 301943.0 34851.0 36167.6 37399.8 37475.4 37708.0 46671.8 46705.5 47459.0 48157.0 48555.8 31202.8 31760.8 32372.5 32607.8 32892.0 32307.8 32965.0 33005.2 33138.7 33298.8 38777.4 39556.0 39900.4 40097.0 40178.0 24492.7 30834.8 30973.8 33422.7 33881.8 21494.0 25367.2 25986.0 26383.0 26726.3 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:35127.72 Median:12373.37 stddev:92752.62 (749.6%) stddev-sans-first:92976.09 10:22:33 INFO - PID 1643 | Values: 368.4 398.7 406.8 457.3 459.7 17340.9 19577.4 21173.4 22035.3 22151.7 21542.5 21965.3 22254.6 22411.4 22496.1 5996.1 6248.1 6250.2 6256.9 6259.0 5929.3 6095.7 6107.5 6201.8 6215.5 6150.9 6151.8 6172.9 6184.3 6184.9 5911.5 6054.3 6072.3 6116.4 6123.8 5134.9 5413.2 5422.9 5436.4 5447.3 23826.3 24367.8 26052.2 26311.9 26811.5 1940.9 2234.3 2250.6 2276.7 2279.9 16740.3 16932.9 17463.0 17484.5 17669.5 1866.2 2098.9 2150.6 2165.7 2174.1 121792.0 141926.0 154628.2 154993.0 174809.3 10093.7 11735.7 12382.9 12421.4 12463.9 15801.3 15976.4 16027.4 16070.9 16080.9 8762.9 8985.4 9009.7 9032.6 9119.7 8471.4 8533.6 8549.3 8675.9 8716.4 6386.8 7654.5 7665.3 7686.4 7759.7 2197.4 2210.7 2211.6 2228.8 2387.5 937.1 954.9 965.3 984.6 1002.1 14799.6 18847.8 20383.6 20440.4 20442.9 998.0 999.0 1001.4 1019.8 1025.1 9362.6 10164.1 10231.6 10250.8 10444.4 530954.0 540271.0 547186.0 554668.0 560519.0 113322.0 117479.4 136341.3 138934.0 140902.0 1205.6 1247.2 1264.7 1272.2 1274.3 19637.8 19903.1 21056.7 21090.9 21125.8 56512.7 57365.0 57907.0 58728.7 59131.7 62768.7 80133.6 81194.8 81527.2 82502.6 7007.6 7185.4 8625.4 8760.9 8808.0 13373.5 13470.5 13626.7 13755.4 13798.7 11371.5 11759.2 11813.9 11840.0 11882.1 9133.7 9930.7 10374.8 10777.2 11227.0 11628.5 11751.2 11768.5 11852.8 12005.3 8367.9 8525.0 8535.6 8749.9 8903.0 9724.8 11602.9 11608.6 11753.2 11884.9 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7112.64 Median:3856.85 stddev:4482.76 (116.2%) stddev-sans-first:4474.60 10:22:33 INFO - PID 1643 | Values: 1374.6 1416.1 1432.9 1438.4 1451.0 11272.0 11554.7 11684.8 11825.4 11854.5 11551.8 11602.9 11732.9 11736.5 11737.6 2147.4 2444.2 2497.5 2499.5 2499.8 2477.2 2525.4 2527.9 2528.8 2534.5 2445.2 2465.9 2488.7 2496.3 2501.9 2444.4 2461.4 2479.4 2487.7 2502.6 2128.8 2305.1 2388.8 2477.1 2497.6 9796.0 11895.0 11970.5 12012.6 12030.5 6605.0 6842.3 6856.2 6861.7 6865.6 4035.4 4347.9 4401.3 4420.0 4438.6 1210.8 1274.2 1292.4 1327.7 1335.6 16034.8 16646.8 16662.3 16758.8 16816.4 4700.6 5481.8 5583.1 5655.8 5762.3 11638.0 11698.1 11719.0 11726.2 11738.4 6517.1 6536.5 6536.5 6551.1 6562.3 5959.6 6131.1 6238.1 6257.2 6258.5 4257.8 4363.7 4390.7 4395.4 4407.5 1261.9 1269.9 1277.7 1279.9 1295.3 750.7 805.3 830.1 841.0 863.7 6197.8 6916.9 7018.5 7040.7 7074.4 459.8 475.5 526.1 612.5 958.4 3804.9 3855.8 3857.9 3987.0 4473.3 12080.4 14514.9 14803.0 15006.6 15014.7 14795.4 14932.4 14938.6 14942.6 15022.0 8266.0 8381.2 8478.2 8584.1 8704.8 7032.3 7053.5 7246.9 7351.1 7368.5 12367.4 12596.7 13262.3 13354.8 13667.9 13668.9 13906.6 14002.9 14045.2 14094.6 9218.5 9398.0 9437.8 9480.2 9504.7 10457.2 10615.0 10727.6 10798.2 10839.7 8714.4 9131.1 9197.2 9220.1 9258.0 8372.5 8868.9 8946.8 8996.4 9013.4 8306.7 8341.9 8358.7 8446.6 8463.8 6162.5 6185.2 6196.4 6205.5 6212.4 6138.7 6183.4 6282.0 6303.9 6348.5 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5349.17 Median:6129.04 stddev:1723.00 (28.1%) stddev-sans-first:1687.27 10:22:33 INFO - PID 1643 | Values: 397.2 404.8 405.4 406.8 418.2 6351.6 6356.6 6416.5 6436.6 6443.0 4713.9 6144.4 6145.6 6200.7 6253.3 4178.0 4411.3 4517.5 4746.6 4762.8 3938.5 4027.6 4522.2 4563.9 4573.1 3521.7 3711.1 4282.9 4528.6 4539.5 3353.7 4515.5 4519.7 4540.4 4542.5 3380.6 3859.1 3886.6 3890.5 3892.9 5250.8 5954.5 6113.7 6169.8 6181.9 4524.5 4796.9 5288.6 5399.3 5487.3 6677.6 6704.9 6715.7 6755.1 6760.3 4398.5 4422.9 4423.5 4444.4 4445.6 5870.5 6293.9 6330.9 7041.2 7080.9 3975.8 4492.9 4504.1 4531.5 4533.1 4043.9 4574.7 4596.1 4597.4 4604.4 5269.5 5371.8 5424.6 5458.4 5471.7 5535.3 6673.7 6747.8 6769.6 6820.8 1549.8 1555.9 1556.6 1561.6 1562.2 814.6 867.0 970.2 1012.3 1027.2 6400.7 6473.4 6495.3 6506.0 6526.7 6034.7 6173.9 6853.1 6944.9 6965.9 5902.0 6398.0 6411.8 6425.1 6458.5 3570.3 3621.9 3653.7 3654.6 3677.9 6912.3 7113.4 7220.2 7243.0 7290.7 6309.4 6855.9 6981.4 7146.9 7224.9 6154.2 7040.2 7158.9 7171.0 7236.2 5423.4 5883.9 6417.2 6959.2 7059.6 5666.6 5691.9 6602.8 6867.5 6971.6 6682.7 6775.3 7179.7 7201.7 7298.2 4404.3 4412.6 4468.4 4506.6 4515.9 5534.6 6502.5 6746.4 6939.1 7139.5 6765.5 6769.9 6774.5 6791.4 6825.0 5210.8 5787.7 5995.9 6637.8 6856.4 5626.3 6613.9 6690.7 6695.8 6715.7 5057.6 5707.8 6331.3 6594.5 6773.5 6297.7 6587.8 6633.5 6658.2 6684.7 10:22:33 INFO - PID 1643 | 10:22:33 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:22538.46 Median:17102.96 stddev:33116.07 (193.6%) stddev-sans-first:33168.79 10:22:33 INFO - PID 1643 | Values: 813.3 841.3 856.4 877.8 878.2 14515.3 15075.7 16478.8 16897.5 16905.7 12615.7 13404.9 17352.8 17746.0 17757.0 816.9 1010.4 1011.6 1016.0 1017.8 947.0 1009.8 1013.8 1021.3 1022.9 1076.9 1078.1 1079.1 1081.5 1082.0 1056.8 1071.9 1074.9 1076.2 1077.4 781.4 791.0 793.1 793.7 800.2 16682.6 17041.9 17164.0 17172.2 17854.6 15570.7 16712.7 16825.3 16988.7 17657.5 14219.8 14267.0 14269.1 14341.6 14488.2 3504.7 3515.5 3524.7 3537.5 3544.8 121131.4 134723.3 137587.0 140879.0 140901.9 13608.5 13987.3 14081.2 14202.6 14205.0 21784.8 25541.7 25960.0 26157.6 26206.0 8036.6 8064.4 8096.6 8104.6 8113.3 3798.5 3802.6 3838.4 3853.8 3879.9 4372.6 4453.2 4465.7 4474.7 4480.9 943.9 967.5 979.0 983.3 999.3 571.8 665.2 674.6 677.1 695.9 9057.5 10333.5 10896.6 11464.1 12660.9 527.6 585.0 658.9 661.6 696.2 5534.4 5540.8 5727.4 5747.3 5847.0 115360.4 116110.0 116634.0 116682.4 117466.0 101836.0 102281.0 105431.0 105753.0 106100.0 65081.7 77022.8 82518.0 82756.0 83709.6 12099.5 12689.4 12719.4 12719.5 12788.6 33914.8 33966.5 38835.0 41542.6 41638.8 53081.5 53239.7 54246.0 54494.5 54504.0 15711.8 15986.8 16118.6 16251.8 16256.8 17710.7 17956.5 18030.5 18083.6 18209.6 15186.9 15929.1 16186.4 17006.0 17032.2 16346.6 16747.8 17519.9 17793.6 17817.3 16122.8 16377.3 16647.7 16901.9 17170.9 10401.2 11784.6 12048.2 12180.6 12245.5 13178.9 13218.5 13303.5 13358.5 13488.2 10:22:33 INFO - PID 1643 | -------- Summary: end -------- 10:22:33 INFO - PID 1643 | 10:22:34 INFO - TEST-INFO | 1643: exit 0 10:22:34 INFO - TEST-OK | dromaeo_css | took 1115996ms 10:22:34 INFO - TEST-START | kraken 10:22:34 INFO - operating with platform_type : mac_ 10:22:34 INFO - Initialising browser for kraken test... 10:22:34 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmpsXA4QO/profile http://localhost:49243/getInfo.html) 10:22:36 INFO - PID 1656 | 2017-05-04 10:22:36.786 plugin-container[1657:10984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.tsm.portname' 10:22:36 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:36 INFO - PID 1656 | 2017-05-04 10:22:36.789 plugin-container[1657:10984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 10:22:36 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:36 INFO - PID 1656 | 2017-05-04 10:22:36.790 plugin-container[1657:10984] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:36 INFO - PID 1656 | __metrics Screen width/height:1600/1200 10:22:36 INFO - PID 1656 | colorDepth:24 10:22:36 INFO - PID 1656 | Browser inner width/height: 1024/691 10:22:36 INFO - PID 1656 | __metrics 10:22:37 INFO - PID 1656 | 10:22:37 INFO - PID 1656 | ###!!! [Child][MessageChannel] Error: (msgtype=0x7C0029,name=PHal::Msg_EnableWakeLockNotifications) Channel closing: too late to send/recv, messages will be lost 10:22:37 INFO - PID 1656 | 10:22:37 INFO - PID 1656 | 2017-05-04 10:22:37.464 plugin-container[1658:11038] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:22:37 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:37 INFO - PID 1656 | 2017-05-04 10:22:37.464 plugin-container[1658:11038] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 10:22:37 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:37 INFO - PID 1656 | 2017-05-04 10:22:37.465 plugin-container[1658:11038] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:38 INFO - TEST-INFO | 1656: exit 0 10:22:38 INFO - Browser initialized. 10:22:38 INFO - Running cycle 1/1 for kraken test... 10:22:38 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmpsXA4QO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:40 INFO - PID 1659 | 2017-05-04 10:22:40.406 plugin-container[1660:11145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 10:22:40 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:40 INFO - PID 1659 | 2017-05-04 10:22:40.407 plugin-container[1660:11145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 10:22:40 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:40 INFO - PID 1659 | 2017-05-04 10:22:40.407 plugin-container[1660:11145] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:40 INFO - PID 1659 | 2017-05-04 10:22:40.924 plugin-container[1661:11185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 10:22:40 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:40 INFO - PID 1659 | 2017-05-04 10:22:40.925 plugin-container[1661:11185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 10:22:40 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:40 INFO - PID 1659 | 2017-05-04 10:22:40.925 plugin-container[1661:11185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:50 INFO - PID 1659 | RSS: Main: 233861120 10:22:50 INFO - PID 1659 | 10:22:52 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:22:53 INFO - PID 1659 | RSS: Main: 246628352 10:22:53 INFO - PID 1659 | 10:22:56 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:22:57 INFO - PID 1659 | RSS: Main: 254922752 10:22:57 INFO - PID 1659 | 10:23:00 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:23:01 INFO - PID 1659 | RSS: Main: 256868352 10:23:01 INFO - PID 1659 | 10:23:03 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:23:03 INFO - PID 1659 | RSS: Main: 258465792 10:23:03 INFO - PID 1659 | 10:23:05 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:06 INFO - PID 1659 | RSS: Main: 260329472 10:23:06 INFO - PID 1659 | 10:23:09 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:10 INFO - PID 1659 | RSS: Main: 265822208 10:23:10 INFO - PID 1659 | 10:23:13 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:14 INFO - PID 1659 | RSS: Main: 263938048 10:23:14 INFO - PID 1659 | 10:23:17 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:23:17 INFO - PID 1659 | RSS: Main: 265216000 10:23:17 INFO - PID 1659 | 10:23:19 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:20 INFO - PID 1659 | RSS: Main: 265175040 10:23:20 INFO - PID 1659 | 10:23:21 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:22 INFO - PID 1659 | RSS: Main: 265424896 10:23:22 INFO - PID 1659 | 10:23:24 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:25 INFO - PID 1659 | RSS: Main: 265027584 10:23:25 INFO - PID 1659 | 10:23:28 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:28 INFO - PID 1659 | RSS: Main: 265134080 10:23:28 INFO - PID 1659 | 10:23:31 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:32 INFO - PID 1659 | RSS: Main: 265310208 10:23:32 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:23:34 INFO - PID 1659 | RSS: Main: 266784768 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | __start_tp_report 10:23:34 INFO - PID 1659 | _x_x_mozilla_page_load 10:23:34 INFO - PID 1659 | _x_x_mozilla_page_load_details 10:23:34 INFO - PID 1659 | |i|pagename|runs| 10:23:34 INFO - PID 1659 | |0;ai-astar;103;116;113;114;113;113;122;112;116;114 10:23:34 INFO - PID 1659 | |1;audio-beat-detection;142;111;110;150;112;139;104;147;167;148 10:23:34 INFO - PID 1659 | |2;audio-dft;201;203;198;205;208;219;231;196;199;201 10:23:34 INFO - PID 1659 | |3;audio-fft;80;59;74;111;83;82;58;58;75;57 10:23:34 INFO - PID 1659 | |4;audio-oscillator;95;73;84;70;75;108;111;80;68;91 10:23:34 INFO - PID 1659 | |5;imaging-gaussian-blur;89;89;108;137;83;127;136;86;128;81 10:23:34 INFO - PID 1659 | |6;imaging-darkroom;105;156;99;110;153;96;123;109;154;132 10:23:34 INFO - PID 1659 | |7;imaging-desaturate;91;90;91;88;90;90;92;90;91;91 10:23:34 INFO - PID 1659 | |8;json-parse-financial;51;50;52;54;53;69;46;66;60;76 10:23:34 INFO - PID 1659 | |9;json-stringify-tinderbox;56;67;55;72;62;59;53;58;55;54 10:23:34 INFO - PID 1659 | |10;stanford-crypto-aes;82;84;81;82;81;83;81;82;84;84 10:23:34 INFO - PID 1659 | |11;stanford-crypto-ccm;150;167;131;135;139;142;167;152;197;154 10:23:34 INFO - PID 1659 | |12;stanford-crypto-pbkdf2;184;186;179;188;183;186;184;217;185;184 10:23:34 INFO - PID 1659 | |13;stanford-crypto-sha256-iterative;70;70;65;69;66;83;87;92;96;90 10:23:34 INFO - PID 1659 | __end_tp_report 10:23:34 INFO - PID 1659 | __start_cc_report 10:23:34 INFO - PID 1659 | _x_x_mozilla_cycle_collect,985 10:23:34 INFO - PID 1659 | __end_cc_report 10:23:34 INFO - PID 1659 | __startTimestamp1493918614674__endTimestamp 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | ------- Summary: start ------- 10:23:34 INFO - PID 1659 | Number of tests: 14 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:4.70 (4.1%) stddev-sans-first:3.03 10:23:34 INFO - PID 1659 | Values: 103.0 116.0 113.0 114.0 113.0 113.0 122.0 112.0 116.0 114.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:144.50 stddev:21.80 (15.1%) stddev-sans-first:22.88 10:23:34 INFO - PID 1659 | Values: 142.0 111.0 110.0 150.0 112.0 139.0 104.0 147.0 167.0 148.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#2] audio-dft Cycles:10 Average:206.10 Median:204.00 stddev:10.91 (5.3%) stddev-sans-first:11.41 10:23:34 INFO - PID 1659 | Values: 201.0 203.0 198.0 205.0 208.0 219.0 231.0 196.0 199.0 201.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.50 stddev:16.92 (22.7%) stddev-sans-first:17.79 10:23:34 INFO - PID 1659 | Values: 80.0 59.0 74.0 111.0 83.0 82.0 58.0 58.0 75.0 57.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:77.50 stddev:15.36 (19.8%) stddev-sans-first:15.90 10:23:34 INFO - PID 1659 | Values: 95.0 73.0 84.0 70.0 75.0 108.0 111.0 80.0 68.0 91.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:106.40 Median:82.00 stddev:23.38 (28.5%) stddev-sans-first:23.94 10:23:34 INFO - PID 1659 | Values: 89.0 89.0 108.0 137.0 83.0 127.0 136.0 86.0 128.0 81.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#6] imaging-darkroom Cycles:10 Average:123.70 Median:153.50 stddev:23.62 (15.4%) stddev-sans-first:24.06 10:23:34 INFO - PID 1659 | Values: 105.0 156.0 99.0 110.0 153.0 96.0 123.0 109.0 154.0 132.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#7] imaging-desaturate Cycles:10 Average:90.40 Median:91.00 stddev:1.07 (1.2%) stddev-sans-first:1.12 10:23:34 INFO - PID 1659 | Values: 91.0 90.0 91.0 88.0 90.0 90.0 92.0 90.0 91.0 91.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:9.70 (17.0%) stddev-sans-first:9.98 10:23:34 INFO - PID 1659 | Values: 51.0 50.0 52.0 54.0 53.0 69.0 46.0 66.0 60.0 76.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.50 stddev:6.19 (10.6%) stddev-sans-first:6.46 10:23:34 INFO - PID 1659 | Values: 56.0 67.0 55.0 72.0 62.0 59.0 53.0 58.0 55.0 54.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.26 (1.5%) stddev-sans-first:1.33 10:23:34 INFO - PID 1659 | Values: 82.0 84.0 81.0 82.0 81.0 83.0 81.0 82.0 84.0 84.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:153.00 stddev:19.61 (12.8%) stddev-sans-first:20.77 10:23:34 INFO - PID 1659 | Values: 150.0 167.0 131.0 135.0 139.0 142.0 167.0 152.0 197.0 154.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.60 Median:185.50 stddev:10.60 (5.7%) stddev-sans-first:11.16 10:23:34 INFO - PID 1659 | Values: 184.0 186.0 179.0 188.0 183.0 186.0 184.0 217.0 185.0 184.0 10:23:34 INFO - PID 1659 | 10:23:34 INFO - PID 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:85.00 stddev:11.95 (14.1%) stddev-sans-first:12.25 10:23:34 INFO - PID 1659 | Values: 70.0 70.0 65.0 69.0 66.0 83.0 87.0 92.0 96.0 90.0 10:23:34 INFO - PID 1659 | -------- Summary: end -------- 10:23:34 INFO - PID 1659 | 10:23:35 INFO - TEST-INFO | 1659: exit 0 10:23:35 INFO - TEST-OK | kraken | took 61730ms 10:23:35 INFO - SUITE-END | took 1177s 10:23:36 INFO - Completed test suite (00:19:38) 10:23:36 INFO - javascript benchmark 10:23:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7918.6861658036205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3594.9101272468183, 3630.636936306369, 3652.41561350184, 3671.3024525340184, 3676.466912297718, 6125.9986145235725, 6178.505719542437, 6223.626582405059, 6244.094606282087, 6284.937150628492, 4426.89327668083, 6179.876402471959, 6219.906701399483, 6234.345393733661, 6287.2140982377205, 4450.5104438511735, 5385.67685938843, 5446.128619420893, 5498.3127109111365, 5498.670079795225, 5061.19020956647, 5069.315642388286, 5600.887982240352, 5626.493615574597, 5647.181158731982, 4593.563611456906, 5408.486193811582, 5497.147942068986, 5539.307586551681, 5664.150377443375, 5444.809431669913, 5446.2919820423485, 5496.532794712454, 5513.228148059275, 5543.944560554383, 5403.648762830443, 5501.257330260443, 5536.916946245809, 5542.667439953575, 5543.528800052, 6057.3336932937345, 6282.560220784547, 6285.842853928642, 6307.5269354798575, 6319.5576309658345, 6524.967375163142, 6599.10912026875, 6703.664816759143, 6783.152105986752, 6801.965990170067, 6858.142732158481, 6887.966804979294, 6890.2420733719255, 6904.551204171763, 6911.5853048817235, 6281.152044474029, 6296.244450665949, 6351.04734289851, 6352.809415717536, 6365.395287447685, 6793.660316984131, 6892.586444813327, 6906.758263460755, 7073.964630176919, 7080.504364694525, 6632.1709786276715, 6646.0, 6687.565308254948, 6692.431143352772, 6713.899291510631, 6809.591424514545, 6834.794956151323, 6857.417119544794, 6857.862842743117, 6874.931250687529, 6494.9675251624385, 6709.6980635871505, 6712.798616041527, 6774.695138718769, 6789.287124851919, 5815.76736930518, 6551.279359270477, 6567.44176744982, 6579.440747536513, 6616.636085015371, 5391.137418013099, 5394.487523685244, 5397.7571009304675, 5410.431904650034, 5434.347878254634, 4745.5966242869745, 4770.737609431445, 4784.736839473792, 4791.544803243686, 4811.158047341702, 6122.733612273343, 6365.9496183130195, 6396.424321810966, 6397.488200943913, 6448.838779030468, 6943.89584156238, 6945.0971373721095, 6948.5483443576, 6960.895586566206, 6975.755848545276, 6478.611283323015, 6499.220093588705, 6513.478921686348, 6518.217813862367, 6518.837029074311, 5845.298564172326, 5935.228420305332, 5961.403859614091, 5967.492763115097, 6082.57421980466, 6165.013597824327, 6890.724371025303, 7054.6825392857445, 7158.856822863618, 7160.498765086394, 6649.534532582673, 6704.631245281556, 6877.449804015567, 6897.448204143757, 6913.170419549686, 6925.065116209247, 7069.752558660422, 7159.248278930637, 7168.462365322517, 7173.390261827803, 6510.837229069311, 6595.967020164869, 6767.1879374475375, 6777.423918966943, 6787.728490860508, 6791.490638202055, 6804.149481314836, 6861.931380686329, 6869.072675188786, 6890.621015844176, 6661.833454163685, 6670.39966403026, 6685.866282674417, 6688.498362622726, 6710.966445167743, 6322.49420046386, 6458.644774537445, 6684.565503242274, 6686.662667466623, 6693.732250710112, 5492.5605951524585, 6277.623342599459, 6438.8390290243115, 6509.381608747161, 6538.476921846146, 6573.934260657332, 6623.602583844985, 6654.334566543307, 6668.832954233087, 6671.966640166768, 5419.891602168013, 6516.087747715229, 6527.5430719849155, 6538.346165383424, 6539.836504087246], "value": 6165.730800808181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.1660606544932, 810.7243537197354, 831.1480732249444, 1211.4548453196057, 1263.5514392390696, 36873.81563092184, 37614.623853761455, 37805.81097094514, 37984.0, 38497.80751096244, 30823.075307740746, 37315.0, 37323.44014839773, 37400.81299593498, 37480.56376335536, 7856.96071519643, 7985.680572777111, 8264.173582641717, 8367.2469477747, 8437.873431898526, 7219.747308844191, 8325.209105135002, 8436.072032076467, 8468.957655211716, 8469.449485783434, 8436.704715334965, 8447.36644751643, 8489.066202717697, 8501.447405918627, 8512.74461766148, 8395.24442800151, 8434.608289632233, 8461.450005749606, 8467.153284671545, 8493.938257717786, 8303.626336814857, 8346.499210047356, 8385.161483851565, 8387.538685372301, 8411.873821892677, 37429.81285093584, 37446.812765936265, 37470.812645936596, 37476.812615936746, 37567.0, 3636.0364503406618, 3663.56037275526, 3663.578688450809, 3664.8534058637624, 3674.503941967827, 30728.2317942051, 30762.615682294352, 30802.691973080207, 30825.537616935762, 30834.38331233385, 3122.765792565544, 3141.4502462069045, 3160.5259211118287, 3162.683731626842, 3170.889018884328, 246658.0, 251793.0, 291282.9999999979, 309211.0, 309875.0, 48763.02473950501, 48789.75605121952, 49001.0, 49047.77380565443, 49059.5094049055, 49041.0, 49174.50825491771, 49188.50811491911, 49308.0, 49351.753241233564, 14030.508932187324, 14142.85857141436, 14232.85767142336, 14236.85763142376, 14248.501302454364, 11645.417729113511, 11653.41732913351, 11657.125715571197, 11662.533498660128, 11671.88328116708, 13327.000474964416, 13408.731825363438, 13463.192208467523, 13478.39347229377, 13586.320683965761, 5479.123340265618, 5591.6365436246515, 5949.524038076944, 5994.220751302303, 6016.789412370634, 954.231843366097, 1000.1398797034544, 1022.8158931392272, 1049.7375656085978, 1088.385062439719, 18102.90948545275, 25007.249782506555, 25116.372090697878, 25218.117365892107, 25458.745412546006, 1134.7276653603076, 1142.6058009986707, 1165.65613144121, 1169.8011338072547, 1178.4461303187488, 11171.497282622302, 12768.936155319165, 16792.90846095, 16880.0, 16941.237644306035, 342943.0, 344717.0, 345698.54301456665, 345726.0, 345875.0, 56855.14717279244, 57056.714716426155, 57397.71301143467, 57479.13781293284, 57587.71206143942, 1221.3526830779701, 1530.800995870552, 1531.3568301313253, 1543.9536813895602, 1556.5563814312866, 22963.540729185657, 29419.85290073536, 30722.385552289277, 30797.8460107707, 31380.05859824209, 39607.80196099001, 39887.0, 39907.80046099867, 40021.0, 40097.0, 235300.0, 301271.86009538494, 301453.0, 301531.0, 301943.0, 34850.9544713659, 36167.63832361748, 37399.813000934824, 37475.43786843145, 37708.0, 46671.76664116658, 46705.53294467012, 47459.0, 48157.0, 48555.757221213666, 31202.751889924148, 31760.841195793873, 32372.514412284305, 32607.836960815042, 32892.0, 32307.838460807547, 32965.0, 33005.17487062843, 33138.67445302258, 33298.833505832314, 38777.418338724376, 39556.0, 39900.40149397819, 40097.0, 40178.0, 24492.67584918459, 30834.845825770728, 30973.845130774203, 33422.66577334293, 33881.814136505105, 21494.032768525765, 25367.238982830546, 25986.0, 26383.0, 26726.331841704112], "value": 17969.524284144507, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.44181065685484, 398.6770715720265, 406.77424029663524, 457.29119864210463, 459.71957106165235, 17340.913295433536, 19577.412677619675, 21173.364799056013, 22035.33893983181, 22151.667724984098, 21542.461438464044, 21965.34103976879, 22254.554908901813, 22411.43971400716, 22496.100155993783, 5996.130561068642, 6248.125262463259, 6250.218722659668, 6256.906146407808, 6259.0, 5929.347771745126, 6095.664738439384, 6107.5113990880845, 6201.782937597185, 6215.502759779207, 6150.938490615082, 6151.784687535937, 6172.9074063889075, 6184.25788905332, 6184.876302473948, 5911.497522710575, 6054.273487181523, 6072.301685306202, 6116.388361163915, 6123.8162855114415, 5134.871628209287, 5413.188021796723, 5422.91865622016, 5436.401995780461, 5447.291852059247, 23826.285211443683, 24367.756322436726, 26052.218433447026, 26311.868440657865, 26811.463770724476, 1940.922363105474, 2234.307364716943, 2250.63989761639, 2276.704028476304, 2279.886005699708, 16740.330386784637, 16932.915335423244, 17463.0, 17484.47546573605, 17669.469915902544, 1866.188208129468, 2098.8666120295024, 2150.602138604363, 2165.7184566006476, 2174.0977494339986, 121792.0, 141926.0, 154628.22685886497, 154993.0, 174809.26716595568, 10093.69718908434, 11735.706607334885, 12382.876171238353, 12421.44103515344, 12463.937680311541, 15801.288941997638, 15976.360945562279, 16027.43903963379, 16070.919645401931, 16080.919595402182, 8762.86855697165, 8985.415947963362, 9009.729708108767, 9032.63869445228, 9119.726408207764, 8471.364647651451, 8533.615987280587, 8549.316054715608, 8675.913240867636, 8716.389852710376, 6386.776462823779, 7654.502457340255, 7665.3101220890385, 7686.423518236043, 7759.672098370466, 2197.3627647982225, 2210.7015552900475, 2211.557688462282, 2228.754836967932, 2387.4747555537756, 937.1331518345503, 954.9092836180552, 965.2712202287228, 984.5864736810556, 1002.1181360402799, 14799.630009249855, 18847.81152188488, 20383.592328153354, 20440.386788396372, 20442.897785510977, 998.026923749353, 999.0, 1001.3741411617739, 1019.8266294729914, 1025.1337619711333, 9362.62549498026, 10164.085232329126, 10231.641892533726, 10250.794984100425, 10444.425556594308, 530954.0, 540271.0, 547186.0, 554668.0, 560519.0, 113322.0, 117479.41260293644, 136341.3182934079, 138934.0, 140902.0, 1205.6081773423673, 1247.1519366830642, 1264.7344057747791, 1272.2175861844898, 1274.2736640115045, 19637.803621963598, 19903.10436030411, 21056.68414973746, 21090.894545527175, 21125.788742112996, 56512.71743641255, 57365.0, 57907.0, 58728.70635646794, 59131.70434147802, 62768.686156568925, 80133.59933200297, 81194.78207827006, 81527.18472815196, 82502.58748706218, 7007.614581198083, 7185.353318201387, 8625.39622226438, 8760.91239087601, 8808.0, 13373.53192638253, 13470.461181552628, 13626.727465450835, 13755.449782008607, 13798.655033623838, 11371.521702178663, 11759.176857619885, 11813.936745692929, 11839.99360054405, 11882.108841836724, 9133.725988220363, 9930.652427165303, 10374.792504149724, 10777.245592808427, 11227.045701115496, 11628.534858605899, 11751.236169648946, 11768.528933883264, 11852.762944740884, 12005.279683219034, 8367.916320836957, 8525.0, 8535.573221339033, 8749.868751968854, 8902.955485222532, 9724.805503889742, 11602.94198529002, 11608.593699220486, 11753.177277590486, 11884.881151188723], "value": 10257.04122450929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.587623712886, 1416.1007760072357, 1432.8853691704664, 1438.4102517967629, 1451.0278113663842, 11272.0, 11554.653360399181, 11684.824727629093, 11825.408729563509, 11854.525818967242, 11551.768964620724, 11602.941985290083, 11732.941335293312, 11736.53053877846, 11737.589184378548, 2147.377260594426, 2444.217850287904, 2497.4880149569294, 2499.5000999800113, 2499.7500249975037, 2477.2072936660275, 2525.393905462694, 2527.936801579957, 2528.84826910386, 2534.4804315115357, 2445.193086281523, 2465.926022219336, 2488.664030355897, 2496.2885577610386, 2501.8874150663173, 2444.4377793107506, 2461.433870209844, 2479.4049428137296, 2487.7139129000216, 2502.587073132931, 2128.8403369747175, 2305.054927479742, 2388.8088952883727, 2477.0834791127218, 2497.5754121799337, 9795.951020244924, 11895.04839612829, 11970.461329240205, 12012.579559715368, 12030.4586293617, 6604.966975165142, 6842.281560436182, 6856.211535673362, 6861.725530978805, 6865.622390768505, 4035.435039094529, 4347.869563913087, 4401.2517871961845, 4419.977900110511, 4438.622717069053, 1210.7941649919446, 1274.1654216488214, 1292.4377895615437, 1327.6548097494624, 1335.5926442435054, 16034.839651603568, 16646.75029874553, 16662.250198741087, 16758.83241167585, 16816.411425600167, 4700.600448961808, 5481.75332110056, 5583.134614134816, 5655.802046928337, 5762.30852297727, 11638.0, 11698.06415486759, 11719.003884669899, 11726.179167458196, 11738.413079345999, 6517.087607734921, 6536.542442029012, 6536.542442029012, 6551.082848401227, 6562.278149403562, 5959.553033522503, 6131.14164017038, 6238.1266622672865, 6257.155284036688, 6258.468030217483, 4257.808398622069, 4363.672724545671, 4390.692651514363, 4395.428594282723, 4407.493138289074, 1261.8927391171853, 1269.9365031748375, 1277.7316763479587, 1279.8720127987126, 1295.33290355467, 750.6659536506203, 805.295366554265, 830.1076342931373, 840.970566030186, 863.7149740585592, 6197.783077592263, 6916.896246556305, 7018.473614478935, 7040.718371265092, 7074.434045276365, 459.76092431935206, 475.4603524999151, 526.1318823940529, 612.4946918792015, 958.4201558057275, 3804.923901521954, 3855.8264878080554, 3857.8812144478347, 3986.9601303986587, 4473.306637471197, 12080.395980200954, 14514.927425363017, 14802.963792534634, 15006.624834379229, 15014.699706005818, 14795.408183672533, 14932.40270389194, 14938.626534336729, 14942.62643433901, 15022.023568468014, 8266.0, 8381.203785640477, 8478.23695867375, 8584.141585841491, 8704.782380440412, 7032.261612530815, 7053.506254562131, 7246.855062898818, 7351.081114860643, 7368.521046131984, 12367.381630918599, 12596.685082872635, 13262.27057511846, 13354.799678005033, 13667.863321367056, 13668.863311366758, 13906.58280251594, 14002.929985350009, 14045.174127363378, 14094.577162685136, 9218.539073046455, 9397.953010235178, 9437.811243775224, 9480.194183494481, 9504.714858554255, 10457.215708821717, 10615.0, 10727.624533141303, 10798.190135739695, 10839.67480975572, 8714.38999270045, 9131.13254240846, 9197.218236449977, 9220.124088211609, 9257.953710231675, 8372.497650141011, 8868.911310887066, 8946.776330591787, 8996.370254082152, 9013.414128081653, 8306.6677332906, 8341.916580834357, 8358.70744523963, 8446.577671116542, 8463.830723385621, 6162.501373996918, 6185.195924529782, 6196.442320191204, 6205.503559715122, 6212.378762123752, 6138.662373569497, 6183.443490085914, 6282.0, 6303.936960630518, 6348.523860710373], "value": 5335.126583598565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.21351723587316, 404.7976011994003, 405.3939360655819, 406.81008051449504, 418.2346306259547, 6351.6189028658255, 6356.552727200026, 6416.486681065509, 6436.645984470852, 6442.967785161073, 4713.858187214318, 6144.3855614438535, 6145.631262124276, 6200.658963756991, 6253.312135665074, 4177.958220417788, 4411.250087485119, 4517.531802164293, 4746.620270378378, 4762.809487620491, 3938.5076865391825, 4027.617376349242, 4522.186006518826, 4563.885902852422, 4573.050382503284, 3521.735869809762, 3711.1464363196483, 4282.850100246492, 4528.6377089832895, 4539.54604539545, 3353.6814002669707, 4515.525869783674, 4519.728816271001, 4540.387047748544, 4542.4776150742755, 3380.577427821522, 3859.0931131184147, 3886.630770076838, 3890.455336252927, 3892.8832135035996, 5250.820909322627, 5954.523638108984, 6113.694315284218, 6169.845753856144, 6181.887260293145, 4524.502304746476, 4796.904061918777, 5288.603354748371, 5399.271098401705, 5487.259220005288, 6677.565958212701, 6704.865902681968, 6715.731370745213, 6755.088063111466, 6760.256371799098, 4398.450193725785, 4422.933655995163, 4423.469183697976, 4444.377787109807, 4445.577670121365, 5870.530357571384, 6293.9370606293805, 6330.87338253237, 7041.225465198824, 7080.929190708079, 3975.8470043687585, 4492.887677808016, 4504.144212599595, 4531.524189960072, 4533.093381323749, 4043.8786836394956, 4574.702644328108, 4596.080783843245, 4597.39091318036, 4604.447466304065, 5269.5233240376965, 5371.811986580529, 5424.5660347172925, 5458.399576046631, 5471.699056551928, 5535.252740880011, 6673.666316684146, 6747.779875533132, 6769.559978601375, 6820.761273355508, 1549.7675348697785, 1555.8599726024713, 1556.5797234746556, 1561.6252099496267, 1562.1642421304548, 814.6497006287353, 866.9596484218963, 970.2335155227291, 1012.2711647613706, 1027.2295778166376, 6400.7119679614525, 6473.352664733489, 6495.285518592951, 6506.0, 6526.738930442729, 6034.668093254913, 6173.876522469615, 6853.059490792814, 6944.930550694529, 6965.895511567331, 5901.970490147608, 6397.977587593717, 6411.839704007344, 6425.132607098076, 6458.514541655446, 3570.2680950405106, 3621.927561448809, 3653.6529029742132, 3654.634536546377, 3677.9448308274864, 6912.343327383891, 7113.430925526049, 7220.169680486812, 7243.0, 7290.7083716651805, 6309.422644338915, 6855.937329713903, 6981.406580440618, 7146.892231704094, 7224.855502889913, 6154.169187159766, 7040.225575186725, 7158.928410715826, 7170.999999999895, 7236.204017558064, 5423.376311724044, 5883.852903677443, 6417.197850268716, 6959.164900212007, 7059.5764254144915, 5666.631668941505, 5691.943080569141, 6602.834929126618, 6867.519273650796, 6971.6165610891885, 6682.665866706742, 6775.322467753185, 7179.676914538963, 7201.739695553152, 7298.23368546295, 4404.317330813729, 4412.602865742098, 4468.419105516392, 4506.616937560344, 4515.909681806411, 5534.640248383842, 6502.544821862424, 6746.392824645805, 6939.097917270722, 7139.464540159613, 6765.458763299022, 6769.93230067693, 6774.4580433564215, 6791.422729067887, 6824.952514245806, 5210.791568337224, 5787.710614469175, 5995.940040599538, 6637.800865974028, 6856.41720453767, 5626.2685850839125, 6613.900791488035, 6690.665466726741, 6695.832604184934, 6715.656868626392, 5057.570106540838, 5707.800226992035, 6331.271903730945, 6594.505412094208, 6773.491988101011, 6297.716602752978, 6587.835304117244, 6633.469322454289, 6658.235567574499, 6684.732610695518], "value": 4809.855456831564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.2924355810444, 841.3017195727547, 856.4261944497187, 877.8237162202647, 878.1613559051104, 14515.274236288196, 15075.698486030273, 16478.835211647896, 16897.49307520775, 16905.661886762256, 12615.684607884807, 13404.932975335134, 17352.82647173528, 17746.0, 17757.02336371499, 816.897887764028, 1010.4240582867768, 1011.5650270383732, 1015.9992407478628, 1017.8371460566311, 947.0245646983618, 1009.8081364540714, 1013.807376598444, 1021.325924889573, 1022.8772547294335, 1076.9461526923662, 1078.094400703409, 1079.0827796373098, 1081.5133190064464, 1082.0477979378136, 1056.8203405421098, 1071.9088877445427, 1074.9032587067202, 1076.2304951959347, 1077.380506208929, 781.4178437064367, 790.9723159689383, 793.0998316910291, 793.670626689923, 800.2237829305623, 16682.58293542659, 17041.914790426094, 17164.0, 17172.22724977379, 17854.5536361592, 15570.688586228325, 16712.665746684997, 16825.326986920507, 16988.74516882248, 17657.470275891745, 14219.786703199461, 14267.0, 14269.072510286798, 14341.56975290743, 14488.20314882681, 3504.7371447141313, 3515.5254040704435, 3524.6827785499427, 3537.4693795930557, 3544.7518673692853, 121131.36605901924, 134723.32638336744, 137587.0, 140879.0, 140901.886471703, 13608.523701670394, 13987.300634968415, 14081.225532595805, 14202.644933876736, 14205.0, 21784.782152178275, 25541.698947842026, 25959.961601535728, 26157.607635885477, 26206.0, 8036.598170091472, 8064.435489515678, 8096.595170241464, 8104.554249516215, 8113.310368618615, 3798.5441746990537, 3802.6007269236334, 3838.3858582626644, 3853.807309634507, 3879.922401551953, 4372.584604462571, 4453.1761624099645, 4465.687401881902, 4474.731516109044, 4480.887977800516, 943.8820147481565, 967.4533888353058, 979.0356498848629, 983.331334692416, 999.2855108597242, 571.8106338815254, 665.1519312876121, 674.6019848289533, 677.140032159165, 695.9443244540424, 9057.501837398875, 10333.534990925276, 10896.61861834832, 11464.082873370111, 12660.936695316648, 527.5568522441091, 585.0, 658.9062156819656, 661.5865084322298, 696.2237105627189, 5534.422689533544, 5540.806071787549, 5727.427257274239, 5747.339056008529, 5847.035239185487, 115360.42319788347, 116110.0, 116634.0, 116682.41658791821, 117466.0, 101836.0, 102281.0, 105431.0, 105753.0, 106100.0, 65081.69836603241, 77022.84465733019, 82518.0, 82756.0, 83709.58145209234, 12099.455524501242, 12689.4289756963, 12719.364031798557, 12719.491220351452, 12788.552400665933, 33914.830425847715, 33966.49050264199, 38835.0, 41542.58457415387, 41638.791806040776, 53081.46918530765, 53239.6690082751, 54246.0, 54494.45505544894, 54504.0, 15711.842881571038, 15986.760198596798, 16118.597035074217, 16251.837481625033, 16256.756148658016, 17710.734338985185, 17956.461306160836, 18030.5492362692, 18083.638327233646, 18209.635807284045, 15186.924065379602, 15929.123898185711, 16186.433474828324, 17005.979641221566, 17032.23354949055, 16346.591335216715, 16747.832521675115, 17519.912400437915, 17793.555161121076, 17817.287308507515, 16122.838771612604, 16377.263023164225, 16647.66704665924, 16901.91549042247, 17170.914145429193, 10401.219908507044, 11784.58753943608, 12048.156629035884, 12180.634580962585, 12245.510179592717, 13178.934105329412, 13218.537351192663, 13303.46786128544, 13358.465661373437, 13488.190708557519], "value": 8454.109228765134, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 113.0, 114.0, 113.0, 113.0, 122.0, 112.0, 116.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 110.0, 150.0, 112.0, 139.0, 104.0, 147.0, 167.0, 148.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 203.0, 198.0, 205.0, 208.0, 219.0, 231.0, 196.0, 199.0, 201.0], "value": 206.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 74.0, 111.0, 83.0, 82.0, 58.0, 58.0, 75.0, 57.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 73.0, 84.0, 70.0, 75.0, 108.0, 111.0, 80.0, 68.0, 91.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 108.0, 137.0, 83.0, 127.0, 136.0, 86.0, 128.0, 81.0], "value": 106.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 156.0, 99.0, 110.0, 153.0, 96.0, 123.0, 109.0, 154.0, 132.0], "value": 123.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 88.0, 90.0, 90.0, 92.0, 90.0, 91.0, 91.0], "value": 90.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 54.0, 53.0, 69.0, 46.0, 66.0, 60.0, 76.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 67.0, 55.0, 72.0, 62.0, 59.0, 53.0, 58.0, 55.0, 54.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 81.0, 82.0, 81.0, 83.0, 81.0, 82.0, 84.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 167.0, 131.0, 135.0, 139.0, 142.0, 167.0, 152.0, 197.0, 154.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 179.0, 188.0, 183.0, 186.0, 184.0, 217.0, 185.0, 184.0], "value": 187.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 65.0, 69.0, 66.0, 83.0, 87.0, 92.0, 96.0, 90.0], "value": 78.8, "unit": "score"}]}]} 10:23:36 INFO - Return code: 0 10:23:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:23:36 INFO - # TBPL SUCCESS # 10:23:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:23:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:23:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:23:36 INFO - 2017-05-04 10:23:36.481 screenresolution[1666:11571] starting screenresolution argv=screenresolution get 10:23:36 INFO - 2017-05-04 10:23:36.484 screenresolution[1666:11571] Display 0: 1600x1200x32@60 10:23:36 INFO - 2017-05-04 10:23:36.490 screenresolution[1667:11574] starting screenresolution argv=screenresolution list 10:23:36 INFO - Available Modes on Display 0 10:23:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:23:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:23:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:23:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:23:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:23:36 INFO - Intel Iris: 10:23:36 INFO - Chipset Model: Intel Iris 10:23:36 INFO - Type: GPU 10:23:36 INFO - Bus: Built-In 10:23:36 INFO - VRAM (Dynamic, Max): 1536 MB 10:23:36 INFO - Vendor: Intel (0x8086) 10:23:36 INFO - Device ID: 0x0a2e 10:23:36 INFO - Revision ID: 0x0009 10:23:36 INFO - Displays: 10:23:36 INFO - Display: 10:23:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:23:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:23:36 INFO - Display Serial Number: 1600x1200 60 10:23:36 INFO - Main Display: Yes 10:23:36 INFO - Mirror: Off 10:23:36 INFO - Online: Yes 10:23:36 INFO - Rotation: Supported 10:23:36 INFO - Return code: 0 10:23:36 INFO - Running post-action listener: _resource_record_post_action 10:23:36 INFO - [mozharness: 2017-05-04 17:23:36.724134Z] Finished run-tests step (success) 10:23:36 INFO - Running post-run listener: _resource_record_post_run 10:23:36 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 38267904; Write bytes: 513342464; Read time: 263; Write time: 1604 10:23:36 INFO - TinderboxPrint: CPU usage
54.3% 10:23:36 INFO - TinderboxPrint: I/O read bytes / time
38,267,904 / 263 10:23:36 INFO - TinderboxPrint: I/O write bytes / time
513,342,464 / 1,604 10:23:36 INFO - TinderboxPrint: CPU idle
2,191.1 (45.7%) 10:23:36 INFO - TinderboxPrint: CPU system
967.3 (20.2%) 10:23:36 INFO - TinderboxPrint: CPU user
1,635.3 (34.1%) 10:23:36 INFO - TinderboxPrint: Swap in / out
246,784,000 / 0 10:23:36 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209433088; Write bytes: 209195008; Read time: 16464; Write time: 453 10:23:36 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35175424; Write bytes: 302812160; Read time: 241; Write time: 1144 10:23:37 INFO - Running post-run listener: _upload_blobber_files 10:23:37 INFO - Blob upload gear active. 10:23:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:37 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 10:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:23:37 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:23:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:23:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:38 INFO - (blobuploader) - INFO - Done attempting. 10:23:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:23:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:23:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:39 INFO - (blobuploader) - INFO - Done attempting. 10:23:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:23:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:23:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:40 INFO - (blobuploader) - INFO - Done attempting. 10:23:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:23:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:42 INFO - (blobuploader) - INFO - Done attempting. 10:23:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:42 INFO - Return code: 0 10:23:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a3234a225613e513bbe854d531c3d5e44304d30d33993f5bbae45756f61f81b15ec5c46cfcb303f444adcc59fe418ffbe19058129d2440c92b07593c08db95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7530847244991d1f90c4275ff841344b809144ba9a6102779e86b731780f3f112d966b372a066dcf2dcc07d75039e0ce3a82ee18aaef54fb60ee686532d980a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee94c11f22f33e1101ea9ea207580639681d2b9458b3d22e6d8547461d5c5b27f41add33154cbfde4e4782d689dac270225b72f9808ea74faaa977e8141671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bab5f2bb6bbfc6d1821251feb4399f48eafc46e6c50e11251a9c3efb6e7858cf1bc957ab50ce572a3e3fe3b63815071dccc5225b32d3c5f3b20460abf81e39"} 10:23:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:42 INFO - Contents: 10:23:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a3234a225613e513bbe854d531c3d5e44304d30d33993f5bbae45756f61f81b15ec5c46cfcb303f444adcc59fe418ffbe19058129d2440c92b07593c08db95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7530847244991d1f90c4275ff841344b809144ba9a6102779e86b731780f3f112d966b372a066dcf2dcc07d75039e0ce3a82ee18aaef54fb60ee686532d980a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee94c11f22f33e1101ea9ea207580639681d2b9458b3d22e6d8547461d5c5b27f41add33154cbfde4e4782d689dac270225b72f9808ea74faaa977e8141671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bab5f2bb6bbfc6d1821251feb4399f48eafc46e6c50e11251a9c3efb6e7858cf1bc957ab50ce572a3e3fe3b63815071dccc5225b32d3c5f3b20460abf81e39"} 10:23:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:42 INFO - Copying logs to upload dir... 10:23:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.722011 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-04 10:23:42.662763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:23:42.666084) ========= 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.FkbXL1Q7VF/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.fp7II4cf42/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a3234a225613e513bbe854d531c3d5e44304d30d33993f5bbae45756f61f81b15ec5c46cfcb303f444adcc59fe418ffbe19058129d2440c92b07593c08db95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7530847244991d1f90c4275ff841344b809144ba9a6102779e86b731780f3f112d966b372a066dcf2dcc07d75039e0ce3a82ee18aaef54fb60ee686532d980a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee94c11f22f33e1101ea9ea207580639681d2b9458b3d22e6d8547461d5c5b27f41add33154cbfde4e4782d689dac270225b72f9808ea74faaa977e8141671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bab5f2bb6bbfc6d1821251feb4399f48eafc46e6c50e11251a9c3efb6e7858cf1bc957ab50ce572a3e3fe3b63815071dccc5225b32d3c5f3b20460abf81e39"} build_url:https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010868 build_url: 'https://queue.taskcluster.net/v1/task/fR8A5dNBT7GsAdOr-m6OOQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a3234a225613e513bbe854d531c3d5e44304d30d33993f5bbae45756f61f81b15ec5c46cfcb303f444adcc59fe418ffbe19058129d2440c92b07593c08db95", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7530847244991d1f90c4275ff841344b809144ba9a6102779e86b731780f3f112d966b372a066dcf2dcc07d75039e0ce3a82ee18aaef54fb60ee686532d980a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5ee94c11f22f33e1101ea9ea207580639681d2b9458b3d22e6d8547461d5c5b27f41add33154cbfde4e4782d689dac270225b72f9808ea74faaa977e8141671", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bab5f2bb6bbfc6d1821251feb4399f48eafc46e6c50e11251a9c3efb6e7858cf1bc957ab50ce572a3e3fe3b63815071dccc5225b32d3c5f3b20460abf81e39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:23:42.701933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:23:42.702258) ========= 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.FkbXL1Q7VF/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.fp7II4cf42/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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.004962 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:23:42.751306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:23:42.751631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:23:42.751966) ========= ========= Total master_lag: 0.19 =========