builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0190 starttime: 1492510828.41 results: success (0) buildid: 20170418014944 builduid: c3b4f8104f4b4155a9257798993dec06 revision: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.413358) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.413795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.414070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.440819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.441179) ========= 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.16uyWxQxzO/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.iwEyeTOJV9/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:20:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 49.4M=0s 2017-04-18 03:20:28 (49.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.592584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.592893) ========= 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.16uyWxQxzO/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.iwEyeTOJV9/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.022106 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:28.641094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 03:20:28.641453) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b43e1c02d4ff32f7d45a6c614720660f52927d9 --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 4b43e1c02d4ff32f7d45a6c614720660f52927d9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.16uyWxQxzO/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.iwEyeTOJV9/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:20:28,725 truncating revision to first 12 chars 2017-04-18 03:20:28,726 Setting DEBUG logging. 2017-04-18 03:20:28,726 attempt 1/10 2017-04-18 03:20:28,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b43e1c02d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 03:20:30,815 unpacking tar archive at: mozilla-aurora-4b43e1c02d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.346910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 03:20:31.012002) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:31.012371) ========= script_repo_revision: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:31.012744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:31.013005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 03:20:31.032562) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-18 03:20:31.032915) ========= /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.16uyWxQxzO/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.iwEyeTOJV9/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:20:31 INFO - MultiFileLogger online at 20170418 03:20:31 in /builds/slave/test 03:20:31 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 03:20:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:31 INFO - {'append_to_log': False, 03:20:31 INFO - 'base_work_dir': '/builds/slave/test', 03:20:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:20:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:31 INFO - 'branch': 'Mozilla-Aurora', 03:20:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:31 INFO - 'config_files': ('talos/mac_config.py',), 03:20:31 INFO - 'default_actions': ('clobber', 03:20:31 INFO - 'read-buildbot-config', 03:20:31 INFO - 'download-and-extract', 03:20:31 INFO - 'populate-webroot', 03:20:31 INFO - 'create-virtualenv', 03:20:31 INFO - 'install', 03:20:31 INFO - 'run-tests'), 03:20:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:31 INFO - 'download_minidump_stackwalk': True, 03:20:31 INFO - 'download_symbols': 'ondemand', 03:20:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:31 INFO - 'gecko_profile': False, 03:20:31 INFO - 'gecko_profile_interval': 0, 03:20:31 INFO - 'installer_path': 'installer.exe', 03:20:31 INFO - 'log_level': 'info', 03:20:31 INFO - 'log_name': 'talos', 03:20:31 INFO - 'log_to_console': True, 03:20:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:20:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:20:31 INFO - 'opt_config_files': (), 03:20:31 INFO - 'pip_index': False, 03:20:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:31 INFO - 'cmd': ('bash', 03:20:31 INFO - '-c', 03:20:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:31 INFO - 'enabled': True, 03:20:31 INFO - 'halt_on_failure': False, 03:20:31 INFO - 'name': 'check_screen_resolution'},), 03:20:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:31 INFO - 'cmd': ('bash', 03:20:31 INFO - '-c', 03:20:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:31 INFO - 'enabled': True, 03:20:31 INFO - 'halt_on_failure': False, 03:20:31 INFO - 'name': 'check_screen_resolution'},), 03:20:31 INFO - 'run_cmd_checks_enabled': True, 03:20:31 INFO - 'suite': 'dromaeojs-e10s', 03:20:31 INFO - 'system_bits': '32', 03:20:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:31 INFO - 'title': 't-yosemite-r7-0190', 03:20:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:31 INFO - 'use_talos_json': True, 03:20:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:31 INFO - 'work_dir': 'build'} 03:20:31 INFO - [mozharness: 2017-04-18 10:20:31.244660Z] Running clobber step. 03:20:31 INFO - Running pre-action listener: _resource_record_pre_action 03:20:31 INFO - Running main action method: clobber 03:20:31 INFO - rmtree: /builds/slave/test/build 03:20:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:34 INFO - Running post-action listener: _resource_record_post_action 03:20:34 INFO - [mozharness: 2017-04-18 10:20:34.448325Z] Finished clobber step (success) 03:20:34 INFO - [mozharness: 2017-04-18 10:20:34.448529Z] Running read-buildbot-config step. 03:20:34 INFO - Running pre-action listener: _resource_record_pre_action 03:20:34 INFO - Running main action method: read_buildbot_config 03:20:34 INFO - Using buildbot properties: 03:20:34 INFO - { 03:20:34 INFO - "project": "", 03:20:34 INFO - "product": "firefox", 03:20:34 INFO - "script_repo_revision": "production", 03:20:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:20:34 INFO - "repository": "", 03:20:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:20:34 INFO - "buildid": "20170418014944", 03:20:34 INFO - "pgo_build": "False", 03:20:34 INFO - "basedir": "/builds/slave/test", 03:20:34 INFO - "buildnumber": 24, 03:20:34 INFO - "slavename": "t-yosemite-r7-0190", 03:20:34 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:20:34 INFO - "platform": "yosemite_r7", 03:20:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:20:34 INFO - "branch": "mozilla-aurora", 03:20:34 INFO - "repo_path": "releases/mozilla-aurora", 03:20:34 INFO - "revision": "4b43e1c02d4ff32f7d45a6c614720660f52927d9", 03:20:34 INFO - "stage_platform": "macosx64", 03:20:34 INFO - "builduid": "c3b4f8104f4b4155a9257798993dec06", 03:20:34 INFO - "slavebuilddir": "test" 03:20:34 INFO - } 03:20:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:20:34 INFO - Running post-action listener: _resource_record_post_action 03:20:34 INFO - [mozharness: 2017-04-18 10:20:34.452556Z] Finished read-buildbot-config step (success) 03:20:34 INFO - [mozharness: 2017-04-18 10:20:34.452729Z] Running download-and-extract step. 03:20:34 INFO - Running pre-action listener: _resource_record_pre_action 03:20:34 INFO - Running main action method: download_and_extract 03:20:34 INFO - mkdir: /builds/slave/test/build/tests 03:20:34 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')]} 03:20:34 INFO - trying https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:20:34 INFO - Downloading https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/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 03:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/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 03:20:35 INFO - Downloaded 1199 bytes. 03:20:35 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:20:35 INFO - Using the following test package requirements: 03:20:35 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:20:35 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:20:35 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:20:35 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'jsshell-mac.zip'], 03:20:35 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:20:35 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:20:35 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:20:35 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:20:35 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:20:35 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:20:35 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:20:35 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:20:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:20:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:20:35 INFO - Fetch https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:20:36 INFO - Expected file size: 51791220 03:20:36 INFO - Obtained file size: 51791220 03:20:52 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 03:20:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:20:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:20:52 INFO - Fetch https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:20:54 INFO - Expected file size: 51791220 03:20:54 INFO - Obtained file size: 51791220 03:21:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:21:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:21:10 INFO - Fetch https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:21:11 INFO - Expected file size: 14404424 03:21:11 INFO - Obtained file size: 14404424 03:21: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')]} 03:21:11 INFO - trying https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:21:11 INFO - Downloading https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/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 03:21:13 INFO - Downloaded 74744123 bytes. 03:21:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:21:13 INFO - mkdir: /builds/slave/test/properties 03:21:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:13 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:13 INFO - Contents: 03:21:13 INFO - build_url:https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:21:14 INFO - Running post-action listener: _resource_record_post_action 03:21:14 INFO - Running post-action listener: set_extra_try_arguments 03:21:14 INFO - [mozharness: 2017-04-18 10:21:14.191248Z] Finished download-and-extract step (success) 03:21:14 INFO - [mozharness: 2017-04-18 10:21:14.191388Z] Running populate-webroot step. 03:21:14 INFO - Running pre-action listener: _resource_record_pre_action 03:21:14 INFO - Running main action method: populate_webroot 03:21:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:14 INFO - '--tppagecycles', 03:21:14 INFO - '7'], 03:21:14 INFO - 'tests': ['tsvgm']}}, 03:21:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['damp', 'tps']}, 03:21:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'tests': ['damp', 'tps']}, 03:21:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['dromaeo_dom']}, 03:21:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['basic_compositor_video']}, 03:21:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:21:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['a11yr', 03:21:14 INFO - 'ts_paint', 03:21:14 INFO - 'tpaint', 03:21:14 INFO - 'sessionrestore', 03:21:14 INFO - 'sessionrestore_no_auto_restore', 03:21:14 INFO - 'tabpaint']}, 03:21:14 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:14 INFO - 'ts_paint', 03:21:14 INFO - 'tpaint', 03:21:14 INFO - 'sessionrestore', 03:21:14 INFO - 'sessionrestore_no_auto_restore', 03:21:14 INFO - 'tabpaint']}, 03:21:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:14 INFO - 'ts_paint', 03:21:14 INFO - 'tpaint', 03:21:14 INFO - 'sessionrestore', 03:21:14 INFO - 'sessionrestore_no_auto_restore', 03:21:14 INFO - 'tabpaint']}, 03:21:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:14 INFO - 'ts_paint', 03:21:14 INFO - 'tpaint', 03:21:14 INFO - 'sessionrestore', 03:21:14 INFO - 'sessionrestore_no_auto_restore', 03:21:14 INFO - 'tabpaint']}, 03:21:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['a11yr', 03:21:14 INFO - 'ts_paint', 03:21:14 INFO - 'tpaint', 03:21:14 INFO - 'sessionrestore', 03:21:14 INFO - 'sessionrestore_no_auto_restore', 03:21:14 INFO - 'tabpaint']}, 03:21:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['a11yr', 03:21:14 INFO - 'ts_paint', 03:21:14 INFO - 'tpaint', 03:21:14 INFO - 'sessionrestore', 03:21:14 INFO - 'sessionrestore_no_auto_restore', 03:21:14 INFO - 'tabpaint']}, 03:21:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['tsvgx', 03:21:14 INFO - 'tsvgr_opacity', 03:21:14 INFO - 'tart', 03:21:14 INFO - 'tscrollx', 03:21:14 INFO - 'cart', 03:21:14 INFO - 'tsvg_static']}, 03:21:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:14 INFO - 'tsvgr_opacity', 03:21:14 INFO - 'tart', 03:21:14 INFO - 'tscrollx', 03:21:14 INFO - 'cart', 03:21:14 INFO - 'tsvg_static']}, 03:21:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'talos_options': ['--disable-e10s'], 03:21:14 INFO - 'tests': ['tp5o']}, 03:21:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:21:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'talos_options': ['--disable-e10s', 03:21:14 INFO - '--xperf_path', 03:21:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:14 INFO - 'tests': ['tp5n']}, 03:21:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:21:14 INFO - 'talos_options': ['--xperf_path', 03:21:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:14 INFO - 'tests': ['tp5n']}}, 03:21:14 INFO - 'talos.zip': {'path': '', 03:21:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:14 INFO - Running post-action listener: _resource_record_post_action 03:21:14 INFO - [mozharness: 2017-04-18 10:21:14.209890Z] Finished populate-webroot step (success) 03:21:14 INFO - [mozharness: 2017-04-18 10:21:14.210002Z] Running create-virtualenv step. 03:21:14 INFO - Running pre-action listener: _resource_record_pre_action 03:21:14 INFO - Running main action method: create_virtualenv 03:21:14 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:14 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 03:21:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:14 INFO - Using real prefix '/tools/python27' 03:21:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:18 INFO - Installing pip.................done. 03:21:18 INFO - Return code: 0 03:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:21:18 INFO - Reading from file tmpfile_stdout 03:21:18 INFO - Output received: 03:21:18 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) 03:21:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:18 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')]} 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:18 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')]} 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:18 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:18 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 03:21:18 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 03:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:18 INFO - 'HOME': '/Users/cltbld', 03:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:18 INFO - 'LOGNAME': 'cltbld', 03:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:18 INFO - 'MOZ_NO_REMOTE': '1', 03:21:18 INFO - 'NO_EM_RESTART': '1', 03:21:18 INFO - 'PAGER': '/bin/cat', 03:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:18 INFO - 'PWD': '/builds/slave/test', 03:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:18 INFO - 'SHELL': '/bin/bash', 03:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:18 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:18 INFO - 'USER': 'cltbld', 03:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:18 INFO - 'XPC_FLAGS': '0x0', 03:21:18 INFO - 'XPC_SERVICE_NAME': '0', 03:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:18 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 03:21:18 INFO - Cleaning up... 03:21:18 INFO - Return code: 0 03:21:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:21:18 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')]} 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:18 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')]} 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:18 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:18 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 03:21:18 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 03:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:18 INFO - 'HOME': '/Users/cltbld', 03:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:18 INFO - 'LOGNAME': 'cltbld', 03:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:18 INFO - 'MOZ_NO_REMOTE': '1', 03:21:18 INFO - 'NO_EM_RESTART': '1', 03:21:18 INFO - 'PAGER': '/bin/cat', 03:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:18 INFO - 'PWD': '/builds/slave/test', 03:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:18 INFO - 'SHELL': '/bin/bash', 03:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:18 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:18 INFO - 'USER': 'cltbld', 03:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:18 INFO - 'XPC_FLAGS': '0x0', 03:21:18 INFO - 'XPC_SERVICE_NAME': '0', 03:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:18 INFO - Downloading/unpacking psutil>=3.1.1 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:22 INFO - Installing collected packages: psutil 03:21:22 INFO - Running setup.py install for psutil 03:21:22 INFO - building 'psutil._psutil_osx' extension 03:21:22 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 03:21:22 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 03:21:22 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 03:21:22 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 03:21:22 INFO - building 'psutil._psutil_posix' extension 03:21:22 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 03:21:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:21:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:21:22 INFO - ^ 03:21:22 INFO - 1 warning generated. 03:21:22 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 03:21:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:23 INFO - Successfully installed psutil 03:21:23 INFO - Cleaning up... 03:21:23 INFO - Return code: 0 03:21:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:21:23 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')]} 03:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:23 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')]} 03:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:23 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:23 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 03:21:23 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 03:21:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:23 INFO - 'HOME': '/Users/cltbld', 03:21:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:23 INFO - 'LOGNAME': 'cltbld', 03:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:23 INFO - 'MOZ_NO_REMOTE': '1', 03:21:23 INFO - 'NO_EM_RESTART': '1', 03:21:23 INFO - 'PAGER': '/bin/cat', 03:21:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:23 INFO - 'PWD': '/builds/slave/test', 03:21:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:23 INFO - 'SHELL': '/bin/bash', 03:21:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:23 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:23 INFO - 'USER': 'cltbld', 03:21:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:23 INFO - 'XPC_FLAGS': '0x0', 03:21:23 INFO - 'XPC_SERVICE_NAME': '0', 03:21:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:21:26 INFO - Installing collected packages: mozsystemmonitor 03:21:26 INFO - Running setup.py install for mozsystemmonitor 03:21:26 INFO - Successfully installed mozsystemmonitor 03:21:26 INFO - Cleaning up... 03:21:26 INFO - Return code: 0 03:21:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:21:26 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')]} 03:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:26 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')]} 03:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:27 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:27 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 03:21:27 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 03:21:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:27 INFO - 'HOME': '/Users/cltbld', 03:21:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:27 INFO - 'LOGNAME': 'cltbld', 03:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:27 INFO - 'MOZ_NO_REMOTE': '1', 03:21:27 INFO - 'NO_EM_RESTART': '1', 03:21:27 INFO - 'PAGER': '/bin/cat', 03:21:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:27 INFO - 'PWD': '/builds/slave/test', 03:21:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:27 INFO - 'SHELL': '/bin/bash', 03:21:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:27 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:27 INFO - 'USER': 'cltbld', 03:21:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:27 INFO - 'XPC_FLAGS': '0x0', 03:21:27 INFO - 'XPC_SERVICE_NAME': '0', 03:21:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:27 INFO - Downloading/unpacking jsonschema==2.5.1 03:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:30 INFO - warning: no files found matching '*.txt' 03:21:30 INFO - no previously-included directories found matching 'build' 03:21:30 INFO - no previously-included directories found matching 'dist' 03:21:30 INFO - no previously-included directories found matching '.git*' 03:21:30 INFO - Installing collected packages: jsonschema, functools32 03:21:31 INFO - Running setup.py install for functools32 03:21:31 INFO - warning: no files found matching '*.txt' 03:21:31 INFO - no previously-included directories found matching 'build' 03:21:31 INFO - no previously-included directories found matching 'dist' 03:21:31 INFO - no previously-included directories found matching '.git*' 03:21:31 INFO - Successfully installed jsonschema functools32 03:21:31 INFO - Cleaning up... 03:21:31 INFO - Return code: 0 03:21:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:31 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 03:21:31 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 03:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:31 INFO - 'HOME': '/Users/cltbld', 03:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:31 INFO - 'LOGNAME': 'cltbld', 03:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:31 INFO - 'MOZ_NO_REMOTE': '1', 03:21:31 INFO - 'NO_EM_RESTART': '1', 03:21:31 INFO - 'PAGER': '/bin/cat', 03:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:31 INFO - 'PWD': '/builds/slave/test', 03:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:31 INFO - 'SHELL': '/bin/bash', 03:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:31 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:31 INFO - 'USER': 'cltbld', 03:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:31 INFO - 'XPC_FLAGS': '0x0', 03:21:31 INFO - 'XPC_SERVICE_NAME': '0', 03:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:21:31 INFO - Cleaning up... 03:21:31 INFO - Return code: 0 03:21:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:31 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 03:21:31 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 03:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:31 INFO - 'HOME': '/Users/cltbld', 03:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:31 INFO - 'LOGNAME': 'cltbld', 03:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:31 INFO - 'MOZ_NO_REMOTE': '1', 03:21:31 INFO - 'NO_EM_RESTART': '1', 03:21:31 INFO - 'PAGER': '/bin/cat', 03:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:31 INFO - 'PWD': '/builds/slave/test', 03:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:31 INFO - 'SHELL': '/bin/bash', 03:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:31 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:31 INFO - 'USER': 'cltbld', 03:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:31 INFO - 'XPC_FLAGS': '0x0', 03:21:31 INFO - 'XPC_SERVICE_NAME': '0', 03:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:35 INFO - Downloading docopt-0.6.1.tar.gz 03:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:35 INFO - Running setup.py install for blobuploader 03:21:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:35 INFO - Running setup.py install for requests 03:21:36 INFO - Running setup.py install for docopt 03:21:36 INFO - Successfully installed blobuploader requests docopt 03:21:36 INFO - Cleaning up... 03:21:36 INFO - Return code: 0 03:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:36 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:36 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 03:21:36 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 03:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:36 INFO - 'HOME': '/Users/cltbld', 03:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:36 INFO - 'LOGNAME': 'cltbld', 03:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:36 INFO - 'MOZ_NO_REMOTE': '1', 03:21:36 INFO - 'NO_EM_RESTART': '1', 03:21:36 INFO - 'PAGER': '/bin/cat', 03:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:36 INFO - 'PWD': '/builds/slave/test', 03:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:36 INFO - 'SHELL': '/bin/bash', 03:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:36 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:36 INFO - 'USER': 'cltbld', 03:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:36 INFO - 'XPC_FLAGS': '0x0', 03:21:36 INFO - 'XPC_SERVICE_NAME': '0', 03:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:36 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2XfSl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:36 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-r4u72k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UfIKtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Nst2og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-_HPoKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-8da4WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-SNw4YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-TVVvZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ZxR0Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-aFKf8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:37 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-KhjiaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FMbk0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-DK1EDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-H6vZGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-q9uOfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-NTwSAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:38 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-1m8c3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:38 INFO - Running setup.py install for manifestparser 03:21:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:38 INFO - Running setup.py install for mozcrash 03:21:38 INFO - Running setup.py install for mozdebug 03:21:39 INFO - Running setup.py install for mozdevice 03:21:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozfile 03:21:39 INFO - Running setup.py install for mozhttpd 03:21:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozinfo 03:21:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozInstall 03:21:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozleak 03:21:39 INFO - Running setup.py install for mozlog 03:21:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for moznetwork 03:21:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for mozprocess 03:21:40 INFO - Running setup.py install for mozprofile 03:21:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for mozrunner 03:21:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for mozscreenshot 03:21:40 INFO - Running setup.py install for moztest 03:21:41 INFO - Running setup.py install for mozversion 03:21:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:41 INFO - Cleaning up... 03:21:41 INFO - Return code: 0 03:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:41 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:41 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 03:21:41 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 03:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:41 INFO - 'HOME': '/Users/cltbld', 03:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:41 INFO - 'LOGNAME': 'cltbld', 03:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:41 INFO - 'MOZ_NO_REMOTE': '1', 03:21:41 INFO - 'NO_EM_RESTART': '1', 03:21:41 INFO - 'PAGER': '/bin/cat', 03:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:41 INFO - 'PWD': '/builds/slave/test', 03:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:41 INFO - 'SHELL': '/bin/bash', 03:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:41 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:41 INFO - 'USER': 'cltbld', 03:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:41 INFO - 'XPC_FLAGS': '0x0', 03:21:41 INFO - 'XPC_SERVICE_NAME': '0', 03:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:41 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-6MnI1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:41 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)) 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:41 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-YtS8SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:41 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)) 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:41 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-nk1kLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:41 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)) 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:41 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-93n82y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-WrVwEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-KAqKM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-VQdQgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-DGXOj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-L4AJQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-pP3hzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-YByjVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-VctnPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FXczxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:42 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ETIX61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Ikqs2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-9X56a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:43 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-bMmT91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:46 INFO - Downloading blessings-1.6.tar.gz 03:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:46 INFO - Installing collected packages: blessings 03:21:46 INFO - Running setup.py install for blessings 03:21:46 INFO - Successfully installed blessings 03:21:46 INFO - Cleaning up... 03:21:46 INFO - Return code: 0 03:21:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:46 INFO - Reading from file tmpfile_stdout 03:21:46 INFO - Current package versions: 03:21:46 INFO - blessings == 1.6 03:21:46 INFO - blobuploader == 1.2.4 03:21:46 INFO - docopt == 0.6.1 03:21:46 INFO - functools32 == 3.2.3-2 03:21:46 INFO - jsonschema == 2.5.1 03:21:46 INFO - manifestparser == 1.1 03:21:46 INFO - mozInstall == 1.12 03:21:46 INFO - mozcrash == 1.0 03:21:46 INFO - mozdebug == 0.1 03:21:46 INFO - mozdevice == 0.49 03:21:46 INFO - mozfile == 1.2 03:21:46 INFO - mozhttpd == 0.7 03:21:46 INFO - mozinfo == 0.9 03:21:46 INFO - mozleak == 0.1 03:21:46 INFO - mozlog == 3.4 03:21:46 INFO - moznetwork == 0.27 03:21:46 INFO - mozprocess == 0.25 03:21:46 INFO - mozprofile == 0.28 03:21:46 INFO - mozrunner == 6.13 03:21:46 INFO - mozscreenshot == 0.1 03:21:46 INFO - mozsystemmonitor == 0.3 03:21:46 INFO - moztest == 0.8 03:21:46 INFO - mozversion == 1.4 03:21:46 INFO - psutil == 3.1.1 03:21:46 INFO - requests == 1.2.3 03:21:46 INFO - wsgiref == 0.1.2 03:21:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:46 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')]} 03:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 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')]} 03:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:46 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 03:21:46 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 03:21:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:46 INFO - 'HOME': '/Users/cltbld', 03:21:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:46 INFO - 'LOGNAME': 'cltbld', 03:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:46 INFO - 'MOZ_NO_REMOTE': '1', 03:21:46 INFO - 'NO_EM_RESTART': '1', 03:21:46 INFO - 'PAGER': '/bin/cat', 03:21:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:46 INFO - 'PWD': '/builds/slave/test', 03:21:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:46 INFO - 'SHELL': '/bin/bash', 03:21:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:46 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:46 INFO - 'USER': 'cltbld', 03:21:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:46 INFO - 'XPC_FLAGS': '0x0', 03:21:46 INFO - 'XPC_SERVICE_NAME': '0', 03:21:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 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)) 03:21:46 INFO - Cleaning up... 03:21:46 INFO - Return code: 0 03:21:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:46 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')]} 03:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 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')]} 03:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 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 0x107c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4bbd8c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, '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.16uyWxQxzO/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.iwEyeTOJV9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 03:21:46 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 03:21:46 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 03:21:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:21:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:46 INFO - 'HOME': '/Users/cltbld', 03:21:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:46 INFO - 'LOGNAME': 'cltbld', 03:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:46 INFO - 'MOZ_NO_REMOTE': '1', 03:21:46 INFO - 'NO_EM_RESTART': '1', 03:21:46 INFO - 'PAGER': '/bin/cat', 03:21:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:46 INFO - 'PWD': '/builds/slave/test', 03:21:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:46 INFO - 'SHELL': '/bin/bash', 03:21:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:21:46 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:21:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:46 INFO - 'USER': 'cltbld', 03:21:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:46 INFO - 'XPC_FLAGS': '0x0', 03:21:46 INFO - 'XPC_SERVICE_NAME': '0', 03:21:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:21:47 INFO - Cleaning up... 03:21:47 INFO - Return code: 0 03:21:47 INFO - Running post-action listener: _resource_record_post_action 03:21:47 INFO - Running post-action listener: _start_resource_monitoring 03:21:47 INFO - Starting resource monitoring. 03:21:47 INFO - [mozharness: 2017-04-18 10:21:47.270268Z] Finished create-virtualenv step (success) 03:21:47 INFO - [mozharness: 2017-04-18 10:21:47.271268Z] Running install step. 03:21:47 INFO - Running pre-action listener: _resource_record_pre_action 03:21:47 INFO - Running main action method: install 03:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:47 INFO - Reading from file tmpfile_stdout 03:21:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:47 INFO - Reading from file tmpfile_stdout 03:21:47 INFO - Output received: 03:21:47 INFO - Usage: mozinstall [options] installer 03:21:47 INFO - Options: 03:21:47 INFO - -h, --help show this help message and exit 03:21:47 INFO - -d DEST, --destination=DEST 03:21:47 INFO - Directory to install application into. [default: 03:21:47 INFO - "/builds/slave/test"] 03:21:47 INFO - --app=APP Application being installed. [default: firefox] 03:21:47 INFO - mkdir: /builds/slave/test/build/application 03:21:47 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'] 03:21:47 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 03:22:07 INFO - Reading from file tmpfile_stdout 03:22:07 INFO - Output received: 03:22:07 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:22:07 INFO - Running post-action listener: _resource_record_post_action 03:22:07 INFO - [mozharness: 2017-04-18 10:22:07.707185Z] Finished install step (success) 03:22:07 INFO - [mozharness: 2017-04-18 10:22:07.707356Z] Running run-tests step. 03:22:07 INFO - Running pre-action listener: _resource_record_pre_action 03:22:07 INFO - Running main action method: run_tests 03:22:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:07 INFO - 2017-04-18 03:22:07.721 screenresolution[2170:24015] starting screenresolution argv=screenresolution get 03:22:07 INFO - 2017-04-18 03:22:07.724 screenresolution[2170:24015] Display 0: 1600x1200x32@60 03:22:07 INFO - 2017-04-18 03:22:07.730 screenresolution[2171:24017] starting screenresolution argv=screenresolution list 03:22:07 INFO - Available Modes on Display 0 03:22:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:07 INFO - Intel Iris: 03:22:07 INFO - Chipset Model: Intel Iris 03:22:07 INFO - Type: GPU 03:22:07 INFO - Bus: Built-In 03:22:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:07 INFO - Vendor: Intel (0x8086) 03:22:07 INFO - Device ID: 0x0a2e 03:22:07 INFO - Revision ID: 0x0009 03:22:07 INFO - Displays: 03:22:07 INFO - Display: 03:22:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:07 INFO - Display Serial Number: 1600x1200 60 03:22:07 INFO - Main Display: Yes 03:22:07 INFO - Mirror: Off 03:22:07 INFO - Online: Yes 03:22:07 INFO - Rotation: Supported 03:22:07 INFO - Return code: 0 03:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:07 INFO - Python 2.7.3 03:22:07 INFO - Return code: 0 03:22:07 INFO - grabbing minidump binary from tooltool 03:22: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')]} 03:22:07 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 0x107a0bd30>, '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 0x107932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a00be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:07 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 03:22:07 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 03:22:07 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 03:22:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:08 INFO - Return code: 0 03:22:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:08 INFO - ENV: RUST_BACKTRACE is now 1 03:22:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:08 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/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 03:22:08 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/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --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 03:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.16uyWxQxzO/Render', 03:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:08 INFO - 'HOME': '/Users/cltbld', 03:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:08 INFO - 'LOGNAME': 'cltbld', 03:22:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:08 INFO - 'MOZ_NO_REMOTE': '1', 03:22:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:08 INFO - 'NO_EM_RESTART': '1', 03:22:08 INFO - 'PAGER': '/bin/cat', 03:22:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:08 INFO - 'PWD': '/builds/slave/test', 03:22:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:08 INFO - 'RUST_BACKTRACE': '1', 03:22:08 INFO - 'SHELL': '/bin/bash', 03:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iwEyeTOJV9/Listeners', 03:22:08 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 03:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:08 INFO - 'USER': 'cltbld', 03:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:08 INFO - 'XPC_FLAGS': '0x0', 03:22:08 INFO - 'XPC_SERVICE_NAME': '0', 03:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:08 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/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 03:22:08 INFO - mozversion application_buildid: 20170418014944 03:22:08 INFO - mozversion application_changeset: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 03:22:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:08 INFO - mozversion application_name: Firefox 03:22:08 INFO - mozversion application_remotingname: firefox-dev 03:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:08 INFO - mozversion application_vendor: Mozilla 03:22:08 INFO - mozversion application_version: 54.0a2 03:22:08 INFO - mozversion platform_buildid: 20170418014944 03:22:08 INFO - mozversion platform_changeset: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 03:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:08 INFO - mozversion platform_version: 54.0a2 03:22:08 INFO - using testdate: 1492510928 03:22:08 INFO - actual date: 1492510928 03:22:08 INFO - starting webserver on 'localhost:58912' 03:22:08 INFO - SUITE-START | Running 2 tests 03:22:08 INFO - TEST-START | dromaeo_css 03:22:08 INFO - operating with platform_type : mac_ 03:22:08 INFO - Initialising browser for dromaeo_css test... 03:22:08 INFO - TEST-INFO | started process 2181 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpsyucwG/profile http://localhost:58912/getInfo.html) 03:22:11 INFO - PROCESS | 2181 | 2017-04-18 03:22:11.223 plugin-container[2183:24180] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 03:22:11 INFO - PROCESS | 2181 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:11 INFO - PROCESS | 2181 | 2017-04-18 03:22:11.226 plugin-container[2183:24180] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 03:22:11 INFO - PROCESS | 2181 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:11 INFO - PROCESS | 2181 | 2017-04-18 03:22:11.226 plugin-container[2183:24180] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:22:11 INFO - PROCESS | 2181 | __metrics Screen width/height:1600/1200 03:22:11 INFO - PROCESS | 2181 | colorDepth:24 03:22:11 INFO - PROCESS | 2181 | Browser inner width/height: 1024/689 03:22:11 INFO - PROCESS | 2181 | __metrics 03:22:11 ERROR - PROCESS | 2181 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 03:22:12 INFO - TEST-INFO | 2181: exit 0 03:22:12 INFO - Browser initialized. 03:22:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:12 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpsyucwG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:14 INFO - PROCESS | 2184 | 2017-04-18 03:22:14.817 plugin-container[2185:24313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 03:22:14 INFO - PROCESS | 2184 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:14 INFO - PROCESS | 2184 | 2017-04-18 03:22:14.818 plugin-container[2185:24313] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 03:22:14 INFO - PROCESS | 2184 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:22:14 INFO - PROCESS | 2184 | 2017-04-18 03:22:14.818 plugin-container[2185:24313] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:22:24 INFO - PROCESS | 2184 | RSS: Main: 220524544 03:22:24 INFO - PROCESS | 2184 | 03:25:27 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58912/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58912/tests/dromaeo/cssquery-ext.html) 03:25:29 INFO - PROCESS | 2184 | RSS: Main: 242601984 03:25:29 INFO - PROCESS | 2184 | 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | A coding exception was thrown and uncaught in a Task. 03:27:12 INFO - PROCESS | 2184 | 03:27:12 ERROR - PROCESS | 2184 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:12 INFO - PROCESS | 2184 | Full stack: 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | A coding exception was thrown and uncaught in a Task. 03:27:12 INFO - PROCESS | 2184 | 03:27:12 ERROR - PROCESS | 2184 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:12 INFO - PROCESS | 2184 | Full stack: 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | A coding exception was thrown and uncaught in a Task. 03:27:12 INFO - PROCESS | 2184 | 03:27:12 ERROR - PROCESS | 2184 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:12 INFO - PROCESS | 2184 | Full stack: 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | ************************* 03:27:12 INFO - PROCESS | 2184 | A coding exception was thrown and uncaught in a Task. 03:27:12 INFO - PROCESS | 2184 | 03:27:12 ERROR - PROCESS | 2184 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:27:12 INFO - PROCESS | 2184 | Full stack: 03:27:12 INFO - PROCESS | 2184 | ************************* 03:28:31 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58912/tests/dromaeo/cssquery-ext.html (next: http://localhost:58912/tests/dromaeo/cssquery-jquery.html) 03:28:32 INFO - PROCESS | 2184 | RSS: Main: 252096512 03:28:32 INFO - PROCESS | 2184 | 03:31:34 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58912/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58912/tests/dromaeo/cssquery-mootools.html) 03:31:35 INFO - PROCESS | 2184 | RSS: Main: 258576384 03:31:35 INFO - PROCESS | 2184 | 03:34:36 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58912/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58912/tests/dromaeo/cssquery-prototype.html) 03:34:37 INFO - PROCESS | 2184 | RSS: Main: 254910464 03:34:37 INFO - PROCESS | 2184 | 03:37:40 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58912/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58912/tests/dromaeo/cssquery-yui.html) 03:37:41 INFO - PROCESS | 2184 | RSS: Main: 259604480 03:37:41 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:58912/tests/dromaeo/cssquery-yui.html (next: http://localhost:58912/tests/dromaeo/cssquery-dojo.html) 03:40:44 INFO - PROCESS | 2184 | RSS: Main: 255963136 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | __start_tp_report 03:40:44 INFO - PROCESS | 2184 | _x_x_mozilla_page_load 03:40:44 INFO - PROCESS | 2184 | _x_x_mozilla_page_load_details 03:40:44 INFO - PROCESS | 2184 | |i|pagename|runs| 03:40:44 INFO - PROCESS | 2184 | |0;dojo.html;2836.5036118679227;3438.8108654024036;3458.1873259783947;3481.2863363010583;3507.4212754895434;5223.242629818678;5492.588055895804;5962.880742385155;6016.368281330458;6049.2136022317145;5947.910781338283;6027.758889644409;6049.092636104587;6049.274087109553;6060.181875446813;5387.299651045359;5463.660891298192;5469.945300547003;5489.176623506466;5509.338879334486;5486.451354864502;5507.421720719327;5518.889622207554;5522;5527.115661494162;5298.92051619226;5328.76020579073;5500.944990550083;5505.917411238835;5552.305961754781;5425.240466334716;5472.644278121909;5542.362628297757;5575.637583557056;5592.664440133605;5363.973180134074;5448.400675925645;5450.291462109901;5467.261919640838;5469.589780766459;5795.362510123883;5987.341392446828;6051.273847138372;6118.877622447526;6132.41742034506;6232.376762323732;6235.095911092866;6239.438450539428;6243.8126856194385;6287;6356.601547659508;6436.227652681661;6444.323346048691;6460.967695161541;6468;4863.2461968394955;6148.354422785633;6154.98442756949;6165.198524191871;6171.290301615371;5276.81531146408;6220.440160385587;6303.432691057827;6531.771388001397;6538.542302038812;5081.59347252219;6306.432421082125;6307.747690092345;6307.842303942346;6333.050042493571;6449.129367535416;6471.5146364022885;6475.935240647627;6479.1901012373455;6486.383793539606;6168.9691551542855;6204.7828326008375;6239.563230573816;6271.937280627135;6380.968095159495;6280.717367718372;6301.464375528039;6319.8104056878365;6326.335734747785;6327.620342779448;5166.276721259027;5175.430702622709;5176.197689358156;5186.9221961669855;5206.453322401169;4433.600975912119;4527.750973696412;4606.907861842811;4630.21286381316;4654.138984287918;6011.939880601226;6020.638761674313;6037.63774173551;6090.512758979271;6114.816555503342;6356.650384228912;6417.486601071903;6422.614643121427;6435.806925792233;6453.225612926479;5833.562482813806;5844.503217226498;6033.788817391458;6075.878482430327;6086.421789929949;5688.431156884279;5694.202811606378;5704.11586204139;5726.284214473191;5749.827505174768;6640.169978752656;6679.9332006679315;6701.932980670131;6704.195496540447;6717.361850624183;6119.654885717031;6218.689065546795;6261.467775238973;6429.54993150475;6444.097826304227;5628.915566266591;6664.466842652673;6698.129243198548;6704.530682852153;6720.428763555153;6325.493960483058;6335.366463353628;6339.429451349216;6343.841403964938;6357.777477788255;5684.943150568607;6156.938430615636;6221.782237621662;6385.201849768779;6395.104685343963;6138.357744607813;6199.628022318675;6212.751489940351;6228.501719862491;6261.5616906816085;6246.281677606951;6257.374262573706;6270.059491076375;6278.811635650938;6288.151099601679;6024.698765061642;6100.572959892942;6110.1638887921135;6227.159333489921;6254.186955695731;6152.538559608137;6161.599496032743;6250.843728906813;6263.154474145932;6263.686815659108;6154.78458253959;6225.066240064027;6242.563020588515;6257.687115644108;6285.2457705075685 03:40:44 INFO - PROCESS | 2184 | |1;ext.html;615.9076138579214;813.7436707437157;852.9957350213252;883.3772190605624;948.1845612773018;38885.02787430312;39978.40032399516;40020.799376018695;40116;40166.397504037464;38641.03397415059;38843.61156388442;38977.80511097448;39018.804905975434;39206.01984950378;7194.460415468835;7410.184879663233;7736.6847635901895;7887.053553573551;7892.052953645571;11038.448077596127;11289.830652540219;11296.322220666745;11299.983001529861;11346.978771910526;11246.55013799447;11253.943730281379;11289.435528223597;11290.20968532199;11302.321860688344;11193.384363859985;11243.494042768054;11243.943780281128;11254.493547790287;11257.774844503147;10860.837087443695;10908.50911708975;10913.83629245562;10917.617883374123;10931.56273749049;39476.407853882214;39480.21039579221;39505.60494395077;39608.60391396078;39794.0051498712;3865.61343865614;3873.825677844504;3911.550171730259;3914.412838074283;3928.3518219494035;23837.880810595838;26504.73495265042;27847.86076069627;28586.857065714747;29711.405771884656;2674.9063782767703;3090.2428904918215;3113.657497675254;3132.4674805283157;3229.8062116272863;311803;344384;345625;346463;346837;42135;42976.78511607422;49218.75390623096;51911;52137.47862521326;52575.47424525706;54838.72580637151;55060.72469637626;55102;55152.44847551473;14647.487337943121;14723.631909202142;14727.410903563738;14746.262686865613;14831.480898168513;12635.62093137189;12641.178323408949;12680.619581412573;12692.555760548337;12726.618201453972;10544.894551054545;12443.191192572634;12449.315287659265;12463.376831158406;12633.620991370273;4717.363155973968;4991.650584459053;5275.076861549213;5280.551153152025;5314.654547454403;835.2357592802639;929.0389321025755;932.3380399916135;933.3186773655269;955.1976339874539;27754.583681244796;28468.71531284702;28882.85558572236;29054.418911621648;29165.270868228465;877.4340550344991;924.9722508324761;1005.8692369991854;1007.4056306778889;1044.3211912257093;14694.55916322512;14699.41202351894;14771.482998095014;14948.626284342978;14976.850231497545;457005;464955;465271;465393;465864;55302;55369.44630553643;55452;55648;55757.72121139449;1384.259421209648;1425.60795781161;1434.426229508205;1437.094630382852;1438.9280535973369;25797.226083217534;26445.603315950662;27982.580261296505;28230.85884570564;28371.57442638321;43135.784321078194;43184.70445886628;43189.13621727611;43193.568064318955;43269.78365108154;420950;423045;423371;423519;423980;27949.860250698617;28557.85768569234;28610.427791444472;34659.65340346564;34751.65248347484;28524.0016599418;37466.81266593649;38156.61843381642;38232.66185683488;38373.23253534858;26043.73956260489;27065.45869082568;27801.304967375978;27837.721622783512;29414;27261;27343;27365;27602.309942250802;28247.43505129845;31642.208944776565;32125.357492849544;32318;32348.191295216868;32352.676473235908;24427.267181984567;27610.861945690143;27844.582331265454;28226.43547129087;28812.42375152527;19244.807551924863;20629.381118566467;20891.059902304736;23320;23892.76107238975 03:40:44 INFO - PROCESS | 2184 | |2;jquery.html;379.52559300873907;405.9330210515265;411.91349816538525;424.1622794979915;455.8330673475902;17479.737803932952;17884.55288617785;19276.807231927676;20289.898550507263;20668.793312066875;20869.895650521725;21125.838078905654;21390.57218855622;21399;21628.675569866424;5534.584906132036;5819.447152520504;6637.203535575738;6665.900011499832;6680.732770689191;5586.525145362629;6439.776442475938;6566.8686626267445;6609.140811694497;6686.297938716438;6587.11074005008;6591.176102987127;6613.768518101868;6614.536982411233;6620.801375958705;6575.605463672171;7040.788776336718;7381.815454613624;7527.247275272429;7544.019277493946;7038.366547010743;7162.4628152888745;7229.710811567531;7264.019357386738;7301.671424785897;24575.13987010464;24616.261512154662;24688.753112468825;25007.749922500723;25128.743562821786;3277.96722032779;3283.326917981808;3347.43093674076;3377.7804442711144;3412.488126780978;14346.937758509015;15241.466548670744;15533.223338833013;15911.60220994473;15986.28061737213;1863.850891928656;1898.6677331467076;1932.9323473678494;1945.309415157627;1958.3831093205738;137318;142953;145262;148753.2562337192;172169.1391543047;16042.598935026717;18924.148413321433;19814.40556783299;19863.801361986196;20567.8971605141;24608.876955615106;28455;29875.402491950474;29963.850180749392;29969;8555.957220213984;9947.452890091114;10083.294169408071;10257.538410771533;10458.581656733646;7493.512921660074;8368.5773418519;8593.22660960504;8594.140585941355;8912.153345432174;7385.483016188815;9208.493532855624;9216.400933939272;9253.768655783524;9347.766305842273;4030.5767894371256;4093.7339072960162;4093.91812163761;4122.814473348706;4132.607402296777;768.1972338905857;872.7948932000975;876.2508055612487;888.3781353052889;908.123660667459;20141.49646258826;20515.692264616042;20722.79277207239;20844.270450534157;20949.68575471369;903.5708038681573;911.6854685133618;915.8397280476023;931.6878845586668;933.8552524358736;8997.987448818627;10255.846162307571;10770.515326810313;10802.98772297644;10805.827215814217;758431.2078439683;765033;784962;790921;803707;150184;161315;164401.17799411167;167280;168087;1224.6081253998814;1242.0870660064845;1263.9810402843964;1269.968250793719;1271.053065466215;17684.115794210495;17923.73114403259;18332.816671833112;18552.44342669722;18648.533786655444;44382;60725;63501.04748428685;63727;63852;91227.71930701786;92415;92512.53743731238;93518.06481935094;93806;10034.845992710932;11093.778124437305;11242.550297988317;11520.078393728649;11743.941280293544;10520.365356579825;12642.051846111763;12718.618441446772;12776.61670149897;13180.472781088649;9590.520473976412;10963.890361096606;11014.00873921351;11042.061424778984;11159;9988.400695958266;10326.225533085199;10341.638042668772;10592.205584581034;10610.522526486173;9484.620615175592;11238.719032024264;11261.49323280438;11360.091192704398;11370.54517819278;11304.943475282571;11424.200305978835;11460.312381257152;11553.707193449827;11556.537738490702;10745.623903163352;11030.44847757625;11082.335059896432;11085.944570277097;11110.055645270242 03:40:44 INFO - PROCESS | 2184 | |3;mootools.html;1524.5883611424922;1537.6617144228267;1545.1192820092544;1559.8518140776628;1570.2855200883596;7958.164392738766;9493.620255189802;10597.993190646886;11168.274062185963;11185.608503702362;9734.221262299017;10589.629362972297;10908.672739817817;10919;10945.398003109845;2280.737715162761;2339.42684042409;2339.9883000584973;2343.5898717724417;2343.8359314847967;2278.498730279336;2299.666548350488;2306.8615883046987;2312;2323.1984965186984;1946.6009468059085;2049.579836133589;2218.0684112672716;2278.362058623588;2308.1921327535397;2041.8774873507637;2194.738025635258;2272.136588096529;2301.9654705179437;2315.641075633271;2265.694131292271;2274.4541310085624;2276.5560715660454;2278.464560828204;2283.8743869087193;10844.728881777939;10916.417119517626;11019.228653994223;11034.062104721108;11100.389478578674;5369.114096174127;5528.834134975917;5538.252335934678;5541.27963364764;5542.7782888684405;3089.5520149578183;3146.685331466858;3312.420326442863;3322.18606441421;3330.117518857505;1061.930974486656;1067.4502631144967;1077.617445806735;1094.584058057933;1101.8126918423886;12504.437300321599;14796.112233266038;14921;15099.396024159021;15200.543983680507;4184.727992680466;4479.350494178326;4511.300748384006;4588.747618880927;4592.311153327028;12649;12686.429110690042;12697.93651031739;12718.046146539047;12741;5471.616986810965;5477.4796394342475;5493.2034854945805;5495.6153069284765;5500;3666.908327291839;4389.670774691911;4933.309336692866;4976.7262800545595;5053.974730126326;3734.402495600691;3810.1998580297895;3820.8662696805477;3848.634379733921;3869.806509674505;941.3645789092335;972.5023463865709;1009.1422291052546;1014.5586669798661;1014.5840205515703;911.4759013567225;920.3511524375433;925.9814803704023;928.9303302252358;951.2817822544073;6435.710393032325;6545.541812073109;6595.70319335631;6615.17310336208;6658.201015878126;954.656323723459;972.66793176422;977.5942983661843;990.3612170150212;991.8809742830906;4003.399490076512;4005.218982298482;4007.338789099766;4112.712110152261;4134.710570260113;13499.392527336293;14113.717725645429;14137.575872723835;14139.010269281052;14182.716345673029;13568.253746043865;13771.862281377058;14094.436222551189;14102.858971410154;14151.858481415054;10031.498425078862;10151.086402223835;10192;10271.281010329354;10279.640212592672;6425.58233714807;6479.643619600967;6485.481161507162;6526.24948130971;6622.63575503352;11691.590794322157;11820.645380638594;12366.62900112998;12375.566855160027;12466.812997804858;12018.939905300418;12126.151169418055;12137.453814578541;12189.817152742538;12376.938115309365;8015.797630355493;8235.95882020586;8960.731178064669;9173.54132293396;9350.719478415658;10124.746881328027;10385;10531.157507399543;10531.736706582396;10544.78910421772;8740.956295218482;8750.343724220837;8767.473951562926;8806;8816.779580510281;8505.277051450696;8567.014793298851;8585.570721463777;8596.570171491525;8775.780605484913;7718.228177182237;7812.64843082074;7856.84286314282;7860.882086768817;7863.646135924012;5753.309602847685;5761.308642962871;5762.423757624204;5881.676507792113;5992.460678538952;5785.4214578541805;5879.382664820303;5921.171036055042;6062.787442511603;6162.568620196544 03:40:44 INFO - PROCESS | 2184 | |4;prototype.html;371.7955124681425;379.41380567023947;383.67579395410877;392.0962182170098;394.0169277652256;4130.690198235133;4365.432493775805;4974.154393753061;5043.268726034723;5143.894062776502;4717.9056418871605;5138.588912886969;5218.843434696965;5229.594386582167;5269.130593452085;4015.457913181727;4074.775887326196;4230.19626271009;4358.476982762065;4370.278903980855;3601.7838929664304;3605.531280933475;4349.586789255031;4395.956040439587;4426.048399594087;4067.755934643916;4204.684648651363;4394.582514661102;4412.889677758066;4429.446319210098;3796.886093417202;4222.915541689149;4391.6267117295065;4401.295792673173;4429.911401771963;3593.7125029997537;4004.058031854548;4015.217032678629;4015.297322968469;4035.051762835731;5174.715390653512;5212.29633999409;5216.7913283468615;5232.633715639907;5253.894922101575;4758.643101767381;4988.226824842119;5066.36670416198;5106.846794596168;5119.513646203604;5583.944160558383;5629.3526244482;5642.7178641067785;5663.377028526858;5676.602637815355;3901.765894046338;4370.082282720632;4496.348029535699;4528.524504926968;4537.4328208973875;4745.810167593292;4943.777530011158;5713.885792270509;5962.731677074542;6001.759929602811;3887.7278590498395;4291.69958102936;4580.702254353457;4653.790014596162;4674.392328997209;4710.105080034851;4759.690620109751;4782.545658162469;4789;4791.353167322437;4410.1400226956075;4549.294859296814;4770.785314660849;4857.417109946829;5060.696358218445;4394.714343567722;4799.0401919616215;4864.635152363516;5541.806036788693;5567.693776842312;1461.437346621537;1593.2989484626728;1603.5910842735027;1607.477569789823;1608.4611655095441;1101.8402331662026;1174.3599738142732;1195.9043276537857;1201.6995751062234;1227.2820400065882;5275.709835958983;5278.4721527846905;5297;5302.549283310962;5331.786728530816;5444.972775136178;5523.210778556803;5623.634463759842;5893.116032595145;5902.468777809931;4697.835575754901;4880.145974454456;4978.477259887732;5069.099087842059;5222.321098257202;2571;2595.8182927195294;2837.5318072518216;3026.228311780482;3070.907872763776;5302.454821685613;5505.889882202414;5511.889762204733;6007.339192688801;6111.96944015277;5710.942890571124;5839.5036421904615;5969.820905372846;5988.790392336335;6045.158775375567;5435.429279925709;5667.376588575254;5719.113537401709;5773.441170883838;5915.674637894957;5107.310513080835;5735.082386818089;5823.7670493181495;5863.413658634273;5875.737840931187;5297.496737809902;5516.475934786189;5711.057675483665;5723.713814309352;5812.622179558315;5335.519803217729;5639.280019594064;5671.744771485211;5684.261046063985;5990.573817603878;3833.9360278105296;3989.6808255338924;4370.6014075496805;4454.866354009385;4574.771261436981;4978.5270399312;5360.65155764874;5407.675119595724;5445.754941027584;5445.883593863327;4860.979194369081;4983.526564976321;5332.973335133454;5550.9453203891135;5613.410591887956;4909.1899836528;5339.626226164131;5593.356763972195;5635.380108188178;5664.620859239047;4960.932035730666;5073.315102461121;5429.891402172014;5536.332179930905;5590.301212348457;4933.950660493493;5206.474859693121;5371.811986580451;5706.885862282814;5753.654780713171;5057.721825299644;5203.814397952945;5500.339959204921;5511.889762204653;5538.750756216061 03:40:44 INFO - PROCESS | 2184 | |5;yui.html;708.2881703887592;762.8962242597025;799.9840202942268;800.4031956247286;818.0183779464642;14612.342444589993;15214.619634509143;15575;15665.765013524791;15851.841481585181;14165.78751318731;14410.351534180962;14471.565853024425;14723.306819715735;14753.336099875505;923.9769005774859;949.1884438804826;955.1833182628857;956.1920177450079;956.8182045411385;914.7850255190025;952.7332346942867;953.7567920180344;954.5418199264358;960.6589660670467;882.4264228251656;1001.3841487485181;1004.6282875336136;1013.6401577440013;1014.7463134216446;1001.8797744270697;1009.6112996496365;1010.9494525273743;1011.6712068577668;1012.4279781923263;740.7296336837015;750.8761054426013;751.1474476469247;751.4138971602159;754.2532892436503;15445;15582.298796554069;15657.29542170605;15875.841241587552;16401.50795476126;13405.597832065054;13604.183748975092;13771.931140344233;13804.723905521934;13874.653133671638;11522.596709115141;11533.942330288295;11636.185467017312;11738.471768770425;12346.382680865921;3422.845971931244;3537.893863184109;3545.3972824619877;3559.626239244894;3563.4120370138894;80613.98465038421;88105.11894881097;94191;94909;96023.03976960211;10150.187984961185;10447.216458765472;10577.9471102644;10660.307080039927;10881.292715973437;20478;20860.58278834415;21040.78959210419;21065.473363166042;21139.26012589552;7353.963230183922;7408.444366672521;7460.440466964999;7611.1627720950655;7615.428842836809;4049.311617025113;4125.381192821041;4137.627613514738;4210.242156411814;4298.527162012176;3308.3714094322004;3331.4336562784383;3376.7805092668896;3385.170633194883;3411.9764070778665;631.6462780842743;632.5540493951753;635.7234602947733;638.9648569328732;646.3665607704476;647.252423450915;666.7499687617144;677.136650770262;688.3391943734072;710.9466789990771;9358.859617105749;10107.3430227035;10154;10299.279050466545;10444.21668374875;565.9122835960433;665.753671141671;671.1576970901488;674.17413668256;684.7021545627568;4655.4171581662395;4838.225883858566;4934.210526315772;4949.232868905254;4950.331705219749;81125.5662330131;98096.50951745195;106081;108635.45682271697;109824.90175098306;59960.10059849106;63429.36570634327;80963;81682;90120.80175239945;77274.6136269315;79845.60077199577;81089.59455202804;81983.18016819874;83305.16694833095;10303.639372621923;10627.716607485812;10902.672919812418;10947.397893115955;10989.120870330195;50222;51662.74168629133;52123;52698.736506317226;53068.469315306356;66215;66795.66602166957;67186.66406667935;67537.82805972622;67609;12157.939210303892;12295.938520307342;12390.690232744253;12452.875471245172;12843.036772242305;14408.927955360155;14658.41366345377;15255.618609534851;15471.922640386727;15858.20708964524;13615.863841361856;14150.504732334319;14311.427542898167;14389.28053597295;14625;13434.126781759154;14060.720122826759;14189.503367382506;14205.218712970473;14250.144991300554;13374.531891383755;13524.256165910969;13742.93128534351;13895.444182232597;14279;8550.016748073802;8771.16673915977;9454.149126578366;9668.274879384215;10131.797364052825;8396.908401907713;9375.906240937777;10273.613062236502;10515.789684206426;11406.942965285452 03:40:44 INFO - PROCESS | 2184 | __end_tp_report 03:40:44 INFO - PROCESS | 2184 | __start_cc_report 03:40:44 INFO - PROCESS | 2184 | _x_x_mozilla_cycle_collect,423 03:40:44 INFO - PROCESS | 2184 | __end_cc_report 03:40:44 INFO - PROCESS | 2184 | __startTimestamp1492512044566__endTimestamp 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | ------- Summary: start ------- 03:40:44 INFO - PROCESS | 2184 | Number of tests: 6 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | [#0] dojo.html Cycles:165 Average:5919.14 Median:6154.78 stddev:661.68 (10.8%) stddev-sans-first:617.94 03:40:44 INFO - PROCESS | 2184 | Values: 2836.5 3438.8 3458.2 3481.3 3507.4 5223.2 5492.6 5962.9 6016.4 6049.2 5947.9 6027.8 6049.1 6049.3 6060.2 5387.3 5463.7 5469.9 5489.2 5509.3 5486.5 5507.4 5518.9 5522.0 5527.1 5298.9 5328.8 5500.9 5505.9 5552.3 5425.2 5472.6 5542.4 5575.6 5592.7 5364.0 5448.4 5450.3 5467.3 5469.6 5795.4 5987.3 6051.3 6118.9 6132.4 6232.4 6235.1 6239.4 6243.8 6287.0 6356.6 6436.2 6444.3 6461.0 6468.0 4863.2 6148.4 6155.0 6165.2 6171.3 5276.8 6220.4 6303.4 6531.8 6538.5 5081.6 6306.4 6307.7 6307.8 6333.1 6449.1 6471.5 6475.9 6479.2 6486.4 6169.0 6204.8 6239.6 6271.9 6381.0 6280.7 6301.5 6319.8 6326.3 6327.6 5166.3 5175.4 5176.2 5186.9 5206.5 4433.6 4527.8 4606.9 4630.2 4654.1 6011.9 6020.6 6037.6 6090.5 6114.8 6356.7 6417.5 6422.6 6435.8 6453.2 5833.6 5844.5 6033.8 6075.9 6086.4 5688.4 5694.2 5704.1 5726.3 5749.8 6640.2 6679.9 6701.9 6704.2 6717.4 6119.7 6218.7 6261.5 6429.5 6444.1 5628.9 6664.5 6698.1 6704.5 6720.4 6325.5 6335.4 6339.4 6343.8 6357.8 5684.9 6156.9 6221.8 6385.2 6395.1 6138.4 6199.6 6212.8 6228.5 6261.6 6246.3 6257.4 6270.1 6278.8 6288.2 6024.7 6100.6 6110.2 6227.2 6254.2 6152.5 6161.6 6250.8 6263.2 6263.7 6154.8 6225.1 6242.6 6257.7 6285.2 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | [#1] ext.html Cycles:180 Average:54291.99 Median:157467.73 stddev:109285.47 (69.4%) stddev-sans-first:109517.73 03:40:44 INFO - PROCESS | 2184 | Values: 615.9 813.7 853.0 883.4 948.2 38885.0 39978.4 40020.8 40116.0 40166.4 38641.0 38843.6 38977.8 39018.8 39206.0 7194.5 7410.2 7736.7 7887.1 7892.1 11038.4 11289.8 11296.3 11300.0 11347.0 11246.6 11253.9 11289.4 11290.2 11302.3 11193.4 11243.5 11243.9 11254.5 11257.8 10860.8 10908.5 10913.8 10917.6 10931.6 39476.4 39480.2 39505.6 39608.6 39794.0 3865.6 3873.8 3911.6 3914.4 3928.4 23837.9 26504.7 27847.9 28586.9 29711.4 2674.9 3090.2 3113.7 3132.5 3229.8 311803.0 344384.0 345625.0 346463.0 346837.0 42135.0 42976.8 49218.8 51911.0 52137.5 52575.5 54838.7 55060.7 55102.0 55152.4 14647.5 14723.6 14727.4 14746.3 14831.5 12635.6 12641.2 12680.6 12692.6 12726.6 10544.9 12443.2 12449.3 12463.4 12633.6 4717.4 4991.7 5275.1 5280.6 5314.7 835.2 929.0 932.3 933.3 955.2 27754.6 28468.7 28882.9 29054.4 29165.3 877.4 925.0 1005.9 1007.4 1044.3 14694.6 14699.4 14771.5 14948.6 14976.9 457005.0 464955.0 465271.0 465393.0 465864.0 55302.0 55369.4 55452.0 55648.0 55757.7 1384.3 1425.6 1434.4 1437.1 1438.9 25797.2 26445.6 27982.6 28230.9 28371.6 43135.8 43184.7 43189.1 43193.6 43269.8 420950.0 423045.0 423371.0 423519.0 423980.0 27949.9 28557.9 28610.4 34659.7 34751.7 28524.0 37466.8 38156.6 38232.7 38373.2 26043.7 27065.5 27801.3 27837.7 29414.0 27261.0 27343.0 27365.0 27602.3 28247.4 31642.2 32125.4 32318.0 32348.2 32352.7 24427.3 27610.9 27844.6 28226.4 28812.4 19244.8 20629.4 20891.1 23320.0 23892.8 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | [#2] jquery.html Cycles:180 Average:43698.47 Median:24612.57 stddev:130207.96 (529.0%) stddev-sans-first:130532.60 03:40:44 INFO - PROCESS | 2184 | Values: 379.5 405.9 411.9 424.2 455.8 17479.7 17884.6 19276.8 20289.9 20668.8 20869.9 21125.8 21390.6 21399.0 21628.7 5534.6 5819.4 6637.2 6665.9 6680.7 5586.5 6439.8 6566.9 6609.1 6686.3 6587.1 6591.2 6613.8 6614.5 6620.8 6575.6 7040.8 7381.8 7527.2 7544.0 7038.4 7162.5 7229.7 7264.0 7301.7 24575.1 24616.3 24688.8 25007.7 25128.7 3278.0 3283.3 3347.4 3377.8 3412.5 14346.9 15241.5 15533.2 15911.6 15986.3 1863.9 1898.7 1932.9 1945.3 1958.4 137318.0 142953.0 145262.0 148753.3 172169.1 16042.6 18924.1 19814.4 19863.8 20567.9 24608.9 28455.0 29875.4 29963.9 29969.0 8556.0 9947.5 10083.3 10257.5 10458.6 7493.5 8368.6 8593.2 8594.1 8912.2 7385.5 9208.5 9216.4 9253.8 9347.8 4030.6 4093.7 4093.9 4122.8 4132.6 768.2 872.8 876.3 888.4 908.1 20141.5 20515.7 20722.8 20844.3 20949.7 903.6 911.7 915.8 931.7 933.9 8998.0 10255.8 10770.5 10803.0 10805.8 758431.2 765033.0 784962.0 790921.0 803707.0 150184.0 161315.0 164401.2 167280.0 168087.0 1224.6 1242.1 1264.0 1270.0 1271.1 17684.1 17923.7 18332.8 18552.4 18648.5 44382.0 60725.0 63501.0 63727.0 63852.0 91227.7 92415.0 92512.5 93518.1 93806.0 10034.8 11093.8 11242.6 11520.1 11743.9 10520.4 12642.1 12718.6 12776.6 13180.5 9590.5 10963.9 11014.0 11042.1 11159.0 9988.4 10326.2 10341.6 10592.2 10610.5 9484.6 11238.7 11261.5 11360.1 11370.5 11304.9 11424.2 11460.3 11553.7 11556.5 10745.6 11030.4 11082.3 11085.9 11110.1 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | [#3] mootools.html Cycles:180 Average:6627.19 Median:3118.12 stddev:4250.24 (136.3%) stddev-sans-first:4244.87 03:40:44 INFO - PROCESS | 2184 | Values: 1524.6 1537.7 1545.1 1559.9 1570.3 7958.2 9493.6 10598.0 11168.3 11185.6 9734.2 10589.6 10908.7 10919.0 10945.4 2280.7 2339.4 2340.0 2343.6 2343.8 2278.5 2299.7 2306.9 2312.0 2323.2 1946.6 2049.6 2218.1 2278.4 2308.2 2041.9 2194.7 2272.1 2302.0 2315.6 2265.7 2274.5 2276.6 2278.5 2283.9 10844.7 10916.4 11019.2 11034.1 11100.4 5369.1 5528.8 5538.3 5541.3 5542.8 3089.6 3146.7 3312.4 3322.2 3330.1 1061.9 1067.5 1077.6 1094.6 1101.8 12504.4 14796.1 14921.0 15099.4 15200.5 4184.7 4479.4 4511.3 4588.7 4592.3 12649.0 12686.4 12697.9 12718.0 12741.0 5471.6 5477.5 5493.2 5495.6 5500.0 3666.9 4389.7 4933.3 4976.7 5054.0 3734.4 3810.2 3820.9 3848.6 3869.8 941.4 972.5 1009.1 1014.6 1014.6 911.5 920.4 926.0 928.9 951.3 6435.7 6545.5 6595.7 6615.2 6658.2 954.7 972.7 977.6 990.4 991.9 4003.4 4005.2 4007.3 4112.7 4134.7 13499.4 14113.7 14137.6 14139.0 14182.7 13568.3 13771.9 14094.4 14102.9 14151.9 10031.5 10151.1 10192.0 10271.3 10279.6 6425.6 6479.6 6485.5 6526.2 6622.6 11691.6 11820.6 12366.6 12375.6 12466.8 12018.9 12126.2 12137.5 12189.8 12376.9 8015.8 8236.0 8960.7 9173.5 9350.7 10124.7 10385.0 10531.2 10531.7 10544.8 8741.0 8750.3 8767.5 8806.0 8816.8 8505.3 8567.0 8585.6 8596.6 8775.8 7718.2 7812.6 7856.8 7860.9 7863.6 5753.3 5761.3 5762.4 5881.7 5992.5 5785.4 5879.4 5921.2 6062.8 6162.6 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | [#4] prototype.html Cycles:180 Average:4660.41 Median:5059.21 stddev:1300.60 (25.7%) stddev-sans-first:1263.79 03:40:44 INFO - PROCESS | 2184 | Values: 371.8 379.4 383.7 392.1 394.0 4130.7 4365.4 4974.2 5043.3 5143.9 4717.9 5138.6 5218.8 5229.6 5269.1 4015.5 4074.8 4230.2 4358.5 4370.3 3601.8 3605.5 4349.6 4396.0 4426.0 4067.8 4204.7 4394.6 4412.9 4429.4 3796.9 4222.9 4391.6 4401.3 4429.9 3593.7 4004.1 4015.2 4015.3 4035.1 5174.7 5212.3 5216.8 5232.6 5253.9 4758.6 4988.2 5066.4 5106.8 5119.5 5583.9 5629.4 5642.7 5663.4 5676.6 3901.8 4370.1 4496.3 4528.5 4537.4 4745.8 4943.8 5713.9 5962.7 6001.8 3887.7 4291.7 4580.7 4653.8 4674.4 4710.1 4759.7 4782.5 4789.0 4791.4 4410.1 4549.3 4770.8 4857.4 5060.7 4394.7 4799.0 4864.6 5541.8 5567.7 1461.4 1593.3 1603.6 1607.5 1608.5 1101.8 1174.4 1195.9 1201.7 1227.3 5275.7 5278.5 5297.0 5302.5 5331.8 5445.0 5523.2 5623.6 5893.1 5902.5 4697.8 4880.1 4978.5 5069.1 5222.3 2571.0 2595.8 2837.5 3026.2 3070.9 5302.5 5505.9 5511.9 6007.3 6112.0 5710.9 5839.5 5969.8 5988.8 6045.2 5435.4 5667.4 5719.1 5773.4 5915.7 5107.3 5735.1 5823.8 5863.4 5875.7 5297.5 5516.5 5711.1 5723.7 5812.6 5335.5 5639.3 5671.7 5684.3 5990.6 3833.9 3989.7 4370.6 4454.9 4574.8 4978.5 5360.7 5407.7 5445.8 5445.9 4861.0 4983.5 5333.0 5550.9 5613.4 4909.2 5339.6 5593.4 5635.4 5664.6 4960.9 5073.3 5429.9 5536.3 5590.3 4934.0 5206.5 5371.8 5706.9 5753.7 5057.7 5203.8 5500.3 5511.9 5538.8 03:40:44 INFO - PROCESS | 2184 | 03:40:44 INFO - PROCESS | 2184 | [#5] yui.html Cycles:180 Average:19710.01 Median:3480.37 stddev:27531.65 (791.1%) stddev-sans-first:27571.91 03:40:44 INFO - PROCESS | 2184 | Values: 708.3 762.9 800.0 800.4 818.0 14612.3 15214.6 15575.0 15665.8 15851.8 14165.8 14410.4 14471.6 14723.3 14753.3 924.0 949.2 955.2 956.2 956.8 914.8 952.7 953.8 954.5 960.7 882.4 1001.4 1004.6 1013.6 1014.7 1001.9 1009.6 1010.9 1011.7 1012.4 740.7 750.9 751.1 751.4 754.3 15445.0 15582.3 15657.3 15875.8 16401.5 13405.6 13604.2 13771.9 13804.7 13874.7 11522.6 11533.9 11636.2 11738.5 12346.4 3422.8 3537.9 3545.4 3559.6 3563.4 80614.0 88105.1 94191.0 94909.0 96023.0 10150.2 10447.2 10577.9 10660.3 10881.3 20478.0 20860.6 21040.8 21065.5 21139.3 7354.0 7408.4 7460.4 7611.2 7615.4 4049.3 4125.4 4137.6 4210.2 4298.5 3308.4 3331.4 3376.8 3385.2 3412.0 631.6 632.6 635.7 639.0 646.4 647.3 666.7 677.1 688.3 710.9 9358.9 10107.3 10154.0 10299.3 10444.2 565.9 665.8 671.2 674.2 684.7 4655.4 4838.2 4934.2 4949.2 4950.3 81125.6 98096.5 106081.0 108635.5 109824.9 59960.1 63429.4 80963.0 81682.0 90120.8 77274.6 79845.6 81089.6 81983.2 83305.2 10303.6 10627.7 10902.7 10947.4 10989.1 50222.0 51662.7 52123.0 52698.7 53068.5 66215.0 66795.7 67186.7 67537.8 67609.0 12157.9 12295.9 12390.7 12452.9 12843.0 14408.9 14658.4 15255.6 15471.9 15858.2 13615.9 14150.5 14311.4 14389.3 14625.0 13434.1 14060.7 14189.5 14205.2 14250.1 13374.5 13524.3 13742.9 13895.4 14279.0 8550.0 8771.2 9454.1 9668.3 10131.8 8396.9 9375.9 10273.6 10515.8 11406.9 03:40:44 INFO - PROCESS | 2184 | -------- Summary: end -------- 03:40:44 INFO - PROCESS | 2184 | 03:40:45 INFO - TEST-INFO | 2184: exit 0 03:40:45 INFO - TEST-OK | dromaeo_css | took 1117051ms 03:40:45 INFO - TEST-START | kraken 03:40:45 INFO - operating with platform_type : mac_ 03:40:45 INFO - Initialising browser for kraken test... 03:40:45 INFO - TEST-INFO | started process 2213 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmph575O4/profile http://localhost:58912/getInfo.html) 03:40:48 INFO - PROCESS | 2213 | 2017-04-18 03:40:48.302 plugin-container[2214:26534] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 03:40:48 INFO - PROCESS | 2213 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:48 INFO - PROCESS | 2213 | 2017-04-18 03:40:48.309 plugin-container[2214:26534] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d17, name = 'com.apple.CFPasteboardClient' 03:40:48 INFO - PROCESS | 2213 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:48 INFO - PROCESS | 2213 | 2017-04-18 03:40:48.309 plugin-container[2214:26534] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:40:48 INFO - PROCESS | 2213 | __metrics Screen width/height:1600/1200 03:40:48 INFO - PROCESS | 2213 | colorDepth:24 03:40:48 INFO - PROCESS | 2213 | Browser inner width/height: 1024/689 03:40:48 INFO - PROCESS | 2213 | __metrics 03:40:48 ERROR - PROCESS | 2213 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 03:40:49 INFO - TEST-INFO | 2213: exit 0 03:40:49 INFO - Browser initialized. 03:40:49 INFO - Running cycle 1/1 for kraken test... 03:40:49 INFO - TEST-INFO | started process 2215 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmph575O4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:51 INFO - PROCESS | 2215 | 2017-04-18 03:40:51.735 plugin-container[2216:26656] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 03:40:51 INFO - PROCESS | 2215 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:51 INFO - PROCESS | 2215 | 2017-04-18 03:40:51.735 plugin-container[2216:26656] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 03:40:51 INFO - PROCESS | 2215 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:40:51 INFO - PROCESS | 2215 | 2017-04-18 03:40:51.735 plugin-container[2216:26656] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:41:01 INFO - PROCESS | 2215 | RSS: Main: 220708864 03:41:01 INFO - PROCESS | 2215 | 03:41:04 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58912/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:05 INFO - PROCESS | 2215 | RSS: Main: 235507712 03:41:05 INFO - PROCESS | 2215 | 03:41:08 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58912/tests/kraken/driver.html?testName=audio-dft) 03:41:08 INFO - PROCESS | 2215 | RSS: Main: 243081216 03:41:08 INFO - PROCESS | 2215 | 03:41:12 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58912/tests/kraken/driver.html?testName=audio-fft) 03:41:12 INFO - PROCESS | 2215 | RSS: Main: 246734848 03:41:12 INFO - PROCESS | 2215 | 03:41:14 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58912/tests/kraken/driver.html?testName=audio-oscillator) 03:41:15 INFO - PROCESS | 2215 | RSS: Main: 248107008 03:41:15 INFO - PROCESS | 2215 | 03:41:17 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58912/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:18 INFO - PROCESS | 2215 | RSS: Main: 248139776 03:41:18 INFO - PROCESS | 2215 | 03:41:21 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58912/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:21 INFO - PROCESS | 2215 | RSS: Main: 252256256 03:41:21 INFO - PROCESS | 2215 | 03:41:25 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58912/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:25 INFO - PROCESS | 2215 | RSS: Main: 252297216 03:41:25 INFO - PROCESS | 2215 | 03:41:28 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58912/tests/kraken/driver.html?testName=json-parse-financial) 03:41:29 INFO - PROCESS | 2215 | RSS: Main: 252002304 03:41:29 INFO - PROCESS | 2215 | 03:41:31 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58912/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:31 INFO - PROCESS | 2215 | RSS: Main: 251334656 03:41:31 INFO - PROCESS | 2215 | 03:41:33 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:34 INFO - PROCESS | 2215 | RSS: Main: 251326464 03:41:34 INFO - PROCESS | 2215 | 03:41:36 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:36 INFO - PROCESS | 2215 | RSS: Main: 251383808 03:41:36 INFO - PROCESS | 2215 | 03:41:39 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:40 INFO - PROCESS | 2215 | RSS: Main: 251760640 03:41:40 INFO - PROCESS | 2215 | 03:41:43 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:44 INFO - PROCESS | 2215 | RSS: Main: 251621376 03:41:44 INFO - PROCESS | 2215 | 03:41:45 INFO - PROCESS | 2215 | Cycle 1(1): loaded http://localhost:58912/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58912/tests/kraken/driver.html?testName=ai-astar) 03:41:46 INFO - PROCESS | 2215 | RSS: Main: 253648896 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | __start_tp_report 03:41:46 INFO - PROCESS | 2215 | _x_x_mozilla_page_load 03:41:46 INFO - PROCESS | 2215 | _x_x_mozilla_page_load_details 03:41:46 INFO - PROCESS | 2215 | |i|pagename|runs| 03:41:46 INFO - PROCESS | 2215 | |0;ai-astar;103;120;122;177;120;121;121;121;121;120 03:41:46 INFO - PROCESS | 2215 | |1;audio-beat-detection;152;114;110;159;113;114;113;116;134;141 03:41:46 INFO - PROCESS | 2215 | |2;audio-dft;230;278;237;194;203;205;199;202;200;199 03:41:46 INFO - PROCESS | 2215 | |3;audio-fft;82;61;64;100;65;62;64;61;74;88 03:41:46 INFO - PROCESS | 2215 | |4;audio-oscillator;90;73;86;71;72;73;83;70;76;108 03:41:46 INFO - PROCESS | 2215 | |5;imaging-gaussian-blur;89;90;89;89;111;115;138;86;136;134 03:41:46 INFO - PROCESS | 2215 | |6;imaging-darkroom;155;97;97;104;154;96;97;96;100;97 03:41:46 INFO - PROCESS | 2215 | |7;imaging-desaturate;91;96;100;92;94;92;92;118;146;92 03:41:46 INFO - PROCESS | 2215 | |8;json-parse-financial;65;66;66;67;68;68;70;70;68;68 03:41:46 INFO - PROCESS | 2215 | |9;json-stringify-tinderbox;57;65;63;67;67;76;83;60;60;60 03:41:46 INFO - PROCESS | 2215 | |10;stanford-crypto-aes;82;88;85;78;85;83;84;85;88;86 03:41:46 INFO - PROCESS | 2215 | |11;stanford-crypto-ccm;161;163;186;140;144;145;141;144;191;143 03:41:46 INFO - PROCESS | 2215 | |12;stanford-crypto-pbkdf2;174;176;172;169;171;173;166;163;171;169 03:41:46 INFO - PROCESS | 2215 | |13;stanford-crypto-sha256-iterative;67;66;68;67;69;70;66;70;87;62 03:41:46 INFO - PROCESS | 2215 | __end_tp_report 03:41:46 INFO - PROCESS | 2215 | __start_cc_report 03:41:46 INFO - PROCESS | 2215 | _x_x_mozilla_cycle_collect,1026 03:41:46 INFO - PROCESS | 2215 | __end_cc_report 03:41:46 INFO - PROCESS | 2215 | __startTimestamp1492512106201__endTimestamp 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | ------- Summary: start ------- 03:41:46 INFO - PROCESS | 2215 | Number of tests: 14 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#0] ai-astar Cycles:10 Average:124.60 Median:121.00 stddev:19.25 (15.9%) stddev-sans-first:18.76 03:41:46 INFO - PROCESS | 2215 | Values: 103.0 120.0 122.0 177.0 120.0 121.0 121.0 121.0 121.0 120.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:125.00 stddev:18.36 (14.7%) stddev-sans-first:17.01 03:41:46 INFO - PROCESS | 2215 | Values: 152.0 114.0 110.0 159.0 113.0 114.0 113.0 116.0 134.0 141.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#2] audio-dft Cycles:10 Average:214.70 Median:204.00 stddev:26.39 (12.9%) stddev-sans-first:27.40 03:41:46 INFO - PROCESS | 2215 | Values: 230.0 278.0 237.0 194.0 203.0 205.0 199.0 202.0 200.0 199.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#3] audio-fft Cycles:10 Average:72.10 Median:64.50 stddev:13.59 (21.1%) stddev-sans-first:13.94 03:41:46 INFO - PROCESS | 2215 | Values: 82.0 61.0 64.0 100.0 65.0 62.0 64.0 61.0 74.0 88.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:74.50 stddev:11.96 (16.1%) stddev-sans-first:12.15 03:41:46 INFO - PROCESS | 2215 | Values: 90.0 73.0 86.0 71.0 72.0 73.0 83.0 70.0 76.0 108.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#5] imaging-gaussian-blur Cycles:10 Average:107.70 Median:87.50 stddev:21.88 (25.0%) stddev-sans-first:22.13 03:41:46 INFO - PROCESS | 2215 | Values: 89.0 90.0 89.0 89.0 111.0 115.0 138.0 86.0 136.0 134.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#6] imaging-darkroom Cycles:10 Average:109.30 Median:96.50 stddev:23.94 (24.8%) stddev-sans-first:18.84 03:41:46 INFO - PROCESS | 2215 | Values: 155.0 97.0 97.0 104.0 154.0 96.0 97.0 96.0 100.0 97.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:92.00 stddev:17.68 (19.2%) stddev-sans-first:18.35 03:41:46 INFO - PROCESS | 2215 | Values: 91.0 96.0 100.0 92.0 94.0 92.0 92.0 118.0 146.0 92.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.45 03:41:46 INFO - PROCESS | 2215 | Values: 65.0 66.0 66.0 67.0 68.0 68.0 70.0 70.0 68.0 68.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:8.09 (12.3%) stddev-sans-first:7.93 03:41:46 INFO - PROCESS | 2215 | Values: 57.0 65.0 63.0 67.0 67.0 76.0 83.0 60.0 60.0 60.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:2.95 (3.5%) stddev-sans-first:3.00 03:41:46 INFO - PROCESS | 2215 | Values: 82.0 88.0 85.0 78.0 85.0 83.0 84.0 85.0 88.0 86.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:153.00 stddev:19.03 (12.4%) stddev-sans-first:20.09 03:41:46 INFO - PROCESS | 2215 | Values: 161.0 163.0 186.0 140.0 144.0 145.0 141.0 144.0 191.0 143.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:3.84 (2.2%) stddev-sans-first:3.84 03:41:46 INFO - PROCESS | 2215 | Values: 174.0 176.0 172.0 169.0 171.0 173.0 166.0 163.0 171.0 169.0 03:41:46 INFO - PROCESS | 2215 | 03:41:46 INFO - PROCESS | 2215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:6.68 (9.8%) stddev-sans-first:7.04 03:41:46 INFO - PROCESS | 2215 | Values: 67.0 66.0 68.0 67.0 69.0 70.0 66.0 70.0 87.0 62.0 03:41:46 INFO - PROCESS | 2215 | -------- Summary: end -------- 03:41:46 INFO - PROCESS | 2215 | 03:41:47 INFO - TEST-INFO | 2215: exit 0 03:41:47 INFO - TEST-OK | kraken | took 61788ms 03:41:47 INFO - SUITE-END | took 1178s 03:41:47 INFO - Completed test suite (00:19:39) 03:41:47 INFO - javascript benchmark 03:41:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7607.97546680792, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2836.5036118679227, 3438.8108654024036, 3458.1873259783947, 3481.2863363010583, 3507.4212754895434, 5223.242629818678, 5492.588055895804, 5962.880742385155, 6016.368281330458, 6049.2136022317145, 5947.910781338283, 6027.758889644409, 6049.092636104587, 6049.274087109553, 6060.181875446813, 5387.299651045359, 5463.660891298192, 5469.945300547003, 5489.176623506466, 5509.338879334486, 5486.451354864502, 5507.421720719327, 5518.889622207554, 5522.0, 5527.115661494162, 5298.92051619226, 5328.76020579073, 5500.944990550083, 5505.917411238835, 5552.305961754781, 5425.240466334716, 5472.644278121909, 5542.362628297757, 5575.637583557056, 5592.664440133605, 5363.973180134074, 5448.400675925645, 5450.291462109901, 5467.261919640838, 5469.589780766459, 5795.362510123883, 5987.341392446828, 6051.273847138372, 6118.877622447526, 6132.41742034506, 6232.376762323732, 6235.095911092866, 6239.438450539428, 6243.8126856194385, 6287.0, 6356.601547659508, 6436.227652681661, 6444.323346048691, 6460.967695161541, 6468.0, 4863.2461968394955, 6148.354422785633, 6154.98442756949, 6165.198524191871, 6171.290301615371, 5276.81531146408, 6220.440160385587, 6303.432691057827, 6531.771388001397, 6538.542302038812, 5081.59347252219, 6306.432421082125, 6307.747690092345, 6307.842303942346, 6333.050042493571, 6449.129367535416, 6471.5146364022885, 6475.935240647627, 6479.1901012373455, 6486.383793539606, 6168.9691551542855, 6204.7828326008375, 6239.563230573816, 6271.937280627135, 6380.968095159495, 6280.717367718372, 6301.464375528039, 6319.8104056878365, 6326.335734747785, 6327.620342779448, 5166.276721259027, 5175.430702622709, 5176.197689358156, 5186.9221961669855, 5206.453322401169, 4433.600975912119, 4527.750973696412, 4606.907861842811, 4630.21286381316, 4654.138984287918, 6011.939880601226, 6020.638761674313, 6037.63774173551, 6090.512758979271, 6114.816555503342, 6356.650384228912, 6417.486601071903, 6422.614643121427, 6435.806925792233, 6453.225612926479, 5833.562482813806, 5844.503217226498, 6033.788817391458, 6075.878482430327, 6086.421789929949, 5688.431156884279, 5694.202811606378, 5704.11586204139, 5726.284214473191, 5749.827505174768, 6640.169978752656, 6679.9332006679315, 6701.932980670131, 6704.195496540447, 6717.361850624183, 6119.654885717031, 6218.689065546795, 6261.467775238973, 6429.54993150475, 6444.097826304227, 5628.915566266591, 6664.466842652673, 6698.129243198548, 6704.530682852153, 6720.428763555153, 6325.493960483058, 6335.366463353628, 6339.429451349216, 6343.841403964938, 6357.777477788255, 5684.943150568607, 6156.938430615636, 6221.782237621662, 6385.201849768779, 6395.104685343963, 6138.357744607813, 6199.628022318675, 6212.751489940351, 6228.501719862491, 6261.5616906816085, 6246.281677606951, 6257.374262573706, 6270.059491076375, 6278.811635650938, 6288.151099601679, 6024.698765061642, 6100.572959892942, 6110.1638887921135, 6227.159333489921, 6254.186955695731, 6152.538559608137, 6161.599496032743, 6250.843728906813, 6263.154474145932, 6263.686815659108, 6154.78458253959, 6225.066240064027, 6242.563020588515, 6257.687115644108, 6285.2457705075685], "value": 5877.605231585652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9076138579214, 813.7436707437157, 852.9957350213252, 883.3772190605624, 948.1845612773018, 38885.02787430312, 39978.40032399516, 40020.799376018695, 40116.0, 40166.397504037464, 38641.03397415059, 38843.61156388442, 38977.80511097448, 39018.804905975434, 39206.01984950378, 7194.460415468835, 7410.184879663233, 7736.6847635901895, 7887.053553573551, 7892.052953645571, 11038.448077596127, 11289.830652540219, 11296.322220666745, 11299.983001529861, 11346.978771910526, 11246.55013799447, 11253.943730281379, 11289.435528223597, 11290.20968532199, 11302.321860688344, 11193.384363859985, 11243.494042768054, 11243.943780281128, 11254.493547790287, 11257.774844503147, 10860.837087443695, 10908.50911708975, 10913.83629245562, 10917.617883374123, 10931.56273749049, 39476.407853882214, 39480.21039579221, 39505.60494395077, 39608.60391396078, 39794.0051498712, 3865.61343865614, 3873.825677844504, 3911.550171730259, 3914.412838074283, 3928.3518219494035, 23837.880810595838, 26504.73495265042, 27847.86076069627, 28586.857065714747, 29711.405771884656, 2674.9063782767703, 3090.2428904918215, 3113.657497675254, 3132.4674805283157, 3229.8062116272863, 311803.0, 344384.0, 345625.0, 346463.0, 346837.0, 42135.0, 42976.78511607422, 49218.75390623096, 51911.0, 52137.47862521326, 52575.47424525706, 54838.72580637151, 55060.72469637626, 55102.0, 55152.44847551473, 14647.487337943121, 14723.631909202142, 14727.410903563738, 14746.262686865613, 14831.480898168513, 12635.62093137189, 12641.178323408949, 12680.619581412573, 12692.555760548337, 12726.618201453972, 10544.894551054545, 12443.191192572634, 12449.315287659265, 12463.376831158406, 12633.620991370273, 4717.363155973968, 4991.650584459053, 5275.076861549213, 5280.551153152025, 5314.654547454403, 835.2357592802639, 929.0389321025755, 932.3380399916135, 933.3186773655269, 955.1976339874539, 27754.583681244796, 28468.71531284702, 28882.85558572236, 29054.418911621648, 29165.270868228465, 877.4340550344991, 924.9722508324761, 1005.8692369991854, 1007.4056306778889, 1044.3211912257093, 14694.55916322512, 14699.41202351894, 14771.482998095014, 14948.626284342978, 14976.850231497545, 457005.0, 464955.0, 465271.0, 465393.0, 465864.0, 55302.0, 55369.44630553643, 55452.0, 55648.0, 55757.72121139449, 1384.259421209648, 1425.60795781161, 1434.426229508205, 1437.094630382852, 1438.9280535973369, 25797.226083217534, 26445.603315950662, 27982.580261296505, 28230.85884570564, 28371.57442638321, 43135.784321078194, 43184.70445886628, 43189.13621727611, 43193.568064318955, 43269.78365108154, 420950.0, 423045.0, 423371.0, 423519.0, 423980.0, 27949.860250698617, 28557.85768569234, 28610.427791444472, 34659.65340346564, 34751.65248347484, 28524.0016599418, 37466.81266593649, 38156.61843381642, 38232.66185683488, 38373.23253534858, 26043.73956260489, 27065.45869082568, 27801.304967375978, 27837.721622783512, 29414.0, 27261.0, 27343.0, 27365.0, 27602.309942250802, 28247.43505129845, 31642.208944776565, 32125.357492849544, 32318.0, 32348.191295216868, 32352.676473235908, 24427.267181984567, 27610.861945690143, 27844.582331265454, 28226.43547129087, 28812.42375152527, 19244.807551924863, 20629.381118566467, 20891.059902304736, 23320.0, 23892.76107238975], "value": 18184.404808869647, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.52559300873907, 405.9330210515265, 411.91349816538525, 424.1622794979915, 455.8330673475902, 17479.737803932952, 17884.55288617785, 19276.807231927676, 20289.898550507263, 20668.793312066875, 20869.895650521725, 21125.838078905654, 21390.57218855622, 21399.0, 21628.675569866424, 5534.584906132036, 5819.447152520504, 6637.203535575738, 6665.900011499832, 6680.732770689191, 5586.525145362629, 6439.776442475938, 6566.8686626267445, 6609.140811694497, 6686.297938716438, 6587.11074005008, 6591.176102987127, 6613.768518101868, 6614.536982411233, 6620.801375958705, 6575.605463672171, 7040.788776336718, 7381.815454613624, 7527.247275272429, 7544.019277493946, 7038.366547010743, 7162.4628152888745, 7229.710811567531, 7264.019357386738, 7301.671424785897, 24575.13987010464, 24616.261512154662, 24688.753112468825, 25007.749922500723, 25128.743562821786, 3277.96722032779, 3283.326917981808, 3347.43093674076, 3377.7804442711144, 3412.488126780978, 14346.937758509015, 15241.466548670744, 15533.223338833013, 15911.60220994473, 15986.28061737213, 1863.850891928656, 1898.6677331467076, 1932.9323473678494, 1945.309415157627, 1958.3831093205738, 137318.0, 142953.0, 145262.0, 148753.2562337192, 172169.1391543047, 16042.598935026717, 18924.148413321433, 19814.40556783299, 19863.801361986196, 20567.8971605141, 24608.876955615106, 28455.0, 29875.402491950474, 29963.850180749392, 29969.0, 8555.957220213984, 9947.452890091114, 10083.294169408071, 10257.538410771533, 10458.581656733646, 7493.512921660074, 8368.5773418519, 8593.22660960504, 8594.140585941355, 8912.153345432174, 7385.483016188815, 9208.493532855624, 9216.400933939272, 9253.768655783524, 9347.766305842273, 4030.5767894371256, 4093.7339072960162, 4093.91812163761, 4122.814473348706, 4132.607402296777, 768.1972338905857, 872.7948932000975, 876.2508055612487, 888.3781353052889, 908.123660667459, 20141.49646258826, 20515.692264616042, 20722.79277207239, 20844.270450534157, 20949.68575471369, 903.5708038681573, 911.6854685133618, 915.8397280476023, 931.6878845586668, 933.8552524358736, 8997.987448818627, 10255.846162307571, 10770.515326810313, 10802.98772297644, 10805.827215814217, 758431.2078439683, 765033.0, 784962.0, 790921.0, 803707.0, 150184.0, 161315.0, 164401.17799411167, 167280.0, 168087.0, 1224.6081253998814, 1242.0870660064845, 1263.9810402843964, 1269.968250793719, 1271.053065466215, 17684.115794210495, 17923.73114403259, 18332.816671833112, 18552.44342669722, 18648.533786655444, 44382.0, 60725.0, 63501.04748428685, 63727.0, 63852.0, 91227.71930701786, 92415.0, 92512.53743731238, 93518.06481935094, 93806.0, 10034.845992710932, 11093.778124437305, 11242.550297988317, 11520.078393728649, 11743.941280293544, 10520.365356579825, 12642.051846111763, 12718.618441446772, 12776.61670149897, 13180.472781088649, 9590.520473976412, 10963.890361096606, 11014.00873921351, 11042.061424778984, 11159.0, 9988.400695958266, 10326.225533085199, 10341.638042668772, 10592.205584581034, 10610.522526486173, 9484.620615175592, 11238.719032024264, 11261.49323280438, 11360.091192704398, 11370.54517819278, 11304.943475282571, 11424.200305978835, 11460.312381257152, 11553.707193449827, 11556.537738490702, 10745.623903163352, 11030.44847757625, 11082.335059896432, 11085.944570277097, 11110.055645270242], "value": 11292.607114121836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.5883611424922, 1537.6617144228267, 1545.1192820092544, 1559.8518140776628, 1570.2855200883596, 7958.164392738766, 9493.620255189802, 10597.993190646886, 11168.274062185963, 11185.608503702362, 9734.221262299017, 10589.629362972297, 10908.672739817817, 10919.0, 10945.398003109845, 2280.737715162761, 2339.42684042409, 2339.9883000584973, 2343.5898717724417, 2343.8359314847967, 2278.498730279336, 2299.666548350488, 2306.8615883046987, 2312.0, 2323.1984965186984, 1946.6009468059085, 2049.579836133589, 2218.0684112672716, 2278.362058623588, 2308.1921327535397, 2041.8774873507637, 2194.738025635258, 2272.136588096529, 2301.9654705179437, 2315.641075633271, 2265.694131292271, 2274.4541310085624, 2276.5560715660454, 2278.464560828204, 2283.8743869087193, 10844.728881777939, 10916.417119517626, 11019.228653994223, 11034.062104721108, 11100.389478578674, 5369.114096174127, 5528.834134975917, 5538.252335934678, 5541.27963364764, 5542.7782888684405, 3089.5520149578183, 3146.685331466858, 3312.420326442863, 3322.18606441421, 3330.117518857505, 1061.930974486656, 1067.4502631144967, 1077.617445806735, 1094.584058057933, 1101.8126918423886, 12504.437300321599, 14796.112233266038, 14921.0, 15099.396024159021, 15200.543983680507, 4184.727992680466, 4479.350494178326, 4511.300748384006, 4588.747618880927, 4592.311153327028, 12649.0, 12686.429110690042, 12697.93651031739, 12718.046146539047, 12741.0, 5471.616986810965, 5477.4796394342475, 5493.2034854945805, 5495.6153069284765, 5500.0, 3666.908327291839, 4389.670774691911, 4933.309336692866, 4976.7262800545595, 5053.974730126326, 3734.402495600691, 3810.1998580297895, 3820.8662696805477, 3848.634379733921, 3869.806509674505, 941.3645789092335, 972.5023463865709, 1009.1422291052546, 1014.5586669798661, 1014.5840205515703, 911.4759013567225, 920.3511524375433, 925.9814803704023, 928.9303302252358, 951.2817822544073, 6435.710393032325, 6545.541812073109, 6595.70319335631, 6615.17310336208, 6658.201015878126, 954.656323723459, 972.66793176422, 977.5942983661843, 990.3612170150212, 991.8809742830906, 4003.399490076512, 4005.218982298482, 4007.338789099766, 4112.712110152261, 4134.710570260113, 13499.392527336293, 14113.717725645429, 14137.575872723835, 14139.010269281052, 14182.716345673029, 13568.253746043865, 13771.862281377058, 14094.436222551189, 14102.858971410154, 14151.858481415054, 10031.498425078862, 10151.086402223835, 10192.0, 10271.281010329354, 10279.640212592672, 6425.58233714807, 6479.643619600967, 6485.481161507162, 6526.24948130971, 6622.63575503352, 11691.590794322157, 11820.645380638594, 12366.62900112998, 12375.566855160027, 12466.812997804858, 12018.939905300418, 12126.151169418055, 12137.453814578541, 12189.817152742538, 12376.938115309365, 8015.797630355493, 8235.95882020586, 8960.731178064669, 9173.54132293396, 9350.719478415658, 10124.746881328027, 10385.0, 10531.157507399543, 10531.736706582396, 10544.78910421772, 8740.956295218482, 8750.343724220837, 8767.473951562926, 8806.0, 8816.779580510281, 8505.277051450696, 8567.014793298851, 8585.570721463777, 8596.570171491525, 8775.780605484913, 7718.228177182237, 7812.64843082074, 7856.84286314282, 7860.882086768817, 7863.646135924012, 5753.309602847685, 5761.308642962871, 5762.423757624204, 5881.676507792113, 5992.460678538952, 5785.4214578541805, 5879.382664820303, 5921.171036055042, 6062.787442511603, 6162.568620196544], "value": 4995.194397779237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7955124681425, 379.41380567023947, 383.67579395410877, 392.0962182170098, 394.0169277652256, 4130.690198235133, 4365.432493775805, 4974.154393753061, 5043.268726034723, 5143.894062776502, 4717.9056418871605, 5138.588912886969, 5218.843434696965, 5229.594386582167, 5269.130593452085, 4015.457913181727, 4074.775887326196, 4230.19626271009, 4358.476982762065, 4370.278903980855, 3601.7838929664304, 3605.531280933475, 4349.586789255031, 4395.956040439587, 4426.048399594087, 4067.755934643916, 4204.684648651363, 4394.582514661102, 4412.889677758066, 4429.446319210098, 3796.886093417202, 4222.915541689149, 4391.6267117295065, 4401.295792673173, 4429.911401771963, 3593.7125029997537, 4004.058031854548, 4015.217032678629, 4015.297322968469, 4035.051762835731, 5174.715390653512, 5212.29633999409, 5216.7913283468615, 5232.633715639907, 5253.894922101575, 4758.643101767381, 4988.226824842119, 5066.36670416198, 5106.846794596168, 5119.513646203604, 5583.944160558383, 5629.3526244482, 5642.7178641067785, 5663.377028526858, 5676.602637815355, 3901.765894046338, 4370.082282720632, 4496.348029535699, 4528.524504926968, 4537.4328208973875, 4745.810167593292, 4943.777530011158, 5713.885792270509, 5962.731677074542, 6001.759929602811, 3887.7278590498395, 4291.69958102936, 4580.702254353457, 4653.790014596162, 4674.392328997209, 4710.105080034851, 4759.690620109751, 4782.545658162469, 4789.0, 4791.353167322437, 4410.1400226956075, 4549.294859296814, 4770.785314660849, 4857.417109946829, 5060.696358218445, 4394.714343567722, 4799.0401919616215, 4864.635152363516, 5541.806036788693, 5567.693776842312, 1461.437346621537, 1593.2989484626728, 1603.5910842735027, 1607.477569789823, 1608.4611655095441, 1101.8402331662026, 1174.3599738142732, 1195.9043276537857, 1201.6995751062234, 1227.2820400065882, 5275.709835958983, 5278.4721527846905, 5297.0, 5302.549283310962, 5331.786728530816, 5444.972775136178, 5523.210778556803, 5623.634463759842, 5893.116032595145, 5902.468777809931, 4697.835575754901, 4880.145974454456, 4978.477259887732, 5069.099087842059, 5222.321098257202, 2571.0, 2595.8182927195294, 2837.5318072518216, 3026.228311780482, 3070.907872763776, 5302.454821685613, 5505.889882202414, 5511.889762204733, 6007.339192688801, 6111.96944015277, 5710.942890571124, 5839.5036421904615, 5969.820905372846, 5988.790392336335, 6045.158775375567, 5435.429279925709, 5667.376588575254, 5719.113537401709, 5773.441170883838, 5915.674637894957, 5107.310513080835, 5735.082386818089, 5823.7670493181495, 5863.413658634273, 5875.737840931187, 5297.496737809902, 5516.475934786189, 5711.057675483665, 5723.713814309352, 5812.622179558315, 5335.519803217729, 5639.280019594064, 5671.744771485211, 5684.261046063985, 5990.573817603878, 3833.9360278105296, 3989.6808255338924, 4370.6014075496805, 4454.866354009385, 4574.771261436981, 4978.5270399312, 5360.65155764874, 5407.675119595724, 5445.754941027584, 5445.883593863327, 4860.979194369081, 4983.526564976321, 5332.973335133454, 5550.9453203891135, 5613.410591887956, 4909.1899836528, 5339.626226164131, 5593.356763972195, 5635.380108188178, 5664.620859239047, 4960.932035730666, 5073.315102461121, 5429.891402172014, 5536.332179930905, 5590.301212348457, 4933.950660493493, 5206.474859693121, 5371.811986580451, 5706.885862282814, 5753.654780713171, 5057.721825299644, 5203.814397952945, 5500.339959204921, 5511.889762204653, 5538.750756216061], "value": 4281.82120302834, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2881703887592, 762.8962242597025, 799.9840202942268, 800.4031956247286, 818.0183779464642, 14612.342444589993, 15214.619634509143, 15575.0, 15665.765013524791, 15851.841481585181, 14165.78751318731, 14410.351534180962, 14471.565853024425, 14723.306819715735, 14753.336099875505, 923.9769005774859, 949.1884438804826, 955.1833182628857, 956.1920177450079, 956.8182045411385, 914.7850255190025, 952.7332346942867, 953.7567920180344, 954.5418199264358, 960.6589660670467, 882.4264228251656, 1001.3841487485181, 1004.6282875336136, 1013.6401577440013, 1014.7463134216446, 1001.8797744270697, 1009.6112996496365, 1010.9494525273743, 1011.6712068577668, 1012.4279781923263, 740.7296336837015, 750.8761054426013, 751.1474476469247, 751.4138971602159, 754.2532892436503, 15445.0, 15582.298796554069, 15657.29542170605, 15875.841241587552, 16401.50795476126, 13405.597832065054, 13604.183748975092, 13771.931140344233, 13804.723905521934, 13874.653133671638, 11522.596709115141, 11533.942330288295, 11636.185467017312, 11738.471768770425, 12346.382680865921, 3422.845971931244, 3537.893863184109, 3545.3972824619877, 3559.626239244894, 3563.4120370138894, 80613.98465038421, 88105.11894881097, 94191.0, 94909.0, 96023.03976960211, 10150.187984961185, 10447.216458765472, 10577.9471102644, 10660.307080039927, 10881.292715973437, 20478.0, 20860.58278834415, 21040.78959210419, 21065.473363166042, 21139.26012589552, 7353.963230183922, 7408.444366672521, 7460.440466964999, 7611.1627720950655, 7615.428842836809, 4049.311617025113, 4125.381192821041, 4137.627613514738, 4210.242156411814, 4298.527162012176, 3308.3714094322004, 3331.4336562784383, 3376.7805092668896, 3385.170633194883, 3411.9764070778665, 631.6462780842743, 632.5540493951753, 635.7234602947733, 638.9648569328732, 646.3665607704476, 647.252423450915, 666.7499687617144, 677.136650770262, 688.3391943734072, 710.9466789990771, 9358.859617105749, 10107.3430227035, 10154.0, 10299.279050466545, 10444.21668374875, 565.9122835960433, 665.753671141671, 671.1576970901488, 674.17413668256, 684.7021545627568, 4655.4171581662395, 4838.225883858566, 4934.210526315772, 4949.232868905254, 4950.331705219749, 81125.5662330131, 98096.50951745195, 106081.0, 108635.45682271697, 109824.90175098306, 59960.10059849106, 63429.36570634327, 80963.0, 81682.0, 90120.80175239945, 77274.6136269315, 79845.60077199577, 81089.59455202804, 81983.18016819874, 83305.16694833095, 10303.639372621923, 10627.716607485812, 10902.672919812418, 10947.397893115955, 10989.120870330195, 50222.0, 51662.74168629133, 52123.0, 52698.736506317226, 53068.469315306356, 66215.0, 66795.66602166957, 67186.66406667935, 67537.82805972622, 67609.0, 12157.939210303892, 12295.938520307342, 12390.690232744253, 12452.875471245172, 12843.036772242305, 14408.927955360155, 14658.41366345377, 15255.618609534851, 15471.922640386727, 15858.20708964524, 13615.863841361856, 14150.504732334319, 14311.427542898167, 14389.28053597295, 14625.0, 13434.126781759154, 14060.720122826759, 14189.503367382506, 14205.218712970473, 14250.144991300554, 13374.531891383755, 13524.256165910969, 13742.93128534351, 13895.444182232597, 14279.0, 8550.016748073802, 8771.16673915977, 9454.149126578366, 9668.274879384215, 10131.797364052825, 8396.908401907713, 9375.906240937777, 10273.613062236502, 10515.789684206426, 11406.942965285452], "value": 7511.039896729039, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 120.0, 122.0, 177.0, 120.0, 121.0, 121.0, 121.0, 121.0, 120.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 110.0, 159.0, 113.0, 114.0, 113.0, 116.0, 134.0, 141.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 278.0, 237.0, 194.0, 203.0, 205.0, 199.0, 202.0, 200.0, 199.0], "value": 214.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 64.0, 100.0, 65.0, 62.0, 64.0, 61.0, 74.0, 88.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 73.0, 86.0, 71.0, 72.0, 73.0, 83.0, 70.0, 76.0, 108.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 89.0, 111.0, 115.0, 138.0, 86.0, 136.0, 134.0], "value": 107.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 97.0, 97.0, 104.0, 154.0, 96.0, 97.0, 96.0, 100.0, 97.0], "value": 109.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 100.0, 92.0, 94.0, 92.0, 92.0, 118.0, 146.0, 92.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 68.0, 68.0, 70.0, 70.0, 68.0, 68.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 65.0, 63.0, 67.0, 67.0, 76.0, 83.0, 60.0, 60.0, 60.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 85.0, 78.0, 85.0, 83.0, 84.0, 85.0, 88.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 186.0, 140.0, 144.0, 145.0, 141.0, 144.0, 191.0, 143.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 172.0, 169.0, 171.0, 173.0, 166.0, 163.0, 171.0, 169.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 69.0, 70.0, 66.0, 70.0, 87.0, 62.0], "value": 69.2, "unit": "score"}]}]} 03:41:47 INFO - Return code: 0 03:41:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:41:47 ERROR - # TBPL SUCCESS # 03:41:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:47 INFO - 2017-04-18 03:41:47.552 screenresolution[2220:27040] starting screenresolution argv=screenresolution get 03:41:47 INFO - 2017-04-18 03:41:47.555 screenresolution[2220:27040] Display 0: 1600x1200x32@60 03:41:47 INFO - 2017-04-18 03:41:47.562 screenresolution[2221:27043] starting screenresolution argv=screenresolution list 03:41:47 INFO - Available Modes on Display 0 03:41:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:47 INFO - Intel Iris: 03:41:47 INFO - Chipset Model: Intel Iris 03:41:47 INFO - Type: GPU 03:41:47 INFO - Bus: Built-In 03:41:47 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:47 INFO - Vendor: Intel (0x8086) 03:41:47 INFO - Device ID: 0x0a2e 03:41:47 INFO - Revision ID: 0x0009 03:41:47 INFO - Displays: 03:41:47 INFO - Display: 03:41:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:47 INFO - Display Serial Number: 1600x1200 60 03:41:47 INFO - Main Display: Yes 03:41:47 INFO - Mirror: Off 03:41:47 INFO - Online: Yes 03:41:47 INFO - Rotation: Supported 03:41:47 INFO - Return code: 0 03:41:47 INFO - Running post-action listener: _resource_record_post_action 03:41:47 INFO - [mozharness: 2017-04-18 10:41:47.799529Z] Finished run-tests step (success) 03:41:47 INFO - Running post-run listener: _resource_record_post_run 03:41:47 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 94720; Write bytes: 512457728; Read time: 4; Write time: 1655 03:41:47 INFO - TinderboxPrint: CPU usage
54.9% 03:41:47 INFO - TinderboxPrint: I/O read bytes / time
94,720 / 4 03:41:47 INFO - TinderboxPrint: I/O write bytes / time
512,457,728 / 1,655 03:41:47 INFO - TinderboxPrint: CPU idle
2,165.7 (45.1%) 03:41:47 INFO - TinderboxPrint: CPU system
973.4 (20.3%) 03:41:47 INFO - TinderboxPrint: CPU user
1,662.7 (34.6%) 03:41:47 INFO - TinderboxPrint: Swap in / out
208,113,664 / 0 03:41:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203657728; Write bytes: 199376896; Read time: 15561; Write time: 372 03:41:47 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 94208; Write bytes: 302152704; Read time: 4; Write time: 1246 03:41:48 INFO - Running post-run listener: _upload_blobber_files 03:41:48 INFO - Blob upload gear active. 03:41:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:48 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 03:41:48 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'] 03:41:48 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 03:41:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:49 INFO - (blobuploader) - INFO - Done attempting. 03:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:50 INFO - (blobuploader) - INFO - Done attempting. 03:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:51 INFO - (blobuploader) - INFO - Done attempting. 03:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:53 INFO - (blobuploader) - INFO - Done attempting. 03:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:53 INFO - Return code: 0 03:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cbc82ed5c2e4d30df39737bf6c1730ad9c5dbe95f829f7fc013de435aa69c70fc839ef965723683b728e17cbb14a0e5a78aa66af2767fcde9c1c3e21d5659f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d832a6444a86b55c53d59f3e57168d0dfef38591b52eb88dbd3cd4fa7f9bc30ce5bac6cf7f12387218f66940ca0d5d036e9f339e721a43a57fd5a16378c0ad4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d29d6534bd5f019b790e99a4b4d07244e43991acfca008d22a7436847e31c170d7239a37f59abaccf06913ffb6005600402ccf3f0d2b5f8133f754b3a553a8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e45f730474f6567d386b652523309280693f70e6bb7f1cdfad088d88e3d581ab157c819a0639633ff137a891a087de2713baf6155781c0bab81b1903a13f808"} 03:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:53 INFO - Contents: 03:41:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cbc82ed5c2e4d30df39737bf6c1730ad9c5dbe95f829f7fc013de435aa69c70fc839ef965723683b728e17cbb14a0e5a78aa66af2767fcde9c1c3e21d5659f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d832a6444a86b55c53d59f3e57168d0dfef38591b52eb88dbd3cd4fa7f9bc30ce5bac6cf7f12387218f66940ca0d5d036e9f339e721a43a57fd5a16378c0ad4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d29d6534bd5f019b790e99a4b4d07244e43991acfca008d22a7436847e31c170d7239a37f59abaccf06913ffb6005600402ccf3f0d2b5f8133f754b3a553a8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e45f730474f6567d386b652523309280693f70e6bb7f1cdfad088d88e3d581ab157c819a0639633ff137a891a087de2713baf6155781c0bab81b1903a13f808"} 03:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:53 INFO - Copying logs to upload dir... 03:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.535381 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-18 03:41:53.622012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:41:53.625851) ========= 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.16uyWxQxzO/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.iwEyeTOJV9/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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/2cbc82ed5c2e4d30df39737bf6c1730ad9c5dbe95f829f7fc013de435aa69c70fc839ef965723683b728e17cbb14a0e5a78aa66af2767fcde9c1c3e21d5659f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d832a6444a86b55c53d59f3e57168d0dfef38591b52eb88dbd3cd4fa7f9bc30ce5bac6cf7f12387218f66940ca0d5d036e9f339e721a43a57fd5a16378c0ad4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d29d6534bd5f019b790e99a4b4d07244e43991acfca008d22a7436847e31c170d7239a37f59abaccf06913ffb6005600402ccf3f0d2b5f8133f754b3a553a8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e45f730474f6567d386b652523309280693f70e6bb7f1cdfad088d88e3d581ab157c819a0639633ff137a891a087de2713baf6155781c0bab81b1903a13f808"} build_url:https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/R7z1Y-NOSBWO2cSUACeNQQ/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/2cbc82ed5c2e4d30df39737bf6c1730ad9c5dbe95f829f7fc013de435aa69c70fc839ef965723683b728e17cbb14a0e5a78aa66af2767fcde9c1c3e21d5659f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d832a6444a86b55c53d59f3e57168d0dfef38591b52eb88dbd3cd4fa7f9bc30ce5bac6cf7f12387218f66940ca0d5d036e9f339e721a43a57fd5a16378c0ad4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d29d6534bd5f019b790e99a4b4d07244e43991acfca008d22a7436847e31c170d7239a37f59abaccf06913ffb6005600402ccf3f0d2b5f8133f754b3a553a8c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e45f730474f6567d386b652523309280693f70e6bb7f1cdfad088d88e3d581ab157c819a0639633ff137a891a087de2713baf6155781c0bab81b1903a13f808"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:41:53.665167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:41:53.665848) ========= 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.16uyWxQxzO/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.iwEyeTOJV9/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005350 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:41:53.715725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:41:53.716136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:41:53.716529) ========= ========= Total master_lag: 0.20 =========