builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0316 starttime: 1492525338.21 results: success (0) buildid: 20170418064621 builduid: 2a9972d3f52a49939d2b46fafe928014 revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.209657) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.210080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.210362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.232506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.232795) ========= 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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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-18 07:22:18-- 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.08M=0.001s 2017-04-18 07:22:18 (8.08 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111684 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.367985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.368314) ========= 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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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.021491 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:18.416569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 07:22:18.417070) ========= 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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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-18 07:22:18,506 truncating revision to first 12 chars 2017-04-18 07:22:18,507 Setting DEBUG logging. 2017-04-18 07:22:18,507 attempt 1/10 2017-04-18 07:22:18,507 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-18 07:22:19,468 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.241705 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 07:22:19.682096) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:19.682435) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:19.682885) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:19.683555) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 07:22:19.707285) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-18 07:22:19.707599) ========= /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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:22:19 INFO - MultiFileLogger online at 20170418 07:22:19 in /builds/slave/test 07:22:19 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 07:22:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:22:19 INFO - {'append_to_log': False, 07:22:19 INFO - 'base_work_dir': '/builds/slave/test', 07:22:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:22:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:22:19 INFO - 'branch': 'Mozilla-Aurora', 07:22:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:22:19 INFO - 'config_files': ('talos/mac_config.py',), 07:22:19 INFO - 'default_actions': ('clobber', 07:22:19 INFO - 'read-buildbot-config', 07:22:19 INFO - 'download-and-extract', 07:22:19 INFO - 'populate-webroot', 07:22:19 INFO - 'create-virtualenv', 07:22:19 INFO - 'install', 07:22:19 INFO - 'run-tests'), 07:22:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:22:19 INFO - 'download_minidump_stackwalk': True, 07:22:19 INFO - 'download_symbols': 'ondemand', 07:22:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:22:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:22:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:22:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:22:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:22:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:22:19 INFO - 'gecko_profile': False, 07:22:19 INFO - 'gecko_profile_interval': 0, 07:22:19 INFO - 'installer_path': 'installer.exe', 07:22:19 INFO - 'log_level': 'info', 07:22:19 INFO - 'log_name': 'talos', 07:22:19 INFO - 'log_to_console': True, 07:22:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:22:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:22:19 INFO - 'opt_config_files': (), 07:22:19 INFO - 'pip_index': False, 07:22:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:22:19 INFO - 'cmd': ('bash', 07:22:19 INFO - '-c', 07:22:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:22:19 INFO - 'enabled': True, 07:22:19 INFO - 'halt_on_failure': False, 07:22:19 INFO - 'name': 'check_screen_resolution'},), 07:22:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:22:19 INFO - 'cmd': ('bash', 07:22:19 INFO - '-c', 07:22:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:22:19 INFO - 'enabled': True, 07:22:19 INFO - 'halt_on_failure': False, 07:22:19 INFO - 'name': 'check_screen_resolution'},), 07:22:19 INFO - 'run_cmd_checks_enabled': True, 07:22:19 INFO - 'suite': 'dromaeojs-e10s', 07:22:19 INFO - 'system_bits': '32', 07:22:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:22:19 INFO - 'title': 't-yosemite-r7-0316', 07:22:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:22:19 INFO - 'use_talos_json': True, 07:22:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:22:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:22:19 INFO - 'work_dir': 'build'} 07:22:19 INFO - [mozharness: 2017-04-18 14:22:19.916050Z] Running clobber step. 07:22:19 INFO - Running pre-action listener: _resource_record_pre_action 07:22:19 INFO - Running main action method: clobber 07:22:19 INFO - rmtree: /builds/slave/test/build 07:22:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:22:22 INFO - Running post-action listener: _resource_record_post_action 07:22:22 INFO - [mozharness: 2017-04-18 14:22:22.047260Z] Finished clobber step (success) 07:22:22 INFO - [mozharness: 2017-04-18 14:22:22.047503Z] Running read-buildbot-config step. 07:22:22 INFO - Running pre-action listener: _resource_record_pre_action 07:22:22 INFO - Running main action method: read_buildbot_config 07:22:22 INFO - Using buildbot properties: 07:22:22 INFO - { 07:22:22 INFO - "project": "", 07:22:22 INFO - "product": "firefox", 07:22:22 INFO - "script_repo_revision": "production", 07:22:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:22:22 INFO - "repository": "", 07:22:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:22:22 INFO - "buildid": "20170418064621", 07:22:22 INFO - "pgo_build": "False", 07:22:22 INFO - "basedir": "/builds/slave/test", 07:22:22 INFO - "buildnumber": 43, 07:22:22 INFO - "slavename": "t-yosemite-r7-0316", 07:22:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:22:22 INFO - "platform": "yosemite_r7", 07:22:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:22:22 INFO - "branch": "mozilla-aurora", 07:22:22 INFO - "repo_path": "releases/mozilla-aurora", 07:22:22 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 07:22:22 INFO - "stage_platform": "macosx64", 07:22:22 INFO - "builduid": "2a9972d3f52a49939d2b46fafe928014", 07:22:22 INFO - "slavebuilddir": "test" 07:22:22 INFO - } 07:22:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 07:22:22 INFO - Running post-action listener: _resource_record_post_action 07:22:22 INFO - [mozharness: 2017-04-18 14:22:22.053200Z] Finished read-buildbot-config step (success) 07:22:22 INFO - [mozharness: 2017-04-18 14:22:22.053420Z] Running download-and-extract step. 07:22:22 INFO - Running pre-action listener: _resource_record_pre_action 07:22:22 INFO - Running main action method: download_and_extract 07:22:22 INFO - mkdir: /builds/slave/test/build/tests 07:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:22:22 INFO - trying https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 07:22:22 INFO - Downloading https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/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 07:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/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 07:22:23 INFO - Downloaded 1199 bytes. 07:22:23 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:22:23 INFO - Using the following test package requirements: 07:22:23 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:22:23 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 07:22:23 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 07:22:23 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'jsshell-mac.zip'], 07:22:23 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 07:22:23 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:22:23 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 07:22:23 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 07:22:23 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 07:22:23 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:22:23 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 07:22:23 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:22:24 INFO - Expected file size: 51791238 07:22:24 INFO - Obtained file size: 51791238 07:22:40 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 07:22:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:22:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:22:40 INFO - Fetch https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:22:42 INFO - Expected file size: 51791238 07:22:42 INFO - Obtained file size: 51791238 07:22:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 07:22:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:22:58 INFO - Fetch https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 07:22:59 INFO - Expected file size: 14404424 07:22:59 INFO - Obtained file size: 14404424 07:22:59 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')]} 07:22:59 INFO - trying https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:22:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 07:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/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 07:23:02 INFO - Downloaded 74746774 bytes. 07:23:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:23:02 INFO - mkdir: /builds/slave/test/properties 07:23:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:23:02 INFO - Writing to file /builds/slave/test/properties/build_url 07:23:02 INFO - Contents: 07:23:02 INFO - build_url:https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:23:02 INFO - Running post-action listener: _resource_record_post_action 07:23:02 INFO - Running post-action listener: set_extra_try_arguments 07:23:02 INFO - [mozharness: 2017-04-18 14:23:02.932972Z] Finished download-and-extract step (success) 07:23:02 INFO - [mozharness: 2017-04-18 14:23:02.933124Z] Running populate-webroot step. 07:23:02 INFO - Running pre-action listener: _resource_record_pre_action 07:23:02 INFO - Running main action method: populate_webroot 07:23:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:23:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:23:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:23:02 INFO - '--tppagecycles', 07:23:02 INFO - '7'], 07:23:02 INFO - 'tests': ['tsvgm']}}, 07:23:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:23:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:23:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:23:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:23:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['damp', 'tps']}, 07:23:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'tests': ['damp', 'tps']}, 07:23:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['dromaeo_dom']}, 07:23:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:23:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['basic_compositor_video']}, 07:23:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:23:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['a11yr', 07:23:02 INFO - 'ts_paint', 07:23:02 INFO - 'tpaint', 07:23:02 INFO - 'sessionrestore', 07:23:02 INFO - 'sessionrestore_no_auto_restore', 07:23:02 INFO - 'tabpaint']}, 07:23:02 INFO - 'other-e10s': {'tests': ['a11yr', 07:23:02 INFO - 'ts_paint', 07:23:02 INFO - 'tpaint', 07:23:02 INFO - 'sessionrestore', 07:23:02 INFO - 'sessionrestore_no_auto_restore', 07:23:02 INFO - 'tabpaint']}, 07:23:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:23:02 INFO - 'ts_paint', 07:23:02 INFO - 'tpaint', 07:23:02 INFO - 'sessionrestore', 07:23:02 INFO - 'sessionrestore_no_auto_restore', 07:23:02 INFO - 'tabpaint']}, 07:23:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:23:02 INFO - 'ts_paint', 07:23:02 INFO - 'tpaint', 07:23:02 INFO - 'sessionrestore', 07:23:02 INFO - 'sessionrestore_no_auto_restore', 07:23:02 INFO - 'tabpaint']}, 07:23:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['a11yr', 07:23:02 INFO - 'ts_paint', 07:23:02 INFO - 'tpaint', 07:23:02 INFO - 'sessionrestore', 07:23:02 INFO - 'sessionrestore_no_auto_restore', 07:23:02 INFO - 'tabpaint']}, 07:23:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['a11yr', 07:23:02 INFO - 'ts_paint', 07:23:02 INFO - 'tpaint', 07:23:02 INFO - 'sessionrestore', 07:23:02 INFO - 'sessionrestore_no_auto_restore', 07:23:02 INFO - 'tabpaint']}, 07:23:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['tsvgx', 07:23:02 INFO - 'tsvgr_opacity', 07:23:02 INFO - 'tart', 07:23:02 INFO - 'tscrollx', 07:23:02 INFO - 'cart', 07:23:02 INFO - 'tsvg_static']}, 07:23:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:23:02 INFO - 'tsvgr_opacity', 07:23:02 INFO - 'tart', 07:23:02 INFO - 'tscrollx', 07:23:02 INFO - 'cart', 07:23:02 INFO - 'tsvg_static']}, 07:23:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'talos_options': ['--disable-e10s'], 07:23:02 INFO - 'tests': ['tp5o']}, 07:23:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:23:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'talos_options': ['--disable-e10s', 07:23:02 INFO - '--xperf_path', 07:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:02 INFO - 'tests': ['tp5n']}, 07:23:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:23:02 INFO - 'talos_options': ['--xperf_path', 07:23:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:02 INFO - 'tests': ['tp5n']}}, 07:23:02 INFO - 'talos.zip': {'path': '', 07:23:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:23:02 INFO - Running post-action listener: _resource_record_post_action 07:23:02 INFO - [mozharness: 2017-04-18 14:23:02.951468Z] Finished populate-webroot step (success) 07:23:02 INFO - [mozharness: 2017-04-18 14:23:02.951600Z] Running create-virtualenv step. 07:23:02 INFO - Running pre-action listener: _resource_record_pre_action 07:23:02 INFO - Running main action method: create_virtualenv 07:23:02 INFO - Creating virtualenv /builds/slave/test/build/venv 07:23:02 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 07:23:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:23:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:23:03 INFO - Using real prefix '/tools/python27' 07:23:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:23:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:23:06 INFO - Installing pip.................done. 07:23:06 INFO - Return code: 0 07:23:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:23:06 INFO - Reading from file tmpfile_stdout 07:23:06 INFO - Output received: 07:23:06 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) 07:23:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:06 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:06 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 07:23:06 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 07:23:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:06 INFO - 'HOME': '/Users/cltbld', 07:23:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:06 INFO - 'LOGNAME': 'cltbld', 07:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:06 INFO - 'MOZ_NO_REMOTE': '1', 07:23:06 INFO - 'NO_EM_RESTART': '1', 07:23:06 INFO - 'PAGER': '/bin/cat', 07:23:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:06 INFO - 'PWD': '/builds/slave/test', 07:23:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:06 INFO - 'SHELL': '/bin/bash', 07:23:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:06 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:06 INFO - 'USER': 'cltbld', 07:23:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:06 INFO - 'XPC_FLAGS': '0x0', 07:23:06 INFO - 'XPC_SERVICE_NAME': '0', 07:23:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:07 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 07:23:07 INFO - Cleaning up... 07:23:07 INFO - Return code: 0 07:23:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:23:07 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')]} 07:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:07 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')]} 07:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:07 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:07 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 07:23:07 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 07:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:07 INFO - 'HOME': '/Users/cltbld', 07:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:07 INFO - 'LOGNAME': 'cltbld', 07:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:07 INFO - 'MOZ_NO_REMOTE': '1', 07:23:07 INFO - 'NO_EM_RESTART': '1', 07:23:07 INFO - 'PAGER': '/bin/cat', 07:23:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:07 INFO - 'PWD': '/builds/slave/test', 07:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:07 INFO - 'SHELL': '/bin/bash', 07:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:07 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:07 INFO - 'USER': 'cltbld', 07:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:07 INFO - 'XPC_FLAGS': '0x0', 07:23:07 INFO - 'XPC_SERVICE_NAME': '0', 07:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:07 INFO - Downloading/unpacking psutil>=3.1.1 07:23:07 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 07:23:07 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 07:23:07 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 07:23:07 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 07:23:07 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 07:23:07 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 07:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:10 INFO - Installing collected packages: psutil 07:23:10 INFO - Running setup.py install for psutil 07:23:11 INFO - building 'psutil._psutil_osx' extension 07:23:11 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 07:23:11 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 07:23:11 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 07:23:11 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 07:23:11 INFO - building 'psutil._psutil_posix' extension 07:23:11 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 07:23:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:23:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:23:11 INFO - ^ 07:23:11 INFO - 1 warning generated. 07:23:11 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 07:23:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:11 INFO - Successfully installed psutil 07:23:11 INFO - Cleaning up... 07:23:11 INFO - Return code: 0 07:23:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:23:11 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')]} 07:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:11 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')]} 07:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:11 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:11 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 07:23:11 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 07:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:11 INFO - 'HOME': '/Users/cltbld', 07:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:11 INFO - 'LOGNAME': 'cltbld', 07:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:11 INFO - 'MOZ_NO_REMOTE': '1', 07:23:11 INFO - 'NO_EM_RESTART': '1', 07:23:11 INFO - 'PAGER': '/bin/cat', 07:23:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:11 INFO - 'PWD': '/builds/slave/test', 07:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:11 INFO - 'SHELL': '/bin/bash', 07:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:11 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:11 INFO - 'USER': 'cltbld', 07:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:11 INFO - 'XPC_FLAGS': '0x0', 07:23:11 INFO - 'XPC_SERVICE_NAME': '0', 07:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:23:12 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 07:23:12 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 07:23:12 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 07:23:12 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 07:23:12 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 07:23:12 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 07:23:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:23:14 INFO - Installing collected packages: mozsystemmonitor 07:23:14 INFO - Running setup.py install for mozsystemmonitor 07:23:14 INFO - Successfully installed mozsystemmonitor 07:23:14 INFO - Cleaning up... 07:23:15 INFO - Return code: 0 07:23:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:15 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:15 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 07:23:15 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 07:23:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:15 INFO - 'HOME': '/Users/cltbld', 07:23:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:15 INFO - 'LOGNAME': 'cltbld', 07:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:15 INFO - 'MOZ_NO_REMOTE': '1', 07:23:15 INFO - 'NO_EM_RESTART': '1', 07:23:15 INFO - 'PAGER': '/bin/cat', 07:23:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:15 INFO - 'PWD': '/builds/slave/test', 07:23:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:15 INFO - 'SHELL': '/bin/bash', 07:23:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:15 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:15 INFO - 'USER': 'cltbld', 07:23:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:15 INFO - 'XPC_FLAGS': '0x0', 07:23:15 INFO - 'XPC_SERVICE_NAME': '0', 07:23:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:16 INFO - Downloading/unpacking jsonschema==2.5.1 07:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:23:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:23:19 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 07:23:19 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 07:23:19 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 07:23:19 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 07:23:19 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 07:23:19 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 07:23:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:23:19 INFO - warning: no files found matching '*.txt' 07:23:19 INFO - no previously-included directories found matching 'build' 07:23:19 INFO - no previously-included directories found matching 'dist' 07:23:19 INFO - no previously-included directories found matching '.git*' 07:23:19 INFO - Installing collected packages: jsonschema, functools32 07:23:19 INFO - Running setup.py install for functools32 07:23:19 INFO - warning: no files found matching '*.txt' 07:23:19 INFO - no previously-included directories found matching 'build' 07:23:19 INFO - no previously-included directories found matching 'dist' 07:23:19 INFO - no previously-included directories found matching '.git*' 07:23:19 INFO - Successfully installed jsonschema functools32 07:23:19 INFO - Cleaning up... 07:23:20 INFO - Return code: 0 07:23:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:23:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:20 INFO - 'HOME': '/Users/cltbld', 07:23:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:20 INFO - 'LOGNAME': 'cltbld', 07:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:20 INFO - 'MOZ_NO_REMOTE': '1', 07:23:20 INFO - 'NO_EM_RESTART': '1', 07:23:20 INFO - 'PAGER': '/bin/cat', 07:23:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:20 INFO - 'PWD': '/builds/slave/test', 07:23:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:20 INFO - 'SHELL': '/bin/bash', 07:23:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:20 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:20 INFO - 'USER': 'cltbld', 07:23:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:20 INFO - 'XPC_FLAGS': '0x0', 07:23:20 INFO - 'XPC_SERVICE_NAME': '0', 07:23:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:23:20 INFO - Cleaning up... 07:23:20 INFO - Return code: 0 07:23:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:23:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:20 INFO - 'HOME': '/Users/cltbld', 07:23:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:20 INFO - 'LOGNAME': 'cltbld', 07:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:20 INFO - 'MOZ_NO_REMOTE': '1', 07:23:20 INFO - 'NO_EM_RESTART': '1', 07:23:20 INFO - 'PAGER': '/bin/cat', 07:23:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:20 INFO - 'PWD': '/builds/slave/test', 07:23:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:20 INFO - 'SHELL': '/bin/bash', 07:23:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:20 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:20 INFO - 'USER': 'cltbld', 07:23:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:20 INFO - 'XPC_FLAGS': '0x0', 07:23:20 INFO - 'XPC_SERVICE_NAME': '0', 07:23:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:23 INFO - Downloading blobuploader-1.2.4.tar.gz 07:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:23:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:23:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 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 07:23:23 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 07:23:24 INFO - Downloading docopt-0.6.1.tar.gz 07:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:23:24 INFO - Running setup.py install for blobuploader 07:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:23:24 INFO - Running setup.py install for requests 07:23:25 INFO - Running setup.py install for docopt 07:23:25 INFO - Successfully installed blobuploader requests docopt 07:23:25 INFO - Cleaning up... 07:23:25 INFO - Return code: 0 07:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:25 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 07:23:25 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 07:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:25 INFO - 'HOME': '/Users/cltbld', 07:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:25 INFO - 'LOGNAME': 'cltbld', 07:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:25 INFO - 'MOZ_NO_REMOTE': '1', 07:23:25 INFO - 'NO_EM_RESTART': '1', 07:23:25 INFO - 'PAGER': '/bin/cat', 07:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:25 INFO - 'PWD': '/builds/slave/test', 07:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:25 INFO - 'SHELL': '/bin/bash', 07:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:25 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:25 INFO - 'USER': 'cltbld', 07:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:25 INFO - 'XPC_FLAGS': '0x0', 07:23:25 INFO - 'XPC_SERVICE_NAME': '0', 07:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:25 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-NB2ldV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:25 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-Efgpwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:25 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-r9YzYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-xASXT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-PxeKzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-rYsT8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-voZjfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-6eU3yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-vDnK0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-DWg3X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-HqGYMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-DHSDis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:26 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-NqXN4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:27 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-dLP54E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:27 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-iBk5sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:27 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-pCIMAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:27 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-7kK011-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:23:27 INFO - Running setup.py install for manifestparser 07:23:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:23:27 INFO - Running setup.py install for mozcrash 07:23:27 INFO - Running setup.py install for mozdebug 07:23:27 INFO - Running setup.py install for mozdevice 07:23:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Running setup.py install for mozfile 07:23:28 INFO - Running setup.py install for mozhttpd 07:23:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Running setup.py install for mozinfo 07:23:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Running setup.py install for mozInstall 07:23:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Running setup.py install for mozleak 07:23:28 INFO - Running setup.py install for mozlog 07:23:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:23:28 INFO - Running setup.py install for moznetwork 07:23:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:23:29 INFO - Running setup.py install for mozprocess 07:23:29 INFO - Running setup.py install for mozprofile 07:23:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:23:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:23:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:23:29 INFO - Running setup.py install for mozrunner 07:23:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:23:29 INFO - Running setup.py install for mozscreenshot 07:23:29 INFO - Running setup.py install for moztest 07:23:29 INFO - Running setup.py install for mozversion 07:23:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:23:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:23:30 INFO - Cleaning up... 07:23:30 INFO - Return code: 0 07:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:30 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:30 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 07:23:30 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 07:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:30 INFO - 'HOME': '/Users/cltbld', 07:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:30 INFO - 'LOGNAME': 'cltbld', 07:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:30 INFO - 'MOZ_NO_REMOTE': '1', 07:23:30 INFO - 'NO_EM_RESTART': '1', 07:23:30 INFO - 'PAGER': '/bin/cat', 07:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:30 INFO - 'PWD': '/builds/slave/test', 07:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:30 INFO - 'SHELL': '/bin/bash', 07:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:30 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:30 INFO - 'USER': 'cltbld', 07:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:30 INFO - 'XPC_FLAGS': '0x0', 07:23:30 INFO - 'XPC_SERVICE_NAME': '0', 07:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-ZZN32D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:30 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)) 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-12WNy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:30 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)) 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-hmthNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:30 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)) 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-E8GtB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:30 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)) 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-xe7bou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:30 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)) 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-fYKuD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:30 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)) 07:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:30 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-mplv4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-rCvvht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-mgaupd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-BQ7sSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-IX2MLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-SAElWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-jNEo0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-NNAYNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-mcEBBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:31 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)) 07:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:31 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-VfY23Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:32 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)) 07:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:32 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-vRjj9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:32 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)) 07:23:32 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)) 07:23:32 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)) 07:23:32 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)) 07:23:32 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)) 07:23:32 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)) 07:23:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:34 INFO - Downloading blessings-1.6.tar.gz 07:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:23:34 INFO - Installing collected packages: blessings 07:23:34 INFO - Running setup.py install for blessings 07:23:34 INFO - Successfully installed blessings 07:23:34 INFO - Cleaning up... 07:23:35 INFO - Return code: 0 07:23:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:23:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:35 INFO - Reading from file tmpfile_stdout 07:23:35 INFO - Current package versions: 07:23:35 INFO - blessings == 1.6 07:23:35 INFO - blobuploader == 1.2.4 07:23:35 INFO - docopt == 0.6.1 07:23:35 INFO - functools32 == 3.2.3-2 07:23:35 INFO - jsonschema == 2.5.1 07:23:35 INFO - manifestparser == 1.1 07:23:35 INFO - mozInstall == 1.12 07:23:35 INFO - mozcrash == 1.0 07:23:35 INFO - mozdebug == 0.1 07:23:35 INFO - mozdevice == 0.49 07:23:35 INFO - mozfile == 1.2 07:23:35 INFO - mozhttpd == 0.7 07:23:35 INFO - mozinfo == 0.9 07:23:35 INFO - mozleak == 0.1 07:23:35 INFO - mozlog == 3.4 07:23:35 INFO - moznetwork == 0.27 07:23:35 INFO - mozprocess == 0.25 07:23:35 INFO - mozprofile == 0.28 07:23:35 INFO - mozrunner == 6.13 07:23:35 INFO - mozscreenshot == 0.1 07:23:35 INFO - mozsystemmonitor == 0.3 07:23:35 INFO - moztest == 0.8 07:23:35 INFO - mozversion == 1.4 07:23:35 INFO - psutil == 3.1.1 07:23:35 INFO - requests == 1.2.3 07:23:35 INFO - wsgiref == 0.1.2 07:23:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:35 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:35 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 07:23:35 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 07:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:35 INFO - 'HOME': '/Users/cltbld', 07:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:35 INFO - 'LOGNAME': 'cltbld', 07:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:35 INFO - 'MOZ_NO_REMOTE': '1', 07:23:35 INFO - 'NO_EM_RESTART': '1', 07:23:35 INFO - 'PAGER': '/bin/cat', 07:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:35 INFO - 'PWD': '/builds/slave/test', 07:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:35 INFO - 'SHELL': '/bin/bash', 07:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:35 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:35 INFO - 'USER': 'cltbld', 07:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:35 INFO - 'XPC_FLAGS': '0x0', 07:23:35 INFO - 'XPC_SERVICE_NAME': '0', 07:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 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)) 07:23:35 INFO - Cleaning up... 07:23:35 INFO - Return code: 0 07:23:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:35 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 0x107a68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc160d8aee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, '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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 07:23:35 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 07:23:35 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 07:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:35 INFO - 'HOME': '/Users/cltbld', 07:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:35 INFO - 'LOGNAME': 'cltbld', 07:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:35 INFO - 'MOZ_NO_REMOTE': '1', 07:23:35 INFO - 'NO_EM_RESTART': '1', 07:23:35 INFO - 'PAGER': '/bin/cat', 07:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:35 INFO - 'PWD': '/builds/slave/test', 07:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:35 INFO - 'SHELL': '/bin/bash', 07:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:35 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:35 INFO - 'USER': 'cltbld', 07:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:35 INFO - 'XPC_FLAGS': '0x0', 07:23:35 INFO - 'XPC_SERVICE_NAME': '0', 07:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:23:35 INFO - Cleaning up... 07:23:35 INFO - Return code: 0 07:23:35 INFO - Running post-action listener: _resource_record_post_action 07:23:35 INFO - Running post-action listener: _start_resource_monitoring 07:23:35 INFO - Starting resource monitoring. 07:23:35 INFO - [mozharness: 2017-04-18 14:23:35.919234Z] Finished create-virtualenv step (success) 07:23:35 INFO - [mozharness: 2017-04-18 14:23:35.920229Z] Running install step. 07:23:35 INFO - Running pre-action listener: _resource_record_pre_action 07:23:35 INFO - Running main action method: install 07:23:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:36 INFO - Reading from file tmpfile_stdout 07:23:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:23:36 INFO - Reading from file tmpfile_stdout 07:23:36 INFO - Output received: 07:23:36 INFO - Usage: mozinstall [options] installer 07:23:36 INFO - Options: 07:23:36 INFO - -h, --help show this help message and exit 07:23:36 INFO - -d DEST, --destination=DEST 07:23:36 INFO - Directory to install application into. [default: 07:23:36 INFO - "/builds/slave/test"] 07:23:36 INFO - --app=APP Application being installed. [default: firefox] 07:23:36 INFO - mkdir: /builds/slave/test/build/application 07:23:36 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'] 07:23:36 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 07:23:56 INFO - Reading from file tmpfile_stdout 07:23:56 INFO - Output received: 07:23:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:23:56 INFO - Running post-action listener: _resource_record_post_action 07:23:56 INFO - [mozharness: 2017-04-18 14:23:56.732646Z] Finished install step (success) 07:23:56 INFO - [mozharness: 2017-04-18 14:23:56.732763Z] Running run-tests step. 07:23:56 INFO - Running pre-action listener: _resource_record_pre_action 07:23:56 INFO - Running main action method: run_tests 07:23:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:23:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:23:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:23:56 INFO - 2017-04-18 07:23:56.747 screenresolution[1973:19275] starting screenresolution argv=screenresolution get 07:23:56 INFO - 2017-04-18 07:23:56.750 screenresolution[1973:19275] Display 0: 1600x1200x32@60 07:23:56 INFO - 2017-04-18 07:23:56.756 screenresolution[1974:19277] starting screenresolution argv=screenresolution list 07:23:56 INFO - Available Modes on Display 0 07:23:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:23:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:23:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:23:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:23:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:23:56 INFO - Intel Iris: 07:23:56 INFO - Chipset Model: Intel Iris 07:23:56 INFO - Type: GPU 07:23:56 INFO - Bus: Built-In 07:23:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:23:56 INFO - Vendor: Intel (0x8086) 07:23:56 INFO - Device ID: 0x0a2e 07:23:56 INFO - Revision ID: 0x0009 07:23:56 INFO - Displays: 07:23:56 INFO - Display: 07:23:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:23:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:23:56 INFO - Display Serial Number: 1600x1200 60 07:23:56 INFO - Main Display: Yes 07:23:56 INFO - Mirror: Off 07:23:56 INFO - Online: Yes 07:23:56 INFO - Rotation: Supported 07:23:56 INFO - Return code: 0 07:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:23:56 INFO - Python 2.7.3 07:23:56 INFO - Return code: 0 07:23:56 INFO - grabbing minidump binary from tooltool 07:23:56 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')]} 07:23:56 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 0x107846d30>, '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 0x10776ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10783bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:23:56 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 07:23:56 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 07:23:56 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 07:23:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:23:57 INFO - Return code: 0 07:23:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:23:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:23:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:23:57 INFO - ENV: RUST_BACKTRACE is now 1 07:23:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:23:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:23:57 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/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 07:23:57 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/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0316 --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 07:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JKpSZS6Yqw/Render', 07:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:57 INFO - 'HOME': '/Users/cltbld', 07:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:57 INFO - 'LOGNAME': 'cltbld', 07:23:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:23:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:57 INFO - 'MOZ_NO_REMOTE': '1', 07:23:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:23:57 INFO - 'NO_EM_RESTART': '1', 07:23:57 INFO - 'PAGER': '/bin/cat', 07:23:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:57 INFO - 'PWD': '/builds/slave/test', 07:23:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:57 INFO - 'RUST_BACKTRACE': '1', 07:23:57 INFO - 'SHELL': '/bin/bash', 07:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pwLxBG8gpp/Listeners', 07:23:57 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 07:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:57 INFO - 'USER': 'cltbld', 07:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:57 INFO - 'XPC_FLAGS': '0x0', 07:23:57 INFO - 'XPC_SERVICE_NAME': '0', 07:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:57 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/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 07:23:57 INFO - mozversion application_buildid: 20170418064621 07:23:57 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 07:23:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:23:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:23:57 INFO - mozversion application_name: Firefox 07:23:57 INFO - mozversion application_remotingname: firefox-dev 07:23:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:23:57 INFO - mozversion application_vendor: Mozilla 07:23:57 INFO - mozversion application_version: 54.0a2 07:23:57 INFO - mozversion platform_buildid: 20170418064621 07:23:57 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 07:23:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:23:57 INFO - mozversion platform_version: 54.0a2 07:23:57 INFO - using testdate: 1492525437 07:23:57 INFO - actual date: 1492525437 07:23:57 INFO - starting webserver on 'localhost:54229' 07:23:57 INFO - SUITE-START | Running 2 tests 07:23:57 INFO - TEST-START | dromaeo_css 07:23:57 INFO - operating with platform_type : mac_ 07:23:57 INFO - Initialising browser for dromaeo_css test... 07:23:57 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmp03izIE/profile http://localhost:54229/getInfo.html) 07:23:59 INFO - PROCESS | 1984 | 2017-04-18 07:23:59.964 plugin-container[1986:19446] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 07:23:59 INFO - PROCESS | 1984 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:23:59 INFO - PROCESS | 1984 | 2017-04-18 07:23:59.967 plugin-container[1986:19446] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 07:23:59 INFO - PROCESS | 1984 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:23:59 INFO - PROCESS | 1984 | 2017-04-18 07:23:59.967 plugin-container[1986:19446] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:24:00 INFO - PROCESS | 1984 | __metrics Screen width/height:1600/1200 07:24:00 INFO - PROCESS | 1984 | colorDepth:24 07:24:00 INFO - PROCESS | 1984 | Browser inner width/height: 1024/689 07:24:00 INFO - PROCESS | 1984 | __metrics 07:24:00 ERROR - PROCESS | 1984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 07:24:00 INFO - TEST-INFO | 1984: exit 0 07:24:00 INFO - Browser initialized. 07:24:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:24:00 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmp03izIE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:03 INFO - PROCESS | 1987 | 2017-04-18 07:24:03.389 plugin-container[1988:19571] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 07:24:03 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:24:03 INFO - PROCESS | 1987 | 2017-04-18 07:24:03.392 plugin-container[1988:19571] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e13, name = 'com.apple.CFPasteboardClient' 07:24:03 INFO - PROCESS | 1987 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:24:03 INFO - PROCESS | 1987 | 2017-04-18 07:24:03.392 plugin-container[1988:19571] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:24:13 INFO - PROCESS | 1987 | RSS: Main: 221097984 07:24:13 INFO - PROCESS | 1987 | 07:27:16 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54229/tests/dromaeo/cssquery-ext.html) 07:27:18 INFO - PROCESS | 1987 | RSS: Main: 238641152 07:27:18 INFO - PROCESS | 1987 | 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | A coding exception was thrown and uncaught in a Task. 07:29:01 INFO - PROCESS | 1987 | 07:29:01 ERROR - PROCESS | 1987 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:29:01 INFO - PROCESS | 1987 | Full stack: 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | A coding exception was thrown and uncaught in a Task. 07:29:01 INFO - PROCESS | 1987 | 07:29:01 ERROR - PROCESS | 1987 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:29:01 INFO - PROCESS | 1987 | Full stack: 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | A coding exception was thrown and uncaught in a Task. 07:29:01 INFO - PROCESS | 1987 | 07:29:01 ERROR - PROCESS | 1987 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:29:01 INFO - PROCESS | 1987 | Full stack: 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | ************************* 07:29:01 INFO - PROCESS | 1987 | A coding exception was thrown and uncaught in a Task. 07:29:01 INFO - PROCESS | 1987 | 07:29:01 ERROR - PROCESS | 1987 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:29:01 INFO - PROCESS | 1987 | Full stack: 07:29:01 INFO - PROCESS | 1987 | ************************* 07:30:20 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-ext.html (next: http://localhost:54229/tests/dromaeo/cssquery-jquery.html) 07:30:20 INFO - PROCESS | 1987 | RSS: Main: 249126912 07:30:20 INFO - PROCESS | 1987 | 07:33:23 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54229/tests/dromaeo/cssquery-mootools.html) 07:33:23 INFO - PROCESS | 1987 | RSS: Main: 256794624 07:33:23 INFO - PROCESS | 1987 | 07:36:25 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54229/tests/dromaeo/cssquery-prototype.html) 07:36:26 INFO - PROCESS | 1987 | RSS: Main: 253054976 07:36:26 INFO - PROCESS | 1987 | 07:39:29 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54229/tests/dromaeo/cssquery-yui.html) 07:39:29 INFO - PROCESS | 1987 | RSS: Main: 258031616 07:39:29 INFO - PROCESS | 1987 | 07:42:32 INFO - PROCESS | 1987 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-yui.html (next: http://localhost:54229/tests/dromaeo/cssquery-dojo.html) 07:42:33 INFO - PROCESS | 1987 | RSS: Main: 254377984 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | __start_tp_report 07:42:33 INFO - PROCESS | 1987 | _x_x_mozilla_page_load 07:42:33 INFO - PROCESS | 1987 | _x_x_mozilla_page_load_details 07:42:33 INFO - PROCESS | 1987 | |i|pagename|runs| 07:42:33 INFO - PROCESS | 1987 | |0;dojo.html;3386.0180547641185;3409.079548521899;3419.281950790334;3440.397930362187;3442.3459542686905;5763.250777398937;5839.591228613998;5883.85290367741;5935.554833387502;5950.523958083354;4771.33201351811;5887.293524777022;5900.144479050535;5905.852353691149;5926.466618004379;5332.413434522199;5354.464553544633;5399.811006614769;5439.782408703647;5455.727213639322;5452.4274951130155;5455.481729235736;5463.890722185554;5478.315210598676;5501.339839219279;5251.973740131294;5261.39493958194;5430.402655707869;5448.155535891943;5462.907418516293;5379.81170659027;5411.594130440213;5464.808731694372;5501.312335958005;5511.807086751985;5274.683518988834;5355.410904800468;5357.732113394315;5366.114591092465;5402.9729851350885;5627.831165065014;5942.108683697436;5943.197668314765;6026.186464827236;6039.063945088475;6217.285012223561;6218.440340369343;6263.31103578606;6265.122882796412;6269;6410.743570257184;6446.258680251784;6455.160829092235;6458.838529036765;6462.579932304385;6063.181470501514;6141.477974372184;6142.662153581551;6160.691965401802;6163.19878415803;6213.627182369072;6308.842278943063;6394.968025159845;6445;6456.612603243821;6188.969055154786;6193.225846769154;6284.151639528696;6293.685315734195;6296.118543403927;6361.872762544724;6402.48780097591;6420.550561460746;6426.228852537725;6430.678466076677;6179.3820617937845;6327.462165715966;6354.3010268870385;6359;6362.395572420613;6206.596571222856;6222.564420490522;6260.655663938436;6268.435840774352;6271.592346497463;5170.922436163461;5172.017316709813;5178.844634660966;5184.274201611777;5213.713245771443;4592.632589392841;4618.445786505641;4628.791704373311;4638.304254361873;4643.164230438486;5778.971105144447;5779.508741756998;5783.59514833966;5803.332616749043;5964;6264.655443950535;6279.058141278845;6355.555111142268;6356.809295721136;6364.77723279683;5760.308762948389;5830.82507524775;5933.792317268875;5965.880682386328;6094.847628809315;5565.1374037024325;5650.180723795027;5673.290838645169;5684.6589204647025;5688.11834165705;6215.751369945332;6265.310815810166;6487.448566871869;6529.444997175293;6574.079628851964;5212.452692467236;6227.283862355887;6283.7800676976085;6331;6355.809325720235;6572.605643661395;6580.967095164685;6591.769288074895;6594.406503414716;6596.241432235354;6165.260168779775;6304.243490781136;6316.968415157895;6341.587796793194;6344.143540622142;5380.381256155436;6204.224471941007;6217.129601855653;6293.024581189923;6440.6135631862235;6235.220597425322;6250.124982502544;6256.061590761422;6258.593191442724;6269.31037585856;6165.352637972948;6188.257409110755;6239.96880015597;6248.312685604671;6252.312245652884;5853.385394533512;5874.853128671646;6109.404666050238;6111.388861113853;6114.969425152845;6233.158523599437;6247.281562620356;6263.592866463665;6268.216472940882;6271.24745030581;5103.897922041464;6195.101710251898;6196.411340922605;6197.225346831646;6225.439710426083 07:42:33 INFO - PROCESS | 1987 | |1;ext.html;750.9173990861004;799.4324029938745;825.5995842016621;946.5929650250393;956.5217391304348;33298.33403331938;39014.21971560567;39555.80222098889;40831.387529187086;41096.794516027454;39762.00594985127;39887;40025.79922602319;40026.19947601054;40155.79532614019;6660.666966651672;8073.31376832967;10653;10900.07349375304;10970.341779493216;10801;10869.565217391335;10891.237613367068;10900;10921.235513514057;10892.455377231146;10907.509162087685;10933.890661093366;10939.890601094006;10951.507182176822;10875.347479151236;10901.781964360669;10903.781924361509;10904.291221070684;10924.28992115514;10536.894631053745;10591.523381447776;10613.628523001735;10620.415877126756;10625;34931.12672183216;35061.82469087664;35065.94802155914;35097.47353789695;35129.64870351315;3729.8881033569037;3779.6031416701126;3781.4894989176382;3808.733388662795;3824.0631045394057;25154.874225628937;25195.49609007828;25247.99008039676;25929.61105583418;26430.86784566084;3059.709327613873;3073.4928736758407;3093.8298393588343;3126.2028182813465;3187.585613870205;370703;377228;377351;377779;378596;43260.78369608195;43439.78280108579;43481.78259108684;43490.782546087066;43584.78207609005;44906.55093449024;45083.54916450794;45371;45501.54498455039;45557.08885822265;13712.17726936387;14118.929405352908;14119.647008824657;14120.71758564823;14137;11166;11187.94406027981;11891;12089.637310880687;12164.722704116117;11470.770584588261;11868.525258989544;11868.525258989544;11871.287722736663;12005.879941200476;5668.858278542987;5702.914456283159;5707.543396528268;5708.514776243983;5735.942640573624;1083.7615724540588;1105.2318638546133;1155.7861795567846;1167.1654766841748;1173.3162911222423;21626.783732162476;27523.036693715625;27708.30729231785;27780.58329125065;28196.872125115176;1234.1669373173252;1259.137490818792;1262.4913228691626;1264.3109505319624;1287.6716437308426;9938.950305248427;14018.439262429389;14034.36845341962;14177.929110354382;14316.141031538142;513555;517107;518125;518703;518988;51218;52319.476805232225;55711.72144139335;56104.438955610734;56158.71920640371;1393.2685340196276;1416.7874818777059;1419.1763583794775;1419.474794326106;1432.8710416062604;26516.939322426886;26896;26957.865210673823;27640.723592763814;27653;39899.60100398959;39943;40059.799701001306;40088.799556002035;40105.1978960425;494331;494913;495835;497007;498159;30038.549421758253;30047.3990520184;30890;32269.35461290714;32318.676813231566;38080.80959595295;38616.42075368816;38822.4176637345;39222;39420.81737547878;23229.651555226348;28049.29876753016;28054.57918131189;28079.719202808526;29138.56292155577;27797.44405111927;28000.019999299926;28859.711402885703;28911.7108828909;29592.852035739685;32902.83548582242;32946.67053329436;33318.50022249619;33331.333373332884;33432.33135337231;26761.197164085108;26802.927882884465;27847.582286266126;28926.27684307825;29378.706212937595;22706.545869082194;23056.42358940973;23077.961491732578;23226.419339516648;23440.765592343858 07:42:33 INFO - PROCESS | 1987 | |2;jquery.html;403.2117210852783;428.2762131996926;431.5279612505503;431.9978400107999;439.14147840970907;18597;19747.60504789905;21074.051667674954;21091.894540527275;21118.15527378905;17944.820551794477;20209.595808083828;21072.367828965118;21407.036683349248;21569.892150539225;6372.649504277263;6689.397954184123;6707.262201157869;6773.525853190278;6783.3216678332265;6377.968110159466;6487.481001519891;6549.77075802347;6604.669766511655;6618.073469714244;6504.414602685757;6578.342165783407;6616.966915165442;6619.966900165492;6628.536002479828;6442.80671579851;6584.670766461706;6590.703418346186;6604.636744979024;6722.596644201363;6239.469645080174;6426.967865160691;6447.161868957052;6455.83860403489;6530.444912182423;25111.37221569457;25150.11974580881;25545.744542554523;25796.742032579623;25942.35144121393;2833.263351528597;2912.4903141950076;3181.602299712536;3413.6245013048547;3418.26507300929;16098.436554720529;16150;16160.353585856668;16170.434034808843;16200.35198592055;1975.8715683480527;2039.6328660841043;2071.3164655663595;2078.7505499340177;2084.9262629745695;110154.88819164253;162839;166256.16871915563;168453.47319790212;168480;17290.308387664354;20794.064267108017;21057.473563160736;21058.89470552668;21078.262260820797;32153.51769723456;32272.83863580667;32703.018909432754;32823.17942051468;33020.50469242963;9906.900930990598;10426.218033647507;10566.418846963337;10723.731906702395;10757.924207579179;6559.540832141704;8813;8844.867326990101;8863.936327640724;9039.45763254207;9719.56261968213;9816.988263377816;9864.260180486492;9936.00639936015;9986.900130998598;3563.322968635951;4144.689148313889;4204;4238.36424536322;4286.207051695446;731.5171986488998;731.6670914733784;795.9124496305402;850.5619605902965;895.1496078725237;18241.17914693842;19891.104900279523;21620.78379216219;21721;21786.455338616346;808.8463191993502;923.7206469040293;933.1508327422149;945.3760518058049;946.3990366117428;10754.516046777913;11063.502142403611;11151.386673733023;11162.330260184415;11192.888071119185;659738;759999;768734;775381;789324;104845;137113;160962;161258;172483.13758431128;1144.3362849547243;1195.6114262864603;1220.6277085489012;1240.8510978682616;1264.797632378815;18705.251789928796;19411.611767764847;20047.799522004592;20426.795732043083;20546.486337841674;64837.999999998116;65983.67008164928;66495.66752166208;68026.319736802;68411.65794170997;88269;88524.11475885159;90747;91036.54481727548;94386;11446.370449625017;11514.19400641947;11614.5354185835;11742.17804753659;11962.04303655688;12891.48434062627;13018.28399438002;13244.80132798028;13323.933380333425;13431.529896453578;9291.349605527548;10755;10965.013148816644;11192.720181995515;11224;10309.690709278733;10373.533191006272;10451.738706532093;10677.839832402675;10746.892531074902;11429.085673145963;11451.312921224753;11528.308301501937;11641.47613357384;11718.472668730099;11566.884331156582;11611.593594224161;11857.229280097112;11970.80291970796;12025;10640.946795265974;10745.516451759846;11179.944100279447;11496.252743571642;11598.18812683138 07:42:33 INFO - PROCESS | 1987 | |3;mootools.html;1352.824132862729;1435.1030605871329;1517.7723341498775;1527.8388424797158;1561.1569752333744;10703.571857125715;11267.380294083821;11311.321320720763;11345.886541134587;11595.652130436101;9336.906630933689;11104.55581776728;11284.774304513905;11293;11297.039751621101;2408.951820963584;2463.519613675334;2469.1851688942697;2472.987635061822;2476.9009239630395;2135.4234356723673;2214.0922221889027;2359.0563774490256;2373.4659701567184;2378.3221781792195;2305.561943230781;2355.0579768092816;2372.608519594265;2407.6990376202975;2423.200343886522;2159.136345461812;2227.4765430123907;2239.6640503924377;2413.1795189635523;2420.515896820625;2128.7871212878745;2144.8820314882673;2423.866687332196;2440.475297810979;2440.9389765255833;10879.456027198688;10925.890741092568;10955.83566246507;10970.890291097066;10982.450877456175;5814.883702325972;5862.355140934494;5935.643861368331;6020.277566692025;6027.186329845458;3536.8585256589704;3707.5736290326686;3761.849526018956;3806.7335286529956;3812.1613245086037;1175.935323557204;1213.7511810078913;1254.3477391756235;1262.267884626914;1265.9240445573203;12843.807342889864;13869.79195312061;14039.578812635636;15449.613759656098;15669.921650391789;4680.134175177603;4710.599599034052;4751.553866552319;4844.588210002119;4846.975765121152;9333.160015598629;11431.828522572168;11724.88275117255;11729.4135293235;11733.00269477087;4902.583280421133;5711.143328500758;5768.567357448208;5782.797602083907;5804.187413762077;5212.035773381936;5314.937012597418;5338.065838478251;5346.198070289488;5438.537724293479;3771.867984620525;3891.4357418174773;3976.204759048202;4037.1723796621623;4042.928623914665;1008.4503945349802;1053.6470282455464;1057.1965306367217;1060.5439660945867;1063.505469956474;928.4661319741176;945.4232917920064;951.6621599332276;959.2709540748941;1009.8030883977701;6725.730970761115;6737.764178253738;6759.425448836904;6953.721851125898;6974.860502790018;949.1837020162654;970.2819913264275;991.5934466868549;996.3125443444001;1028.6965345223177;3690.760100593453;4337.414449049401;4355.128974205171;4459.331100334975;4489.147062058199;13654.180749155083;14316.57050288493;14325.140491570539;14364;14408.783868241984;11772.470238839272;13821.930890345686;13959.511417100555;14369.20969346675;14378.137311761118;8650.567471626393;8751.781205469786;10357.119644830123;10477.057064864199;10538.789224215472;6388.718516413184;6878.793636190922;6919;6974.093367862146;7060.8940865886025;12538.435770390537;12722.300273485047;12778.488860445477;12859;12925;12784.936075319563;13053.543125990545;13090.934545327213;13149.276789776653;13229.470821167046;8399.28606068491;8521.53131577769;8590.699325523577;8597.785055373666;8609;8420.873686894824;10407.791844163226;10443.216758742972;10529.789404212026;10539;9109.590068446803;9112.954435228046;9141.314401419788;9144.954275228582;9156.496392698466;8770.12298770118;8882.422642528216;8910.198082172636;8923.330750193632;8931.062238464867;8015.959920200362;8103.473274237392;8169.591520424074;8223.383246256435;8227.876581851157;5936.406359364202;5947.881042379215;5983.192269043623;6126.908096378469;6195.4424101831055;5490.80782172622;5525.254090697705;6050.848728781815;6241.126242325987;6334.683265836782 07:42:33 INFO - PROCESS | 1987 | |4;prototype.html;330.8825366994717;371.22599380292087;377.294459360995;388.95332560092777;394.44974260906037;4784.497627749089;5129.820456284031;5181.870453238671;5409.890972350669;5443.733759744152;5008.39899212095;5143.948560514394;5229.921551176726;5286.365636123671;5315.199632262931;3839.1361943562615;4391.694360460768;4485.372047913294;4621.359417406823;4674.626029917598;3803.581606023335;4320.271891243497;4517.887052823673;4634.397528321313;4692.451491007976;4022.658074063708;4191.350340697181;4308.3968244445805;4344.9348259776125;4367.606915377615;3738.2336620992633;3945.737364043507;4095.815688294034;4350.717203381786;4381.715188512737;3621.746477746559;3887.0953232915667;4053.858114965962;4096.439725171767;4096.931049819852;3903.765774053566;4049.8053074342847;4528.9547104528865;4993.628026687331;5042.747862606891;4632.444106707183;4645.488996210414;4873.585745211662;5107;5200.531952124289;4592.448906131252;4800.511841329164;5613.915791263134;5703.914441283384;5720.370759216525;3777.7533413973597;3851.614838516126;3913.804309784528;3995.9410756149646;4451.844185453494;4704.952950470486;5087.465816089294;5611.136362501196;5672.716364181774;5689.293212036372;4094.9385759213637;4624.9768751156025;4653.115488227273;4682.367880336179;4714.175019371596;4723.7401942893475;4746;4756.500567440369;4759.405074365704;4765.7140571565815;4793.5685788279225;4918.483559226302;4967.857392799677;5013.273075404046;5097.46476619957;5516.227728118067;5560.857161414772;5685.20407142992;5701.462849032224;5717.256756621613;1327.966800829987;1455.2869094143794;1483.5373280354559;1582.6201711589135;1594.7687585300066;980.9068138526972;1109.5298729183864;1162.3490845126587;1196.682879037056;1207.918912573242;4407.162639098561;5036.5718913892;5154.30416893722;5255.78976840922;5279.709615971158;4941.6657502474845;5530.032159479086;5539;5812.505936995402;5874.647521148745;4480.812584665066;4868.683535570248;5197.8045049638795;5240.816571420059;5254.238135470336;2955.4779288666355;2973.8550657996825;3049.573059771634;3073.969260307413;3091.211741006074;5271.920921186185;5451.509364157245;5959.493443057302;6110.511159107261;6125.877482450415;5006.023825354094;5149.2276158576515;5347.893042139135;5540.529055030287;5722.677909544164;5695.579378764009;6053.4261092115485;6127.019676851683;6135.478484328882;6139.877202455926;5260.4218734378765;5726.742296596746;5830.387809280134;5844.736986835517;5929.657785174745;5561.443855614568;5582.62251337951;5802.883942321046;5816.680082595498;5847.502962248086;5535.948169847716;5941.435563621449;5975.309382135003;6009.759609615567;6116.847078823065;4029.952212424732;4674.499142958501;4685;4698.506656800987;4720.622350211906;5560;5775.451332123442;5943.732532035982;5967.8209653710455;5968.881047228171;5049.84850454487;5417.945820541744;5604.8318550443555;5608.130739735348;5661.933394311129;5609.943900560942;5662.971685141548;5672.801451949162;5674.829755107354;5693.544516438592;4902.975485122552;5059.671121377099;5326.440723723953;5495.972520137534;5563.13771365439;5044.949550504448;5352.357717073976;5402.918956215739;5717.656940583578;5726.570507212059;3957.753307708063;4908.140940468981;4991.850244492526;5190.740462976761;5569.632906015008 07:42:33 INFO - PROCESS | 1987 | |5;yui.html;709.4643544124185;719.9388052015579;737.856118056979;759.269079609264;857.2242120880605;14686.926565367172;15345;15842;15887.761683574741;15888.28502717379;15052.322645480952;15085.698286034272;15290.923545382286;15344.232788360594;15386.923065384657;900.4327273817519;917.0829170829154;922.3082687984012;938.976525586859;948.2556193388192;898.3576742629019;938.052566907425;940.534435454451;943.4339396362162;945.938513996588;968;980.0738302304289;981.8919918808925;982.2583949118406;983.2920297385906;974.6247694637544;974.9658761943298;975.556121964508;975.5658731864323;975.6243846119295;717.0928775099503;718.066513532411;718.7735863203075;720.2113685514354;721.030214361688;15941.840581594151;16230.944988575704;16301.429449969313;16651.91674041634;16995.320187192498;13989.720205595933;14207.552603096115;14319.355628996616;14382.712345753027;14418.49535266271;11746.412679365998;11824.467898944482;11859.822102668468;11863.703407414798;11873.406329683481;3575.696065834381;3611.5846677632144;3639.872604458831;3673.7244706647107;3793.905152371213;95842;97214.99999999929;98779.50610246975;98784.50607746986;98896.50551747339;9163.541822908828;9747.561359738687;10197.18422526196;10201;10448.843267350996;21592.35222943314;21634.56730865374;21751.238706645192;21872.23447179341;22080.44798880041;7620.047494063242;7721.691132354756;7774.455788094892;7798.727044553413;7911.248431399008;3956.22853543562;4321.308590625485;4323.978380108079;4496.3255511673515;4585.12882552314;3486.6687664671817;3513.191965847869;3549.6627820357025;3562.697170740516;3589.9102522437147;624.8469125064297;634.2800920954658;642.2325321241073;651.2347991110427;652.0317328766778;601.8074216250845;688.3598253624177;707.6249587718518;709.5955305475933;712.2805965974403;8659.567021648892;9122.543872806333;9684.322097453252;9844.114029737215;10311.07200351972;652.1880259077384;681.5637991685326;693.5396779003565;693.549193024528;720.772956518695;4623.468301145344;4989.426215985136;4992.176290911959;5004.1492946198505;5092.26162206478;74924.25075749282;98843.01156988482;106641.46679266554;107821;112880;60056.699716501134;76514;79712.60143699244;86551.13448865556;94272.52863735774;65712.01431978524;68681.31318686849;71470;81553.59223203965;87576;10735.516901739284;11105.777884442105;11119.722006949567;11233.157513186381;11420.657380278604;51745.7412712934;51939.70150746262;52142;52367.47632523626;52710.94578108493;60895.08657370232;61883.38116618956;70226.64886675533;71028.57942841011;71433;13643.863561364657;13775.104618199784;14115.929420352833;14169.079009864327;14739.92630036886;13209.537666182023;15182.620434488785;15231.314590843216;15239.923800380928;15511.37954481808;13866;13903.443862245396;14070.366833492722;14302.427902883768;14305.21321327337;11850.525978960744;13647.590572282847;13944.79082813779;13969.720605587629;14050.648733781329;13103.672408189872;13702.794458082937;13815.516456923959;14114.941379396381;14142.292885355897;9128.817423651357;9340;9366.859497107685;9485;9673.661421850202;10253.384796912209;11112.444377781241;11481.36852473122;11849.52601895949;12117.878821212027 07:42:33 INFO - PROCESS | 1987 | __end_tp_report 07:42:33 INFO - PROCESS | 1987 | __start_cc_report 07:42:33 INFO - PROCESS | 1987 | _x_x_mozilla_cycle_collect,426 07:42:33 INFO - PROCESS | 1987 | __end_cc_report 07:42:33 INFO - PROCESS | 1987 | __startTimestamp1492526553189__endTimestamp 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | ------- Summary: start ------- 07:42:33 INFO - PROCESS | 1987 | Number of tests: 6 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | [#0] dojo.html Cycles:165 Average:5881.18 Median:6163.20 stddev:638.23 (10.4%) stddev-sans-first:609.43 07:42:33 INFO - PROCESS | 1987 | Values: 3386.0 3409.1 3419.3 3440.4 3442.3 5763.3 5839.6 5883.9 5935.6 5950.5 4771.3 5887.3 5900.1 5905.9 5926.5 5332.4 5354.5 5399.8 5439.8 5455.7 5452.4 5455.5 5463.9 5478.3 5501.3 5252.0 5261.4 5430.4 5448.2 5462.9 5379.8 5411.6 5464.8 5501.3 5511.8 5274.7 5355.4 5357.7 5366.1 5403.0 5627.8 5942.1 5943.2 6026.2 6039.1 6217.3 6218.4 6263.3 6265.1 6269.0 6410.7 6446.3 6455.2 6458.8 6462.6 6063.2 6141.5 6142.7 6160.7 6163.2 6213.6 6308.8 6395.0 6445.0 6456.6 6189.0 6193.2 6284.2 6293.7 6296.1 6361.9 6402.5 6420.6 6426.2 6430.7 6179.4 6327.5 6354.3 6359.0 6362.4 6206.6 6222.6 6260.7 6268.4 6271.6 5170.9 5172.0 5178.8 5184.3 5213.7 4592.6 4618.4 4628.8 4638.3 4643.2 5779.0 5779.5 5783.6 5803.3 5964.0 6264.7 6279.1 6355.6 6356.8 6364.8 5760.3 5830.8 5933.8 5965.9 6094.8 5565.1 5650.2 5673.3 5684.7 5688.1 6215.8 6265.3 6487.4 6529.4 6574.1 5212.5 6227.3 6283.8 6331.0 6355.8 6572.6 6581.0 6591.8 6594.4 6596.2 6165.3 6304.2 6317.0 6341.6 6344.1 5380.4 6204.2 6217.1 6293.0 6440.6 6235.2 6250.1 6256.1 6258.6 6269.3 6165.4 6188.3 6240.0 6248.3 6252.3 5853.4 5874.9 6109.4 6111.4 6115.0 6233.2 6247.3 6263.6 6268.2 6271.2 5103.9 6195.1 6196.4 6197.2 6225.4 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | [#1] ext.html Cycles:180 Average:58244.69 Median:29485.78 stddev:124605.14 (422.6%) stddev-sans-first:124879.91 07:42:33 INFO - PROCESS | 1987 | Values: 750.9 799.4 825.6 946.6 956.5 33298.3 39014.2 39555.8 40831.4 41096.8 39762.0 39887.0 40025.8 40026.2 40155.8 6660.7 8073.3 10653.0 10900.1 10970.3 10801.0 10869.6 10891.2 10900.0 10921.2 10892.5 10907.5 10933.9 10939.9 10951.5 10875.3 10901.8 10903.8 10904.3 10924.3 10536.9 10591.5 10613.6 10620.4 10625.0 34931.1 35061.8 35065.9 35097.5 35129.6 3729.9 3779.6 3781.5 3808.7 3824.1 25154.9 25195.5 25248.0 25929.6 26430.9 3059.7 3073.5 3093.8 3126.2 3187.6 370703.0 377228.0 377351.0 377779.0 378596.0 43260.8 43439.8 43481.8 43490.8 43584.8 44906.6 45083.5 45371.0 45501.5 45557.1 13712.2 14118.9 14119.6 14120.7 14137.0 11166.0 11187.9 11891.0 12089.6 12164.7 11470.8 11868.5 11868.5 11871.3 12005.9 5668.9 5702.9 5707.5 5708.5 5735.9 1083.8 1105.2 1155.8 1167.2 1173.3 21626.8 27523.0 27708.3 27780.6 28196.9 1234.2 1259.1 1262.5 1264.3 1287.7 9939.0 14018.4 14034.4 14177.9 14316.1 513555.0 517107.0 518125.0 518703.0 518988.0 51218.0 52319.5 55711.7 56104.4 56158.7 1393.3 1416.8 1419.2 1419.5 1432.9 26516.9 26896.0 26957.9 27640.7 27653.0 39899.6 39943.0 40059.8 40088.8 40105.2 494331.0 494913.0 495835.0 497007.0 498159.0 30038.5 30047.4 30890.0 32269.4 32318.7 38080.8 38616.4 38822.4 39222.0 39420.8 23229.7 28049.3 28054.6 28079.7 29138.6 27797.4 28000.0 28859.7 28911.7 29592.9 32902.8 32946.7 33318.5 33331.3 33432.3 26761.2 26802.9 27847.6 28926.3 29378.7 22706.5 23056.4 23078.0 23226.4 23440.8 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | [#2] jquery.html Cycles:180 Average:43113.90 Median:21670.89 stddev:125503.46 (579.1%) stddev-sans-first:125814.55 07:42:33 INFO - PROCESS | 1987 | Values: 403.2 428.3 431.5 432.0 439.1 18597.0 19747.6 21074.1 21091.9 21118.2 17944.8 20209.6 21072.4 21407.0 21569.9 6372.6 6689.4 6707.3 6773.5 6783.3 6378.0 6487.5 6549.8 6604.7 6618.1 6504.4 6578.3 6617.0 6620.0 6628.5 6442.8 6584.7 6590.7 6604.6 6722.6 6239.5 6427.0 6447.2 6455.8 6530.4 25111.4 25150.1 25545.7 25796.7 25942.4 2833.3 2912.5 3181.6 3413.6 3418.3 16098.4 16150.0 16160.4 16170.4 16200.4 1975.9 2039.6 2071.3 2078.8 2084.9 110154.9 162839.0 166256.2 168453.5 168480.0 17290.3 20794.1 21057.5 21058.9 21078.3 32153.5 32272.8 32703.0 32823.2 33020.5 9906.9 10426.2 10566.4 10723.7 10757.9 6559.5 8813.0 8844.9 8863.9 9039.5 9719.6 9817.0 9864.3 9936.0 9986.9 3563.3 4144.7 4204.0 4238.4 4286.2 731.5 731.7 795.9 850.6 895.1 18241.2 19891.1 21620.8 21721.0 21786.5 808.8 923.7 933.2 945.4 946.4 10754.5 11063.5 11151.4 11162.3 11192.9 659738.0 759999.0 768734.0 775381.0 789324.0 104845.0 137113.0 160962.0 161258.0 172483.1 1144.3 1195.6 1220.6 1240.9 1264.8 18705.3 19411.6 20047.8 20426.8 20546.5 64838.0 65983.7 66495.7 68026.3 68411.7 88269.0 88524.1 90747.0 91036.5 94386.0 11446.4 11514.2 11614.5 11742.2 11962.0 12891.5 13018.3 13244.8 13323.9 13431.5 9291.3 10755.0 10965.0 11192.7 11224.0 10309.7 10373.5 10451.7 10677.8 10746.9 11429.1 11451.3 11528.3 11641.5 11718.5 11566.9 11611.6 11857.2 11970.8 12025.0 10640.9 10745.5 11179.9 11496.3 11598.2 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | [#3] mootools.html Cycles:180 Average:6763.50 Median:2474.94 stddev:4227.85 (170.8%) stddev-sans-first:4220.16 07:42:33 INFO - PROCESS | 1987 | Values: 1352.8 1435.1 1517.8 1527.8 1561.2 10703.6 11267.4 11311.3 11345.9 11595.7 9336.9 11104.6 11284.8 11293.0 11297.0 2409.0 2463.5 2469.2 2473.0 2476.9 2135.4 2214.1 2359.1 2373.5 2378.3 2305.6 2355.1 2372.6 2407.7 2423.2 2159.1 2227.5 2239.7 2413.2 2420.5 2128.8 2144.9 2423.9 2440.5 2440.9 10879.5 10925.9 10955.8 10970.9 10982.5 5814.9 5862.4 5935.6 6020.3 6027.2 3536.9 3707.6 3761.8 3806.7 3812.2 1175.9 1213.8 1254.3 1262.3 1265.9 12843.8 13869.8 14039.6 15449.6 15669.9 4680.1 4710.6 4751.6 4844.6 4847.0 9333.2 11431.8 11724.9 11729.4 11733.0 4902.6 5711.1 5768.6 5782.8 5804.2 5212.0 5314.9 5338.1 5346.2 5438.5 3771.9 3891.4 3976.2 4037.2 4042.9 1008.5 1053.6 1057.2 1060.5 1063.5 928.5 945.4 951.7 959.3 1009.8 6725.7 6737.8 6759.4 6953.7 6974.9 949.2 970.3 991.6 996.3 1028.7 3690.8 4337.4 4355.1 4459.3 4489.1 13654.2 14316.6 14325.1 14364.0 14408.8 11772.5 13821.9 13959.5 14369.2 14378.1 8650.6 8751.8 10357.1 10477.1 10538.8 6388.7 6878.8 6919.0 6974.1 7060.9 12538.4 12722.3 12778.5 12859.0 12925.0 12784.9 13053.5 13090.9 13149.3 13229.5 8399.3 8521.5 8590.7 8597.8 8609.0 8420.9 10407.8 10443.2 10529.8 10539.0 9109.6 9113.0 9141.3 9145.0 9156.5 8770.1 8882.4 8910.2 8923.3 8931.1 8016.0 8103.5 8169.6 8223.4 8227.9 5936.4 5947.9 5983.2 6126.9 6195.4 5490.8 5525.3 6050.8 6241.1 6334.7 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | [#4] prototype.html Cycles:180 Average:4686.50 Median:5043.85 stddev:1322.89 (26.2%) stddev-sans-first:1285.57 07:42:33 INFO - PROCESS | 1987 | Values: 330.9 371.2 377.3 389.0 394.4 4784.5 5129.8 5181.9 5409.9 5443.7 5008.4 5143.9 5229.9 5286.4 5315.2 3839.1 4391.7 4485.4 4621.4 4674.6 3803.6 4320.3 4517.9 4634.4 4692.5 4022.7 4191.4 4308.4 4344.9 4367.6 3738.2 3945.7 4095.8 4350.7 4381.7 3621.7 3887.1 4053.9 4096.4 4096.9 3903.8 4049.8 4529.0 4993.6 5042.7 4632.4 4645.5 4873.6 5107.0 5200.5 4592.4 4800.5 5613.9 5703.9 5720.4 3777.8 3851.6 3913.8 3995.9 4451.8 4705.0 5087.5 5611.1 5672.7 5689.3 4094.9 4625.0 4653.1 4682.4 4714.2 4723.7 4746.0 4756.5 4759.4 4765.7 4793.6 4918.5 4967.9 5013.3 5097.5 5516.2 5560.9 5685.2 5701.5 5717.3 1328.0 1455.3 1483.5 1582.6 1594.8 980.9 1109.5 1162.3 1196.7 1207.9 4407.2 5036.6 5154.3 5255.8 5279.7 4941.7 5530.0 5539.0 5812.5 5874.6 4480.8 4868.7 5197.8 5240.8 5254.2 2955.5 2973.9 3049.6 3074.0 3091.2 5271.9 5451.5 5959.5 6110.5 6125.9 5006.0 5149.2 5347.9 5540.5 5722.7 5695.6 6053.4 6127.0 6135.5 6139.9 5260.4 5726.7 5830.4 5844.7 5929.7 5561.4 5582.6 5802.9 5816.7 5847.5 5535.9 5941.4 5975.3 6009.8 6116.8 4030.0 4674.5 4685.0 4698.5 4720.6 5560.0 5775.5 5943.7 5967.8 5968.9 5049.8 5417.9 5604.8 5608.1 5661.9 5609.9 5663.0 5672.8 5674.8 5693.5 4903.0 5059.7 5326.4 5496.0 5563.1 5044.9 5352.4 5402.9 5717.7 5726.6 3957.8 4908.1 4991.9 5190.7 5569.6 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - PROCESS | 1987 | [#5] yui.html Cycles:180 Average:20003.21 Median:5048.21 stddev:27969.15 (554.0%) stddev-sans-first:28010.09 07:42:33 INFO - PROCESS | 1987 | Values: 709.5 719.9 737.9 759.3 857.2 14686.9 15345.0 15842.0 15887.8 15888.3 15052.3 15085.7 15290.9 15344.2 15386.9 900.4 917.1 922.3 939.0 948.3 898.4 938.1 940.5 943.4 945.9 968.0 980.1 981.9 982.3 983.3 974.6 975.0 975.6 975.6 975.6 717.1 718.1 718.8 720.2 721.0 15941.8 16230.9 16301.4 16651.9 16995.3 13989.7 14207.6 14319.4 14382.7 14418.5 11746.4 11824.5 11859.8 11863.7 11873.4 3575.7 3611.6 3639.9 3673.7 3793.9 95842.0 97215.0 98779.5 98784.5 98896.5 9163.5 9747.6 10197.2 10201.0 10448.8 21592.4 21634.6 21751.2 21872.2 22080.4 7620.0 7721.7 7774.5 7798.7 7911.2 3956.2 4321.3 4324.0 4496.3 4585.1 3486.7 3513.2 3549.7 3562.7 3589.9 624.8 634.3 642.2 651.2 652.0 601.8 688.4 707.6 709.6 712.3 8659.6 9122.5 9684.3 9844.1 10311.1 652.2 681.6 693.5 693.5 720.8 4623.5 4989.4 4992.2 5004.1 5092.3 74924.3 98843.0 106641.5 107821.0 112880.0 60056.7 76514.0 79712.6 86551.1 94272.5 65712.0 68681.3 71470.0 81553.6 87576.0 10735.5 11105.8 11119.7 11233.2 11420.7 51745.7 51939.7 52142.0 52367.5 52710.9 60895.1 61883.4 70226.6 71028.6 71433.0 13643.9 13775.1 14115.9 14169.1 14739.9 13209.5 15182.6 15231.3 15239.9 15511.4 13866.0 13903.4 14070.4 14302.4 14305.2 11850.5 13647.6 13944.8 13969.7 14050.6 13103.7 13702.8 13815.5 14114.9 14142.3 9128.8 9340.0 9366.9 9485.0 9673.7 10253.4 11112.4 11481.4 11849.5 12117.9 07:42:33 INFO - PROCESS | 1987 | -------- Summary: end -------- 07:42:33 INFO - PROCESS | 1987 | 07:42:33 INFO - TEST-INFO | 1987: exit 0 07:42:33 INFO - TEST-OK | dromaeo_css | took 1116544ms 07:42:33 INFO - TEST-START | kraken 07:42:33 INFO - operating with platform_type : mac_ 07:42:33 INFO - Initialising browser for kraken test... 07:42:33 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmpFqO1DS/profile http://localhost:54229/getInfo.html) 07:42:36 INFO - PROCESS | 1994 | 2017-04-18 07:42:36.587 plugin-container[1995:21745] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 07:42:36 INFO - PROCESS | 1994 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:36 INFO - PROCESS | 1994 | 2017-04-18 07:42:36.590 plugin-container[1995:21745] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 07:42:36 INFO - PROCESS | 1994 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:36 INFO - PROCESS | 1994 | 2017-04-18 07:42:36.590 plugin-container[1995:21745] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:36 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 07:42:36 INFO - PROCESS | 1994 | colorDepth:24 07:42:36 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 07:42:36 INFO - PROCESS | 1994 | __metrics 07:42:36 ERROR - PROCESS | 1994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 07:42:37 INFO - TEST-INFO | 1994: exit 0 07:42:37 INFO - Browser initialized. 07:42:37 INFO - Running cycle 1/1 for kraken test... 07:42:37 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmpFqO1DS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:39 INFO - PROCESS | 1996 | 2017-04-18 07:42:39.994 plugin-container[1997:21871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a53, name = 'com.apple.tsm.portname' 07:42:39 INFO - PROCESS | 1996 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:39 INFO - PROCESS | 1996 | 2017-04-18 07:42:39.995 plugin-container[1997:21871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 07:42:39 INFO - PROCESS | 1996 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:42:39 INFO - PROCESS | 1996 | 2017-04-18 07:42:39.995 plugin-container[1997:21871] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:42:49 INFO - PROCESS | 1996 | RSS: Main: 220954624 07:42:49 INFO - PROCESS | 1996 | 07:42:52 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-beat-detection) 07:42:53 INFO - PROCESS | 1996 | RSS: Main: 235503616 07:42:53 INFO - PROCESS | 1996 | 07:42:56 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-dft) 07:42:56 INFO - PROCESS | 1996 | RSS: Main: 243380224 07:42:56 INFO - PROCESS | 1996 | 07:43:00 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-fft) 07:43:00 INFO - PROCESS | 1996 | RSS: Main: 247078912 07:43:00 INFO - PROCESS | 1996 | 07:43:02 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-oscillator) 07:43:03 INFO - PROCESS | 1996 | RSS: Main: 247504896 07:43:03 INFO - PROCESS | 1996 | 07:43:05 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:43:06 INFO - PROCESS | 1996 | RSS: Main: 248868864 07:43:06 INFO - PROCESS | 1996 | 07:43:09 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54229/tests/kraken/driver.html?testName=imaging-darkroom) 07:43:09 INFO - PROCESS | 1996 | RSS: Main: 252735488 07:43:09 INFO - PROCESS | 1996 | 07:43:12 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54229/tests/kraken/driver.html?testName=imaging-desaturate) 07:43:13 INFO - PROCESS | 1996 | RSS: Main: 252317696 07:43:13 INFO - PROCESS | 1996 | 07:43:16 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54229/tests/kraken/driver.html?testName=json-parse-financial) 07:43:17 INFO - PROCESS | 1996 | RSS: Main: 252387328 07:43:17 INFO - PROCESS | 1996 | 07:43:19 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:43:19 INFO - PROCESS | 1996 | RSS: Main: 251797504 07:43:19 INFO - PROCESS | 1996 | 07:43:21 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:43:22 INFO - PROCESS | 1996 | RSS: Main: 251781120 07:43:22 INFO - PROCESS | 1996 | 07:43:24 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:43:25 INFO - PROCESS | 1996 | RSS: Main: 251822080 07:43:25 INFO - PROCESS | 1996 | 07:43:27 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:43:28 INFO - PROCESS | 1996 | RSS: Main: 252231680 07:43:28 INFO - PROCESS | 1996 | 07:43:31 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:43:32 INFO - PROCESS | 1996 | RSS: Main: 251985920 07:43:32 INFO - PROCESS | 1996 | 07:43:33 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54229/tests/kraken/driver.html?testName=ai-astar) 07:43:34 INFO - PROCESS | 1996 | RSS: Main: 253849600 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | __start_tp_report 07:43:34 INFO - PROCESS | 1996 | _x_x_mozilla_page_load 07:43:34 INFO - PROCESS | 1996 | _x_x_mozilla_page_load_details 07:43:34 INFO - PROCESS | 1996 | |i|pagename|runs| 07:43:34 INFO - PROCESS | 1996 | |0;ai-astar;107;120;121;120;119;119;121;119;120;119 07:43:34 INFO - PROCESS | 1996 | |1;audio-beat-detection;140;143;139;149;136;139;142;115;129;113 07:43:34 INFO - PROCESS | 1996 | |2;audio-dft;202;199;193;199;198;195;199;195;203;194 07:43:34 INFO - PROCESS | 1996 | |3;audio-fft;110;51;71;80;55;76;85;87;97;52 07:43:34 INFO - PROCESS | 1996 | |4;audio-oscillator;86;73;88;71;71;69;82;69;69;82 07:43:34 INFO - PROCESS | 1996 | |5;imaging-gaussian-blur;89;109;89;90;91;102;103;117;81;135 07:43:34 INFO - PROCESS | 1996 | |6;imaging-darkroom;97;97;103;91;151;143;98;97;102;93 07:43:34 INFO - PROCESS | 1996 | |7;imaging-desaturate;91;110;146;99;144;94;152;92;154;90 07:43:34 INFO - PROCESS | 1996 | |8;json-parse-financial;67;65;65;67;90;102;105;77;68;70 07:43:34 INFO - PROCESS | 1996 | |9;json-stringify-tinderbox;56;57;70;67;63;60;58;58;60;61 07:43:34 INFO - PROCESS | 1996 | |10;stanford-crypto-aes;89;86;85;84;82;87;82;86;86;85 07:43:34 INFO - PROCESS | 1996 | |11;stanford-crypto-ccm;139;139;138;139;139;139;143;142;186;141 07:43:34 INFO - PROCESS | 1996 | |12;stanford-crypto-pbkdf2;172;173;167;169;172;168;195;172;166;171 07:43:34 INFO - PROCESS | 1996 | |13;stanford-crypto-sha256-iterative;65;66;65;67;64;65;66;76;73;65 07:43:34 INFO - PROCESS | 1996 | __end_tp_report 07:43:34 INFO - PROCESS | 1996 | __start_cc_report 07:43:34 INFO - PROCESS | 1996 | _x_x_mozilla_cycle_collect,1014 07:43:34 INFO - PROCESS | 1996 | __end_cc_report 07:43:34 INFO - PROCESS | 1996 | __startTimestamp1492526614152__endTimestamp 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | ------- Summary: start ------- 07:43:34 INFO - PROCESS | 1996 | Number of tests: 14 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#0] ai-astar Cycles:10 Average:118.50 Median:120.00 stddev:4.12 (3.4%) stddev-sans-first:0.83 07:43:34 INFO - PROCESS | 1996 | Values: 107.0 120.0 121.0 120.0 119.0 119.0 121.0 119.0 120.0 119.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:139.50 stddev:11.95 (8.6%) stddev-sans-first:12.50 07:43:34 INFO - PROCESS | 1996 | Values: 140.0 143.0 139.0 149.0 136.0 139.0 142.0 115.0 129.0 113.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#2] audio-dft Cycles:10 Average:197.70 Median:199.00 stddev:3.37 (1.7%) stddev-sans-first:3.19 07:43:34 INFO - PROCESS | 1996 | Values: 202.0 199.0 193.0 199.0 198.0 195.0 199.0 195.0 203.0 194.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#3] audio-fft Cycles:10 Average:76.40 Median:78.00 stddev:19.66 (25.2%) stddev-sans-first:16.68 07:43:34 INFO - PROCESS | 1996 | Values: 110.0 51.0 71.0 80.0 55.0 76.0 85.0 87.0 97.0 52.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.50 stddev:7.62 (9.8%) stddev-sans-first:7.17 07:43:34 INFO - PROCESS | 1996 | Values: 86.0 73.0 88.0 71.0 71.0 69.0 82.0 69.0 69.0 82.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:85.00 stddev:16.29 (19.2%) stddev-sans-first:16.73 07:43:34 INFO - PROCESS | 1996 | Values: 89.0 109.0 89.0 90.0 91.0 102.0 103.0 117.0 81.0 135.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:95.00 stddev:21.36 (22.5%) stddev-sans-first:22.33 07:43:34 INFO - PROCESS | 1996 | Values: 97.0 97.0 103.0 91.0 151.0 143.0 98.0 97.0 102.0 93.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#7] imaging-desaturate Cycles:10 Average:117.20 Median:90.50 stddev:28.08 (31.0%) stddev-sans-first:28.14 07:43:34 INFO - PROCESS | 1996 | Values: 91.0 110.0 146.0 99.0 144.0 94.0 152.0 92.0 154.0 90.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#8] json-parse-financial Cycles:10 Average:77.60 Median:67.50 stddev:15.61 (23.1%) stddev-sans-first:16.08 07:43:34 INFO - PROCESS | 1996 | Values: 67.0 65.0 65.0 67.0 90.0 102.0 105.0 77.0 68.0 70.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:60.50 stddev:4.50 (7.4%) stddev-sans-first:4.39 07:43:34 INFO - PROCESS | 1996 | Values: 56.0 57.0 70.0 67.0 63.0 60.0 58.0 58.0 60.0 61.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:2.15 (2.5%) stddev-sans-first:1.79 07:43:34 INFO - PROCESS | 1996 | Values: 89.0 86.0 85.0 84.0 82.0 87.0 82.0 86.0 86.0 85.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:140.00 stddev:14.67 (10.5%) stddev-sans-first:15.42 07:43:34 INFO - PROCESS | 1996 | Values: 139.0 139.0 138.0 139.0 139.0 139.0 143.0 142.0 186.0 141.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.00 stddev:8.26 (4.8%) stddev-sans-first:8.76 07:43:34 INFO - PROCESS | 1996 | Values: 172.0 173.0 167.0 169.0 172.0 168.0 195.0 172.0 166.0 171.0 07:43:34 INFO - PROCESS | 1996 | 07:43:34 INFO - PROCESS | 1996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.00 stddev:3.99 (6.1%) stddev-sans-first:4.16 07:43:34 INFO - PROCESS | 1996 | Values: 65.0 66.0 65.0 67.0 64.0 65.0 66.0 76.0 73.0 65.0 07:43:34 INFO - PROCESS | 1996 | -------- Summary: end -------- 07:43:34 INFO - PROCESS | 1996 | 07:43:35 INFO - TEST-INFO | 1996: exit 0 07:43:35 INFO - TEST-OK | kraken | took 61219ms 07:43:35 INFO - SUITE-END | took 1177s 07:43:35 INFO - Completed test suite (00:19:37) 07:43:35 INFO - javascript benchmark 07:43:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7696.2925957524385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3386.0180547641185, 3409.079548521899, 3419.281950790334, 3440.397930362187, 3442.3459542686905, 5763.250777398937, 5839.591228613998, 5883.85290367741, 5935.554833387502, 5950.523958083354, 4771.33201351811, 5887.293524777022, 5900.144479050535, 5905.852353691149, 5926.466618004379, 5332.413434522199, 5354.464553544633, 5399.811006614769, 5439.782408703647, 5455.727213639322, 5452.4274951130155, 5455.481729235736, 5463.890722185554, 5478.315210598676, 5501.339839219279, 5251.973740131294, 5261.39493958194, 5430.402655707869, 5448.155535891943, 5462.907418516293, 5379.81170659027, 5411.594130440213, 5464.808731694372, 5501.312335958005, 5511.807086751985, 5274.683518988834, 5355.410904800468, 5357.732113394315, 5366.114591092465, 5402.9729851350885, 5627.831165065014, 5942.108683697436, 5943.197668314765, 6026.186464827236, 6039.063945088475, 6217.285012223561, 6218.440340369343, 6263.31103578606, 6265.122882796412, 6269.0, 6410.743570257184, 6446.258680251784, 6455.160829092235, 6458.838529036765, 6462.579932304385, 6063.181470501514, 6141.477974372184, 6142.662153581551, 6160.691965401802, 6163.19878415803, 6213.627182369072, 6308.842278943063, 6394.968025159845, 6445.0, 6456.612603243821, 6188.969055154786, 6193.225846769154, 6284.151639528696, 6293.685315734195, 6296.118543403927, 6361.872762544724, 6402.48780097591, 6420.550561460746, 6426.228852537725, 6430.678466076677, 6179.3820617937845, 6327.462165715966, 6354.3010268870385, 6359.0, 6362.395572420613, 6206.596571222856, 6222.564420490522, 6260.655663938436, 6268.435840774352, 6271.592346497463, 5170.922436163461, 5172.017316709813, 5178.844634660966, 5184.274201611777, 5213.713245771443, 4592.632589392841, 4618.445786505641, 4628.791704373311, 4638.304254361873, 4643.164230438486, 5778.971105144447, 5779.508741756998, 5783.59514833966, 5803.332616749043, 5964.0, 6264.655443950535, 6279.058141278845, 6355.555111142268, 6356.809295721136, 6364.77723279683, 5760.308762948389, 5830.82507524775, 5933.792317268875, 5965.880682386328, 6094.847628809315, 5565.1374037024325, 5650.180723795027, 5673.290838645169, 5684.6589204647025, 5688.11834165705, 6215.751369945332, 6265.310815810166, 6487.448566871869, 6529.444997175293, 6574.079628851964, 5212.452692467236, 6227.283862355887, 6283.7800676976085, 6331.0, 6355.809325720235, 6572.605643661395, 6580.967095164685, 6591.769288074895, 6594.406503414716, 6596.241432235354, 6165.260168779775, 6304.243490781136, 6316.968415157895, 6341.587796793194, 6344.143540622142, 5380.381256155436, 6204.224471941007, 6217.129601855653, 6293.024581189923, 6440.6135631862235, 6235.220597425322, 6250.124982502544, 6256.061590761422, 6258.593191442724, 6269.31037585856, 6165.352637972948, 6188.257409110755, 6239.96880015597, 6248.312685604671, 6252.312245652884, 5853.385394533512, 5874.853128671646, 6109.404666050238, 6111.388861113853, 6114.969425152845, 6233.158523599437, 6247.281562620356, 6263.592866463665, 6268.216472940882, 6271.24745030581, 5103.897922041464, 6195.101710251898, 6196.411340922605, 6197.225346831646, 6225.439710426083], "value": 5842.1119300268965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.9173990861004, 799.4324029938745, 825.5995842016621, 946.5929650250393, 956.5217391304348, 33298.33403331938, 39014.21971560567, 39555.80222098889, 40831.387529187086, 41096.794516027454, 39762.00594985127, 39887.0, 40025.79922602319, 40026.19947601054, 40155.79532614019, 6660.666966651672, 8073.31376832967, 10653.0, 10900.07349375304, 10970.341779493216, 10801.0, 10869.565217391335, 10891.237613367068, 10900.0, 10921.235513514057, 10892.455377231146, 10907.509162087685, 10933.890661093366, 10939.890601094006, 10951.507182176822, 10875.347479151236, 10901.781964360669, 10903.781924361509, 10904.291221070684, 10924.28992115514, 10536.894631053745, 10591.523381447776, 10613.628523001735, 10620.415877126756, 10625.0, 34931.12672183216, 35061.82469087664, 35065.94802155914, 35097.47353789695, 35129.64870351315, 3729.8881033569037, 3779.6031416701126, 3781.4894989176382, 3808.733388662795, 3824.0631045394057, 25154.874225628937, 25195.49609007828, 25247.99008039676, 25929.61105583418, 26430.86784566084, 3059.709327613873, 3073.4928736758407, 3093.8298393588343, 3126.2028182813465, 3187.585613870205, 370703.0, 377228.0, 377351.0, 377779.0, 378596.0, 43260.78369608195, 43439.78280108579, 43481.78259108684, 43490.782546087066, 43584.78207609005, 44906.55093449024, 45083.54916450794, 45371.0, 45501.54498455039, 45557.08885822265, 13712.17726936387, 14118.929405352908, 14119.647008824657, 14120.71758564823, 14137.0, 11166.0, 11187.94406027981, 11891.0, 12089.637310880687, 12164.722704116117, 11470.770584588261, 11868.525258989544, 11868.525258989544, 11871.287722736663, 12005.879941200476, 5668.858278542987, 5702.914456283159, 5707.543396528268, 5708.514776243983, 5735.942640573624, 1083.7615724540588, 1105.2318638546133, 1155.7861795567846, 1167.1654766841748, 1173.3162911222423, 21626.783732162476, 27523.036693715625, 27708.30729231785, 27780.58329125065, 28196.872125115176, 1234.1669373173252, 1259.137490818792, 1262.4913228691626, 1264.3109505319624, 1287.6716437308426, 9938.950305248427, 14018.439262429389, 14034.36845341962, 14177.929110354382, 14316.141031538142, 513555.0, 517107.0, 518125.0, 518703.0, 518988.0, 51218.0, 52319.476805232225, 55711.72144139335, 56104.438955610734, 56158.71920640371, 1393.2685340196276, 1416.7874818777059, 1419.1763583794775, 1419.474794326106, 1432.8710416062604, 26516.939322426886, 26896.0, 26957.865210673823, 27640.723592763814, 27653.0, 39899.60100398959, 39943.0, 40059.799701001306, 40088.799556002035, 40105.1978960425, 494331.0, 494913.0, 495835.0, 497007.0, 498159.0, 30038.549421758253, 30047.3990520184, 30890.0, 32269.35461290714, 32318.676813231566, 38080.80959595295, 38616.42075368816, 38822.4176637345, 39222.0, 39420.81737547878, 23229.651555226348, 28049.29876753016, 28054.57918131189, 28079.719202808526, 29138.56292155577, 27797.44405111927, 28000.019999299926, 28859.711402885703, 28911.7108828909, 29592.852035739685, 32902.83548582242, 32946.67053329436, 33318.50022249619, 33331.333373332884, 33432.33135337231, 26761.197164085108, 26802.927882884465, 27847.582286266126, 28926.27684307825, 29378.706212937595, 22706.545869082194, 23056.42358940973, 23077.961491732578, 23226.419339516648, 23440.765592343858], "value": 18380.072079729518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.2117210852783, 428.2762131996926, 431.5279612505503, 431.9978400107999, 439.14147840970907, 18597.0, 19747.60504789905, 21074.051667674954, 21091.894540527275, 21118.15527378905, 17944.820551794477, 20209.595808083828, 21072.367828965118, 21407.036683349248, 21569.892150539225, 6372.649504277263, 6689.397954184123, 6707.262201157869, 6773.525853190278, 6783.3216678332265, 6377.968110159466, 6487.481001519891, 6549.77075802347, 6604.669766511655, 6618.073469714244, 6504.414602685757, 6578.342165783407, 6616.966915165442, 6619.966900165492, 6628.536002479828, 6442.80671579851, 6584.670766461706, 6590.703418346186, 6604.636744979024, 6722.596644201363, 6239.469645080174, 6426.967865160691, 6447.161868957052, 6455.83860403489, 6530.444912182423, 25111.37221569457, 25150.11974580881, 25545.744542554523, 25796.742032579623, 25942.35144121393, 2833.263351528597, 2912.4903141950076, 3181.602299712536, 3413.6245013048547, 3418.26507300929, 16098.436554720529, 16150.0, 16160.353585856668, 16170.434034808843, 16200.35198592055, 1975.8715683480527, 2039.6328660841043, 2071.3164655663595, 2078.7505499340177, 2084.9262629745695, 110154.88819164253, 162839.0, 166256.16871915563, 168453.47319790212, 168480.0, 17290.308387664354, 20794.064267108017, 21057.473563160736, 21058.89470552668, 21078.262260820797, 32153.51769723456, 32272.83863580667, 32703.018909432754, 32823.17942051468, 33020.50469242963, 9906.900930990598, 10426.218033647507, 10566.418846963337, 10723.731906702395, 10757.924207579179, 6559.540832141704, 8813.0, 8844.867326990101, 8863.936327640724, 9039.45763254207, 9719.56261968213, 9816.988263377816, 9864.260180486492, 9936.00639936015, 9986.900130998598, 3563.322968635951, 4144.689148313889, 4204.0, 4238.36424536322, 4286.207051695446, 731.5171986488998, 731.6670914733784, 795.9124496305402, 850.5619605902965, 895.1496078725237, 18241.17914693842, 19891.104900279523, 21620.78379216219, 21721.0, 21786.455338616346, 808.8463191993502, 923.7206469040293, 933.1508327422149, 945.3760518058049, 946.3990366117428, 10754.516046777913, 11063.502142403611, 11151.386673733023, 11162.330260184415, 11192.888071119185, 659738.0, 759999.0, 768734.0, 775381.0, 789324.0, 104845.0, 137113.0, 160962.0, 161258.0, 172483.13758431128, 1144.3362849547243, 1195.6114262864603, 1220.6277085489012, 1240.8510978682616, 1264.797632378815, 18705.251789928796, 19411.611767764847, 20047.799522004592, 20426.795732043083, 20546.486337841674, 64837.999999998116, 65983.67008164928, 66495.66752166208, 68026.319736802, 68411.65794170997, 88269.0, 88524.11475885159, 90747.0, 91036.54481727548, 94386.0, 11446.370449625017, 11514.19400641947, 11614.5354185835, 11742.17804753659, 11962.04303655688, 12891.48434062627, 13018.28399438002, 13244.80132798028, 13323.933380333425, 13431.529896453578, 9291.349605527548, 10755.0, 10965.013148816644, 11192.720181995515, 11224.0, 10309.690709278733, 10373.533191006272, 10451.738706532093, 10677.839832402675, 10746.892531074902, 11429.085673145963, 11451.312921224753, 11528.308301501937, 11641.47613357384, 11718.472668730099, 11566.884331156582, 11611.593594224161, 11857.229280097112, 11970.80291970796, 12025.0, 10640.946795265974, 10745.516451759846, 11179.944100279447, 11496.252743571642, 11598.18812683138], "value": 11488.548536887054, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.824132862729, 1435.1030605871329, 1517.7723341498775, 1527.8388424797158, 1561.1569752333744, 10703.571857125715, 11267.380294083821, 11311.321320720763, 11345.886541134587, 11595.652130436101, 9336.906630933689, 11104.55581776728, 11284.774304513905, 11293.0, 11297.039751621101, 2408.951820963584, 2463.519613675334, 2469.1851688942697, 2472.987635061822, 2476.9009239630395, 2135.4234356723673, 2214.0922221889027, 2359.0563774490256, 2373.4659701567184, 2378.3221781792195, 2305.561943230781, 2355.0579768092816, 2372.608519594265, 2407.6990376202975, 2423.200343886522, 2159.136345461812, 2227.4765430123907, 2239.6640503924377, 2413.1795189635523, 2420.515896820625, 2128.7871212878745, 2144.8820314882673, 2423.866687332196, 2440.475297810979, 2440.9389765255833, 10879.456027198688, 10925.890741092568, 10955.83566246507, 10970.890291097066, 10982.450877456175, 5814.883702325972, 5862.355140934494, 5935.643861368331, 6020.277566692025, 6027.186329845458, 3536.8585256589704, 3707.5736290326686, 3761.849526018956, 3806.7335286529956, 3812.1613245086037, 1175.935323557204, 1213.7511810078913, 1254.3477391756235, 1262.267884626914, 1265.9240445573203, 12843.807342889864, 13869.79195312061, 14039.578812635636, 15449.613759656098, 15669.921650391789, 4680.134175177603, 4710.599599034052, 4751.553866552319, 4844.588210002119, 4846.975765121152, 9333.160015598629, 11431.828522572168, 11724.88275117255, 11729.4135293235, 11733.00269477087, 4902.583280421133, 5711.143328500758, 5768.567357448208, 5782.797602083907, 5804.187413762077, 5212.035773381936, 5314.937012597418, 5338.065838478251, 5346.198070289488, 5438.537724293479, 3771.867984620525, 3891.4357418174773, 3976.204759048202, 4037.1723796621623, 4042.928623914665, 1008.4503945349802, 1053.6470282455464, 1057.1965306367217, 1060.5439660945867, 1063.505469956474, 928.4661319741176, 945.4232917920064, 951.6621599332276, 959.2709540748941, 1009.8030883977701, 6725.730970761115, 6737.764178253738, 6759.425448836904, 6953.721851125898, 6974.860502790018, 949.1837020162654, 970.2819913264275, 991.5934466868549, 996.3125443444001, 1028.6965345223177, 3690.760100593453, 4337.414449049401, 4355.128974205171, 4459.331100334975, 4489.147062058199, 13654.180749155083, 14316.57050288493, 14325.140491570539, 14364.0, 14408.783868241984, 11772.470238839272, 13821.930890345686, 13959.511417100555, 14369.20969346675, 14378.137311761118, 8650.567471626393, 8751.781205469786, 10357.119644830123, 10477.057064864199, 10538.789224215472, 6388.718516413184, 6878.793636190922, 6919.0, 6974.093367862146, 7060.8940865886025, 12538.435770390537, 12722.300273485047, 12778.488860445477, 12859.0, 12925.0, 12784.936075319563, 13053.543125990545, 13090.934545327213, 13149.276789776653, 13229.470821167046, 8399.28606068491, 8521.53131577769, 8590.699325523577, 8597.785055373666, 8609.0, 8420.873686894824, 10407.791844163226, 10443.216758742972, 10529.789404212026, 10539.0, 9109.590068446803, 9112.954435228046, 9141.314401419788, 9144.954275228582, 9156.496392698466, 8770.12298770118, 8882.422642528216, 8910.198082172636, 8923.330750193632, 8931.062238464867, 8015.959920200362, 8103.473274237392, 8169.591520424074, 8223.383246256435, 8227.876581851157, 5936.406359364202, 5947.881042379215, 5983.192269043623, 6126.908096378469, 6195.4424101831055, 5490.80782172622, 5525.254090697705, 6050.848728781815, 6241.126242325987, 6334.683265836782], "value": 5156.240829314785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8825366994717, 371.22599380292087, 377.294459360995, 388.95332560092777, 394.44974260906037, 4784.497627749089, 5129.820456284031, 5181.870453238671, 5409.890972350669, 5443.733759744152, 5008.39899212095, 5143.948560514394, 5229.921551176726, 5286.365636123671, 5315.199632262931, 3839.1361943562615, 4391.694360460768, 4485.372047913294, 4621.359417406823, 4674.626029917598, 3803.581606023335, 4320.271891243497, 4517.887052823673, 4634.397528321313, 4692.451491007976, 4022.658074063708, 4191.350340697181, 4308.3968244445805, 4344.9348259776125, 4367.606915377615, 3738.2336620992633, 3945.737364043507, 4095.815688294034, 4350.717203381786, 4381.715188512737, 3621.746477746559, 3887.0953232915667, 4053.858114965962, 4096.439725171767, 4096.931049819852, 3903.765774053566, 4049.8053074342847, 4528.9547104528865, 4993.628026687331, 5042.747862606891, 4632.444106707183, 4645.488996210414, 4873.585745211662, 5107.0, 5200.531952124289, 4592.448906131252, 4800.511841329164, 5613.915791263134, 5703.914441283384, 5720.370759216525, 3777.7533413973597, 3851.614838516126, 3913.804309784528, 3995.9410756149646, 4451.844185453494, 4704.952950470486, 5087.465816089294, 5611.136362501196, 5672.716364181774, 5689.293212036372, 4094.9385759213637, 4624.9768751156025, 4653.115488227273, 4682.367880336179, 4714.175019371596, 4723.7401942893475, 4746.0, 4756.500567440369, 4759.405074365704, 4765.7140571565815, 4793.5685788279225, 4918.483559226302, 4967.857392799677, 5013.273075404046, 5097.46476619957, 5516.227728118067, 5560.857161414772, 5685.20407142992, 5701.462849032224, 5717.256756621613, 1327.966800829987, 1455.2869094143794, 1483.5373280354559, 1582.6201711589135, 1594.7687585300066, 980.9068138526972, 1109.5298729183864, 1162.3490845126587, 1196.682879037056, 1207.918912573242, 4407.162639098561, 5036.5718913892, 5154.30416893722, 5255.78976840922, 5279.709615971158, 4941.6657502474845, 5530.032159479086, 5539.0, 5812.505936995402, 5874.647521148745, 4480.812584665066, 4868.683535570248, 5197.8045049638795, 5240.816571420059, 5254.238135470336, 2955.4779288666355, 2973.8550657996825, 3049.573059771634, 3073.969260307413, 3091.211741006074, 5271.920921186185, 5451.509364157245, 5959.493443057302, 6110.511159107261, 6125.877482450415, 5006.023825354094, 5149.2276158576515, 5347.893042139135, 5540.529055030287, 5722.677909544164, 5695.579378764009, 6053.4261092115485, 6127.019676851683, 6135.478484328882, 6139.877202455926, 5260.4218734378765, 5726.742296596746, 5830.387809280134, 5844.736986835517, 5929.657785174745, 5561.443855614568, 5582.62251337951, 5802.883942321046, 5816.680082595498, 5847.502962248086, 5535.948169847716, 5941.435563621449, 5975.309382135003, 6009.759609615567, 6116.847078823065, 4029.952212424732, 4674.499142958501, 4685.0, 4698.506656800987, 4720.622350211906, 5560.0, 5775.451332123442, 5943.732532035982, 5967.8209653710455, 5968.881047228171, 5049.84850454487, 5417.945820541744, 5604.8318550443555, 5608.130739735348, 5661.933394311129, 5609.943900560942, 5662.971685141548, 5672.801451949162, 5674.829755107354, 5693.544516438592, 4902.975485122552, 5059.671121377099, 5326.440723723953, 5495.972520137534, 5563.13771365439, 5044.949550504448, 5352.357717073976, 5402.918956215739, 5717.656940583578, 5726.570507212059, 3957.753307708063, 4908.140940468981, 4991.850244492526, 5190.740462976761, 5569.632906015008], "value": 4293.984388277494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.4643544124185, 719.9388052015579, 737.856118056979, 759.269079609264, 857.2242120880605, 14686.926565367172, 15345.0, 15842.0, 15887.761683574741, 15888.28502717379, 15052.322645480952, 15085.698286034272, 15290.923545382286, 15344.232788360594, 15386.923065384657, 900.4327273817519, 917.0829170829154, 922.3082687984012, 938.976525586859, 948.2556193388192, 898.3576742629019, 938.052566907425, 940.534435454451, 943.4339396362162, 945.938513996588, 968.0, 980.0738302304289, 981.8919918808925, 982.2583949118406, 983.2920297385906, 974.6247694637544, 974.9658761943298, 975.556121964508, 975.5658731864323, 975.6243846119295, 717.0928775099503, 718.066513532411, 718.7735863203075, 720.2113685514354, 721.030214361688, 15941.840581594151, 16230.944988575704, 16301.429449969313, 16651.91674041634, 16995.320187192498, 13989.720205595933, 14207.552603096115, 14319.355628996616, 14382.712345753027, 14418.49535266271, 11746.412679365998, 11824.467898944482, 11859.822102668468, 11863.703407414798, 11873.406329683481, 3575.696065834381, 3611.5846677632144, 3639.872604458831, 3673.7244706647107, 3793.905152371213, 95842.0, 97214.99999999929, 98779.50610246975, 98784.50607746986, 98896.50551747339, 9163.541822908828, 9747.561359738687, 10197.18422526196, 10201.0, 10448.843267350996, 21592.35222943314, 21634.56730865374, 21751.238706645192, 21872.23447179341, 22080.44798880041, 7620.047494063242, 7721.691132354756, 7774.455788094892, 7798.727044553413, 7911.248431399008, 3956.22853543562, 4321.308590625485, 4323.978380108079, 4496.3255511673515, 4585.12882552314, 3486.6687664671817, 3513.191965847869, 3549.6627820357025, 3562.697170740516, 3589.9102522437147, 624.8469125064297, 634.2800920954658, 642.2325321241073, 651.2347991110427, 652.0317328766778, 601.8074216250845, 688.3598253624177, 707.6249587718518, 709.5955305475933, 712.2805965974403, 8659.567021648892, 9122.543872806333, 9684.322097453252, 9844.114029737215, 10311.07200351972, 652.1880259077384, 681.5637991685326, 693.5396779003565, 693.549193024528, 720.772956518695, 4623.468301145344, 4989.426215985136, 4992.176290911959, 5004.1492946198505, 5092.26162206478, 74924.25075749282, 98843.01156988482, 106641.46679266554, 107821.0, 112880.0, 60056.699716501134, 76514.0, 79712.60143699244, 86551.13448865556, 94272.52863735774, 65712.01431978524, 68681.31318686849, 71470.0, 81553.59223203965, 87576.0, 10735.516901739284, 11105.777884442105, 11119.722006949567, 11233.157513186381, 11420.657380278604, 51745.7412712934, 51939.70150746262, 52142.0, 52367.47632523626, 52710.94578108493, 60895.08657370232, 61883.38116618956, 70226.64886675533, 71028.57942841011, 71433.0, 13643.863561364657, 13775.104618199784, 14115.929420352833, 14169.079009864327, 14739.92630036886, 13209.537666182023, 15182.620434488785, 15231.314590843216, 15239.923800380928, 15511.37954481808, 13866.0, 13903.443862245396, 14070.366833492722, 14302.427902883768, 14305.21321327337, 11850.525978960744, 13647.590572282847, 13944.79082813779, 13969.720605587629, 14050.648733781329, 13103.672408189872, 13702.794458082937, 13815.516456923959, 14114.941379396381, 14142.292885355897, 9128.817423651357, 9340.0, 9366.859497107685, 9485.0, 9673.661421850202, 10253.384796912209, 11112.444377781241, 11481.36852473122, 11849.52601895949, 12117.878821212027], "value": 7608.059217674051, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 121.0, 120.0, 119.0, 119.0, 121.0, 119.0, 120.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 139.0, 149.0, 136.0, 139.0, 142.0, 115.0, 129.0, 113.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 199.0, 193.0, 199.0, 198.0, 195.0, 199.0, 195.0, 203.0, 194.0], "value": 197.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 51.0, 71.0, 80.0, 55.0, 76.0, 85.0, 87.0, 97.0, 52.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 73.0, 88.0, 71.0, 71.0, 69.0, 82.0, 69.0, 69.0, 82.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 109.0, 89.0, 90.0, 91.0, 102.0, 103.0, 117.0, 81.0, 135.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 103.0, 91.0, 151.0, 143.0, 98.0, 97.0, 102.0, 93.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 110.0, 146.0, 99.0, 144.0, 94.0, 152.0, 92.0, 154.0, 90.0], "value": 117.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 67.0, 90.0, 102.0, 105.0, 77.0, 68.0, 70.0], "value": 77.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 70.0, 67.0, 63.0, 60.0, 58.0, 58.0, 60.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 85.0, 84.0, 82.0, 87.0, 82.0, 86.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 138.0, 139.0, 139.0, 139.0, 143.0, 142.0, 186.0, 141.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 167.0, 169.0, 172.0, 168.0, 195.0, 172.0, 166.0, 171.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 67.0, 64.0, 65.0, 66.0, 76.0, 73.0, 65.0], "value": 67.2, "unit": "score"}]}]} 07:43:35 INFO - Return code: 0 07:43:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:43:35 ERROR - # TBPL SUCCESS # 07:43:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:43:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:43:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:43:35 INFO - 2017-04-18 07:43:35.474 screenresolution[2001:22263] starting screenresolution argv=screenresolution get 07:43:35 INFO - 2017-04-18 07:43:35.477 screenresolution[2001:22263] Display 0: 1600x1200x32@60 07:43:35 INFO - 2017-04-18 07:43:35.483 screenresolution[2002:22266] starting screenresolution argv=screenresolution list 07:43:35 INFO - Available Modes on Display 0 07:43:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:43:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:43:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:43:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:43:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:43:35 INFO - Intel Iris: 07:43:35 INFO - Chipset Model: Intel Iris 07:43:35 INFO - Type: GPU 07:43:35 INFO - Bus: Built-In 07:43:35 INFO - VRAM (Dynamic, Max): 1536 MB 07:43:35 INFO - Vendor: Intel (0x8086) 07:43:35 INFO - Device ID: 0x0a2e 07:43:35 INFO - Revision ID: 0x0009 07:43:35 INFO - Displays: 07:43:35 INFO - Display: 07:43:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:43:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:43:35 INFO - Display Serial Number: 1600x1200 60 07:43:35 INFO - Main Display: Yes 07:43:35 INFO - Mirror: Off 07:43:35 INFO - Online: Yes 07:43:35 INFO - Rotation: Supported 07:43:35 INFO - Return code: 0 07:43:35 INFO - Running post-action listener: _resource_record_post_action 07:43:35 INFO - [mozharness: 2017-04-18 14:43:35.722099Z] Finished run-tests step (success) 07:43:35 INFO - Running post-run listener: _resource_record_post_run 07:43:35 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 1650688; Write bytes: 511474688; Read time: 9; Write time: 1623 07:43:35 INFO - TinderboxPrint: CPU usage
54.5% 07:43:35 INFO - TinderboxPrint: I/O read bytes / time
1,650,688 / 9 07:43:35 INFO - TinderboxPrint: I/O write bytes / time
511,474,688 / 1,623 07:43:35 INFO - TinderboxPrint: CPU idle
2,184.5 (45.5%) 07:43:35 INFO - TinderboxPrint: CPU system
958.9 (20.0%) 07:43:35 INFO - TinderboxPrint: CPU user
1,654.4 (34.5%) 07:43:35 INFO - TinderboxPrint: Swap in / out
209,244,160 / 0 07:43:35 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 199991808; Write bytes: 201832448; Read time: 15515; Write time: 428 07:43:35 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1646592; Write bytes: 299717632; Read time: 9; Write time: 1161 07:43:36 INFO - Running post-run listener: _upload_blobber_files 07:43:36 INFO - Blob upload gear active. 07:43:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:43:36 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 07:43:36 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'] 07:43:36 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 07:43:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:37 INFO - (blobuploader) - INFO - Done attempting. 07:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:38 INFO - (blobuploader) - INFO - Done attempting. 07:43:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:43:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:43:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:39 INFO - (blobuploader) - INFO - Done attempting. 07:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:41 INFO - (blobuploader) - INFO - Done attempting. 07:43:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:43:41 INFO - Return code: 0 07:43:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:43:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:43:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/107abb6bda920ace6b68cc0a7ed92ace397d57c42d07ab1d5a3661ce7c712795b9eb5141b1c7f8911319311b4efbc45632ddee21b4a9da64346c7753b4e67cf0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1ec916b0ae387171eb4af8368465b9d5547534ae70750b0b06df15bf5f7c3beb5ee776af7c2417e4f9c07d31cab22ca23492a6d6856df51253f95096008396", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be7f21f5c4336cc9776809d67c2efa6c904ec3d0d59e83589ec142d8aa785fadba4a33edf74e52544b7063eb88d5380e72c4cd44597172acaf9e8003c175f5a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e8e12adc32c5fc08037a995ac6bc4d8bf974e6649ff54fa8d8a3bc3de705ba2375999e316c4b65cc00252a08b441ffca3e1c98d84739ed7a6916eccb29b6db"} 07:43:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:43:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:43:41 INFO - Contents: 07:43:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/107abb6bda920ace6b68cc0a7ed92ace397d57c42d07ab1d5a3661ce7c712795b9eb5141b1c7f8911319311b4efbc45632ddee21b4a9da64346c7753b4e67cf0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1ec916b0ae387171eb4af8368465b9d5547534ae70750b0b06df15bf5f7c3beb5ee776af7c2417e4f9c07d31cab22ca23492a6d6856df51253f95096008396", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be7f21f5c4336cc9776809d67c2efa6c904ec3d0d59e83589ec142d8aa785fadba4a33edf74e52544b7063eb88d5380e72c4cd44597172acaf9e8003c175f5a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e8e12adc32c5fc08037a995ac6bc4d8bf974e6649ff54fa8d8a3bc3de705ba2375999e316c4b65cc00252a08b441ffca3e1c98d84739ed7a6916eccb29b6db"} 07:43:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:43:41 INFO - Copying logs to upload dir... 07:43:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:43:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.565311 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-18 07:43:41.313936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 07:43:41.317245) ========= 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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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/107abb6bda920ace6b68cc0a7ed92ace397d57c42d07ab1d5a3661ce7c712795b9eb5141b1c7f8911319311b4efbc45632ddee21b4a9da64346c7753b4e67cf0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1ec916b0ae387171eb4af8368465b9d5547534ae70750b0b06df15bf5f7c3beb5ee776af7c2417e4f9c07d31cab22ca23492a6d6856df51253f95096008396", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be7f21f5c4336cc9776809d67c2efa6c904ec3d0d59e83589ec142d8aa785fadba4a33edf74e52544b7063eb88d5380e72c4cd44597172acaf9e8003c175f5a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e8e12adc32c5fc08037a995ac6bc4d8bf974e6649ff54fa8d8a3bc3de705ba2375999e316c4b65cc00252a08b441ffca3e1c98d84739ed7a6916eccb29b6db"} build_url:https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010929 build_url: 'https://queue.taskcluster.net/v1/task/fSwzWM53TSO1CLbh41rPbQ/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/107abb6bda920ace6b68cc0a7ed92ace397d57c42d07ab1d5a3661ce7c712795b9eb5141b1c7f8911319311b4efbc45632ddee21b4a9da64346c7753b4e67cf0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1ec916b0ae387171eb4af8368465b9d5547534ae70750b0b06df15bf5f7c3beb5ee776af7c2417e4f9c07d31cab22ca23492a6d6856df51253f95096008396", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be7f21f5c4336cc9776809d67c2efa6c904ec3d0d59e83589ec142d8aa785fadba4a33edf74e52544b7063eb88d5380e72c4cd44597172acaf9e8003c175f5a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e8e12adc32c5fc08037a995ac6bc4d8bf974e6649ff54fa8d8a3bc3de705ba2375999e316c4b65cc00252a08b441ffca3e1c98d84739ed7a6916eccb29b6db"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 07:43:41.354867) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:43:41.355213) ========= 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.JKpSZS6Yqw/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.pwLxBG8gpp/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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.004500 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:43:41.403840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 07:43:41.404167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 07:43:41.404505) ========= ========= Total master_lag: 0.19 =========