builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0148 starttime: 1493371526.25 results: success (0) buildid: 20170428004016 builduid: 9fd367b211e143de867661eb6ca5cf78 revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.248374) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.248810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.249087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.274843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.275215) ========= 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.axtAbcfLym/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.nZNyoRmPrl/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-28 02:25: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% 8.18M=0.001s 2017-04-28 02:25:26 (8.18 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133489 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.434761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.435153) ========= 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.axtAbcfLym/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.nZNyoRmPrl/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.020598 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:26.483629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-28 02:25:26.483988) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.axtAbcfLym/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.nZNyoRmPrl/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-28 02:25:26,567 truncating revision to first 12 chars 2017-04-28 02:25:26,567 Setting DEBUG logging. 2017-04-28 02:25:26,567 attempt 1/10 2017-04-28 02:25:26,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 02:25:28,526 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.203565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-28 02:25:28.712016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:28.712339) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:28.712758) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:28.713027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 02:25:28.733500) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-28 02:25:28.733883) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.axtAbcfLym/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.nZNyoRmPrl/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:25:28 INFO - MultiFileLogger online at 20170428 02:25:28 in /builds/slave/test 02:25:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:25:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:28 INFO - {'append_to_log': False, 02:25:28 INFO - 'base_work_dir': '/builds/slave/test', 02:25:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:25:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:28 INFO - 'branch': 'Mozilla-Aurora', 02:25:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:28 INFO - 'config_files': ('talos/mac_config.py',), 02:25:28 INFO - 'default_actions': ('clobber', 02:25:28 INFO - 'read-buildbot-config', 02:25:28 INFO - 'download-and-extract', 02:25:28 INFO - 'populate-webroot', 02:25:28 INFO - 'create-virtualenv', 02:25:28 INFO - 'install', 02:25:28 INFO - 'run-tests'), 02:25:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:28 INFO - 'download_minidump_stackwalk': True, 02:25:28 INFO - 'download_symbols': 'ondemand', 02:25:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:28 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:28 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:28 INFO - 'gecko_profile': False, 02:25:28 INFO - 'gecko_profile_interval': 0, 02:25:28 INFO - 'installer_path': 'installer.exe', 02:25:28 INFO - 'log_level': 'info', 02:25:28 INFO - 'log_name': 'talos', 02:25:28 INFO - 'log_to_console': True, 02:25:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:25:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:25:28 INFO - 'opt_config_files': (), 02:25:28 INFO - 'pip_index': False, 02:25:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:28 INFO - 'cmd': ('bash', 02:25:28 INFO - '-c', 02:25:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:28 INFO - 'enabled': True, 02:25:28 INFO - 'halt_on_failure': False, 02:25:28 INFO - 'name': 'check_screen_resolution'},), 02:25:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:28 INFO - 'cmd': ('bash', 02:25:28 INFO - '-c', 02:25:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:28 INFO - 'enabled': True, 02:25:28 INFO - 'halt_on_failure': False, 02:25:28 INFO - 'name': 'check_screen_resolution'},), 02:25:28 INFO - 'run_cmd_checks_enabled': True, 02:25:28 INFO - 'suite': 'dromaeojs-e10s', 02:25:28 INFO - 'system_bits': '32', 02:25:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:28 INFO - 'title': 't-yosemite-r7-0148', 02:25:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:28 INFO - 'use_talos_json': True, 02:25:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:28 INFO - 'work_dir': 'build'} 02:25:28 INFO - [mozharness: 2017-04-28 09:25:28.941674Z] Running clobber step. 02:25:28 INFO - Running pre-action listener: _resource_record_pre_action 02:25:28 INFO - Running main action method: clobber 02:25:28 INFO - rmtree: /builds/slave/test/build 02:25:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:29 INFO - Running post-action listener: _resource_record_post_action 02:25:29 INFO - [mozharness: 2017-04-28 09:25:29.596567Z] Finished clobber step (success) 02:25:29 INFO - [mozharness: 2017-04-28 09:25:29.596732Z] Running read-buildbot-config step. 02:25:29 INFO - Running pre-action listener: _resource_record_pre_action 02:25:29 INFO - Running main action method: read_buildbot_config 02:25:29 INFO - Using buildbot properties: 02:25:29 INFO - { 02:25:29 INFO - "project": "", 02:25:29 INFO - "product": "firefox", 02:25:29 INFO - "script_repo_revision": "production", 02:25:29 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:25:29 INFO - "repository": "", 02:25:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:25:29 INFO - "buildid": "20170428004016", 02:25:29 INFO - "stage_platform": "macosx64", 02:25:29 INFO - "basedir": "/builds/slave/test", 02:25:29 INFO - "nightly_build": "True", 02:25:29 INFO - "buildnumber": 21, 02:25:29 INFO - "slavename": "t-yosemite-r7-0148", 02:25:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:25:29 INFO - "platform": "yosemite_r7", 02:25:29 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:25:29 INFO - "branch": "mozilla-aurora", 02:25:29 INFO - "repo_path": "releases/mozilla-aurora", 02:25:29 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 02:25:29 INFO - "pgo_build": "False", 02:25:29 INFO - "builduid": "9fd367b211e143de867661eb6ca5cf78", 02:25:29 INFO - "slavebuilddir": "test" 02:25:29 INFO - } 02:25:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:25:29 INFO - Running post-action listener: _resource_record_post_action 02:25:29 INFO - [mozharness: 2017-04-28 09:25:29.599922Z] Finished read-buildbot-config step (success) 02:25:29 INFO - [mozharness: 2017-04-28 09:25:29.600052Z] Running download-and-extract step. 02:25:29 INFO - Running pre-action listener: _resource_record_pre_action 02:25:29 INFO - Running main action method: download_and_extract 02:25:29 INFO - mkdir: /builds/slave/test/build/tests 02:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:29 INFO - trying https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:25:31 INFO - Downloaded 1199 bytes. 02:25:31 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:31 INFO - Using the following test package requirements: 02:25:31 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:25:31 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:25:31 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:25:31 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'jsshell-mac.zip'], 02:25:31 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:25:31 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:25:31 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:25:31 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:25:31 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:25:31 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:31 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:25:31 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:25:32 INFO - Expected file size: 51791990 02:25:32 INFO - Obtained file size: 51791990 02:25:48 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:25:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:25:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:48 INFO - Fetch https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:25:50 INFO - Expected file size: 51791990 02:25:50 INFO - Obtained file size: 51791990 02:26:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:26:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:26:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:26:05 INFO - Expected file size: 14404424 02:26:05 INFO - Obtained file size: 14404424 02:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:06 INFO - trying https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:26:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:26:08 INFO - Downloaded 74780131 bytes. 02:26:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:26:08 INFO - mkdir: /builds/slave/test/properties 02:26:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:08 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:08 INFO - Contents: 02:26:08 INFO - build_url:https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:26:08 INFO - Running post-action listener: _resource_record_post_action 02:26:08 INFO - Running post-action listener: set_extra_try_arguments 02:26:08 INFO - [mozharness: 2017-04-28 09:26:08.991335Z] Finished download-and-extract step (success) 02:26:08 INFO - [mozharness: 2017-04-28 09:26:08.991457Z] Running populate-webroot step. 02:26:08 INFO - Running pre-action listener: _resource_record_pre_action 02:26:08 INFO - Running main action method: populate_webroot 02:26:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:09 INFO - '--tppagecycles', 02:26:09 INFO - '7'], 02:26:09 INFO - 'tests': ['tsvgm']}}, 02:26:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['damp', 'tps']}, 02:26:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'tests': ['damp', 'tps']}, 02:26:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['dromaeo_dom']}, 02:26:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['basic_compositor_video']}, 02:26:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:26:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['a11yr', 02:26:09 INFO - 'ts_paint', 02:26:09 INFO - 'tpaint', 02:26:09 INFO - 'sessionrestore', 02:26:09 INFO - 'sessionrestore_no_auto_restore', 02:26:09 INFO - 'tabpaint']}, 02:26:09 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:09 INFO - 'ts_paint', 02:26:09 INFO - 'tpaint', 02:26:09 INFO - 'sessionrestore', 02:26:09 INFO - 'sessionrestore_no_auto_restore', 02:26:09 INFO - 'tabpaint']}, 02:26:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:09 INFO - 'ts_paint', 02:26:09 INFO - 'tpaint', 02:26:09 INFO - 'sessionrestore', 02:26:09 INFO - 'sessionrestore_no_auto_restore', 02:26:09 INFO - 'tabpaint']}, 02:26:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:09 INFO - 'ts_paint', 02:26:09 INFO - 'tpaint', 02:26:09 INFO - 'sessionrestore', 02:26:09 INFO - 'sessionrestore_no_auto_restore', 02:26:09 INFO - 'tabpaint']}, 02:26:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['a11yr', 02:26:09 INFO - 'ts_paint', 02:26:09 INFO - 'tpaint', 02:26:09 INFO - 'sessionrestore', 02:26:09 INFO - 'sessionrestore_no_auto_restore', 02:26:09 INFO - 'tabpaint']}, 02:26:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['a11yr', 02:26:09 INFO - 'ts_paint', 02:26:09 INFO - 'tpaint', 02:26:09 INFO - 'sessionrestore', 02:26:09 INFO - 'sessionrestore_no_auto_restore', 02:26:09 INFO - 'tabpaint']}, 02:26:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['tsvgx', 02:26:09 INFO - 'tsvgr_opacity', 02:26:09 INFO - 'tart', 02:26:09 INFO - 'tscrollx', 02:26:09 INFO - 'cart', 02:26:09 INFO - 'tsvg_static']}, 02:26:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:09 INFO - 'tsvgr_opacity', 02:26:09 INFO - 'tart', 02:26:09 INFO - 'tscrollx', 02:26:09 INFO - 'cart', 02:26:09 INFO - 'tsvg_static']}, 02:26:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'talos_options': ['--disable-e10s'], 02:26:09 INFO - 'tests': ['tp5o']}, 02:26:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:26:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'talos_options': ['--disable-e10s', 02:26:09 INFO - '--xperf_path', 02:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:09 INFO - 'tests': ['tp5n']}, 02:26:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:26:09 INFO - 'talos_options': ['--xperf_path', 02:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:09 INFO - 'tests': ['tp5n']}}, 02:26:09 INFO - 'talos.zip': {'path': '', 02:26:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:09 INFO - Running post-action listener: _resource_record_post_action 02:26:09 INFO - [mozharness: 2017-04-28 09:26:09.009736Z] Finished populate-webroot step (success) 02:26:09 INFO - [mozharness: 2017-04-28 09:26:09.009873Z] Running create-virtualenv step. 02:26:09 INFO - Running pre-action listener: _resource_record_pre_action 02:26:09 INFO - Running main action method: create_virtualenv 02:26:09 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:09 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 02:26:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:09 INFO - Using real prefix '/tools/python27' 02:26:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:12 INFO - Installing pip.................done. 02:26:12 INFO - Return code: 0 02:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:26:12 INFO - Reading from file tmpfile_stdout 02:26:12 INFO - Output received: 02:26:12 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) 02:26:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:12 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')]} 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 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')]} 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:12 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 02:26:12 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 02:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:12 INFO - 'HOME': '/Users/cltbld', 02:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:12 INFO - 'LOGNAME': 'cltbld', 02:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:12 INFO - 'MOZ_NO_REMOTE': '1', 02:26:12 INFO - 'NO_EM_RESTART': '1', 02:26:12 INFO - 'PAGER': '/bin/cat', 02:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:12 INFO - 'PWD': '/builds/slave/test', 02:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:12 INFO - 'SHELL': '/bin/bash', 02:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:12 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:12 INFO - 'USER': 'cltbld', 02:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:12 INFO - 'XPC_FLAGS': '0x0', 02:26:12 INFO - 'XPC_SERVICE_NAME': '0', 02:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:13 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 02:26:13 INFO - Cleaning up... 02:26:13 INFO - Return code: 0 02:26:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:13 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:13 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 02:26:13 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 02:26:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:13 INFO - 'HOME': '/Users/cltbld', 02:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:13 INFO - 'LOGNAME': 'cltbld', 02:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:13 INFO - 'MOZ_NO_REMOTE': '1', 02:26:13 INFO - 'NO_EM_RESTART': '1', 02:26:13 INFO - 'PAGER': '/bin/cat', 02:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:13 INFO - 'PWD': '/builds/slave/test', 02:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:13 INFO - 'SHELL': '/bin/bash', 02:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:13 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:13 INFO - 'USER': 'cltbld', 02:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:13 INFO - 'XPC_FLAGS': '0x0', 02:26:13 INFO - 'XPC_SERVICE_NAME': '0', 02:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:13 INFO - Downloading/unpacking psutil>=3.1.1 02:26:13 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 02:26:13 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 02:26:13 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 02:26:13 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 02:26:13 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 02:26:13 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 02:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:17 INFO - Installing collected packages: psutil 02:26:17 INFO - Running setup.py install for psutil 02:26:17 INFO - building 'psutil._psutil_osx' extension 02:26:17 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 02:26:17 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 02:26:17 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 02:26:17 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 02:26:17 INFO - building 'psutil._psutil_posix' extension 02:26:17 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 02:26:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:26:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:26:17 INFO - ^ 02:26:17 INFO - 1 warning generated. 02:26:17 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 02:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:17 INFO - Successfully installed psutil 02:26:17 INFO - Cleaning up... 02:26:17 INFO - Return code: 0 02:26:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:17 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')]} 02:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:17 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')]} 02:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:17 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:17 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 02:26:17 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 02:26:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:17 INFO - 'HOME': '/Users/cltbld', 02:26:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:17 INFO - 'LOGNAME': 'cltbld', 02:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:17 INFO - 'MOZ_NO_REMOTE': '1', 02:26:17 INFO - 'NO_EM_RESTART': '1', 02:26:17 INFO - 'PAGER': '/bin/cat', 02:26:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:17 INFO - 'PWD': '/builds/slave/test', 02:26:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:17 INFO - 'SHELL': '/bin/bash', 02:26:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:17 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:17 INFO - 'USER': 'cltbld', 02:26:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:17 INFO - 'XPC_FLAGS': '0x0', 02:26:17 INFO - 'XPC_SERVICE_NAME': '0', 02:26:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:20 INFO - Installing collected packages: mozsystemmonitor 02:26:20 INFO - Running setup.py install for mozsystemmonitor 02:26:21 INFO - Successfully installed mozsystemmonitor 02:26:21 INFO - Cleaning up... 02:26:21 INFO - Return code: 0 02:26:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:21 INFO - 'HOME': '/Users/cltbld', 02:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:21 INFO - 'LOGNAME': 'cltbld', 02:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:21 INFO - 'MOZ_NO_REMOTE': '1', 02:26:21 INFO - 'NO_EM_RESTART': '1', 02:26:21 INFO - 'PAGER': '/bin/cat', 02:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:21 INFO - 'PWD': '/builds/slave/test', 02:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:21 INFO - 'SHELL': '/bin/bash', 02:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:21 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:21 INFO - 'USER': 'cltbld', 02:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:21 INFO - 'XPC_FLAGS': '0x0', 02:26:21 INFO - 'XPC_SERVICE_NAME': '0', 02:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:21 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:21 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 02:26:21 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 02:26:21 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 02:26:21 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 02:26:21 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 02:26:21 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 02:26:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26: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 02:26: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 02:26: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 02:26: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 02:26: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 02:26: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 02:26:24 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:24 INFO - warning: no files found matching '*.txt' 02:26:24 INFO - no previously-included directories found matching 'build' 02:26:24 INFO - no previously-included directories found matching 'dist' 02:26:24 INFO - no previously-included directories found matching '.git*' 02:26:24 INFO - Installing collected packages: jsonschema, functools32 02:26:24 INFO - Running setup.py install for functools32 02:26:24 INFO - warning: no files found matching '*.txt' 02:26:24 INFO - no previously-included directories found matching 'build' 02:26:24 INFO - no previously-included directories found matching 'dist' 02:26:24 INFO - no previously-included directories found matching '.git*' 02:26:24 INFO - Successfully installed jsonschema functools32 02:26:24 INFO - Cleaning up... 02:26:24 INFO - Return code: 0 02:26:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:25 INFO - 'HOME': '/Users/cltbld', 02:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:25 INFO - 'LOGNAME': 'cltbld', 02:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:25 INFO - 'MOZ_NO_REMOTE': '1', 02:26:25 INFO - 'NO_EM_RESTART': '1', 02:26:25 INFO - 'PAGER': '/bin/cat', 02:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:25 INFO - 'PWD': '/builds/slave/test', 02:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:25 INFO - 'SHELL': '/bin/bash', 02:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:25 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:25 INFO - 'USER': 'cltbld', 02:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:25 INFO - 'XPC_FLAGS': '0x0', 02:26:25 INFO - 'XPC_SERVICE_NAME': '0', 02:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:26:25 INFO - Cleaning up... 02:26:25 INFO - Return code: 0 02:26:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:26 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:26 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 02:26:26 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 02:26:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:26 INFO - 'HOME': '/Users/cltbld', 02:26:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:26 INFO - 'LOGNAME': 'cltbld', 02:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:26 INFO - 'MOZ_NO_REMOTE': '1', 02:26:26 INFO - 'NO_EM_RESTART': '1', 02:26:26 INFO - 'PAGER': '/bin/cat', 02:26:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:26 INFO - 'PWD': '/builds/slave/test', 02:26:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:26 INFO - 'SHELL': '/bin/bash', 02:26:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:26 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:26 INFO - 'USER': 'cltbld', 02:26:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:26 INFO - 'XPC_FLAGS': '0x0', 02:26:26 INFO - 'XPC_SERVICE_NAME': '0', 02:26:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:26: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 02:26: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 02:26: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 02:26: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 02:26: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 02:26: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 02:26:29 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:30 INFO - Downloading docopt-0.6.1.tar.gz 02:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:31 INFO - Running setup.py install for blobuploader 02:26:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:31 INFO - Running setup.py install for requests 02:26:31 INFO - Running setup.py install for docopt 02:26:31 INFO - Successfully installed blobuploader requests docopt 02:26:31 INFO - Cleaning up... 02:26:31 INFO - Return code: 0 02:26:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:31 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:31 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 02:26:31 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 02:26:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:31 INFO - 'HOME': '/Users/cltbld', 02:26:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:31 INFO - 'LOGNAME': 'cltbld', 02:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:31 INFO - 'MOZ_NO_REMOTE': '1', 02:26:31 INFO - 'NO_EM_RESTART': '1', 02:26:31 INFO - 'PAGER': '/bin/cat', 02:26:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:31 INFO - 'PWD': '/builds/slave/test', 02:26:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:31 INFO - 'SHELL': '/bin/bash', 02:26:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:31 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:31 INFO - 'USER': 'cltbld', 02:26:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:31 INFO - 'XPC_FLAGS': '0x0', 02:26:31 INFO - 'XPC_SERVICE_NAME': '0', 02:26:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gf2_q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-avTM6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-lzz6e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-TeHMXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ZwF59s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-GDpTNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Jk5w5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-nibgzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:32 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-FGkvpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Sff_Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-QUysmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-vcxDXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-f_80Tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-e9x9fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-BPIO_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-YXQ1e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:33 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-11PGoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:33 INFO - Running setup.py install for manifestparser 02:26:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:34 INFO - Running setup.py install for mozcrash 02:26:34 INFO - Running setup.py install for mozdebug 02:26:34 INFO - Running setup.py install for mozdevice 02:26:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:34 INFO - Running setup.py install for mozfile 02:26:34 INFO - Running setup.py install for mozhttpd 02:26:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:34 INFO - Running setup.py install for mozinfo 02:26:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:34 INFO - Running setup.py install for mozInstall 02:26:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozleak 02:26:35 INFO - Running setup.py install for mozlog 02:26:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for moznetwork 02:26:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozprocess 02:26:35 INFO - Running setup.py install for mozprofile 02:26:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:35 INFO - Running setup.py install for mozrunner 02:26:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Running setup.py install for mozscreenshot 02:26:36 INFO - Running setup.py install for moztest 02:26:36 INFO - Running setup.py install for mozversion 02:26:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:36 INFO - Cleaning up... 02:26:36 INFO - Return code: 0 02:26:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:36 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:36 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 02:26:36 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 02:26:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:36 INFO - 'HOME': '/Users/cltbld', 02:26:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:36 INFO - 'LOGNAME': 'cltbld', 02:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:36 INFO - 'MOZ_NO_REMOTE': '1', 02:26:36 INFO - 'NO_EM_RESTART': '1', 02:26:36 INFO - 'PAGER': '/bin/cat', 02:26:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:36 INFO - 'PWD': '/builds/slave/test', 02:26:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:36 INFO - 'SHELL': '/bin/bash', 02:26:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:36 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:36 INFO - 'USER': 'cltbld', 02:26:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:36 INFO - 'XPC_FLAGS': '0x0', 02:26:36 INFO - 'XPC_SERVICE_NAME': '0', 02:26:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-6iJA3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:36 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)) 02:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-2vfG3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-y7che7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-yAQxVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-4wBUKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-y77mMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-KRqxcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-8gVKP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-QnVMRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-2R_leQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-KWdjER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:37 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)) 02:26:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:37 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Mw1MS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:38 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-3Oxwom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:38 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-bSTtsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:38 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-SbT6SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:38 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-_TaBLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:38 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)) 02:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:38 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-QYdqf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:38 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)) 02:26:38 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)) 02:26:38 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)) 02:26:38 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)) 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:26:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:41 INFO - Downloading blessings-1.6.tar.gz 02:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:41 INFO - Installing collected packages: blessings 02:26:41 INFO - Running setup.py install for blessings 02:26:41 INFO - Successfully installed blessings 02:26:41 INFO - Cleaning up... 02:26:41 INFO - Return code: 0 02:26:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:41 INFO - Reading from file tmpfile_stdout 02:26:41 INFO - Current package versions: 02:26:41 INFO - blessings == 1.6 02:26:41 INFO - blobuploader == 1.2.4 02:26:41 INFO - docopt == 0.6.1 02:26:41 INFO - functools32 == 3.2.3-2 02:26:41 INFO - jsonschema == 2.5.1 02:26:41 INFO - manifestparser == 1.1 02:26:41 INFO - mozInstall == 1.12 02:26:41 INFO - mozcrash == 1.0 02:26:41 INFO - mozdebug == 0.1 02:26:41 INFO - mozdevice == 0.49 02:26:41 INFO - mozfile == 1.2 02:26:41 INFO - mozhttpd == 0.7 02:26:41 INFO - mozinfo == 0.9 02:26:41 INFO - mozleak == 0.1 02:26:41 INFO - mozlog == 3.4 02:26:41 INFO - moznetwork == 0.27 02:26:41 INFO - mozprocess == 0.25 02:26:41 INFO - mozprofile == 0.28 02:26:41 INFO - mozrunner == 6.13 02:26:41 INFO - mozscreenshot == 0.1 02:26:41 INFO - mozsystemmonitor == 0.3 02:26:41 INFO - moztest == 0.8 02:26:41 INFO - mozversion == 1.4 02:26:41 INFO - psutil == 3.1.1 02:26:41 INFO - requests == 1.2.3 02:26:41 INFO - wsgiref == 0.1.2 02:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:41 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:41 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 02:26:41 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 02:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:41 INFO - 'HOME': '/Users/cltbld', 02:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:41 INFO - 'LOGNAME': 'cltbld', 02:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:41 INFO - 'MOZ_NO_REMOTE': '1', 02:26:41 INFO - 'NO_EM_RESTART': '1', 02:26:41 INFO - 'PAGER': '/bin/cat', 02:26:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:41 INFO - 'PWD': '/builds/slave/test', 02:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:41 INFO - 'SHELL': '/bin/bash', 02:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:41 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:41 INFO - 'USER': 'cltbld', 02:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:41 INFO - 'XPC_FLAGS': '0x0', 02:26:41 INFO - 'XPC_SERVICE_NAME': '0', 02:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 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)) 02:26:42 INFO - Cleaning up... 02:26:42 INFO - Return code: 0 02:26:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:42 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 0x10e984b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e987768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbea5d8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, '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.axtAbcfLym/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.nZNyoRmPrl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 02:26:42 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 02:26:42 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 02:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:42 INFO - 'HOME': '/Users/cltbld', 02:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:42 INFO - 'LOGNAME': 'cltbld', 02:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:42 INFO - 'MOZ_NO_REMOTE': '1', 02:26:42 INFO - 'NO_EM_RESTART': '1', 02:26:42 INFO - 'PAGER': '/bin/cat', 02:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:42 INFO - 'PWD': '/builds/slave/test', 02:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:42 INFO - 'SHELL': '/bin/bash', 02:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:26:42 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:42 INFO - 'USER': 'cltbld', 02:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:42 INFO - 'XPC_FLAGS': '0x0', 02:26:42 INFO - 'XPC_SERVICE_NAME': '0', 02:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:42 INFO - Cleaning up... 02:26:42 INFO - Return code: 0 02:26:42 INFO - Running post-action listener: _resource_record_post_action 02:26:42 INFO - Running post-action listener: _start_resource_monitoring 02:26:42 INFO - Starting resource monitoring. 02:26:42 INFO - [mozharness: 2017-04-28 09:26:42.471897Z] Finished create-virtualenv step (success) 02:26:42 INFO - [mozharness: 2017-04-28 09:26:42.472862Z] Running install step. 02:26:42 INFO - Running pre-action listener: _resource_record_pre_action 02:26:42 INFO - Running main action method: install 02:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:42 INFO - Reading from file tmpfile_stdout 02:26:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:42 INFO - Reading from file tmpfile_stdout 02:26:42 INFO - Output received: 02:26:42 INFO - Usage: mozinstall [options] installer 02:26:42 INFO - Options: 02:26:42 INFO - -h, --help show this help message and exit 02:26:42 INFO - -d DEST, --destination=DEST 02:26:42 INFO - Directory to install application into. [default: 02:26:42 INFO - "/builds/slave/test"] 02:26:42 INFO - --app=APP Application being installed. [default: firefox] 02:26:42 INFO - mkdir: /builds/slave/test/build/application 02:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:27:03 INFO - Reading from file tmpfile_stdout 02:27:03 INFO - Output received: 02:27:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:27:03 INFO - Running post-action listener: _resource_record_post_action 02:27:03 INFO - [mozharness: 2017-04-28 09:27:03.179474Z] Finished install step (success) 02:27:03 INFO - [mozharness: 2017-04-28 09:27:03.179634Z] Running run-tests step. 02:27:03 INFO - Running pre-action listener: _resource_record_pre_action 02:27:03 INFO - Running main action method: run_tests 02:27:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:27:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:27:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:27:03 INFO - 2017-04-28 02:27:03.194 screenresolution[30169:277642] starting screenresolution argv=screenresolution get 02:27:03 INFO - 2017-04-28 02:27:03.197 screenresolution[30169:277642] Display 0: 1600x1200x32@60 02:27:03 INFO - 2017-04-28 02:27:03.202 screenresolution[30170:277644] starting screenresolution argv=screenresolution list 02:27:03 INFO - Available Modes on Display 0 02:27:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:27:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:27:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:27:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:27:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:27:03 INFO - Intel Iris: 02:27:03 INFO - Chipset Model: Intel Iris 02:27:03 INFO - Type: GPU 02:27:03 INFO - Bus: Built-In 02:27:03 INFO - VRAM (Dynamic, Max): 1536 MB 02:27:03 INFO - Vendor: Intel (0x8086) 02:27:03 INFO - Device ID: 0x0a2e 02:27:03 INFO - Revision ID: 0x0009 02:27:03 INFO - Displays: 02:27:03 INFO - Display: 02:27:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:27:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:27:03 INFO - Display Serial Number: 1600x1200 60 02:27:03 INFO - Main Display: Yes 02:27:03 INFO - Mirror: Off 02:27:03 INFO - Online: Yes 02:27:03 INFO - Rotation: Supported 02:27:03 INFO - Return code: 0 02:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:03 INFO - Python 2.7.3 02:27:03 INFO - Return code: 0 02:27:03 INFO - grabbing minidump binary from tooltool 02:27:03 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')]} 02:27:03 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 0x10e762d30>, '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 0x10e689db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e757be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:03 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 02:27:03 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 02:27:03 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 02:27:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:03 INFO - Return code: 0 02:27:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:27:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:03 INFO - ENV: RUST_BACKTRACE is now 1 02:27:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:27:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 02:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0148 --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 02:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.axtAbcfLym/Render', 02:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:03 INFO - 'HOME': '/Users/cltbld', 02:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:03 INFO - 'LOGNAME': 'cltbld', 02:27:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:03 INFO - 'MOZ_NO_REMOTE': '1', 02:27:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:03 INFO - 'NO_EM_RESTART': '1', 02:27:03 INFO - 'PAGER': '/bin/cat', 02:27:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:03 INFO - 'PWD': '/builds/slave/test', 02:27:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:03 INFO - 'RUST_BACKTRACE': '1', 02:27:03 INFO - 'SHELL': '/bin/bash', 02:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nZNyoRmPrl/Listeners', 02:27:03 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 02:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:03 INFO - 'USER': 'cltbld', 02:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:03 INFO - 'XPC_FLAGS': '0x0', 02:27:03 INFO - 'XPC_SERVICE_NAME': '0', 02:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 02:27:03 INFO - mozversion application_buildid: 20170428004016 02:27:03 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 02:27:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:27:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:03 INFO - mozversion application_name: Firefox 02:27:03 INFO - mozversion application_remotingname: firefox-dev 02:27:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:03 INFO - mozversion application_vendor: Mozilla 02:27:03 INFO - mozversion application_version: 54.0a2 02:27:03 INFO - mozversion platform_buildid: 20170428004016 02:27:03 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 02:27:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:03 INFO - mozversion platform_version: 54.0a2 02:27:03 INFO - using testdate: 1493371623 02:27:03 INFO - actual date: 1493371623 02:27:03 INFO - starting webserver on 'localhost:49291' 02:27:03 INFO - SUITE-START | Running 2 tests 02:27:03 INFO - TEST-START | dromaeo_css 02:27:03 INFO - operating with platform_type : mac_ 02:27:03 INFO - Initialising browser for dromaeo_css test... 02:27:03 INFO - TEST-INFO | started process 30180 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmp7vALF5/profile http://localhost:49291/getInfo.html) 02:27:06 INFO - PROCESS | 30180 | 2017-04-28 02:27:06.904 plugin-container[30183:277825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 02:27:06 INFO - PROCESS | 30180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:27:06 INFO - PROCESS | 30180 | 2017-04-28 02:27:06.905 plugin-container[30183:277825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 02:27:06 INFO - PROCESS | 30180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:27:06 INFO - PROCESS | 30180 | 2017-04-28 02:27:06.905 plugin-container[30183:277825] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:27:06 INFO - PROCESS | 30180 | __metrics Screen width/height:1600/1200 02:27:06 INFO - PROCESS | 30180 | colorDepth:24 02:27:06 INFO - PROCESS | 30180 | Browser inner width/height: 1024/689 02:27:06 INFO - PROCESS | 30180 | __metrics 02:27:07 ERROR - PROCESS | 30180 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:27:07 INFO - TEST-INFO | 30180: exit 0 02:27:07 INFO - Browser initialized. 02:27:07 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:07 INFO - TEST-INFO | started process 30185 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmp7vALF5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:10 INFO - PROCESS | 30185 | 2017-04-28 02:27:10.201 plugin-container[30186:277956] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 02:27:10 INFO - PROCESS | 30185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:27:10 INFO - PROCESS | 30185 | 2017-04-28 02:27:10.202 plugin-container[30186:277956] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:27:10 INFO - PROCESS | 30185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:27:10 INFO - PROCESS | 30185 | 2017-04-28 02:27:10.202 plugin-container[30186:277956] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:27:19 INFO - PROCESS | 30185 | RSS: Main: 220667904 02:27:19 INFO - PROCESS | 30185 | 02:30:23 INFO - PROCESS | 30185 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49291/tests/dromaeo/cssquery-ext.html) 02:30:24 INFO - PROCESS | 30185 | RSS: Main: 241582080 02:30:24 INFO - PROCESS | 30185 | 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | A coding exception was thrown and uncaught in a Task. 02:32:08 INFO - PROCESS | 30185 | 02:32:08 ERROR - PROCESS | 30185 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:32:08 INFO - PROCESS | 30185 | Full stack: 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | A coding exception was thrown and uncaught in a Task. 02:32:08 INFO - PROCESS | 30185 | 02:32:08 ERROR - PROCESS | 30185 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:32:08 INFO - PROCESS | 30185 | Full stack: 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | A coding exception was thrown and uncaught in a Task. 02:32:08 INFO - PROCESS | 30185 | 02:32:08 ERROR - PROCESS | 30185 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:32:08 INFO - PROCESS | 30185 | Full stack: 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | ************************* 02:32:08 INFO - PROCESS | 30185 | A coding exception was thrown and uncaught in a Task. 02:32:08 INFO - PROCESS | 30185 | 02:32:08 ERROR - PROCESS | 30185 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:32:08 INFO - PROCESS | 30185 | Full stack: 02:32:08 INFO - PROCESS | 30185 | ************************* 02:33:27 INFO - PROCESS | 30185 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-ext.html (next: http://localhost:49291/tests/dromaeo/cssquery-jquery.html) 02:33:28 INFO - PROCESS | 30185 | RSS: Main: 247242752 02:33:28 INFO - PROCESS | 30185 | 02:36:30 INFO - PROCESS | 30185 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49291/tests/dromaeo/cssquery-mootools.html) 02:36:30 INFO - PROCESS | 30185 | RSS: Main: 256671744 02:36:30 INFO - PROCESS | 30185 | 02:39:32 INFO - PROCESS | 30185 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49291/tests/dromaeo/cssquery-prototype.html) 02:39:33 INFO - PROCESS | 30185 | RSS: Main: 252903424 02:39:33 INFO - PROCESS | 30185 | 02:42:36 INFO - PROCESS | 30185 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49291/tests/dromaeo/cssquery-yui.html) 02:42:36 INFO - PROCESS | 30185 | RSS: Main: 258002944 02:42:36 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-yui.html (next: http://localhost:49291/tests/dromaeo/cssquery-dojo.html) 02:45:39 INFO - PROCESS | 30185 | RSS: Main: 254119936 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | __start_tp_report 02:45:39 INFO - PROCESS | 30185 | _x_x_mozilla_page_load 02:45:39 INFO - PROCESS | 30185 | _x_x_mozilla_page_load_details 02:45:39 INFO - PROCESS | 30185 | |i|pagename|runs| 02:45:39 INFO - PROCESS | 30185 | |0;dojo.html;3382.5771778527683;3400.9659903400957;3431.330890476357;3438.5186073949653;3442.0706409269515;4300.591443812837;5923.5853490255695;5925.200097986771;5939.435753603406;5953.821385358447;5933.525317974562;5976.5517586180995;5984.401559844014;5991.790287339944;6031.517478601712;5336.279602253685;5399.19012148179;5418.647787893794;5449.5640348772;5460.863478413032;5464.672119672832;5465.945340546584;5467.726613669301;5471.699056551888;5489.409451555571;5259.842204733845;5288.4711528847;5441.646292990943;5463.672179669213;5512.090505066659;5345.893082138375;5350;5374.274472946161;5382.91925621116;5391.56867450603;5275.973620131913;5402.648827826179;5413.133898576209;5428.782848686048;5460.153676180198;5966.731497082598;6028.608140470856;6057.454829065361;6057.697115144269;6069.15031895535;5109.9489005109845;6251.031090181029;6263.279722831841;6315.778947736807;6327.367263273682;6302.40127187921;6308.148399966038;6324.367563243685;6419.454346380563;6425.967870160619;6152.969235153795;6158.445739883432;6168.444839964424;6169.475594574512;6184.8763024739255;6491.734111848239;6555.115059466911;6569.835754106186;6582.243042050225;6597.47220222381;6142.375998161017;6175.783847565313;6271.874562508724;6289.496840252768;6302.243730752248;6396.680165991682;6397.4562162216735;6413.45485633717;6414.358564143548;6417.06952491886;6275.870343338243;6326.4622507087415;6337.4613157882095;6343.464422937622;6351.301356850743;6209.844753881189;6277.811665650038;6280.780172693934;6306.905396419057;6327.430531252117;4256.404103425523;5012.022655582199;5095.949040509621;5113.846584602468;5135.178371460548;4586.770661466913;4594.816207351735;4602.033572949718;4610.2623580227;4627.398438203012;5892.440218179266;5916.467517923322;5969.850753731192;5993.580449368503;6030.5778595497895;6239.126522286883;6302.180716506825;6412.551121421456;6423.807285781434;6446.194225721785;5900.586958912921;5927.8221653350465;5987.491063259672;6002.489788368038;6046.516278697693;5605.5515558756015;5620.522255608237;5624.746886390122;5629.831105066854;5632.155176723524;6297.2128483939505;6599.274079851117;6615.073889655452;6616.66916654175;6622.602643841288;6292.11910332563;6296.244450665767;6319.336469670802;6396.584222025554;6416;6502.252240992158;6506.512011599054;6569.343065693583;6606.273309935807;6607.075009498578;5298.655587386807;6343.968280158754;6351.237851457669;6372.968135159294;6398.264199617103;5565.693886836263;5890.617109887844;6284.811455656338;6303.905441418474;6348;6257.7184026719815;6304.495640348853;6308.779192728232;6328.240611126695;6344.651044192429;5818.156367326629;6259.561830671809;6325.114483972339;6352.968235158794;6379.872402552016;5819.243498345188;5895.469407753323;6001.489873360639;6032.517398608188;6124.014786914997;6204.162438070984;6300.621962682254;6308.558400911892;6326.956052251327;6348;5979.1031345296815;6180.6291622502795;6191.81424557264;6201.193844800147;6206.565540412128 02:45:39 INFO - PROCESS | 30185 | |1;ext.html;743.2864450127877;800.0878997942345;823.5182418285304;887.8635346756155;930.7161315798679;28982.85508572457;37996.05009874751;39516.80241598788;39619.60380396195;39630;38502.61497385025;38651.840444786634;38667.613323866826;38742.41886371707;38842.61157388425;6905.930940690579;7717.80374042023;10473.790524189511;10733.731656708605;10814.621488247913;9345.766355841124;10250.231232657543;10515.263931524796;10640.521176547036;10646.201534884915;10646.733831654194;10669.466526673636;10669.679909602724;10685.145188384911;10689.465526723672;8898.199162075443;10594.311369760979;10624.362538247653;10637.946810265976;10640.840387394195;8682.739517814476;8689.26141277992;10410;10501.4224217668;10519.684409467729;32743.836280818443;33060.834695826605;33070.17324566881;33114;33506;3672.155404257036;3695.6662081431937;3713.3316003119426;3728.105254738843;3765.924681506382;24176.274711758677;24291;24467.77661116937;24887.50224995508;25652.35869103269;2992.251937015746;3075.784695071346;3149.8425078745972;3154.779165458419;3248.951265731016;355489.8902021971;355922;365831;368600;368955.15522422484;43904.3414348785;43978.34032489515;44147;44203.557964420586;44204.336934946004;37042.8147859259;45470;45609;45796.3130553042;46117;13364;13448.663783405493;13449.394777235048;13467.12463689857;13487;11627.244229125079;11828.290302581872;11842.407879605986;11859.762804743857;11863.762724745457;11599.188056836108;11695.239809412362;11707.76584468306;11714.589989350332;11838.467268972918;4796.184648609745;4984.925226121611;5686.09022556389;5715.8856822864145;5727.885442291131;830.9376796740148;848.7835601921471;854.2567965869733;870.2820173357006;889.0037986515822;20748.58502829935;26773.062942796907;26888.462230755275;26936.461270774475;27552;866.696656170348;871.8648609465542;977.2816979520047;987.1263931420744;989.7129832348538;12885;13616.251106189056;13871.543487933823;14231.003829732026;14245.145291282557;480512;482899;482990;483062;483223;56864;57306.42693573011;57418.425815741306;57435;57580;1375.6629625741757;1436.6408397900525;1437.9790348852223;1438.8273407190995;1438.8489208632943;21159.682604760634;21738.782612173676;25908.35229119287;26539.469210615294;26562.734372656025;45802;45935.08129837451;45968.31047534357;45974.310385343575;46062.309065364716;437834;441333;442408.78795605816;442547;443012;25658.973641054148;26063.73936260689;30505.389892202475;31111.844440778557;31144.688553114178;41541.79229103835;41631;43064.13871722611;43161.78419107884;44435.55564444314;27908.720912790614;29713.405731885672;29994.95017674371;31059.68940310568;31231.37537249197;28294.717052829208;29357.706422936353;30349.089527314216;30518.084457466313;30746.692533074383;32363.67636323701;33171;34183.145421364665;35531.467027994084;36520.08699782527;23107.88446057759;27336.859795848493;27446.039388621302;27560.862195688893;28386.290342741595;22368.993395296926;23129.65305520385;23155.536889262457;23539.29382118539;23795.762042379356 02:45:39 INFO - PROCESS | 30185 | |2;jquery.html;410.54429583162664;424.7812376626037;428.310765389417;434.8434563557121;438.43441959871757;19481.123349449274;20028;20540.38378848633;20686.793132068673;20888.477788055305;19924.601507969834;20386;21939.122435102578;22073.779262207372;22126.668099978473;6410.102585638026;6650.30171831958;6662.400383965442;6664.8000559983275;6666.76666316679;4725.40932383452;6603.867922641544;6616.338366163369;6627.072209890619;6627.536072474929;6317.1156038154695;6518.51111166662;6613.041109039186;6632.93367066328;6634.104395906539;6530.085787989661;6548.312427195147;6553.541252112306;6587.242467116295;6588.769393071219;6244.656543890084;6336;6348.396902294275;6375.93624063758;6388.425041746265;21488.35534933939;22759.544809103725;24197.395065123335;24353.756462435325;24599.87700061488;2821.5001687144095;2878.6683926773617;2908.7672986161056;2919.0221275872395;2926.7219614136625;14577.562673119823;15861.175964764085;15916.840831591768;16008.359665613361;16405.753913691304;2049.415916463801;2076.678114892194;2079.5321052763156;2081.9791802081936;2084.4267826347723;138393.77228024762;144995;152318;166478;186224;14976.775348369783;20790.896045519676;21000.264990725253;21015.474613134487;21070;31863.68136318607;32015.839920800714;32107.678923210467;32367.190820229684;32370.190745231088;10267.897321026694;10381.857995620476;10518.789624207473;10681.626143084955;10732.409717465614;8723.563821809012;8814;8835.955820220857;8982.955085224663;9014.18872301496;9437.292203084658;9464.384814987005;9538.761530961781;9575.467925131945;9613.134817866425;4060.309747342959;4197.853075142417;4225.323948168279;4228.23891699497;4236.4704411948505;886.7472770260574;899.4198741811495;902.9593668284812;933.9486328251876;939.6945992552311;16009.199540022952;17602.559936001704;18504.352347667766;18529.907350463433;21096.78903210979;878.9868151977726;898.5821592959305;914.3736540469799;953.3136141977765;958.6548842416724;10161.593536258615;10803.459827008619;10815;10827;10841.403722795321;762746;768367;769906;774280;792961;146138;152869;153355;156238;156989;1195.5337418406828;1206.7526157137765;1227.3433712963522;1229.305442425027;1236.486857953939;18037;18805.623887522448;18850.434486965412;18861.528461788017;18901.43295701131;52547.16084937009;59627.80744385001;60076.39923600708;60410;61031.694841527285;75892;88438.55780721056;89094;89134.55432722795;94912;11625.5349786011;12343.13598048128;12428.192167509083;12785.232886026868;13189.40647670838;13064.608061758163;13139.14595551286;13335.266560338887;13335.933320333335;13760.449582016607;11517.07863370945;11625.069994400597;11852.288862668267;11948.641540753792;12029.338386388483;10337;10885.727856803644;10925.672229833117;11167.664970050912;11238.381888996184;10067.496625168858;11902.940485297519;11911.927926486658;12068;12110;10886.29239099456;11806;12077;12250.938745306217;12808.807867881802;11190.94404527972;11352.54589816398;11376.715582110513;11506.597269095877;11942.283462992249 02:45:39 INFO - PROCESS | 30185 | |3;mootools.html;1536.631208509958;1542.9691406171876;1569.803774528184;1574.559123445435;1575.5194665626982;9346.719598412059;9556.283278754086;10903.618373356934;11390.829137562943;11399.886001139976;9917.760279965005;10725.570977160904;11076.667699968993;11096.667099986993;11111.333320000806;2207.6026315263207;2370.2415227127326;2383.7735415135535;2385.95228095438;2388.0328466970905;2323.4423738302853;2346.495503466754;2357.233898982829;2368.3723813189517;2368.8460250083776;2324.8140148788143;2338.485533182697;2345.554344674515;2346.1671106757112;2349.4713689419827;2303.884805759722;2304.0092760113143;2310.06442390832;2316.81465482761;2363.392892832873;1938.5153711572107;2325.860448373086;2328.1502251678185;2330.2892617751577;2334.0780391745166;11206.439678016148;11226.66320010401;11279.605213817476;11301.886981130248;11309.660710178709;5635.633683810539;5806.303243610751;5824.068149096167;5836.824895253149;5875.618084824516;3338.115399419132;3411.181316484026;3607.2244467439627;3623.3840247158046;3630.8547658093644;1108.6009036746764;1136.909047276216;1184.8281999110168;1185.1526158796416;1188.6909403555137;12745.426455809511;14946.252687365588;15506;15596.922015389964;15606.843931560652;4526.253168227206;4776.689515181502;4835.323054772335;4835.911919818012;4885.413750349981;12803.423845926956;12809.103362764703;12840.357982100857;12865.807012894815;12866.871331286568;5811.215485909348;5828.213191219216;5843.620164689281;5845.035569131131;5850.1224816277045;4392.780360981938;4439.356293337448;4844.4186697596515;5107.846764597068;5156.664816786897;3881.8059097045034;3984.900377490586;4000.139969906484;4014.6788256939376;4070.1656160487028;927.8979312275644;1077.2405454154803;1083.247143235444;1087.5704096881686;1096.1504833753745;924.8150369925908;930.7673081729567;941.4210260689626;947.9573419196153;986.40815510693;6473.967630161819;6550.148480697479;6638.871391863395;6769.796906092825;6948.826279342956;907.0566610724904;961.6586111930304;980.9852852207223;986.6497393425374;1012.86832711747;3401.9829900850336;4170.332746760504;4181.560936101666;4213.578642135762;4331.740095594275;13386.929045676323;13782.448702052006;13808.240546769823;13825.10136841102;13865.792013119812;13126.278054706892;13516.459341626225;13887.861121388858;13892.374843132084;13907.652308692364;9963.750906227402;10237;10239.48802559869;10241.180705543538;10305.124064454605;6486.383793539606;6683.3984941353565;7030.824229394306;7031.753888613874;7036.648167591497;11999.980001699952;12159.392030398269;12312.692182695504;12350.505979760708;12429.192102513307;12599.307038112991;12614.180078294881;12646.557370491988;12738.745225095632;12755;8067.354611631173;8302.377321700777;9192.35653504275;9213.539323033956;9473.194778443634;10016.699499015042;10655.786884262116;10751.978562036595;10766.46167691628;10793.136549076213;8718.476891386537;8756.168164024408;8775.07861674515;8847.292216622784;8998.64005439775;8620.698275560326;8641.56792160402;8643.611037503202;8663.523506207219;8665.306775458075;7765.961170194113;7797;7803.92196078032;7881.881771773314;7903.762887113396;4534.818607255673;5992.850178745566;6003.459688628044;6023.819285421444;6059.182010428712;5962.612430192024;6051.122587224916;6221.813345599639;6228.906566401598;6286.245650521967 02:45:39 INFO - PROCESS | 30185 | |4;prototype.html;361.83355656398055;368.90961714379966;380.65360521925044;382.6498753640419;388.8328018951851;4324.524302326741;4834.975825120874;5135.04734777503;5135.640505164631;5149.691018538891;4462;4664.416947881515;4850.151223535876;4943.184374578191;4962.379702537183;3443.5695538057807;3834.849545136462;4180.979095104521;4194.66442684586;4206.49522057352;3920.5491368492703;4025.9532521544315;4218.409422680827;4233.491980962289;4259.914801703964;3723.3670276053;3967.404889266604;4230.280852255109;4260.72305300156;4261.8051703372785;3903.9609603904023;4162.042730172077;4183.435236243099;4225.281702110648;4253.255680255943;2925.429541239459;3148.2758965437847;3429.537012503305;3861.899358682762;3899.8635047773478;4370.978145109286;4696.7084051886;4889.975550122226;4932.842980492488;4936.679115857458;4031.677465802729;4327.879339123838;4635.745034023127;4677.345171675968;4785.808567657289;4990.85210401606;5059.721715305656;5155.74221288934;5466.426025267329;5484.341878974508;3811.447340135665;4224.697539840794;4357;4368.191884501346;4384.7369157850635;4148.398482220091;4675.7895894684825;5226.398964119099;5230.875361797193;5853.004989151855;3780.3573392523335;4411.389842707389;4437.622802061796;4441.378207051015;4458.35353873693;4069.718038817763;4374.978125109354;4496.842610508616;4511.954880451219;4553.157665831832;4841.3222148899185;4891.6575839691595;4912.778924948386;4954.47321865851;5034.917492739079;4557.248054071041;5057.570106540912;5122.718250496258;5413.593980451482;5458.181272809111;1482.9555113346617;1521.987878061077;1540.0836502281124;1559.4463965292157;1573.6931298396933;920.8213486736987;1086.918516076509;1087.5377964365114;1157.6064138193055;1183.8046722290899;4698.942737883949;4789.521047895252;4913.87715307113;5053.2420136979745;5150.407703114115;5201.609879259071;5281.973590132025;5376.521456599467;5489.670619762827;5700.377826199994;4377.912441751211;4451.998300382388;4497.144313361039;4505.594496495266;4942.298784874536;2865.6561212654196;2895.406441679451;2900.202444327827;2903.8693258803405;2918.941621167607;5054.368203974504;5137.741253392943;5733.827985160452;5813.6221145625395;5824.64102038675;4932.457429682732;5384.9730751346;5418.512333889968;5490.780368785284;5492.642978206483;4938.678985865908;5027.99440111979;5599.44005599445;5640.448876558897;5838.5621078418435;5056.974715126401;5668.51817595509;5693.63714058661;5725.2843394575675;5729.914051289151;4945.579625731853;4974.5376038860995;5572.192032155233;5624.465675760796;5671.631343962794;4796.905995632867;5121.642764667441;5201.037808005531;5220.686758794484;5698.293310677395;3819.1025109099896;4145.564715704928;4319.824928677357;4443;4505.842295519641;4937.777799998937;5138.118787152146;5304.336957880265;5346;5422.566194704335;4619.584237418514;5419.4038655747045;5449.809256675997;5460.716731567999;5462.371827239918;5410.458954104558;5416.916616676602;5444.754986025559;5458.454154584669;5479.643823151482;4470.664700147437;4597.42532183477;4693.601043911306;4765.4996225395835;5285.471452854684;4774.045190961891;5408.891177308721;5455.3453585568395;5511.641743286834;5525.038611293094;5033.219850923113;5058.898822023612;5176.378834539879;5337.386200586827;5359.383670877899 02:45:39 INFO - PROCESS | 30185 | |5;yui.html;706.8409607838233;731.5803821466626;751.5866273549547;812.7608438751239;826.6197549127401;15210.391584336627;16411.93322434041;16428.342866285366;16446.588835279123;16447.424340148096;16195.02829830211;17179.74230386542;17360.218790154442;17640.647187056253;17643.82356176441;918.3020904112889;942.8915674697395;954.0221273194961;958.3100167879115;959.4722902403685;798.5129071266523;917.9816403671922;939.8543225800012;940.7742141885966;951.9952400238024;987.4815721746105;992.2310209587555;993.0417147452707;993.8459538771466;993.9652112176075;977.8435450327913;982.0277924854414;990.9058639429243;991.8363470027437;992.3847214726916;623.5790841182184;628.2115944489682;727.6798208788116;734.4418242136015;734.8273155808381;16028.038317700975;16386.918065409714;16576.254068566945;16758.916205419016;16867.493975180765;10889.618863339825;13881.514147004907;13882.652933676638;14052.726201148027;14340.211288379134;11416;11793.29240245588;11827.079122651567;11873.406329683568;12113.33376664283;3386.356592247465;3679.3745063339297;3680.0983758978955;3680.6871415929677;3802.277567262239;66378.0043299351;94007;110331.44834275858;111842;117497.41251293775;11659.708507287216;11699.473523691455;11707.239029463057;11822.645320640395;11852.288862668267;23901.760982389955;25342;25443;25485.872570637028;25592.360190995376;8319;8342.16578342161;8410.579471026424;8448;8594.269487093543;4418.690691651554;4465.531119232499;4479.126570318822;4484.663650226246;4533.297338912474;3526.717862570988;3586.336527742376;3596.4384011626607;3631.1285291529844;3636.61815509373;653.2194028136427;663.9767608133692;666.7832954289876;677.3057615943698;679.6737565968363;653.4478365781002;671.1576970901488;688.4870771275332;698.8986596943415;709.202147583968;8250.3116429818;10302.845457318146;10482.37105773656;10499.285881351792;10651.467426628638;684.1858188755365;687.7730348984823;707.2538471912079;712.4798896805361;722.3931897206372;4663.906721865544;5041.949580504222;5052.141136006888;5070.388809625989;5112.795488180505;98532;104881;104991.47504262583;105940;108728;88602;89911.55044224738;91001.54499227594;91653.62519562212;93005;52629.473705263226;68043;80141.39717205623;81421.59289203635;83188;8338;9744.902550974399;9770.413775173512;9830.311878168459;9837.704868853945;48680.756596216794;48998.75500622474;51431;52361.47638523718;53687.92624147573;69676.30323696698;69971.650141751;71526.28473715404;71866.28133718595;73003;12602.991760658942;12808.423620937267;12852.807207891701;12919.418626162033;13548.187108773505;13140.80288795688;14246.715065698421;15247.695046098794;15359.308831102404;15372.308246128727;13296.933515332361;13757.587272381845;13837.446502140205;13893.235872027135;14027.158370497802;13228.338607989159;13961.720765584834;14087;14107.929460352632;14161.645958851112;12898;13436.261005644783;13522.864771352553;13686.52097176594;13818.96357773191;9913.157381622643;10041.899581004389;10119.595216191565;10224.488775561342;10335.793284134124;8676.956615217136;10171.898281017095;10676.733081673021;10972;11405.372704501333 02:45:39 INFO - PROCESS | 30185 | __end_tp_report 02:45:39 INFO - PROCESS | 30185 | __start_cc_report 02:45:39 INFO - PROCESS | 30185 | _x_x_mozilla_cycle_collect,423 02:45:39 INFO - PROCESS | 30185 | __end_cc_report 02:45:39 INFO - PROCESS | 30185 | __startTimestamp1493372739710__endTimestamp 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | ------- Summary: start ------- 02:45:39 INFO - PROCESS | 30185 | Number of tests: 6 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | [#0] dojo.html Cycles:165 Average:5896.04 Median:6152.97 stddev:668.74 (10.9%) stddev-sans-first:641.06 02:45:39 INFO - PROCESS | 30185 | Values: 3382.6 3401.0 3431.3 3438.5 3442.1 4300.6 5923.6 5925.2 5939.4 5953.8 5933.5 5976.6 5984.4 5991.8 6031.5 5336.3 5399.2 5418.6 5449.6 5460.9 5464.7 5465.9 5467.7 5471.7 5489.4 5259.8 5288.5 5441.6 5463.7 5512.1 5345.9 5350.0 5374.3 5382.9 5391.6 5276.0 5402.6 5413.1 5428.8 5460.2 5966.7 6028.6 6057.5 6057.7 6069.2 5109.9 6251.0 6263.3 6315.8 6327.4 6302.4 6308.1 6324.4 6419.5 6426.0 6153.0 6158.4 6168.4 6169.5 6184.9 6491.7 6555.1 6569.8 6582.2 6597.5 6142.4 6175.8 6271.9 6289.5 6302.2 6396.7 6397.5 6413.5 6414.4 6417.1 6275.9 6326.5 6337.5 6343.5 6351.3 6209.8 6277.8 6280.8 6306.9 6327.4 4256.4 5012.0 5095.9 5113.8 5135.2 4586.8 4594.8 4602.0 4610.3 4627.4 5892.4 5916.5 5969.9 5993.6 6030.6 6239.1 6302.2 6412.6 6423.8 6446.2 5900.6 5927.8 5987.5 6002.5 6046.5 5605.6 5620.5 5624.7 5629.8 5632.2 6297.2 6599.3 6615.1 6616.7 6622.6 6292.1 6296.2 6319.3 6396.6 6416.0 6502.3 6506.5 6569.3 6606.3 6607.1 5298.7 6344.0 6351.2 6373.0 6398.3 5565.7 5890.6 6284.8 6303.9 6348.0 6257.7 6304.5 6308.8 6328.2 6344.7 5818.2 6259.6 6325.1 6353.0 6379.9 5819.2 5895.5 6001.5 6032.5 6124.0 6204.2 6300.6 6308.6 6327.0 6348.0 5979.1 6180.6 6191.8 6201.2 6206.6 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | [#1] ext.html Cycles:180 Average:55422.83 Median:17996.39 stddev:114845.06 (638.2%) stddev-sans-first:115093.85 02:45:39 INFO - PROCESS | 30185 | Values: 743.3 800.1 823.5 887.9 930.7 28982.9 37996.1 39516.8 39619.6 39630.0 38502.6 38651.8 38667.6 38742.4 38842.6 6905.9 7717.8 10473.8 10733.7 10814.6 9345.8 10250.2 10515.3 10640.5 10646.2 10646.7 10669.5 10669.7 10685.1 10689.5 8898.2 10594.3 10624.4 10637.9 10640.8 8682.7 8689.3 10410.0 10501.4 10519.7 32743.8 33060.8 33070.2 33114.0 33506.0 3672.2 3695.7 3713.3 3728.1 3765.9 24176.3 24291.0 24467.8 24887.5 25652.4 2992.3 3075.8 3149.8 3154.8 3249.0 355489.9 355922.0 365831.0 368600.0 368955.2 43904.3 43978.3 44147.0 44203.6 44204.3 37042.8 45470.0 45609.0 45796.3 46117.0 13364.0 13448.7 13449.4 13467.1 13487.0 11627.2 11828.3 11842.4 11859.8 11863.8 11599.2 11695.2 11707.8 11714.6 11838.5 4796.2 4984.9 5686.1 5715.9 5727.9 830.9 848.8 854.3 870.3 889.0 20748.6 26773.1 26888.5 26936.5 27552.0 866.7 871.9 977.3 987.1 989.7 12885.0 13616.3 13871.5 14231.0 14245.1 480512.0 482899.0 482990.0 483062.0 483223.0 56864.0 57306.4 57418.4 57435.0 57580.0 1375.7 1436.6 1438.0 1438.8 1438.8 21159.7 21738.8 25908.4 26539.5 26562.7 45802.0 45935.1 45968.3 45974.3 46062.3 437834.0 441333.0 442408.8 442547.0 443012.0 25659.0 26063.7 30505.4 31111.8 31144.7 41541.8 41631.0 43064.1 43161.8 44435.6 27908.7 29713.4 29995.0 31059.7 31231.4 28294.7 29357.7 30349.1 30518.1 30746.7 32363.7 33171.0 34183.1 35531.5 36520.1 23107.9 27336.9 27446.0 27560.9 28386.3 22369.0 23129.7 23155.5 23539.3 23795.8 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | [#2] jquery.html Cycles:180 Average:43571.73 Median:21083.39 stddev:128972.56 (611.7%) stddev-sans-first:129293.65 02:45:39 INFO - PROCESS | 30185 | Values: 410.5 424.8 428.3 434.8 438.4 19481.1 20028.0 20540.4 20686.8 20888.5 19924.6 20386.0 21939.1 22073.8 22126.7 6410.1 6650.3 6662.4 6664.8 6666.8 4725.4 6603.9 6616.3 6627.1 6627.5 6317.1 6518.5 6613.0 6632.9 6634.1 6530.1 6548.3 6553.5 6587.2 6588.8 6244.7 6336.0 6348.4 6375.9 6388.4 21488.4 22759.5 24197.4 24353.8 24599.9 2821.5 2878.7 2908.8 2919.0 2926.7 14577.6 15861.2 15916.8 16008.4 16405.8 2049.4 2076.7 2079.5 2082.0 2084.4 138393.8 144995.0 152318.0 166478.0 186224.0 14976.8 20790.9 21000.3 21015.5 21070.0 31863.7 32015.8 32107.7 32367.2 32370.2 10267.9 10381.9 10518.8 10681.6 10732.4 8723.6 8814.0 8836.0 8983.0 9014.2 9437.3 9464.4 9538.8 9575.5 9613.1 4060.3 4197.9 4225.3 4228.2 4236.5 886.7 899.4 903.0 933.9 939.7 16009.2 17602.6 18504.4 18529.9 21096.8 879.0 898.6 914.4 953.3 958.7 10161.6 10803.5 10815.0 10827.0 10841.4 762746.0 768367.0 769906.0 774280.0 792961.0 146138.0 152869.0 153355.0 156238.0 156989.0 1195.5 1206.8 1227.3 1229.3 1236.5 18037.0 18805.6 18850.4 18861.5 18901.4 52547.2 59627.8 60076.4 60410.0 61031.7 75892.0 88438.6 89094.0 89134.6 94912.0 11625.5 12343.1 12428.2 12785.2 13189.4 13064.6 13139.1 13335.3 13335.9 13760.4 11517.1 11625.1 11852.3 11948.6 12029.3 10337.0 10885.7 10925.7 11167.7 11238.4 10067.5 11902.9 11911.9 12068.0 12110.0 10886.3 11806.0 12077.0 12250.9 12808.8 11190.9 11352.5 11376.7 11506.6 11942.3 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | [#3] mootools.html Cycles:180 Average:6750.52 Median:2863.07 stddev:4266.14 (149.0%) stddev-sans-first:4260.12 02:45:39 INFO - PROCESS | 30185 | Values: 1536.6 1543.0 1569.8 1574.6 1575.5 9346.7 9556.3 10903.6 11390.8 11399.9 9917.8 10725.6 11076.7 11096.7 11111.3 2207.6 2370.2 2383.8 2386.0 2388.0 2323.4 2346.5 2357.2 2368.4 2368.8 2324.8 2338.5 2345.6 2346.2 2349.5 2303.9 2304.0 2310.1 2316.8 2363.4 1938.5 2325.9 2328.2 2330.3 2334.1 11206.4 11226.7 11279.6 11301.9 11309.7 5635.6 5806.3 5824.1 5836.8 5875.6 3338.1 3411.2 3607.2 3623.4 3630.9 1108.6 1136.9 1184.8 1185.2 1188.7 12745.4 14946.3 15506.0 15596.9 15606.8 4526.3 4776.7 4835.3 4835.9 4885.4 12803.4 12809.1 12840.4 12865.8 12866.9 5811.2 5828.2 5843.6 5845.0 5850.1 4392.8 4439.4 4844.4 5107.8 5156.7 3881.8 3984.9 4000.1 4014.7 4070.2 927.9 1077.2 1083.2 1087.6 1096.2 924.8 930.8 941.4 948.0 986.4 6474.0 6550.1 6638.9 6769.8 6948.8 907.1 961.7 981.0 986.6 1012.9 3402.0 4170.3 4181.6 4213.6 4331.7 13386.9 13782.4 13808.2 13825.1 13865.8 13126.3 13516.5 13887.9 13892.4 13907.7 9963.8 10237.0 10239.5 10241.2 10305.1 6486.4 6683.4 7030.8 7031.8 7036.6 12000.0 12159.4 12312.7 12350.5 12429.2 12599.3 12614.2 12646.6 12738.7 12755.0 8067.4 8302.4 9192.4 9213.5 9473.2 10016.7 10655.8 10752.0 10766.5 10793.1 8718.5 8756.2 8775.1 8847.3 8998.6 8620.7 8641.6 8643.6 8663.5 8665.3 7766.0 7797.0 7803.9 7881.9 7903.8 4534.8 5992.9 6003.5 6023.8 6059.2 5962.6 6051.1 6221.8 6228.9 6286.2 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | [#4] prototype.html Cycles:180 Average:4462.89 Median:4838.15 stddev:1240.95 (25.6%) stddev-sans-first:1205.65 02:45:39 INFO - PROCESS | 30185 | Values: 361.8 368.9 380.7 382.6 388.8 4324.5 4835.0 5135.0 5135.6 5149.7 4462.0 4664.4 4850.2 4943.2 4962.4 3443.6 3834.8 4181.0 4194.7 4206.5 3920.5 4026.0 4218.4 4233.5 4259.9 3723.4 3967.4 4230.3 4260.7 4261.8 3904.0 4162.0 4183.4 4225.3 4253.3 2925.4 3148.3 3429.5 3861.9 3899.9 4371.0 4696.7 4890.0 4932.8 4936.7 4031.7 4327.9 4635.7 4677.3 4785.8 4990.9 5059.7 5155.7 5466.4 5484.3 3811.4 4224.7 4357.0 4368.2 4384.7 4148.4 4675.8 5226.4 5230.9 5853.0 3780.4 4411.4 4437.6 4441.4 4458.4 4069.7 4375.0 4496.8 4512.0 4553.2 4841.3 4891.7 4912.8 4954.5 5034.9 4557.2 5057.6 5122.7 5413.6 5458.2 1483.0 1522.0 1540.1 1559.4 1573.7 920.8 1086.9 1087.5 1157.6 1183.8 4698.9 4789.5 4913.9 5053.2 5150.4 5201.6 5282.0 5376.5 5489.7 5700.4 4377.9 4452.0 4497.1 4505.6 4942.3 2865.7 2895.4 2900.2 2903.9 2918.9 5054.4 5137.7 5733.8 5813.6 5824.6 4932.5 5385.0 5418.5 5490.8 5492.6 4938.7 5028.0 5599.4 5640.4 5838.6 5057.0 5668.5 5693.6 5725.3 5729.9 4945.6 4974.5 5572.2 5624.5 5671.6 4796.9 5121.6 5201.0 5220.7 5698.3 3819.1 4145.6 4319.8 4443.0 4505.8 4937.8 5138.1 5304.3 5346.0 5422.6 4619.6 5419.4 5449.8 5460.7 5462.4 5410.5 5416.9 5444.8 5458.5 5479.6 4470.7 4597.4 4693.6 4765.5 5285.5 4774.0 5408.9 5455.3 5511.6 5525.0 5033.2 5058.9 5176.4 5337.4 5359.4 02:45:39 INFO - PROCESS | 30185 | 02:45:39 INFO - PROCESS | 30185 | [#5] yui.html Cycles:180 Average:20669.60 Median:4472.33 stddev:29308.98 (655.3%) stddev-sans-first:29352.86 02:45:39 INFO - PROCESS | 30185 | Values: 706.8 731.6 751.6 812.8 826.6 15210.4 16411.9 16428.3 16446.6 16447.4 16195.0 17179.7 17360.2 17640.6 17643.8 918.3 942.9 954.0 958.3 959.5 798.5 918.0 939.9 940.8 952.0 987.5 992.2 993.0 993.8 994.0 977.8 982.0 990.9 991.8 992.4 623.6 628.2 727.7 734.4 734.8 16028.0 16386.9 16576.3 16758.9 16867.5 10889.6 13881.5 13882.7 14052.7 14340.2 11416.0 11793.3 11827.1 11873.4 12113.3 3386.4 3679.4 3680.1 3680.7 3802.3 66378.0 94007.0 110331.4 111842.0 117497.4 11659.7 11699.5 11707.2 11822.6 11852.3 23901.8 25342.0 25443.0 25485.9 25592.4 8319.0 8342.2 8410.6 8448.0 8594.3 4418.7 4465.5 4479.1 4484.7 4533.3 3526.7 3586.3 3596.4 3631.1 3636.6 653.2 664.0 666.8 677.3 679.7 653.4 671.2 688.5 698.9 709.2 8250.3 10302.8 10482.4 10499.3 10651.5 684.2 687.8 707.3 712.5 722.4 4663.9 5041.9 5052.1 5070.4 5112.8 98532.0 104881.0 104991.5 105940.0 108728.0 88602.0 89911.6 91001.5 91653.6 93005.0 52629.5 68043.0 80141.4 81421.6 83188.0 8338.0 9744.9 9770.4 9830.3 9837.7 48680.8 48998.8 51431.0 52361.5 53687.9 69676.3 69971.7 71526.3 71866.3 73003.0 12603.0 12808.4 12852.8 12919.4 13548.2 13140.8 14246.7 15247.7 15359.3 15372.3 13296.9 13757.6 13837.4 13893.2 14027.2 13228.3 13961.7 14087.0 14107.9 14161.6 12898.0 13436.3 13522.9 13686.5 13819.0 9913.2 10041.9 10119.6 10224.5 10335.8 8677.0 10171.9 10676.7 10972.0 11405.4 02:45:39 INFO - PROCESS | 30185 | -------- Summary: end -------- 02:45:39 INFO - PROCESS | 30185 | 02:45:40 INFO - TEST-INFO | 30185: exit 0 02:45:40 INFO - TEST-OK | dromaeo_css | took 1116675ms 02:45:40 INFO - TEST-START | kraken 02:45:40 INFO - operating with platform_type : mac_ 02:45:40 INFO - Initialising browser for kraken test... 02:45:40 INFO - TEST-INFO | started process 30193 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpmzFChY/profile http://localhost:49291/getInfo.html) 02:45:43 INFO - PROCESS | 30193 | 2017-04-28 02:45:43.518 plugin-container[30195:280170] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 02:45:43 INFO - PROCESS | 30193 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:43 INFO - PROCESS | 30193 | 2017-04-28 02:45:43.519 plugin-container[30195:280170] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.CFPasteboardClient' 02:45:43 INFO - PROCESS | 30193 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:43 INFO - PROCESS | 30193 | 2017-04-28 02:45:43.519 plugin-container[30195:280170] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:45:43 INFO - PROCESS | 30193 | __metrics Screen width/height:1600/1200 02:45:43 INFO - PROCESS | 30193 | colorDepth:24 02:45:43 INFO - PROCESS | 30193 | Browser inner width/height: 1024/689 02:45:43 INFO - PROCESS | 30193 | __metrics 02:45:43 ERROR - PROCESS | 30193 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:45:44 INFO - TEST-INFO | 30193: exit 0 02:45:44 INFO - Browser initialized. 02:45:44 INFO - Running cycle 1/1 for kraken test... 02:45:44 INFO - TEST-INFO | started process 30196 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpmzFChY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:46 INFO - PROCESS | 30196 | 2017-04-28 02:45:46.927 plugin-container[30197:280294] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 02:45:46 INFO - PROCESS | 30196 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:46 INFO - PROCESS | 30196 | 2017-04-28 02:45:46.927 plugin-container[30197:280294] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 02:45:46 INFO - PROCESS | 30196 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:46 INFO - PROCESS | 30196 | 2017-04-28 02:45:46.927 plugin-container[30197:280294] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:45:56 INFO - PROCESS | 30196 | RSS: Main: 220667904 02:45:56 INFO - PROCESS | 30196 | 02:45:59 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:00 INFO - PROCESS | 30196 | RSS: Main: 235294720 02:46:00 INFO - PROCESS | 30196 | 02:46:03 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-dft) 02:46:04 INFO - PROCESS | 30196 | RSS: Main: 243224576 02:46:04 INFO - PROCESS | 30196 | 02:46:07 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-fft) 02:46:08 INFO - PROCESS | 30196 | RSS: Main: 246915072 02:46:08 INFO - PROCESS | 30196 | 02:46:09 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-oscillator) 02:46:10 INFO - PROCESS | 30196 | RSS: Main: 248389632 02:46:10 INFO - PROCESS | 30196 | 02:46:12 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:13 INFO - PROCESS | 30196 | RSS: Main: 248709120 02:46:13 INFO - PROCESS | 30196 | 02:46:16 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:16 INFO - PROCESS | 30196 | RSS: Main: 252821504 02:46:16 INFO - PROCESS | 30196 | 02:46:20 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:20 INFO - PROCESS | 30196 | RSS: Main: 252502016 02:46:20 INFO - PROCESS | 30196 | 02:46:24 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49291/tests/kraken/driver.html?testName=json-parse-financial) 02:46:24 INFO - PROCESS | 30196 | RSS: Main: 252190720 02:46:24 INFO - PROCESS | 30196 | 02:46:26 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:27 INFO - PROCESS | 30196 | RSS: Main: 251498496 02:46:27 INFO - PROCESS | 30196 | 02:46:29 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:30 INFO - PROCESS | 30196 | RSS: Main: 251412480 02:46:30 INFO - PROCESS | 30196 | 02:46:32 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:32 INFO - PROCESS | 30196 | RSS: Main: 252284928 02:46:32 INFO - PROCESS | 30196 | 02:46:35 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:36 INFO - PROCESS | 30196 | RSS: Main: 252260352 02:46:36 INFO - PROCESS | 30196 | 02:46:39 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:40 INFO - PROCESS | 30196 | RSS: Main: 251940864 02:46:40 INFO - PROCESS | 30196 | 02:46:41 INFO - PROCESS | 30196 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49291/tests/kraken/driver.html?testName=ai-astar) 02:46:42 INFO - PROCESS | 30196 | RSS: Main: 255627264 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | __start_tp_report 02:46:42 INFO - PROCESS | 30196 | _x_x_mozilla_page_load 02:46:42 INFO - PROCESS | 30196 | _x_x_mozilla_page_load_details 02:46:42 INFO - PROCESS | 30196 | |i|pagename|runs| 02:46:42 INFO - PROCESS | 30196 | |0;ai-astar;107;120;121;121;120;119;121;121;130;179 02:46:42 INFO - PROCESS | 30196 | |1;audio-beat-detection;167;106;145;182;142;130;113;125;133;115 02:46:42 INFO - PROCESS | 30196 | |2;audio-dft;193;199;198;206;200;199;194;196;205;265 02:46:42 INFO - PROCESS | 30196 | |3;audio-fft;85;59;62;87;62;74;63;61;76;60 02:46:42 INFO - PROCESS | 30196 | |4;audio-oscillator;84;71;85;73;73;71;81;71;73;83 02:46:42 INFO - PROCESS | 30196 | |5;imaging-gaussian-blur;90;89;90;90;109;135;100;135;91;136 02:46:42 INFO - PROCESS | 30196 | |6;imaging-darkroom;105;123;148;153;98;97;96;97;99;106 02:46:42 INFO - PROCESS | 30196 | |7;imaging-desaturate;118;90;155;99;85;139;142;77;146;141 02:46:42 INFO - PROCESS | 30196 | |8;json-parse-financial;66;67;74;97;107;79;68;75;84;110 02:46:42 INFO - PROCESS | 30196 | |9;json-stringify-tinderbox;86;74;63;62;60;58;74;89;88;89 02:46:42 INFO - PROCESS | 30196 | |10;stanford-crypto-aes;81;85;83;69;92;103;83;87;83;93 02:46:42 INFO - PROCESS | 30196 | |11;stanford-crypto-ccm;162;175;141;151;139;145;153;148;183;139 02:46:42 INFO - PROCESS | 30196 | |12;stanford-crypto-pbkdf2;169;167;178;203;168;168;185;221;173;166 02:46:42 INFO - PROCESS | 30196 | |13;stanford-crypto-sha256-iterative;61;58;78;85;89;78;64;59;81;100 02:46:42 INFO - PROCESS | 30196 | __end_tp_report 02:46:42 INFO - PROCESS | 30196 | __start_cc_report 02:46:42 INFO - PROCESS | 30196 | _x_x_mozilla_cycle_collect,1009 02:46:42 INFO - PROCESS | 30196 | __end_cc_report 02:46:42 INFO - PROCESS | 30196 | __startTimestamp1493372802250__endTimestamp 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | ------- Summary: start ------- 02:46:42 INFO - PROCESS | 30196 | Number of tests: 14 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#0] ai-astar Cycles:10 Average:125.90 Median:121.00 stddev:19.46 (16.1%) stddev-sans-first:19.40 02:46:42 INFO - PROCESS | 30196 | Values: 107.0 120.0 121.0 121.0 120.0 119.0 121.0 121.0 130.0 179.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:137.50 stddev:24.11 (17.5%) stddev-sans-first:22.77 02:46:42 INFO - PROCESS | 30196 | Values: 167.0 106.0 145.0 182.0 142.0 130.0 113.0 125.0 133.0 115.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#2] audio-dft Cycles:10 Average:205.50 Median:199.50 stddev:21.32 (10.7%) stddev-sans-first:22.13 02:46:42 INFO - PROCESS | 30196 | Values: 193.0 199.0 198.0 206.0 200.0 199.0 194.0 196.0 205.0 265.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#3] audio-fft Cycles:10 Average:68.90 Median:68.50 stddev:10.71 (15.6%) stddev-sans-first:9.65 02:46:42 INFO - PROCESS | 30196 | Values: 85.0 59.0 62.0 87.0 62.0 74.0 63.0 61.0 76.0 60.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:5.95 (7.7%) stddev-sans-first:5.66 02:46:42 INFO - PROCESS | 30196 | Values: 84.0 71.0 85.0 73.0 73.0 71.0 81.0 71.0 73.0 83.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#5] imaging-gaussian-blur Cycles:10 Average:106.50 Median:89.50 stddev:20.83 (23.3%) stddev-sans-first:21.22 02:46:42 INFO - PROCESS | 30196 | Values: 90.0 89.0 90.0 90.0 109.0 135.0 100.0 135.0 91.0 136.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#6] imaging-darkroom Cycles:10 Average:112.20 Median:96.50 stddev:21.74 (22.5%) stddev-sans-first:22.90 02:46:42 INFO - PROCESS | 30196 | Values: 105.0 123.0 148.0 153.0 98.0 97.0 96.0 97.0 99.0 106.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#7] imaging-desaturate Cycles:10 Average:119.20 Median:116.00 stddev:29.06 (25.1%) stddev-sans-first:30.82 02:46:42 INFO - PROCESS | 30196 | Values: 118.0 90.0 155.0 99.0 85.0 139.0 142.0 77.0 146.0 141.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#8] json-parse-financial Cycles:10 Average:82.70 Median:74.50 stddev:16.44 (22.1%) stddev-sans-first:16.29 02:46:42 INFO - PROCESS | 30196 | Values: 66.0 67.0 74.0 97.0 107.0 79.0 68.0 75.0 84.0 110.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:80.00 stddev:12.94 (16.2%) stddev-sans-first:13.01 02:46:42 INFO - PROCESS | 30196 | Values: 86.0 74.0 63.0 62.0 60.0 58.0 74.0 89.0 88.0 89.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:8.92 (10.6%) stddev-sans-first:9.29 02:46:42 INFO - PROCESS | 30196 | Values: 81.0 85.0 83.0 69.0 92.0 103.0 83.0 87.0 83.0 93.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:152.00 stddev:15.24 (10.0%) stddev-sans-first:15.86 02:46:42 INFO - PROCESS | 30196 | Values: 162.0 175.0 141.0 151.0 139.0 145.0 153.0 148.0 183.0 139.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:175.50 stddev:18.44 (10.5%) stddev-sans-first:19.14 02:46:42 INFO - PROCESS | 30196 | Values: 169.0 167.0 178.0 203.0 168.0 168.0 185.0 221.0 173.0 166.0 02:46:42 INFO - PROCESS | 30196 | 02:46:42 INFO - PROCESS | 30196 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:78.00 stddev:14.28 (18.3%) stddev-sans-first:14.18 02:46:42 INFO - PROCESS | 30196 | Values: 61.0 58.0 78.0 85.0 89.0 78.0 64.0 59.0 81.0 100.0 02:46:42 INFO - PROCESS | 30196 | -------- Summary: end -------- 02:46:42 INFO - PROCESS | 30196 | 02:46:43 INFO - TEST-INFO | 30196: exit 0 02:46:43 INFO - TEST-OK | kraken | took 62690ms 02:46:43 INFO - SUITE-END | took 1179s 02:46:43 INFO - Completed test suite (00:19:39) 02:46:43 INFO - javascript benchmark 02:46:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7610.460283367808, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.5771778527683, 3400.9659903400957, 3431.330890476357, 3438.5186073949653, 3442.0706409269515, 4300.591443812837, 5923.5853490255695, 5925.200097986771, 5939.435753603406, 5953.821385358447, 5933.525317974562, 5976.5517586180995, 5984.401559844014, 5991.790287339944, 6031.517478601712, 5336.279602253685, 5399.19012148179, 5418.647787893794, 5449.5640348772, 5460.863478413032, 5464.672119672832, 5465.945340546584, 5467.726613669301, 5471.699056551888, 5489.409451555571, 5259.842204733845, 5288.4711528847, 5441.646292990943, 5463.672179669213, 5512.090505066659, 5345.893082138375, 5350.0, 5374.274472946161, 5382.91925621116, 5391.56867450603, 5275.973620131913, 5402.648827826179, 5413.133898576209, 5428.782848686048, 5460.153676180198, 5966.731497082598, 6028.608140470856, 6057.454829065361, 6057.697115144269, 6069.15031895535, 5109.9489005109845, 6251.031090181029, 6263.279722831841, 6315.778947736807, 6327.367263273682, 6302.40127187921, 6308.148399966038, 6324.367563243685, 6419.454346380563, 6425.967870160619, 6152.969235153795, 6158.445739883432, 6168.444839964424, 6169.475594574512, 6184.8763024739255, 6491.734111848239, 6555.115059466911, 6569.835754106186, 6582.243042050225, 6597.47220222381, 6142.375998161017, 6175.783847565313, 6271.874562508724, 6289.496840252768, 6302.243730752248, 6396.680165991682, 6397.4562162216735, 6413.45485633717, 6414.358564143548, 6417.06952491886, 6275.870343338243, 6326.4622507087415, 6337.4613157882095, 6343.464422937622, 6351.301356850743, 6209.844753881189, 6277.811665650038, 6280.780172693934, 6306.905396419057, 6327.430531252117, 4256.404103425523, 5012.022655582199, 5095.949040509621, 5113.846584602468, 5135.178371460548, 4586.770661466913, 4594.816207351735, 4602.033572949718, 4610.2623580227, 4627.398438203012, 5892.440218179266, 5916.467517923322, 5969.850753731192, 5993.580449368503, 6030.5778595497895, 6239.126522286883, 6302.180716506825, 6412.551121421456, 6423.807285781434, 6446.194225721785, 5900.586958912921, 5927.8221653350465, 5987.491063259672, 6002.489788368038, 6046.516278697693, 5605.5515558756015, 5620.522255608237, 5624.746886390122, 5629.831105066854, 5632.155176723524, 6297.2128483939505, 6599.274079851117, 6615.073889655452, 6616.66916654175, 6622.602643841288, 6292.11910332563, 6296.244450665767, 6319.336469670802, 6396.584222025554, 6416.0, 6502.252240992158, 6506.512011599054, 6569.343065693583, 6606.273309935807, 6607.075009498578, 5298.655587386807, 6343.968280158754, 6351.237851457669, 6372.968135159294, 6398.264199617103, 5565.693886836263, 5890.617109887844, 6284.811455656338, 6303.905441418474, 6348.0, 6257.7184026719815, 6304.495640348853, 6308.779192728232, 6328.240611126695, 6344.651044192429, 5818.156367326629, 6259.561830671809, 6325.114483972339, 6352.968235158794, 6379.872402552016, 5819.243498345188, 5895.469407753323, 6001.489873360639, 6032.517398608188, 6124.014786914997, 6204.162438070984, 6300.621962682254, 6308.558400911892, 6326.956052251327, 6348.0, 5979.1031345296815, 6180.6291622502795, 6191.81424557264, 6201.193844800147, 6206.565540412128], "value": 5854.185199961982, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.2864450127877, 800.0878997942345, 823.5182418285304, 887.8635346756155, 930.7161315798679, 28982.85508572457, 37996.05009874751, 39516.80241598788, 39619.60380396195, 39630.0, 38502.61497385025, 38651.840444786634, 38667.613323866826, 38742.41886371707, 38842.61157388425, 6905.930940690579, 7717.80374042023, 10473.790524189511, 10733.731656708605, 10814.621488247913, 9345.766355841124, 10250.231232657543, 10515.263931524796, 10640.521176547036, 10646.201534884915, 10646.733831654194, 10669.466526673636, 10669.679909602724, 10685.145188384911, 10689.465526723672, 8898.199162075443, 10594.311369760979, 10624.362538247653, 10637.946810265976, 10640.840387394195, 8682.739517814476, 8689.26141277992, 10410.0, 10501.4224217668, 10519.684409467729, 32743.836280818443, 33060.834695826605, 33070.17324566881, 33114.0, 33506.0, 3672.155404257036, 3695.6662081431937, 3713.3316003119426, 3728.105254738843, 3765.924681506382, 24176.274711758677, 24291.0, 24467.77661116937, 24887.50224995508, 25652.35869103269, 2992.251937015746, 3075.784695071346, 3149.8425078745972, 3154.779165458419, 3248.951265731016, 355489.8902021971, 355922.0, 365831.0, 368600.0, 368955.15522422484, 43904.3414348785, 43978.34032489515, 44147.0, 44203.557964420586, 44204.336934946004, 37042.8147859259, 45470.0, 45609.0, 45796.3130553042, 46117.0, 13364.0, 13448.663783405493, 13449.394777235048, 13467.12463689857, 13487.0, 11627.244229125079, 11828.290302581872, 11842.407879605986, 11859.762804743857, 11863.762724745457, 11599.188056836108, 11695.239809412362, 11707.76584468306, 11714.589989350332, 11838.467268972918, 4796.184648609745, 4984.925226121611, 5686.09022556389, 5715.8856822864145, 5727.885442291131, 830.9376796740148, 848.7835601921471, 854.2567965869733, 870.2820173357006, 889.0037986515822, 20748.58502829935, 26773.062942796907, 26888.462230755275, 26936.461270774475, 27552.0, 866.696656170348, 871.8648609465542, 977.2816979520047, 987.1263931420744, 989.7129832348538, 12885.0, 13616.251106189056, 13871.543487933823, 14231.003829732026, 14245.145291282557, 480512.0, 482899.0, 482990.0, 483062.0, 483223.0, 56864.0, 57306.42693573011, 57418.425815741306, 57435.0, 57580.0, 1375.6629625741757, 1436.6408397900525, 1437.9790348852223, 1438.8273407190995, 1438.8489208632943, 21159.682604760634, 21738.782612173676, 25908.35229119287, 26539.469210615294, 26562.734372656025, 45802.0, 45935.08129837451, 45968.31047534357, 45974.310385343575, 46062.309065364716, 437834.0, 441333.0, 442408.78795605816, 442547.0, 443012.0, 25658.973641054148, 26063.73936260689, 30505.389892202475, 31111.844440778557, 31144.688553114178, 41541.79229103835, 41631.0, 43064.13871722611, 43161.78419107884, 44435.55564444314, 27908.720912790614, 29713.405731885672, 29994.95017674371, 31059.68940310568, 31231.37537249197, 28294.717052829208, 29357.706422936353, 30349.089527314216, 30518.084457466313, 30746.692533074383, 32363.67636323701, 33171.0, 34183.145421364665, 35531.467027994084, 36520.08699782527, 23107.88446057759, 27336.859795848493, 27446.039388621302, 27560.862195688893, 28386.290342741595, 22368.993395296926, 23129.65305520385, 23155.536889262457, 23539.29382118539, 23795.762042379356], "value": 17825.89121707053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.54429583162664, 424.7812376626037, 428.310765389417, 434.8434563557121, 438.43441959871757, 19481.123349449274, 20028.0, 20540.38378848633, 20686.793132068673, 20888.477788055305, 19924.601507969834, 20386.0, 21939.122435102578, 22073.779262207372, 22126.668099978473, 6410.102585638026, 6650.30171831958, 6662.400383965442, 6664.8000559983275, 6666.76666316679, 4725.40932383452, 6603.867922641544, 6616.338366163369, 6627.072209890619, 6627.536072474929, 6317.1156038154695, 6518.51111166662, 6613.041109039186, 6632.93367066328, 6634.104395906539, 6530.085787989661, 6548.312427195147, 6553.541252112306, 6587.242467116295, 6588.769393071219, 6244.656543890084, 6336.0, 6348.396902294275, 6375.93624063758, 6388.425041746265, 21488.35534933939, 22759.544809103725, 24197.395065123335, 24353.756462435325, 24599.87700061488, 2821.5001687144095, 2878.6683926773617, 2908.7672986161056, 2919.0221275872395, 2926.7219614136625, 14577.562673119823, 15861.175964764085, 15916.840831591768, 16008.359665613361, 16405.753913691304, 2049.415916463801, 2076.678114892194, 2079.5321052763156, 2081.9791802081936, 2084.4267826347723, 138393.77228024762, 144995.0, 152318.0, 166478.0, 186224.0, 14976.775348369783, 20790.896045519676, 21000.264990725253, 21015.474613134487, 21070.0, 31863.68136318607, 32015.839920800714, 32107.678923210467, 32367.190820229684, 32370.190745231088, 10267.897321026694, 10381.857995620476, 10518.789624207473, 10681.626143084955, 10732.409717465614, 8723.563821809012, 8814.0, 8835.955820220857, 8982.955085224663, 9014.18872301496, 9437.292203084658, 9464.384814987005, 9538.761530961781, 9575.467925131945, 9613.134817866425, 4060.309747342959, 4197.853075142417, 4225.323948168279, 4228.23891699497, 4236.4704411948505, 886.7472770260574, 899.4198741811495, 902.9593668284812, 933.9486328251876, 939.6945992552311, 16009.199540022952, 17602.559936001704, 18504.352347667766, 18529.907350463433, 21096.78903210979, 878.9868151977726, 898.5821592959305, 914.3736540469799, 953.3136141977765, 958.6548842416724, 10161.593536258615, 10803.459827008619, 10815.0, 10827.0, 10841.403722795321, 762746.0, 768367.0, 769906.0, 774280.0, 792961.0, 146138.0, 152869.0, 153355.0, 156238.0, 156989.0, 1195.5337418406828, 1206.7526157137765, 1227.3433712963522, 1229.305442425027, 1236.486857953939, 18037.0, 18805.623887522448, 18850.434486965412, 18861.528461788017, 18901.43295701131, 52547.16084937009, 59627.80744385001, 60076.39923600708, 60410.0, 61031.694841527285, 75892.0, 88438.55780721056, 89094.0, 89134.55432722795, 94912.0, 11625.5349786011, 12343.13598048128, 12428.192167509083, 12785.232886026868, 13189.40647670838, 13064.608061758163, 13139.14595551286, 13335.266560338887, 13335.933320333335, 13760.449582016607, 11517.07863370945, 11625.069994400597, 11852.288862668267, 11948.641540753792, 12029.338386388483, 10337.0, 10885.727856803644, 10925.672229833117, 11167.664970050912, 11238.381888996184, 10067.496625168858, 11902.940485297519, 11911.927926486658, 12068.0, 12110.0, 10886.29239099456, 11806.0, 12077.0, 12250.938745306217, 12808.807867881802, 11190.94404527972, 11352.54589816398, 11376.715582110513, 11506.597269095877, 11942.283462992249], "value": 11459.250397561917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.631208509958, 1542.9691406171876, 1569.803774528184, 1574.559123445435, 1575.5194665626982, 9346.719598412059, 9556.283278754086, 10903.618373356934, 11390.829137562943, 11399.886001139976, 9917.760279965005, 10725.570977160904, 11076.667699968993, 11096.667099986993, 11111.333320000806, 2207.6026315263207, 2370.2415227127326, 2383.7735415135535, 2385.95228095438, 2388.0328466970905, 2323.4423738302853, 2346.495503466754, 2357.233898982829, 2368.3723813189517, 2368.8460250083776, 2324.8140148788143, 2338.485533182697, 2345.554344674515, 2346.1671106757112, 2349.4713689419827, 2303.884805759722, 2304.0092760113143, 2310.06442390832, 2316.81465482761, 2363.392892832873, 1938.5153711572107, 2325.860448373086, 2328.1502251678185, 2330.2892617751577, 2334.0780391745166, 11206.439678016148, 11226.66320010401, 11279.605213817476, 11301.886981130248, 11309.660710178709, 5635.633683810539, 5806.303243610751, 5824.068149096167, 5836.824895253149, 5875.618084824516, 3338.115399419132, 3411.181316484026, 3607.2244467439627, 3623.3840247158046, 3630.8547658093644, 1108.6009036746764, 1136.909047276216, 1184.8281999110168, 1185.1526158796416, 1188.6909403555137, 12745.426455809511, 14946.252687365588, 15506.0, 15596.922015389964, 15606.843931560652, 4526.253168227206, 4776.689515181502, 4835.323054772335, 4835.911919818012, 4885.413750349981, 12803.423845926956, 12809.103362764703, 12840.357982100857, 12865.807012894815, 12866.871331286568, 5811.215485909348, 5828.213191219216, 5843.620164689281, 5845.035569131131, 5850.1224816277045, 4392.780360981938, 4439.356293337448, 4844.4186697596515, 5107.846764597068, 5156.664816786897, 3881.8059097045034, 3984.900377490586, 4000.139969906484, 4014.6788256939376, 4070.1656160487028, 927.8979312275644, 1077.2405454154803, 1083.247143235444, 1087.5704096881686, 1096.1504833753745, 924.8150369925908, 930.7673081729567, 941.4210260689626, 947.9573419196153, 986.40815510693, 6473.967630161819, 6550.148480697479, 6638.871391863395, 6769.796906092825, 6948.826279342956, 907.0566610724904, 961.6586111930304, 980.9852852207223, 986.6497393425374, 1012.86832711747, 3401.9829900850336, 4170.332746760504, 4181.560936101666, 4213.578642135762, 4331.740095594275, 13386.929045676323, 13782.448702052006, 13808.240546769823, 13825.10136841102, 13865.792013119812, 13126.278054706892, 13516.459341626225, 13887.861121388858, 13892.374843132084, 13907.652308692364, 9963.750906227402, 10237.0, 10239.48802559869, 10241.180705543538, 10305.124064454605, 6486.383793539606, 6683.3984941353565, 7030.824229394306, 7031.753888613874, 7036.648167591497, 11999.980001699952, 12159.392030398269, 12312.692182695504, 12350.505979760708, 12429.192102513307, 12599.307038112991, 12614.180078294881, 12646.557370491988, 12738.745225095632, 12755.0, 8067.354611631173, 8302.377321700777, 9192.35653504275, 9213.539323033956, 9473.194778443634, 10016.699499015042, 10655.786884262116, 10751.978562036595, 10766.46167691628, 10793.136549076213, 8718.476891386537, 8756.168164024408, 8775.07861674515, 8847.292216622784, 8998.64005439775, 8620.698275560326, 8641.56792160402, 8643.611037503202, 8663.523506207219, 8665.306775458075, 7765.961170194113, 7797.0, 7803.92196078032, 7881.881771773314, 7903.762887113396, 4534.818607255673, 5992.850178745566, 6003.459688628044, 6023.819285421444, 6059.182010428712, 5962.612430192024, 6051.122587224916, 6221.813345599639, 6228.906566401598, 6286.245650521967], "value": 5120.23427958692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.83355656398055, 368.90961714379966, 380.65360521925044, 382.6498753640419, 388.8328018951851, 4324.524302326741, 4834.975825120874, 5135.04734777503, 5135.640505164631, 5149.691018538891, 4462.0, 4664.416947881515, 4850.151223535876, 4943.184374578191, 4962.379702537183, 3443.5695538057807, 3834.849545136462, 4180.979095104521, 4194.66442684586, 4206.49522057352, 3920.5491368492703, 4025.9532521544315, 4218.409422680827, 4233.491980962289, 4259.914801703964, 3723.3670276053, 3967.404889266604, 4230.280852255109, 4260.72305300156, 4261.8051703372785, 3903.9609603904023, 4162.042730172077, 4183.435236243099, 4225.281702110648, 4253.255680255943, 2925.429541239459, 3148.2758965437847, 3429.537012503305, 3861.899358682762, 3899.8635047773478, 4370.978145109286, 4696.7084051886, 4889.975550122226, 4932.842980492488, 4936.679115857458, 4031.677465802729, 4327.879339123838, 4635.745034023127, 4677.345171675968, 4785.808567657289, 4990.85210401606, 5059.721715305656, 5155.74221288934, 5466.426025267329, 5484.341878974508, 3811.447340135665, 4224.697539840794, 4357.0, 4368.191884501346, 4384.7369157850635, 4148.398482220091, 4675.7895894684825, 5226.398964119099, 5230.875361797193, 5853.004989151855, 3780.3573392523335, 4411.389842707389, 4437.622802061796, 4441.378207051015, 4458.35353873693, 4069.718038817763, 4374.978125109354, 4496.842610508616, 4511.954880451219, 4553.157665831832, 4841.3222148899185, 4891.6575839691595, 4912.778924948386, 4954.47321865851, 5034.917492739079, 4557.248054071041, 5057.570106540912, 5122.718250496258, 5413.593980451482, 5458.181272809111, 1482.9555113346617, 1521.987878061077, 1540.0836502281124, 1559.4463965292157, 1573.6931298396933, 920.8213486736987, 1086.918516076509, 1087.5377964365114, 1157.6064138193055, 1183.8046722290899, 4698.942737883949, 4789.521047895252, 4913.87715307113, 5053.2420136979745, 5150.407703114115, 5201.609879259071, 5281.973590132025, 5376.521456599467, 5489.670619762827, 5700.377826199994, 4377.912441751211, 4451.998300382388, 4497.144313361039, 4505.594496495266, 4942.298784874536, 2865.6561212654196, 2895.406441679451, 2900.202444327827, 2903.8693258803405, 2918.941621167607, 5054.368203974504, 5137.741253392943, 5733.827985160452, 5813.6221145625395, 5824.64102038675, 4932.457429682732, 5384.9730751346, 5418.512333889968, 5490.780368785284, 5492.642978206483, 4938.678985865908, 5027.99440111979, 5599.44005599445, 5640.448876558897, 5838.5621078418435, 5056.974715126401, 5668.51817595509, 5693.63714058661, 5725.2843394575675, 5729.914051289151, 4945.579625731853, 4974.5376038860995, 5572.192032155233, 5624.465675760796, 5671.631343962794, 4796.905995632867, 5121.642764667441, 5201.037808005531, 5220.686758794484, 5698.293310677395, 3819.1025109099896, 4145.564715704928, 4319.824928677357, 4443.0, 4505.842295519641, 4937.777799998937, 5138.118787152146, 5304.336957880265, 5346.0, 5422.566194704335, 4619.584237418514, 5419.4038655747045, 5449.809256675997, 5460.716731567999, 5462.371827239918, 5410.458954104558, 5416.916616676602, 5444.754986025559, 5458.454154584669, 5479.643823151482, 4470.664700147437, 4597.42532183477, 4693.601043911306, 4765.4996225395835, 5285.471452854684, 4774.045190961891, 5408.891177308721, 5455.3453585568395, 5511.641743286834, 5525.038611293094, 5033.219850923113, 5058.898822023612, 5176.378834539879, 5337.386200586827, 5359.383670877899], "value": 4103.764963739651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.8409607838233, 731.5803821466626, 751.5866273549547, 812.7608438751239, 826.6197549127401, 15210.391584336627, 16411.93322434041, 16428.342866285366, 16446.588835279123, 16447.424340148096, 16195.02829830211, 17179.74230386542, 17360.218790154442, 17640.647187056253, 17643.82356176441, 918.3020904112889, 942.8915674697395, 954.0221273194961, 958.3100167879115, 959.4722902403685, 798.5129071266523, 917.9816403671922, 939.8543225800012, 940.7742141885966, 951.9952400238024, 987.4815721746105, 992.2310209587555, 993.0417147452707, 993.8459538771466, 993.9652112176075, 977.8435450327913, 982.0277924854414, 990.9058639429243, 991.8363470027437, 992.3847214726916, 623.5790841182184, 628.2115944489682, 727.6798208788116, 734.4418242136015, 734.8273155808381, 16028.038317700975, 16386.918065409714, 16576.254068566945, 16758.916205419016, 16867.493975180765, 10889.618863339825, 13881.514147004907, 13882.652933676638, 14052.726201148027, 14340.211288379134, 11416.0, 11793.29240245588, 11827.079122651567, 11873.406329683568, 12113.33376664283, 3386.356592247465, 3679.3745063339297, 3680.0983758978955, 3680.6871415929677, 3802.277567262239, 66378.0043299351, 94007.0, 110331.44834275858, 111842.0, 117497.41251293775, 11659.708507287216, 11699.473523691455, 11707.239029463057, 11822.645320640395, 11852.288862668267, 23901.760982389955, 25342.0, 25443.0, 25485.872570637028, 25592.360190995376, 8319.0, 8342.16578342161, 8410.579471026424, 8448.0, 8594.269487093543, 4418.690691651554, 4465.531119232499, 4479.126570318822, 4484.663650226246, 4533.297338912474, 3526.717862570988, 3586.336527742376, 3596.4384011626607, 3631.1285291529844, 3636.61815509373, 653.2194028136427, 663.9767608133692, 666.7832954289876, 677.3057615943698, 679.6737565968363, 653.4478365781002, 671.1576970901488, 688.4870771275332, 698.8986596943415, 709.202147583968, 8250.3116429818, 10302.845457318146, 10482.37105773656, 10499.285881351792, 10651.467426628638, 684.1858188755365, 687.7730348984823, 707.2538471912079, 712.4798896805361, 722.3931897206372, 4663.906721865544, 5041.949580504222, 5052.141136006888, 5070.388809625989, 5112.795488180505, 98532.0, 104881.0, 104991.47504262583, 105940.0, 108728.0, 88602.0, 89911.55044224738, 91001.54499227594, 91653.62519562212, 93005.0, 52629.473705263226, 68043.0, 80141.39717205623, 81421.59289203635, 83188.0, 8338.0, 9744.902550974399, 9770.413775173512, 9830.311878168459, 9837.704868853945, 48680.756596216794, 48998.75500622474, 51431.0, 52361.47638523718, 53687.92624147573, 69676.30323696698, 69971.650141751, 71526.28473715404, 71866.28133718595, 73003.0, 12602.991760658942, 12808.423620937267, 12852.807207891701, 12919.418626162033, 13548.187108773505, 13140.80288795688, 14246.715065698421, 15247.695046098794, 15359.308831102404, 15372.308246128727, 13296.933515332361, 13757.587272381845, 13837.446502140205, 13893.235872027135, 14027.158370497802, 13228.338607989159, 13961.720765584834, 14087.0, 14107.929460352632, 14161.645958851112, 12898.0, 13436.261005644783, 13522.864771352553, 13686.52097176594, 13818.96357773191, 9913.157381622643, 10041.899581004389, 10119.595216191565, 10224.488775561342, 10335.793284134124, 8676.956615217136, 10171.898281017095, 10676.733081673021, 10972.0, 11405.372704501333], "value": 7731.761533014852, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 121.0, 121.0, 120.0, 119.0, 121.0, 121.0, 130.0, 179.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 106.0, 145.0, 182.0, 142.0, 130.0, 113.0, 125.0, 133.0, 115.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 199.0, 198.0, 206.0, 200.0, 199.0, 194.0, 196.0, 205.0, 265.0], "value": 205.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 62.0, 87.0, 62.0, 74.0, 63.0, 61.0, 76.0, 60.0], "value": 68.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 85.0, 73.0, 73.0, 71.0, 81.0, 71.0, 73.0, 83.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 90.0, 109.0, 135.0, 100.0, 135.0, 91.0, 136.0], "value": 106.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 123.0, 148.0, 153.0, 98.0, 97.0, 96.0, 97.0, 99.0, 106.0], "value": 112.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 90.0, 155.0, 99.0, 85.0, 139.0, 142.0, 77.0, 146.0, 141.0], "value": 119.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 74.0, 97.0, 107.0, 79.0, 68.0, 75.0, 84.0, 110.0], "value": 82.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 74.0, 63.0, 62.0, 60.0, 58.0, 74.0, 89.0, 88.0, 89.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 83.0, 69.0, 92.0, 103.0, 83.0, 87.0, 83.0, 93.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 175.0, 141.0, 151.0, 139.0, 145.0, 153.0, 148.0, 183.0, 139.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 178.0, 203.0, 168.0, 168.0, 185.0, 221.0, 173.0, 166.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 78.0, 85.0, 89.0, 78.0, 64.0, 59.0, 81.0, 100.0], "value": 75.3, "unit": "score"}]}]} 02:46:43 INFO - Return code: 0 02:46:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:43 ERROR - # TBPL SUCCESS # 02:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:43 INFO - 2017-04-28 02:46:43.543 screenresolution[30201:280696] starting screenresolution argv=screenresolution get 02:46:43 INFO - 2017-04-28 02:46:43.545 screenresolution[30201:280696] Display 0: 1600x1200x32@60 02:46:43 INFO - 2017-04-28 02:46:43.551 screenresolution[30202:280699] starting screenresolution argv=screenresolution list 02:46:43 INFO - Available Modes on Display 0 02:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:43 INFO - Intel Iris: 02:46:43 INFO - Chipset Model: Intel Iris 02:46:43 INFO - Type: GPU 02:46:43 INFO - Bus: Built-In 02:46:43 INFO - VRAM (Dynamic, Max): 1536 MB 02:46:43 INFO - Vendor: Intel (0x8086) 02:46:43 INFO - Device ID: 0x0a2e 02:46:43 INFO - Revision ID: 0x0009 02:46:43 INFO - Displays: 02:46:43 INFO - Display: 02:46:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:43 INFO - Display Serial Number: 1600x1200 60 02:46:43 INFO - Main Display: Yes 02:46:43 INFO - Mirror: Off 02:46:43 INFO - Online: Yes 02:46:43 INFO - Rotation: Supported 02:46:43 INFO - Return code: 0 02:46:43 INFO - Running post-action listener: _resource_record_post_action 02:46:43 INFO - [mozharness: 2017-04-28 09:46:43.788658Z] Finished run-tests step (success) 02:46:43 INFO - Running post-run listener: _resource_record_post_run 02:46:43 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 32817152; Write bytes: 510966272; Read time: 297; Write time: 1548 02:46:43 INFO - TinderboxPrint: CPU usage
54.5% 02:46:43 INFO - TinderboxPrint: I/O read bytes / time
32,817,152 / 297 02:46:43 INFO - TinderboxPrint: I/O write bytes / time
510,966,272 / 1,548 02:46:43 INFO - TinderboxPrint: CPU idle
2,183.6 (45.5%) 02:46:43 INFO - TinderboxPrint: CPU system
966.7 (20.1%) 02:46:43 INFO - TinderboxPrint: CPU user
1,651.3 (34.4%) 02:46:43 INFO - TinderboxPrint: Swap in / out
235,462,656 / 0 02:46:43 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 200483328; Write bytes: 202145280; Read time: 15816; Write time: 439 02:46:43 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 32817152; Write bytes: 298896384; Read time: 297; Write time: 1076 02:46:44 INFO - Running post-run listener: _upload_blobber_files 02:46:44 INFO - Blob upload gear active. 02:46:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:46:44 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:46:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:46:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:45 INFO - (blobuploader) - INFO - Done attempting. 02:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:46 INFO - (blobuploader) - INFO - Done attempting. 02:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:46:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:48 INFO - (blobuploader) - INFO - Done attempting. 02:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:50 INFO - (blobuploader) - INFO - Done attempting. 02:46:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:50 INFO - Return code: 0 02:46:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d05d5d1992228c3751e284cb67ad558d561353e967ceb546bf489c71e2dad457ac449c2a69a4ac5cdb89feb585ffd2451453aff5ae2e8fdc7476f72ee9edfedb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df4ba9db62bca8a0fd695bbb2ad793c0caa1ef78c11eb52bb9c7e57989b30c8b4e0ca47ff3c8777d24423021bf50a7bda87cd2da35bf8a4c86c8269fb0468498", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b16fec6b258edb10ccfece39a1901d84e1d5c0be973ddb0078865b7f143c09e8f7da4c1172a64adb64f4e7ee0ffa237acc5f91e0080a24206bb269e2bffab51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68022c961bfd6fbb6cb60bfdef58aca084b50a72b64cd00fa1f2b78dada9527adb1e1f3c207b159ac4e5b28f39066ebf67ceff49adba0ce64808e333754f44df"} 02:46:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:50 INFO - Contents: 02:46:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d05d5d1992228c3751e284cb67ad558d561353e967ceb546bf489c71e2dad457ac449c2a69a4ac5cdb89feb585ffd2451453aff5ae2e8fdc7476f72ee9edfedb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df4ba9db62bca8a0fd695bbb2ad793c0caa1ef78c11eb52bb9c7e57989b30c8b4e0ca47ff3c8777d24423021bf50a7bda87cd2da35bf8a4c86c8269fb0468498", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b16fec6b258edb10ccfece39a1901d84e1d5c0be973ddb0078865b7f143c09e8f7da4c1172a64adb64f4e7ee0ffa237acc5f91e0080a24206bb269e2bffab51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68022c961bfd6fbb6cb60bfdef58aca084b50a72b64cd00fa1f2b78dada9527adb1e1f3c207b159ac4e5b28f39066ebf67ceff49adba0ce64808e333754f44df"} 02:46:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:50 INFO - Copying logs to upload dir... 02:46:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.841122 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-28 02:46:51.389619) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 02:46:51.393779) ========= 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.axtAbcfLym/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.nZNyoRmPrl/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d05d5d1992228c3751e284cb67ad558d561353e967ceb546bf489c71e2dad457ac449c2a69a4ac5cdb89feb585ffd2451453aff5ae2e8fdc7476f72ee9edfedb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df4ba9db62bca8a0fd695bbb2ad793c0caa1ef78c11eb52bb9c7e57989b30c8b4e0ca47ff3c8777d24423021bf50a7bda87cd2da35bf8a4c86c8269fb0468498", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b16fec6b258edb10ccfece39a1901d84e1d5c0be973ddb0078865b7f143c09e8f7da4c1172a64adb64f4e7ee0ffa237acc5f91e0080a24206bb269e2bffab51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68022c961bfd6fbb6cb60bfdef58aca084b50a72b64cd00fa1f2b78dada9527adb1e1f3c207b159ac4e5b28f39066ebf67ceff49adba0ce64808e333754f44df"} build_url:https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010386 build_url: 'https://queue.taskcluster.net/v1/task/YX17cOkCRRewqZlu6uqquA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d05d5d1992228c3751e284cb67ad558d561353e967ceb546bf489c71e2dad457ac449c2a69a4ac5cdb89feb585ffd2451453aff5ae2e8fdc7476f72ee9edfedb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df4ba9db62bca8a0fd695bbb2ad793c0caa1ef78c11eb52bb9c7e57989b30c8b4e0ca47ff3c8777d24423021bf50a7bda87cd2da35bf8a4c86c8269fb0468498", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b16fec6b258edb10ccfece39a1901d84e1d5c0be973ddb0078865b7f143c09e8f7da4c1172a64adb64f4e7ee0ffa237acc5f91e0080a24206bb269e2bffab51c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68022c961bfd6fbb6cb60bfdef58aca084b50a72b64cd00fa1f2b78dada9527adb1e1f3c207b159ac4e5b28f39066ebf67ceff49adba0ce64808e333754f44df"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 02:46:51.434752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 02:46:51.435164) ========= 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.axtAbcfLym/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.nZNyoRmPrl/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 02:46:51.483280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 02:46:51.484089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 02:46:51.484413) ========= ========= Total master_lag: 0.97 =========