builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1471097239.4 results: success (0) buildid: 20160813044816 builduid: 3fdab888aa854f8eb812eb2ea9c327c5 revision: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.400386) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.400917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.401234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.468454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:19.468873) ========= 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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 --2016-08-13 07:07:19-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-08-13 07:07:19 (40.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.485731 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:20.003350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:20.003683) ========= 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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.020816 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:20.078759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 07:07:20.079154) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VIHy8MwqUe/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.h3yhkB2jkI/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 2016-08-13 07:07:20,147 truncating revision to first 12 chars 2016-08-13 07:07:20,148 Setting DEBUG logging. 2016-08-13 07:07:20,148 attempt 1/10 2016-08-13 07:07:20,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6e191a55c3d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 07:07:20,931 unpacking tar archive at: mozilla-central-6e191a55c3d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 07:07:21.177162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.177564) ========= script_repo_revision: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.177998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.178310) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 07:07:21.198229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-13 07:07:21.198664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VIHy8MwqUe/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.h3yhkB2jkI/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:07:21 INFO - MultiFileLogger online at 20160813 07:07:21 in /builds/slave/test 07:07:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:07:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:07:21 INFO - {'append_to_log': False, 07:07:21 INFO - 'base_work_dir': '/builds/slave/test', 07:07:21 INFO - 'blob_upload_branch': 'Firefox', 07:07:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:07:21 INFO - 'branch': 'Firefox', 07:07:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:07:21 INFO - 'config_files': ('talos/mac_config.py',), 07:07:21 INFO - 'default_actions': ('clobber', 07:07:21 INFO - 'read-buildbot-config', 07:07:21 INFO - 'download-and-extract', 07:07:21 INFO - 'populate-webroot', 07:07:21 INFO - 'create-virtualenv', 07:07:21 INFO - 'install', 07:07:21 INFO - 'run-tests'), 07:07:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:07:21 INFO - 'download_minidump_stackwalk': True, 07:07:21 INFO - 'download_symbols': 'ondemand', 07:07:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:07:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:07:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:07:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:07:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:07:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:07:21 INFO - 'installer_path': 'installer.exe', 07:07:21 INFO - 'log_level': 'info', 07:07:21 INFO - 'log_name': 'talos', 07:07:21 INFO - 'log_to_console': True, 07:07:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:07:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:07:21 INFO - 'opt_config_files': (), 07:07:21 INFO - 'pip_index': False, 07:07:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:07:21 INFO - 'cmd': ('bash', 07:07:21 INFO - '-c', 07:07:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:07:21 INFO - 'enabled': True, 07:07:21 INFO - 'halt_on_failure': False, 07:07:21 INFO - 'name': 'check_screen_resolution'},), 07:07:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:07:21 INFO - 'cmd': ('bash', 07:07:21 INFO - '-c', 07:07:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:07:21 INFO - 'enabled': True, 07:07:21 INFO - 'halt_on_failure': False, 07:07:21 INFO - 'name': 'check_screen_resolution'},), 07:07:21 INFO - 'run_cmd_checks_enabled': True, 07:07:21 INFO - 'sps_profile': False, 07:07:21 INFO - 'sps_profile_interval': 0, 07:07:21 INFO - 'suite': 'dromaeojs-e10s', 07:07:21 INFO - 'system_bits': '32', 07:07:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:07:21 INFO - 'title': 't-yosemite-r7-0014', 07:07:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:07:21 INFO - 'use_talos_json': True, 07:07:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:07:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:07:21 INFO - 'work_dir': 'build'} 07:07:21 INFO - [mozharness: 2016-08-13 14:07:21.384228Z] Running clobber step. 07:07:21 INFO - Running pre-action listener: _resource_record_pre_action 07:07:21 INFO - Running main action method: clobber 07:07:21 INFO - rmtree: /builds/slave/test/build 07:07:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:07:23 INFO - Running post-action listener: _resource_record_post_action 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.473950Z] Finished clobber step (success) 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.474113Z] Running read-buildbot-config step. 07:07:23 INFO - Running pre-action listener: _resource_record_pre_action 07:07:23 INFO - Running main action method: read_buildbot_config 07:07:23 INFO - Using buildbot properties: 07:07:23 INFO - { 07:07:23 INFO - "project": "", 07:07:23 INFO - "product": "firefox", 07:07:23 INFO - "script_repo_revision": "production", 07:07:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:07:23 INFO - "repository": "", 07:07:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:07:23 INFO - "buildid": "20160813044816", 07:07:23 INFO - "pgo_build": "False", 07:07:23 INFO - "basedir": "/builds/slave/test", 07:07:23 INFO - "buildnumber": 42, 07:07:23 INFO - "slavename": "t-yosemite-r7-0014", 07:07:23 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:07:23 INFO - "platform": "yosemite_r7", 07:07:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:07:23 INFO - "branch": "mozilla-central", 07:07:23 INFO - "repo_path": "mozilla-central", 07:07:23 INFO - "revision": "6e191a55c3d23e83e6a2e72e4e80c1dc21516493", 07:07:23 INFO - "stage_platform": "macosx64", 07:07:23 INFO - "builduid": "3fdab888aa854f8eb812eb2ea9c327c5", 07:07:23 INFO - "slavebuilddir": "test" 07:07:23 INFO - } 07:07:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:07:23 INFO - Running post-action listener: _resource_record_post_action 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.477328Z] Finished read-buildbot-config step (success) 07:07:23 INFO - [mozharness: 2016-08-13 14:07:23.477460Z] Running download-and-extract step. 07:07:23 INFO - Running pre-action listener: _resource_record_pre_action 07:07:23 INFO - Running main action method: download_and_extract 07:07:23 INFO - mkdir: /builds/slave/test/build/tests 07:07: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')]} 07:07:23 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:07:23 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 07:07:24 INFO - Downloaded 1199 bytes. 07:07:24 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:07:24 INFO - Using the following test package requirements: 07:07:24 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:07:24 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:07:24 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:07:24 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'jsshell-mac.zip'], 07:07:24 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:07:24 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:07:24 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:07:24 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:07:24 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:07:24 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:07:24 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:07:24 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:24 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:07:24 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:07:25 INFO - Downloaded 16330538 bytes. 07:07:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:07:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:32 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:07:32 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:07:33 INFO - Downloaded 16330538 bytes. 07:07:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:39 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:07:39 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:07:42 INFO - Downloaded 14413719 bytes. 07:07:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 07:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:42 INFO - trying https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 07:07:50 INFO - Downloaded 111051637 bytes. 07:07:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:07:50 INFO - mkdir: /builds/slave/test/properties 07:07:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:07:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:07:50 INFO - Contents: 07:07:50 INFO - build_url:https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:07:51 INFO - Running post-action listener: _resource_record_post_action 07:07:51 INFO - Running post-action listener: set_extra_try_arguments 07:07:51 INFO - [mozharness: 2016-08-13 14:07:51.796865Z] Finished download-and-extract step (success) 07:07:51 INFO - [mozharness: 2016-08-13 14:07:51.797028Z] Running populate-webroot step. 07:07:51 INFO - Running pre-action listener: _resource_record_pre_action 07:07:51 INFO - Running main action method: populate_webroot 07:07:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:51 INFO - '--tppagecycles', 07:07:51 INFO - '7'], 07:07:51 INFO - 'tests': ['tsvgm']}}, 07:07:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:07:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:07:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:07:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['damp', 'tps']}, 07:07:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'tests': ['damp', 'tps']}, 07:07:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['dromaeo_dom']}, 07:07:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['basic_compositor_video']}, 07:07:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:07:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['a11yr', 07:07:51 INFO - 'ts_paint', 07:07:51 INFO - 'tpaint', 07:07:51 INFO - 'sessionrestore', 07:07:51 INFO - 'sessionrestore_no_auto_restore', 07:07:51 INFO - 'tabpaint']}, 07:07:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:07:51 INFO - 'ts_paint', 07:07:51 INFO - 'tpaint', 07:07:51 INFO - 'sessionrestore', 07:07:51 INFO - 'sessionrestore_no_auto_restore', 07:07:51 INFO - 'tabpaint']}, 07:07:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:07:51 INFO - 'ts_paint', 07:07:51 INFO - 'tpaint', 07:07:51 INFO - 'sessionrestore', 07:07:51 INFO - 'sessionrestore_no_auto_restore', 07:07:51 INFO - 'tabpaint']}, 07:07:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:07:51 INFO - 'ts_paint', 07:07:51 INFO - 'tpaint', 07:07:51 INFO - 'sessionrestore', 07:07:51 INFO - 'sessionrestore_no_auto_restore', 07:07:51 INFO - 'tabpaint']}, 07:07:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['a11yr', 07:07:51 INFO - 'ts_paint', 07:07:51 INFO - 'tpaint', 07:07:51 INFO - 'sessionrestore', 07:07:51 INFO - 'sessionrestore_no_auto_restore', 07:07:51 INFO - 'tabpaint']}, 07:07:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['a11yr', 07:07:51 INFO - 'ts_paint', 07:07:51 INFO - 'tpaint', 07:07:51 INFO - 'sessionrestore', 07:07:51 INFO - 'sessionrestore_no_auto_restore', 07:07:51 INFO - 'tabpaint']}, 07:07:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['tsvgx', 07:07:51 INFO - 'tsvgr_opacity', 07:07:51 INFO - 'tart', 07:07:51 INFO - 'tscrollx', 07:07:51 INFO - 'cart']}, 07:07:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:07:51 INFO - 'tsvgr_opacity', 07:07:51 INFO - 'tart', 07:07:51 INFO - 'tscrollx', 07:07:51 INFO - 'cart']}, 07:07:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'talos_options': ['--disable-e10s'], 07:07:51 INFO - 'tests': ['tp5o']}, 07:07:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'tests': ['tp5o']}, 07:07:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'talos_options': ['--disable-e10s', 07:07:51 INFO - '--xperf_path', 07:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:51 INFO - 'tests': ['tp5n']}, 07:07:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:51 INFO - 'talos_options': ['--xperf_path', 07:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:51 INFO - 'tests': ['tp5n']}}, 07:07:51 INFO - 'talos.zip': {'path': '', 07:07:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:51 INFO - Running post-action listener: _resource_record_post_action 07:07:51 INFO - [mozharness: 2016-08-13 14:07:51.816050Z] Finished populate-webroot step (success) 07:07:51 INFO - [mozharness: 2016-08-13 14:07:51.816195Z] Running create-virtualenv step. 07:07:51 INFO - Running pre-action listener: _resource_record_pre_action 07:07:51 INFO - Running main action method: create_virtualenv 07:07:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:07:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:07:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:07:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:51 INFO - Using real prefix '/tools/python27' 07:07:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:07:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:55 INFO - Installing pip.................done. 07:07:55 INFO - Return code: 0 07:07:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:55 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:55 INFO - 'HOME': '/Users/cltbld', 07:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:55 INFO - 'LOGNAME': 'cltbld', 07:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:55 INFO - 'MOZ_NO_REMOTE': '1', 07:07:55 INFO - 'NO_EM_RESTART': '1', 07:07:55 INFO - 'PAGER': '/bin/cat', 07:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:55 INFO - 'PWD': '/builds/slave/test', 07:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:55 INFO - 'SHELL': '/bin/bash', 07:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:07:55 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:55 INFO - 'USER': 'cltbld', 07:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:55 INFO - 'XPC_FLAGS': '0x0', 07:07:55 INFO - 'XPC_SERVICE_NAME': '0', 07:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:07:55 INFO - Cleaning up... 07:07:55 INFO - Return code: 0 07:07:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:55 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:07:55 INFO - 'HOME': '/Users/cltbld', 07:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:07:55 INFO - 'LOGNAME': 'cltbld', 07:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:55 INFO - 'MOZ_NO_REMOTE': '1', 07:07:55 INFO - 'NO_EM_RESTART': '1', 07:07:55 INFO - 'PAGER': '/bin/cat', 07:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:55 INFO - 'PWD': '/builds/slave/test', 07:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:07:55 INFO - 'SHELL': '/bin/bash', 07:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:07:55 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:07:55 INFO - 'USER': 'cltbld', 07:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:55 INFO - 'XPC_FLAGS': '0x0', 07:07:55 INFO - 'XPC_SERVICE_NAME': '0', 07:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:56 INFO - Downloading/unpacking psutil>=3.1.1 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:59 INFO - Installing collected packages: psutil 07:07:59 INFO - Running setup.py install for psutil 07:08:00 INFO - building 'psutil._psutil_osx' extension 07:08:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:08:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:08:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:08:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:08:00 INFO - building 'psutil._psutil_posix' extension 07:08:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:08:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:08:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:08:00 INFO - ^ 07:08:00 INFO - 1 warning generated. 07:08:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:00 INFO - Successfully installed psutil 07:08:00 INFO - Cleaning up... 07:08:00 INFO - Return code: 0 07:08:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:00 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:00 INFO - 'HOME': '/Users/cltbld', 07:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:00 INFO - 'LOGNAME': 'cltbld', 07:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:00 INFO - 'MOZ_NO_REMOTE': '1', 07:08:00 INFO - 'NO_EM_RESTART': '1', 07:08:00 INFO - 'PAGER': '/bin/cat', 07:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:00 INFO - 'PWD': '/builds/slave/test', 07:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:00 INFO - 'SHELL': '/bin/bash', 07:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:00 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:00 INFO - 'USER': 'cltbld', 07:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:00 INFO - 'XPC_FLAGS': '0x0', 07:08:00 INFO - 'XPC_SERVICE_NAME': '0', 07:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:08:03 INFO - Installing collected packages: mozsystemmonitor 07:08:03 INFO - Running setup.py install for mozsystemmonitor 07:08:03 INFO - Successfully installed mozsystemmonitor 07:08:03 INFO - Cleaning up... 07:08:03 INFO - Return code: 0 07:08:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:08:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:03 INFO - 'HOME': '/Users/cltbld', 07:08:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:03 INFO - 'LOGNAME': 'cltbld', 07:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:03 INFO - 'MOZ_NO_REMOTE': '1', 07:08:03 INFO - 'NO_EM_RESTART': '1', 07:08:03 INFO - 'PAGER': '/bin/cat', 07:08:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:03 INFO - 'PWD': '/builds/slave/test', 07:08:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:03 INFO - 'SHELL': '/bin/bash', 07:08:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:03 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:03 INFO - 'USER': 'cltbld', 07:08:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:03 INFO - 'XPC_FLAGS': '0x0', 07:08:03 INFO - 'XPC_SERVICE_NAME': '0', 07:08:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:04 INFO - Downloading/unpacking jsonschema==2.5.1 07:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:06 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:07 INFO - warning: no files found matching '*.txt' 07:08:07 INFO - no previously-included directories found matching 'build' 07:08:07 INFO - no previously-included directories found matching 'dist' 07:08:07 INFO - no previously-included directories found matching '.git*' 07:08:07 INFO - Installing collected packages: jsonschema, functools32 07:08:07 INFO - Running setup.py install for functools32 07:08:07 INFO - warning: no files found matching '*.txt' 07:08:07 INFO - no previously-included directories found matching 'build' 07:08:07 INFO - no previously-included directories found matching 'dist' 07:08:07 INFO - no previously-included directories found matching '.git*' 07:08:07 INFO - Successfully installed jsonschema functools32 07:08:07 INFO - Cleaning up... 07:08:07 INFO - Return code: 0 07:08:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:07 INFO - 'HOME': '/Users/cltbld', 07:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:07 INFO - 'LOGNAME': 'cltbld', 07:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:07 INFO - 'MOZ_NO_REMOTE': '1', 07:08:07 INFO - 'NO_EM_RESTART': '1', 07:08:07 INFO - 'PAGER': '/bin/cat', 07:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:07 INFO - 'PWD': '/builds/slave/test', 07:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:07 INFO - 'SHELL': '/bin/bash', 07:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:07 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:07 INFO - 'USER': 'cltbld', 07:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:07 INFO - 'XPC_FLAGS': '0x0', 07:08:07 INFO - 'XPC_SERVICE_NAME': '0', 07:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:08:07 INFO - Cleaning up... 07:08:07 INFO - Return code: 0 07:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:07 INFO - 'HOME': '/Users/cltbld', 07:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:07 INFO - 'LOGNAME': 'cltbld', 07:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:07 INFO - 'MOZ_NO_REMOTE': '1', 07:08:07 INFO - 'NO_EM_RESTART': '1', 07:08:07 INFO - 'PAGER': '/bin/cat', 07:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:07 INFO - 'PWD': '/builds/slave/test', 07:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:07 INFO - 'SHELL': '/bin/bash', 07:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:07 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:07 INFO - 'USER': 'cltbld', 07:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:07 INFO - 'XPC_FLAGS': '0x0', 07:08:07 INFO - 'XPC_SERVICE_NAME': '0', 07:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:07 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:11 INFO - Downloading docopt-0.6.1.tar.gz 07:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:11 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:11 INFO - Running setup.py install for blobuploader 07:08:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:11 INFO - Running setup.py install for requests 07:08:12 INFO - Running setup.py install for docopt 07:08:12 INFO - Successfully installed blobuploader requests docopt 07:08:12 INFO - Cleaning up... 07:08:12 INFO - Return code: 0 07:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:12 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:12 INFO - 'HOME': '/Users/cltbld', 07:08:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:12 INFO - 'LOGNAME': 'cltbld', 07:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:12 INFO - 'MOZ_NO_REMOTE': '1', 07:08:12 INFO - 'NO_EM_RESTART': '1', 07:08:12 INFO - 'PAGER': '/bin/cat', 07:08:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:12 INFO - 'PWD': '/builds/slave/test', 07:08:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:12 INFO - 'SHELL': '/bin/bash', 07:08:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:12 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:12 INFO - 'USER': 'cltbld', 07:08:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:12 INFO - 'XPC_FLAGS': '0x0', 07:08:12 INFO - 'XPC_SERVICE_NAME': '0', 07:08:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:12 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-BZGmYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:12 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1GvCr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:12 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-7d5Xrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-eWT4pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-JlOwJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jxqJ3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-i90xTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bJsyqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-WjoDm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-CehSo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-HCIOn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Q_JAnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bEeIAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-K96VsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-5WTVhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-xnxID2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-H5QmwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:14 INFO - Running setup.py install for manifestparser 07:08:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:14 INFO - Running setup.py install for mozcrash 07:08:14 INFO - Running setup.py install for mozdebug 07:08:14 INFO - Running setup.py install for mozdevice 07:08:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Running setup.py install for mozfile 07:08:15 INFO - Running setup.py install for mozhttpd 07:08:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Running setup.py install for mozinfo 07:08:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Running setup.py install for mozInstall 07:08:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:15 INFO - Running setup.py install for mozleak 07:08:15 INFO - Running setup.py install for mozlog 07:08:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:16 INFO - Running setup.py install for moznetwork 07:08:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:16 INFO - Running setup.py install for mozprocess 07:08:16 INFO - Running setup.py install for mozprofile 07:08:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:16 INFO - Running setup.py install for mozrunner 07:08:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:16 INFO - Running setup.py install for mozscreenshot 07:08:16 INFO - Running setup.py install for moztest 07:08:17 INFO - Running setup.py install for mozversion 07:08:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:17 INFO - Cleaning up... 07:08:17 INFO - Return code: 0 07:08:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:17 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:17 INFO - 'HOME': '/Users/cltbld', 07:08:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:17 INFO - 'LOGNAME': 'cltbld', 07:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:17 INFO - 'MOZ_NO_REMOTE': '1', 07:08:17 INFO - 'NO_EM_RESTART': '1', 07:08:17 INFO - 'PAGER': '/bin/cat', 07:08:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:17 INFO - 'PWD': '/builds/slave/test', 07:08:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:17 INFO - 'SHELL': '/bin/bash', 07:08:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:17 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:17 INFO - 'USER': 'cltbld', 07:08:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:17 INFO - 'XPC_FLAGS': '0x0', 07:08:17 INFO - 'XPC_SERVICE_NAME': '0', 07:08:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-pNJI16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Z1pahu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-8Cc2F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-5dX8aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-p_DVlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-vcifBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-OqNhmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uIcx8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-AgvNwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jKGXMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-YGlFX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-7_AyA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-AAbnhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1duSHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-LLFYcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ouk_DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SfkM_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:08:19 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:19 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:21 INFO - Downloading blessings-1.6.tar.gz 07:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:21 INFO - Installing collected packages: blessings 07:08:21 INFO - Running setup.py install for blessings 07:08:21 INFO - Successfully installed blessings 07:08:21 INFO - Cleaning up... 07:08:22 INFO - Return code: 0 07:08:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:22 INFO - Reading from file tmpfile_stdout 07:08:22 INFO - Current package versions: 07:08:22 INFO - blessings == 1.6 07:08:22 INFO - blobuploader == 1.2.4 07:08:22 INFO - docopt == 0.6.1 07:08:22 INFO - functools32 == 3.2.3-2 07:08:22 INFO - jsonschema == 2.5.1 07:08:22 INFO - manifestparser == 1.1 07:08:22 INFO - mozInstall == 1.12 07:08:22 INFO - mozcrash == 0.17 07:08:22 INFO - mozdebug == 0.1 07:08:22 INFO - mozdevice == 0.48 07:08:22 INFO - mozfile == 1.2 07:08:22 INFO - mozhttpd == 0.7 07:08:22 INFO - mozinfo == 0.9 07:08:22 INFO - mozleak == 0.1 07:08:22 INFO - mozlog == 3.3 07:08:22 INFO - moznetwork == 0.27 07:08:22 INFO - mozprocess == 0.23 07:08:22 INFO - mozprofile == 0.28 07:08:22 INFO - mozrunner == 6.12 07:08:22 INFO - mozscreenshot == 0.1 07:08:22 INFO - mozsystemmonitor == 0.3 07:08:22 INFO - moztest == 0.7 07:08:22 INFO - mozversion == 1.4 07:08:22 INFO - psutil == 3.1.1 07:08:22 INFO - requests == 1.2.3 07:08:22 INFO - wsgiref == 0.1.2 07:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:22 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 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:22 INFO - 'HOME': '/Users/cltbld', 07:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:22 INFO - 'LOGNAME': 'cltbld', 07:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:22 INFO - 'MOZ_NO_REMOTE': '1', 07:08:22 INFO - 'NO_EM_RESTART': '1', 07:08:22 INFO - 'PAGER': '/bin/cat', 07:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:22 INFO - 'PWD': '/builds/slave/test', 07:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:22 INFO - 'SHELL': '/bin/bash', 07:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:22 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:22 INFO - 'USER': 'cltbld', 07:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:22 INFO - 'XPC_FLAGS': '0x0', 07:08:22 INFO - 'XPC_SERVICE_NAME': '0', 07:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:08:22 INFO - Cleaning up... 07:08:22 INFO - Return code: 0 07:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108af8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b8d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff899d9ba00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, '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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:08:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:22 INFO - 'HOME': '/Users/cltbld', 07:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:22 INFO - 'LOGNAME': 'cltbld', 07:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:22 INFO - 'MOZ_NO_REMOTE': '1', 07:08:22 INFO - 'NO_EM_RESTART': '1', 07:08:22 INFO - 'PAGER': '/bin/cat', 07:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:22 INFO - 'PWD': '/builds/slave/test', 07:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:22 INFO - 'SHELL': '/bin/bash', 07:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:22 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:22 INFO - 'USER': 'cltbld', 07:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:22 INFO - 'XPC_FLAGS': '0x0', 07:08:22 INFO - 'XPC_SERVICE_NAME': '0', 07:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:08:22 INFO - Cleaning up... 07:08:22 INFO - Return code: 0 07:08:22 INFO - Running post-action listener: _resource_record_post_action 07:08:22 INFO - Running post-action listener: _start_resource_monitoring 07:08:22 INFO - Starting resource monitoring. 07:08:22 INFO - [mozharness: 2016-08-13 14:08:22.898234Z] Finished create-virtualenv step (success) 07:08:22 INFO - [mozharness: 2016-08-13 14:08:22.899208Z] Running install step. 07:08:22 INFO - Running pre-action listener: _resource_record_pre_action 07:08:22 INFO - Running main action method: install 07:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:23 INFO - Reading from file tmpfile_stdout 07:08:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:23 INFO - Reading from file tmpfile_stdout 07:08:23 INFO - Output received: 07:08:23 INFO - Usage: mozinstall [options] installer 07:08:23 INFO - Options: 07:08:23 INFO - -h, --help show this help message and exit 07:08:23 INFO - -d DEST, --destination=DEST 07:08:23 INFO - Directory to install application into. [default: 07:08:23 INFO - "/builds/slave/test"] 07:08:23 INFO - --app=APP Application being installed. [default: firefox] 07:08:23 INFO - mkdir: /builds/slave/test/build/application 07:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:08:57 INFO - Reading from file tmpfile_stdout 07:08:57 INFO - Output received: 07:08:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:08:57 INFO - Running post-action listener: _resource_record_post_action 07:08:57 INFO - [mozharness: 2016-08-13 14:08:57.915792Z] Finished install step (success) 07:08:57 INFO - [mozharness: 2016-08-13 14:08:57.915940Z] Running run-tests step. 07:08:57 INFO - Running pre-action listener: _resource_record_pre_action 07:08:57 INFO - Running main action method: run_tests 07:08:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:08:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:08:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:08:57 INFO - 2016-08-13 07:08:57.930 screenresolution[2027:26843] starting screenresolution argv=screenresolution get 07:08:57 INFO - 2016-08-13 07:08:57.933 screenresolution[2027:26843] Display 0: 1600x1200x32@60 07:08:57 INFO - 2016-08-13 07:08:57.939 screenresolution[2028:26845] starting screenresolution argv=screenresolution list 07:08:57 INFO - Available Modes on Display 0 07:08:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:08:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:08:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:08:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:08:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:08:58 INFO - Intel Iris: 07:08:58 INFO - Chipset Model: Intel Iris 07:08:58 INFO - Type: GPU 07:08:58 INFO - Bus: Built-In 07:08:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:08:58 INFO - Vendor: Intel (0x8086) 07:08:58 INFO - Device ID: 0x0a2e 07:08:58 INFO - Revision ID: 0x0009 07:08:58 INFO - Displays: 07:08:58 INFO - Display: 07:08:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:08:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:08:58 INFO - Display Serial Number: 1600x1200 60 07:08:58 INFO - Main Display: Yes 07:08:58 INFO - Mirror: Off 07:08:58 INFO - Online: Yes 07:08:58 INFO - Rotation: Supported 07:08:58 INFO - Return code: 0 07:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:08:58 INFO - Python 2.7.3 07:08:58 INFO - Return code: 0 07:08:58 INFO - grabbing minidump binary from tooltool 07:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:58 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 0x108a5cd30>, '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 0x1087c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a54b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:08:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:08:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:08:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:08:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:58 INFO - Return code: 0 07:08:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:08:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:08:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:08:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:08:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VIHy8MwqUe/Render', 07:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:08:58 INFO - 'HOME': '/Users/cltbld', 07:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:08:58 INFO - 'LOGNAME': 'cltbld', 07:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:58 INFO - 'MOZ_NO_REMOTE': '1', 07:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:08:58 INFO - 'NO_EM_RESTART': '1', 07:08:58 INFO - 'PAGER': '/bin/cat', 07:08:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:58 INFO - 'PWD': '/builds/slave/test', 07:08:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:08:58 INFO - 'SHELL': '/bin/bash', 07:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h3yhkB2jkI/Listeners', 07:08:58 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 07:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:08:58 INFO - 'USER': 'cltbld', 07:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:58 INFO - 'XPC_FLAGS': '0x0', 07:08:58 INFO - 'XPC_SERVICE_NAME': '0', 07:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:08:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:08:58 INFO - mozversion application_buildid: 20160813044816 07:08:58 INFO - mozversion application_changeset: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 07:08:58 INFO - mozversion application_display_name: Nightly 07:08:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:58 INFO - mozversion application_name: Firefox 07:08:58 INFO - mozversion application_remotingname: firefox 07:08:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:08:58 INFO - mozversion application_vendor: Mozilla 07:08:58 INFO - mozversion application_version: 51.0a1 07:08:58 INFO - mozversion platform_buildid: 20160813044816 07:08:58 INFO - mozversion platform_changeset: 6e191a55c3d23e83e6a2e72e4e80c1dc21516493 07:08:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:08:58 INFO - mozversion platform_version: 51.0a1 07:08:58 INFO - using testdate: 1471097338 07:08:58 INFO - actual date: 1471097338 07:08:58 INFO - starting webserver on 'localhost:57261' 07:08:58 INFO - SUITE-START | Running 2 tests 07:08:58 INFO - TEST-START | dromaeo_css 07:08:58 INFO - operating with platform_type : mac_ 07:08:58 INFO - Initialising browser for dromaeo_css test... 07:08:58 INFO - TEST-INFO | started process 2038 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp_QIukW/profile http://localhost:57261/getInfo.html) 07:09:01 INFO - PROCESS | 2038 | __metrics Screen width/height:1600/1200 07:09:01 INFO - PROCESS | 2038 | colorDepth:24 07:09:01 INFO - PROCESS | 2038 | Browser inner width/height: 1024/663 07:09:01 INFO - PROCESS | 2038 | __metrics 07:09:01 ERROR - PROCESS | 2038 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 07:09:02 INFO - TEST-INFO | 2038: exit 0 07:09:02 INFO - Browser initialized. 07:09:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:02 INFO - TEST-INFO | started process 2041 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp_QIukW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:14 INFO - PROCESS | 2041 | RSS: Main: 253304832 07:09:14 INFO - PROCESS | 2041 | 07:10:04 INFO - PROCESS | 2041 | 1471097404238 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:12:15 INFO - PROCESS | 2041 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57261/tests/dromaeo/cssquery-ext.html) 07:12:17 INFO - PROCESS | 2041 | RSS: Main: 267722752 07:12:17 INFO - PROCESS | 2041 | 07:15:19 INFO - PROCESS | 2041 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-ext.html (next: http://localhost:57261/tests/dromaeo/cssquery-jquery.html) 07:15:20 INFO - PROCESS | 2041 | RSS: Main: 277975040 07:15:20 INFO - PROCESS | 2041 | 07:18:21 INFO - PROCESS | 2041 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57261/tests/dromaeo/cssquery-mootools.html) 07:18:22 INFO - PROCESS | 2041 | RSS: Main: 282722304 07:18:22 INFO - PROCESS | 2041 | 07:21:24 INFO - PROCESS | 2041 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57261/tests/dromaeo/cssquery-prototype.html) 07:21:25 INFO - PROCESS | 2041 | RSS: Main: 282087424 07:21:25 INFO - PROCESS | 2041 | 07:24:28 INFO - PROCESS | 2041 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57261/tests/dromaeo/cssquery-yui.html) 07:24:28 INFO - PROCESS | 2041 | RSS: Main: 287338496 07:24:28 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | Cycle 1(1): loaded http://localhost:57261/tests/dromaeo/cssquery-yui.html (next: http://localhost:57261/tests/dromaeo/cssquery-dojo.html) 07:27:31 INFO - PROCESS | 2041 | RSS: Main: 289869824 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | __start_tp_report 07:27:31 INFO - PROCESS | 2041 | _x_x_mozilla_page_load 07:27:31 INFO - PROCESS | 2041 | _x_x_mozilla_page_load_details 07:27:31 INFO - PROCESS | 2041 | |i|pagename|runs| 07:27:31 INFO - PROCESS | 2041 | |0;dojo.html;2883;3385.8645654173833;3403.030136411122;3412.2663627320153;3440.105572551137;4617.422822147231;4759.524047595239;5611.915821262679;5774.451427114428;5811.302643682759;5672.858178545538;5830.125481177825;5845.678487683176;5905.645661260327;5991.850203744909;5188.325517682696;5191.402988656297;5254.737263136847;5339.679619222859;5379.731013449332;5339.919901201485;5416.133418653017;5432.592555558329;5438.129899216126;5505.807296744615;4257.276263035292;5163.1480805667015;5186.377634683824;5308.654937429054;5331.493508116742;4477.910441791146;5329.573634109262;5341.1187154119525;5346.572274218053;5437.456254374571;4122.958770412288;4632.791524381411;5260.2372655965055;5313.362396512443;5372.892542149174;5665.178549110397;5675.602707810455;5683.403242659544;5762.942370576283;5851.678157701324;6229.0967809667345;6263.029230469285;6323.9051414228825;6328.11406403104;6345.333739957284;6266.655333956631;6287.371262873676;6288.465480434169;6312.905306420407;6314.0844577536;5738.282714660668;5863.149843272701;5961.344252132262;5984.521238300969;5995.430434108796;6257.374262573797;6354.3645635437015;6362.077498762654;6372.107904893226;6382.425581697669;6141.07883817422;6254.749810007549;6265.216847894013;6294.748210071546;6299.716512756937;6147;6203.2556093269095;6323.019931910561;6329.651869147149;6329.7468101275435;5102.36220472441;6314.0528920661345;6315.905261421082;6338.334474880164;6350.745970161234;6270.905936410957;6281.8743625127245;6303.558750887486;6308.274548426898;6311.779087731908;4862.9756851216225;4905.754712264373;4933.210686290248;5008.574271186917;5041.319421878;4431.62331201845;4447.199504089295;4488.977555112204;4519.276915693474;4563.155816174019;5545.223668686387;5939.198208241918;5943.31651860033;5968.731407086691;5997.310309314397;6189.133521307021;6230.968845155745;6237.039320897759;6241.375862413813;6309.463695585835;4881.4630390657;5859.1797148399255;5972.731227094791;6022.5784195105925;6030.095485677183;5487.259220005328;5489.917651235235;5504.6421982571;5508.9724551377785;5510.669359838343;5658.264425624642;6234.1583886174785;6313.96843015782;6430.260520040255;6438.999999999906;6240.282367527792;6282.057691346335;6295.748170073146;6306.864764342462;6318.399752023551;6419.711112999833;6455.225372955088;6458.031295305742;6472.708728107341;6479.870402592016;6124.2588809726185;6154.907676384947;6249.937500624936;6274.874502510015;6300.936990630035;6183.598066125687;6224.688765561795;6294.748210071729;6302.432781049728;6314.747410103544;6251.53113516479;6251.68741562911;6265.27949285838;6271.905921411091;6291.307956124731;6100.572959892765;6159.5688301818445;6211.751529938751;6225.937740622536;6248.0003199487865;6013.6692481913915;6054.788082417094;6098.695065246631;6116.418940200674;6170.7223174958135;6199.473044791243;6214.322781525637;6261.68691565429;6286.874262514815;6296.527760418078;6004.909926351021;6023.939760602513;6168.35232300602;6175.7838475654935;6196.628202307876 07:27:31 INFO - PROCESS | 2041 | |1;ext.html;473.7015680121523;510.65020460984204;512.3953734593179;516.0762235598279;530.4377359998401;37543.249135017286;39905;39918.800405997965;39973.40039899397;40009.799951000205;40853.182936341254;41323.58676413235;41340.79329603355;41610.29533080348;41661.375079373756;9637.03629637036;9852.064053914866;9869.90130098697;9880.703578892644;9884.406935583887;9758.219342452623;9861.950690246538;9875.654352097677;9879.456629885353;9883.950580247089;9854.359466634645;9859.161971232454;9887.950560247189;9922.751931201741;9927.2058235341;9849.852252216187;9874.308798384116;9875.555599998017;9893;9896;9559.61761529538;9633.566489507988;9652.420854748738;9658.903410965871;9679.322447428684;39526.802365988275;39690.60309396898;39839.60160398388;39855.8007209965;39886.60113398858;2596.4677241165514;3144.559761633373;3257.2508323085585;3416.385050690875;3454.9481757773656;24451.633225501453;29115.708842911725;30386.84806575953;30430.239244018856;30633.693663063306;3081.2408562983283;3125.9687403125904;3144.984275078633;3154.321820808514;3190.984045079783;467830;470318;471435;474178;475234;32550.837245814095;32646.836765816493;32694.836525817693;32722.891325324534;32882;33452.3309533808;33978.66021339804;34043.14892127667;34495.31009379798;35263.471047934305;16624.3350265988;16744.66510669804;16818.07500587455;16849.831501685072;16877.240524176443;12900.225986440844;13086.541971031158;13089.672758181121;13114.213147211198;13114.934425328003;15216.619584510254;15246.771298430533;16231.51305460838;17720.734188987175;18653.626927461373;6765.695543700545;7928.127905930343;7999.200079991954;8045.678172873137;8079.959600202079;718.6263143165525;880.8414485392691;940.8212439636447;1041.2294901772634;1161.9593314233962;25554.872225639123;29443.705562944095;29829.850850746043;30413.087607371814;30823.537646935314;921.6175287255847;980.7940332530106;1066.0245875024266;1108.95564177432;1171.2152857585438;15681.529554113395;15690.980086294354;15796.8942174049;15936.840631593535;16160.111193884213;569698;635083;647969;657377;657953;56794.43205567892;57025.429745702015;57224;57248.71375643095;57394;1184.8696643369221;1269.0482138396203;1313.3564553368972;1352.3305963548107;1356.4777560639027;25896.22311330663;29081.34698448323;29169;29540.704592953796;29709.554356684235;52619.15832945829;56210.59473513031;57071.71464142653;57104;57295.14057289228;559658;613636;616656;624754;625498;42619.934501637705;42926.570734292254;43303.566964329955;43352.916177094565;43690.56309436865;46857.531424685316;47199.29201061918;48241.517584823705;48242.75878620584;48285.51714482951;39034;39205;39505.03712221653;40970.38544421776;41012.97467563335;38414;38697.6130238694;38774.80612596919;39659.20681586294;40077.39883901685;37711.434328485644;38207.617923820406;39607.81176564708;39623;40883.59116408917;28615.85692071526;31568.842155789072;35411.645883540834;35506.822465887504;35518.822405887804;24447.75552244455;25366;25752.484950301263;26103.955841766117;27587 07:27:31 INFO - PROCESS | 2041 | |2;jquery.html;312.36589722862584;377.90552361909516;385.108473882961;389.2817751248948;403.63067792969434;20218.98905054747;20437;21087;21251.14995400184;21412.99999999996;9502.47736374499;10296;12272;12316.445759940802;13693;5450.700211488366;5628.240187574666;5630.09918413054;5636.689982051006;5640.266765320503;3938.310795610771;5554.972225138868;5975.731092100866;6248.4064013918605;6310;6196.907046394308;6248;6267.623942563438;6301;6388.520860935425;5382.730863456831;6121.326654068049;6125.346156537732;6222.657753823538;6260.217472815898;5379.515843574097;5854.18041474194;5872.708004239061;6090.512758979316;6118.235220597426;13493.12294700851;13577.796333055012;13582.388792504362;13597.252151131685;23823.880880595658;2033.7762846086919;2095.308548179097;2112.9220604233824;2134.487722946482;2143.1748776721074;10060.748481287954;10100.88890222075;11135.554577816878;15178.392864285415;16004.679906401807;1834.4129878438905;1859.7675290588677;1870.9064546772743;1873.072828949665;1968.9409317720492;116983;124641;126671.36664316712;127742;129441.35279323543;9412.482313472688;11080.778384432266;11518.30890146577;11562.595309164139;11743.823842642367;14321.928390357982;14508.839292856757;14508.927455362867;14537.636559086108;14559.636009099857;8296.8340633187;8590.312774977987;8599.818067315133;8706.434081784664;8758.036615972238;8439.367047471342;8574.914250857411;8597.613107410181;8707.477551346812;8740.475571465733;4448.510663826976;4557.111363284194;4565.288016993627;4604.516525764813;4624.5375462453485;1760.251892945493;1821.7449557062023;1885.9811401885806;1917.5493758966632;1943.5802425979464;863.6372723456038;898.2364989758784;905.9773505662412;931.5994122527243;983.2085171437062;19961.101750420974;20717.68923466149;21413.67879481809;21481.570368592853;21658.675119873216;932.5663566441638;956.8325543029941;979.7305740921304;1020.4285600063988;1058.0900425634102;10602.734931626772;11185.552577896793;11192.272502287326;11213.439328033566;11245.718857028476;527522;602866;613817.9309103426;617170;617814;115718;116627;129463;133699;134655;953.5518306396121;955.8231727130503;970.3595626886221;974.668612671695;1002.4987506247022;15553;17116.058616776198;17894.015829129523;18965.810341896406;19146.329878454188;37711.05722356853;38235;49246;55688;55908;66186.00720989093;73175.63412182905;77225.22774772406;77755.83366249397;78244.60877695575;8102.7569172924905;8139.3081588063305;8201.056878458814;8273.627686753991;8285.295749861329;9491.572879220314;11979.281243125091;12429.75140497203;12776.233425994471;13150.736985260433;11164.385958772345;11477.770444590895;11486.483108259981;11535.36555489456;11651.825222621497;10896.746874109578;11022.944885275523;11166.441677916235;11332.036776874058;11414.086873050303;11125.666230013112;11164.9951504365;11501.309921404743;11668.124890633067;11903.821442678194;8026.357891368793;8044;8174.713885014234;8299.543525106177;8420.747377578682;8263.710770123016;10723.30298530593;10797.13622910181;10937.507812148313;11038 07:27:31 INFO - PROCESS | 2041 | |3;mootools.html;1408.9436422543095;1536.8539988701073;1720.0797573298287;1822.6445843060592;1826.3517899046378;7923.445358824884;8395.83208335833;8616.569171541414;8977.416467929588;8994.100589941003;8640.567971601426;8812.515311657857;8836.823263534725;8845.336599755012;8864.335174861879;2346.483773569816;2371.158238825218;2375.2874137758604;2380.1550449590404;2385.33210701004;2339.4034521197073;2365.1840115160244;2380.9047638094457;2382.690250267463;2389.940251493709;2360.5160942006933;2371.34787933318;2377.5601513720017;2388.737238903719;2392.820538459614;2337.0651739304412;2351.706036745407;2354.6585745066955;2363.3618922890723;2366.656834758959;2319.420144963759;2332.055517515409;2342.543204075206;2345.2612427085414;2347.225415612844;7404.629768511553;8857.645694172226;8921.776955576162;8929;8931.285497160212;5236.92144617831;5315.893682126374;5336.759845806948;5386.461353864622;5401.351837779453;3141.780075394723;3637.3634613942454;3645.981770091159;3700.9259814803554;3733.1413774831667;1087.3856271206744;1096.0026375997884;1101.515333253374;1113.777244551093;1119.4458742922225;11592.478338474704;11736.471858766376;11818.054555635528;11839.052875769918;11862.466189021428;4696.38946936896;4712.528747125329;4789.1015422530445;4831.855044348676;4885.364902562644;8909.376343655882;9693.369930954465;9906.752331191778;10007.849882251772;10017.649382271586;5351.063563876306;5357.276767636397;5357.678539287655;5375.408705042442;5381.112116500812;4433;4765.547273009128;4881.633877459205;4900.754962251945;4915.090708218991;3478.7912725236565;3868.709846761504;3960.1881614269582;3960.20795840833;3997.380406037069;1283.4406196471332;1292.4700872642172;1297.6690943809267;1306.6667999660026;1310.2662508994993;834.2741814621197;875.5753459572103;937.9859302110474;941.2422999485343;941.2987324443196;5792.652440853562;5895.4399332063385;6006.369331220247;6114.082887566811;6177.660228687465;433.30022014446445;445.5588966922788;449.94825595056335;453.8003278557424;455.37386094120586;3863.8454461821775;3982.920341593152;4016.0961796413253;4040.878773636796;4151.73013754105;10475.47622618866;10924.2899211551;10938.234323597431;10940.835887461695;10966.561337546409;10886.510107045202;10907.945460272647;10918.890811091946;10919.12646988239;10963.945180274048;7743.5353878767455;8174.468659537111;8219.095899451055;8268.8346233075;8337.082920878698;5399.893021930417;5690.402507736628;5986.204138758442;6057.848553786191;6199.318075011835;9563.474008929576;9833.999999999714;10073.899261007296;10119.696409107739;10181.541830617789;9953.004699529989;10293.3823970562;10301.536430860779;10388.792224155626;10461.110805581306;6614.470842332698;7509.924900751141;7615.923840761743;7676;7685;8339.66641334364;8411.116832732476;8415.537145456814;8425.87361189595;8432.620532075949;7335.266473352622;7394.408447324308;7557.244275572399;7620;7628.923710762821;7328.853422931618;7471.402287816853;7486.876968454558;7570.735024274124;7640.885386719093;6931.133608298963;7048.823779405351;7098.503104782616;7101.893471598033;7126.180489243803;4336.1978034063795;4951.405831300123;4975.50244975514;5007.349044624321;5144.871378215575;3874.8881859387266;5037.395512538519;5135.640505164752;5191.76637051326;5237.869053273546 07:27:31 INFO - PROCESS | 2041 | |4;prototype.html;307.1706392739603;310.10534607656916;312.773239401434;317.3161836242896;320.5752378099019;5183.352080989876;5554.472325129106;5623.1003039513635;5627.296587926509;5678.716064196789;4378.6934914555995;4814.374131362927;5184.429712731606;5282.445343238962;5649.802256921009;3463.8960831175104;4031.2945234583904;4101.89248902796;4162.729422587538;4176.331786914095;3127.6246850377875;3720.9069773255615;4115.839184428184;4191.7275377100395;4192.664586833046;4177.16456708658;4193.664506839461;4199.45407097077;4208.284591619432;4209.137126888981;2815.7610651313357;4060.2691515527194;4161.9375709364385;4164.5210800758;4237.6186143247105;2967.9018763057593;3435.57423669177;3550.6449355064547;3551.8756843510355;3581.81509279342;4406.294992801137;4799.808007679689;5059.3422855028975;5421.051316019721;5443.938432005761;4364.6508279337895;4397.912041759147;4474.552544745532;4774.092922344744;4806.543378379083;4838.491958344393;5649.971750141264;5812.82561523155;5835.5915085944;5852.648841069549;3745.943810842812;3920.8235629396745;3951.4467974483596;3963.564007959122;3974.6621537169376;5303.867403314909;5688.829335119953;5912.196779982104;5971.104334349839;6262.874742505124;3226.9677303227136;4000.299947509174;4028.5568587455355;4070.409790580349;4077.510698716173;3610.5847827499647;4094.1811637672586;4099.036726369301;4101.5488296287385;4129.855455059119;4334.82959600906;4523.072770082125;4773.164696178155;4802.247179779355;4835.685680430831;4836.226203807374;5127.3847138343635;5911.467967882912;5939.881202375928;5979.790707325223;1356.1524047470332;1371.3417559571462;1381.597678356469;1401.341369556307;1401.7336706026026;789.2226157235119;806.0609390060514;837.7654256808104;842.7682387343407;855.6320782063773;4987.501249875056;5224.399194092652;5485.561155107582;5506.944930550643;5515.7242137892945;5225.085610018232;5875.884681514652;6117.204763380821;6182.505399568024;6183.81448556544;5250.816221432232;5469.726513674301;5521;5523.4752698494385;5559.610827242054;2726.573349718752;3140.481820499592;3176.6664500227143;3184.9840750796097;3191.4042978510743;5019.6948793314;5983.491403230774;6289.276733175743;6294.9685251574365;6334.873302534015;5659.603827732019;6194.314382942142;6199.752009919643;6209.441150296405;6244.843878903063;5279.073138304491;5722.884037612792;5945.791897283574;6268.561200715997;6284.402981716729;5696.829095127153;5802.245708057925;5980.557484376688;6011.609245399035;6017.217761690952;5913.34953155144;5967.597614560662;6027.60820546663;6038.818835434944;6041.214642096676;4908.509149085063;5533.446655334435;5555.972070194431;5941.465268125889;6288.402601752826;3569.6608822162893;3711.814409279579;3758.977893653764;3962.663173630274;4052.6555242804693;6123.663198524124;6132.785352512819;6136.631802091889;6143.447089761943;6216.937830621636;4534.795934183036;4900.701314151824;5858.681796595903;5987.520998320037;6006.819795406145;4864.935090892715;4930.630202734737;5966.642001479925;5968.150542899719;5984.8803023940145;4778.689385189951;5624.128260119688;5778.855528611818;5829.417058294137;5849.473547380756;5613.354464236501;5623.971880140573;5668.631538949955;5774;6039.486643635164;5847.912281315868;5856.238688970577;5880.529557635465;5881.529477641693;5884.735186916513 07:27:31 INFO - PROCESS | 2041 | |5;yui.html;708.4474110194047;716.2550947015104;746.5931067568175;777.0985656638301;834.5076404921095;14833.703325933475;15638.609034774136;15674.999999999985;15677.764833527506;15703.371865125395;14141.646458838533;14262.643433914158;14275.214863182548;14319.42722291107;14337.426502939896;553.9058360078776;820.9794755131139;848.8854004709378;849.3884403229665;850.0309647002391;841.0874201491389;845.3575282785066;846.5513277962659;851.6806197675871;853.9786505337386;881.7663319220412;892.7187935800234;895.0691281067682;895.5880295064278;899.2850683706469;873.1617647058799;884.5886662701843;887.3389324952951;888.6711916590871;888.8177923525661;661.2957200581366;661.5137873662902;662.7978466567695;664.4783844681901;665.4077870695086;14547.199904005276;14644.267786610626;14657.193854338007;14691.926540367336;14719.190444525548;13161.210327380388;13466.730665386638;14829.48096816617;14835.332410041574;15021.849781502264;11304.265222760494;12195.878041219563;12366.505339786398;12418.81371779424;12617.053720970964;3500.3174380995715;3845.6923446124524;3872.6320999505283;4089.672826173899;4094.4267802507675;101513.95458136268;104054.99999999924;117889;118623;118819.40590296993;11370.204085714086;11379.146564007733;11438.942805286088;11590.826137607943;11616.303021818718;23273.418164546023;23429.062837486308;23478.413039673804;23526.7647323528;23541.646875296883;7386.926130738624;7946.284834364935;8088.514689118671;8184.263416292562;8322.958385208156;4358.150160718629;4432.534583868712;4440.755758433253;4497.302918047708;4548.476925153584;3723.6648701616987;3956.9711874912155;3965.583613720518;3986.880393588197;4006.358982562834;681.2370145437043;707.2255879811598;711.7686402523663;713.8822094354477;716.2622498826217;606.6511755740466;608.9360617135226;680.4828330468879;703.581508128951;714.6885465171365;9185.678501252423;9689.70930872075;9804.803903921882;9866.654667086761;9900.405975641484;545.9317585301837;600.3756093662543;636.2197198243613;661.110805965975;688.5145972089665;4282.76444795533;4621.214393553104;4862.367892173995;4888;4897.897972956056;136197;142528.28735856462;161481;167845;168528.15735921243;144084;144898;149448.2527587355;149782;150399;103670;122095.16857247148;123364;123860;124789.37605311915;9539.427634341962;10127.949360253446;10138.847917281395;10281.177505799667;10318.329308594917;61993.690031551356;64573.70852583016;65464;66697.81033505972;68025;79445;79928;88775;89759;98959.50520247352;12967.157134786208;13010.54463093825;13086.80369794473;13321;13335.266560339274;12830;14855.40578376896;14898.255087245378;14938.477153299582;15110.524579347031;13822.166455876722;13866;14025.079275000757;14351.497697580535;14413.927930360282;14012;14033.789493157816;14279.500217492337;14685.779713304095;14933.775993360325;13817.654558636115;14124.152550846982;14130.646733831325;14149.43402263939;14618.976671632883;10758.569657213624;10958.154709211267;11042.723931901766;11352.829707554558;11581.189316747746;10097.091261786474;10307.278490505592;10676.7721712001;10968.287061340987;11866.584669536525 07:27:31 INFO - PROCESS | 2041 | __end_tp_report 07:27:31 INFO - PROCESS | 2041 | __start_cc_report 07:27:31 INFO - PROCESS | 2041 | _x_x_mozilla_cycle_collect,422 07:27:31 INFO - PROCESS | 2041 | __end_cc_report 07:27:31 INFO - PROCESS | 2041 | __startTimestamp1471098451765__endTimestamp 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | ------- Summary: start ------- 07:27:31 INFO - PROCESS | 2041 | Number of tests: 6 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | [#0] dojo.html Cycles:165 Average:5787.45 Median:6100.57 stddev:704.90 (11.6%) stddev-sans-first:669.23 07:27:31 INFO - PROCESS | 2041 | Values: 2883.0 3385.9 3403.0 3412.3 3440.1 4617.4 4759.5 5611.9 5774.5 5811.3 5672.9 5830.1 5845.7 5905.6 5991.9 5188.3 5191.4 5254.7 5339.7 5379.7 5339.9 5416.1 5432.6 5438.1 5505.8 4257.3 5163.1 5186.4 5308.7 5331.5 4477.9 5329.6 5341.1 5346.6 5437.5 4123.0 4632.8 5260.2 5313.4 5372.9 5665.2 5675.6 5683.4 5762.9 5851.7 6229.1 6263.0 6323.9 6328.1 6345.3 6266.7 6287.4 6288.5 6312.9 6314.1 5738.3 5863.1 5961.3 5984.5 5995.4 6257.4 6354.4 6362.1 6372.1 6382.4 6141.1 6254.7 6265.2 6294.7 6299.7 6147.0 6203.3 6323.0 6329.7 6329.7 5102.4 6314.1 6315.9 6338.3 6350.7 6270.9 6281.9 6303.6 6308.3 6311.8 4863.0 4905.8 4933.2 5008.6 5041.3 4431.6 4447.2 4489.0 4519.3 4563.2 5545.2 5939.2 5943.3 5968.7 5997.3 6189.1 6231.0 6237.0 6241.4 6309.5 4881.5 5859.2 5972.7 6022.6 6030.1 5487.3 5489.9 5504.6 5509.0 5510.7 5658.3 6234.2 6314.0 6430.3 6439.0 6240.3 6282.1 6295.7 6306.9 6318.4 6419.7 6455.2 6458.0 6472.7 6479.9 6124.3 6154.9 6249.9 6274.9 6300.9 6183.6 6224.7 6294.7 6302.4 6314.7 6251.5 6251.7 6265.3 6271.9 6291.3 6100.6 6159.6 6211.8 6225.9 6248.0 6013.7 6054.8 6098.7 6116.4 6170.7 6199.5 6214.3 6261.7 6286.9 6296.5 6004.9 6023.9 6168.4 6175.8 6196.6 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | [#1] ext.html Cycles:180 Average:69409.76 Median:39871.20 stddev:154107.78 (386.5%) stddev-sans-first:154453.18 07:27:31 INFO - PROCESS | 2041 | Values: 473.7 510.7 512.4 516.1 530.4 37543.2 39905.0 39918.8 39973.4 40009.8 40853.2 41323.6 41340.8 41610.3 41661.4 9637.0 9852.1 9869.9 9880.7 9884.4 9758.2 9862.0 9875.7 9879.5 9884.0 9854.4 9859.2 9888.0 9922.8 9927.2 9849.9 9874.3 9875.6 9893.0 9896.0 9559.6 9633.6 9652.4 9658.9 9679.3 39526.8 39690.6 39839.6 39855.8 39886.6 2596.5 3144.6 3257.3 3416.4 3454.9 24451.6 29115.7 30386.8 30430.2 30633.7 3081.2 3126.0 3145.0 3154.3 3191.0 467830.0 470318.0 471435.0 474178.0 475234.0 32550.8 32646.8 32694.8 32722.9 32882.0 33452.3 33978.7 34043.1 34495.3 35263.5 16624.3 16744.7 16818.1 16849.8 16877.2 12900.2 13086.5 13089.7 13114.2 13114.9 15216.6 15246.8 16231.5 17720.7 18653.6 6765.7 7928.1 7999.2 8045.7 8080.0 718.6 880.8 940.8 1041.2 1162.0 25554.9 29443.7 29829.9 30413.1 30823.5 921.6 980.8 1066.0 1109.0 1171.2 15681.5 15691.0 15796.9 15936.8 16160.1 569698.0 635083.0 647969.0 657377.0 657953.0 56794.4 57025.4 57224.0 57248.7 57394.0 1184.9 1269.0 1313.4 1352.3 1356.5 25896.2 29081.3 29169.0 29540.7 29709.6 52619.2 56210.6 57071.7 57104.0 57295.1 559658.0 613636.0 616656.0 624754.0 625498.0 42619.9 42926.6 43303.6 43352.9 43690.6 46857.5 47199.3 48241.5 48242.8 48285.5 39034.0 39205.0 39505.0 40970.4 41013.0 38414.0 38697.6 38774.8 39659.2 40077.4 37711.4 38207.6 39607.8 39623.0 40883.6 28615.9 31568.8 35411.6 35506.8 35518.8 24447.8 25366.0 25752.5 26104.0 27587.0 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | [#2] jquery.html Cycles:180 Average:34386.57 Median:11812.37 stddev:99789.75 (844.8%) stddev-sans-first:100036.89 07:27:31 INFO - PROCESS | 2041 | Values: 312.4 377.9 385.1 389.3 403.6 20219.0 20437.0 21087.0 21251.1 21413.0 9502.5 10296.0 12272.0 12316.4 13693.0 5450.7 5628.2 5630.1 5636.7 5640.3 3938.3 5555.0 5975.7 6248.4 6310.0 6196.9 6248.0 6267.6 6301.0 6388.5 5382.7 6121.3 6125.3 6222.7 6260.2 5379.5 5854.2 5872.7 6090.5 6118.2 13493.1 13577.8 13582.4 13597.3 23823.9 2033.8 2095.3 2112.9 2134.5 2143.2 10060.7 10100.9 11135.6 15178.4 16004.7 1834.4 1859.8 1870.9 1873.1 1968.9 116983.0 124641.0 126671.4 127742.0 129441.4 9412.5 11080.8 11518.3 11562.6 11743.8 14321.9 14508.8 14508.9 14537.6 14559.6 8296.8 8590.3 8599.8 8706.4 8758.0 8439.4 8574.9 8597.6 8707.5 8740.5 4448.5 4557.1 4565.3 4604.5 4624.5 1760.3 1821.7 1886.0 1917.5 1943.6 863.6 898.2 906.0 931.6 983.2 19961.1 20717.7 21413.7 21481.6 21658.7 932.6 956.8 979.7 1020.4 1058.1 10602.7 11185.6 11192.3 11213.4 11245.7 527522.0 602866.0 613817.9 617170.0 617814.0 115718.0 116627.0 129463.0 133699.0 134655.0 953.6 955.8 970.4 974.7 1002.5 15553.0 17116.1 17894.0 18965.8 19146.3 37711.1 38235.0 49246.0 55688.0 55908.0 66186.0 73175.6 77225.2 77755.8 78244.6 8102.8 8139.3 8201.1 8273.6 8285.3 9491.6 11979.3 12429.8 12776.2 13150.7 11164.4 11477.8 11486.5 11535.4 11651.8 10896.7 11022.9 11166.4 11332.0 11414.1 11125.7 11165.0 11501.3 11668.1 11903.8 8026.4 8044.0 8174.7 8299.5 8420.7 8263.7 10723.3 10797.1 10937.5 11038.0 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | [#3] mootools.html Cycles:180 Average:5724.56 Median:4810.48 stddev:3239.10 (67.3%) stddev-sans-first:3231.95 07:27:31 INFO - PROCESS | 2041 | Values: 1408.9 1536.9 1720.1 1822.6 1826.4 7923.4 8395.8 8616.6 8977.4 8994.1 8640.6 8812.5 8836.8 8845.3 8864.3 2346.5 2371.2 2375.3 2380.2 2385.3 2339.4 2365.2 2380.9 2382.7 2389.9 2360.5 2371.3 2377.6 2388.7 2392.8 2337.1 2351.7 2354.7 2363.4 2366.7 2319.4 2332.1 2342.5 2345.3 2347.2 7404.6 8857.6 8921.8 8929.0 8931.3 5236.9 5315.9 5336.8 5386.5 5401.4 3141.8 3637.4 3646.0 3700.9 3733.1 1087.4 1096.0 1101.5 1113.8 1119.4 11592.5 11736.5 11818.1 11839.1 11862.5 4696.4 4712.5 4789.1 4831.9 4885.4 8909.4 9693.4 9906.8 10007.8 10017.6 5351.1 5357.3 5357.7 5375.4 5381.1 4433.0 4765.5 4881.6 4900.8 4915.1 3478.8 3868.7 3960.2 3960.2 3997.4 1283.4 1292.5 1297.7 1306.7 1310.3 834.3 875.6 938.0 941.2 941.3 5792.7 5895.4 6006.4 6114.1 6177.7 433.3 445.6 449.9 453.8 455.4 3863.8 3982.9 4016.1 4040.9 4151.7 10475.5 10924.3 10938.2 10940.8 10966.6 10886.5 10907.9 10918.9 10919.1 10963.9 7743.5 8174.5 8219.1 8268.8 8337.1 5399.9 5690.4 5986.2 6057.8 6199.3 9563.5 9834.0 10073.9 10119.7 10181.5 9953.0 10293.4 10301.5 10388.8 10461.1 6614.5 7509.9 7615.9 7676.0 7685.0 8339.7 8411.1 8415.5 8425.9 8432.6 7335.3 7394.4 7557.2 7620.0 7628.9 7328.9 7471.4 7486.9 7570.7 7640.9 6931.1 7048.8 7098.5 7101.9 7126.2 4336.2 4951.4 4975.5 5007.3 5144.9 3874.9 5037.4 5135.6 5191.8 5237.9 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | [#4] prototype.html Cycles:180 Average:4694.30 Median:5264.94 stddev:1490.69 (28.3%) stddev-sans-first:1458.05 07:27:31 INFO - PROCESS | 2041 | Values: 307.2 310.1 312.8 317.3 320.6 5183.4 5554.5 5623.1 5627.3 5678.7 4378.7 4814.4 5184.4 5282.4 5649.8 3463.9 4031.3 4101.9 4162.7 4176.3 3127.6 3720.9 4115.8 4191.7 4192.7 4177.2 4193.7 4199.5 4208.3 4209.1 2815.8 4060.3 4161.9 4164.5 4237.6 2967.9 3435.6 3550.6 3551.9 3581.8 4406.3 4799.8 5059.3 5421.1 5443.9 4364.7 4397.9 4474.6 4774.1 4806.5 4838.5 5650.0 5812.8 5835.6 5852.6 3745.9 3920.8 3951.4 3963.6 3974.7 5303.9 5688.8 5912.2 5971.1 6262.9 3227.0 4000.3 4028.6 4070.4 4077.5 3610.6 4094.2 4099.0 4101.5 4129.9 4334.8 4523.1 4773.2 4802.2 4835.7 4836.2 5127.4 5911.5 5939.9 5979.8 1356.2 1371.3 1381.6 1401.3 1401.7 789.2 806.1 837.8 842.8 855.6 4987.5 5224.4 5485.6 5506.9 5515.7 5225.1 5875.9 6117.2 6182.5 6183.8 5250.8 5469.7 5521.0 5523.5 5559.6 2726.6 3140.5 3176.7 3185.0 3191.4 5019.7 5983.5 6289.3 6295.0 6334.9 5659.6 6194.3 6199.8 6209.4 6244.8 5279.1 5722.9 5945.8 6268.6 6284.4 5696.8 5802.2 5980.6 6011.6 6017.2 5913.3 5967.6 6027.6 6038.8 6041.2 4908.5 5533.4 5556.0 5941.5 6288.4 3569.7 3711.8 3759.0 3962.7 4052.7 6123.7 6132.8 6136.6 6143.4 6216.9 4534.8 4900.7 5858.7 5987.5 6006.8 4864.9 4930.6 5966.6 5968.2 5984.9 4778.7 5624.1 5778.9 5829.4 5849.5 5613.4 5624.0 5668.6 5774.0 6039.5 5847.9 5856.2 5880.5 5881.5 5884.7 07:27:31 INFO - PROCESS | 2041 | 07:27:31 INFO - PROCESS | 2041 | [#5] yui.html Cycles:180 Average:26030.45 Median:23453.74 stddev:42269.33 (180.2%) stddev-sans-first:42345.15 07:27:31 INFO - PROCESS | 2041 | Values: 708.4 716.3 746.6 777.1 834.5 14833.7 15638.6 15675.0 15677.8 15703.4 14141.6 14262.6 14275.2 14319.4 14337.4 553.9 821.0 848.9 849.4 850.0 841.1 845.4 846.6 851.7 854.0 881.8 892.7 895.1 895.6 899.3 873.2 884.6 887.3 888.7 888.8 661.3 661.5 662.8 664.5 665.4 14547.2 14644.3 14657.2 14691.9 14719.2 13161.2 13466.7 14829.5 14835.3 15021.8 11304.3 12195.9 12366.5 12418.8 12617.1 3500.3 3845.7 3872.6 4089.7 4094.4 101514.0 104055.0 117889.0 118623.0 118819.4 11370.2 11379.1 11438.9 11590.8 11616.3 23273.4 23429.1 23478.4 23526.8 23541.6 7386.9 7946.3 8088.5 8184.3 8323.0 4358.2 4432.5 4440.8 4497.3 4548.5 3723.7 3957.0 3965.6 3986.9 4006.4 681.2 707.2 711.8 713.9 716.3 606.7 608.9 680.5 703.6 714.7 9185.7 9689.7 9804.8 9866.7 9900.4 545.9 600.4 636.2 661.1 688.5 4282.8 4621.2 4862.4 4888.0 4897.9 136197.0 142528.3 161481.0 167845.0 168528.2 144084.0 144898.0 149448.3 149782.0 150399.0 103670.0 122095.2 123364.0 123860.0 124789.4 9539.4 10127.9 10138.8 10281.2 10318.3 61993.7 64573.7 65464.0 66697.8 68025.0 79445.0 79928.0 88775.0 89759.0 98959.5 12967.2 13010.5 13086.8 13321.0 13335.3 12830.0 14855.4 14898.3 14938.5 15110.5 13822.2 13866.0 14025.1 14351.5 14413.9 14012.0 14033.8 14279.5 14685.8 14933.8 13817.7 14124.2 14130.6 14149.4 14619.0 10758.6 10958.2 11042.7 11352.8 11581.2 10097.1 10307.3 10676.8 10968.3 11866.6 07:27:31 INFO - PROCESS | 2041 | -------- Summary: end -------- 07:27:31 INFO - PROCESS | 2041 | 07:27:32 INFO - TEST-INFO | 2041: exit 0 07:27:32 INFO - TEST-OK | dromaeo_css | took 1113887ms 07:27:32 INFO - TEST-START | kraken 07:27:32 INFO - operating with platform_type : mac_ 07:27:32 INFO - Initialising browser for kraken test... 07:27:32 INFO - TEST-INFO | started process 2045 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp9irZ8F/profile http://localhost:57261/getInfo.html) 07:27:35 INFO - PROCESS | 2045 | __metrics Screen width/height:1600/1200 07:27:35 INFO - PROCESS | 2045 | colorDepth:24 07:27:35 INFO - PROCESS | 2045 | Browser inner width/height: 1024/663 07:27:35 INFO - PROCESS | 2045 | __metrics 07:27:35 ERROR - PROCESS | 2045 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 07:27:36 INFO - TEST-INFO | 2045: exit 0 07:27:36 INFO - Browser initialized. 07:27:36 INFO - Running cycle 1/1 for kraken test... 07:27:36 INFO - TEST-INFO | started process 2047 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp9irZ8F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:48 INFO - PROCESS | 2047 | RSS: Main: 252137472 07:27:48 INFO - PROCESS | 2047 | 07:27:51 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:52 INFO - PROCESS | 2047 | RSS: Main: 262385664 07:27:52 INFO - PROCESS | 2047 | 07:27:54 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-dft) 07:27:55 INFO - PROCESS | 2047 | RSS: Main: 271101952 07:27:55 INFO - PROCESS | 2047 | 07:27:58 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-fft) 07:27:59 INFO - PROCESS | 2047 | RSS: Main: 271241216 07:27:59 INFO - PROCESS | 2047 | 07:28:01 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57261/tests/kraken/driver.html?testName=audio-oscillator) 07:28:02 INFO - PROCESS | 2047 | RSS: Main: 272076800 07:28:02 INFO - PROCESS | 2047 | 07:28:04 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:04 INFO - PROCESS | 2047 | RSS: Main: 272547840 07:28:04 INFO - PROCESS | 2047 | 07:28:07 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57261/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:08 INFO - PROCESS | 2047 | RSS: Main: 272568320 07:28:08 INFO - PROCESS | 2047 | 07:28:11 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57261/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:12 INFO - PROCESS | 2047 | RSS: Main: 273080320 07:28:12 INFO - PROCESS | 2047 | 07:28:15 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57261/tests/kraken/driver.html?testName=json-parse-financial) 07:28:16 INFO - PROCESS | 2047 | RSS: Main: 274038784 07:28:16 INFO - PROCESS | 2047 | 07:28:17 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:18 INFO - PROCESS | 2047 | RSS: Main: 273911808 07:28:18 INFO - PROCESS | 2047 | 07:28:20 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:21 INFO - PROCESS | 2047 | RSS: Main: 273977344 07:28:21 INFO - PROCESS | 2047 | 07:28:23 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:24 INFO - PROCESS | 2047 | RSS: Main: 274329600 07:28:24 INFO - PROCESS | 2047 | 07:28:27 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:27 INFO - PROCESS | 2047 | RSS: Main: 274923520 07:28:27 INFO - PROCESS | 2047 | 07:28:30 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:31 INFO - PROCESS | 2047 | RSS: Main: 274685952 07:28:31 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | Cycle 1(1): loaded http://localhost:57261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57261/tests/kraken/driver.html?testName=ai-astar) 07:28:33 INFO - PROCESS | 2047 | RSS: Main: 275804160 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | __start_tp_report 07:28:33 INFO - PROCESS | 2047 | _x_x_mozilla_page_load 07:28:33 INFO - PROCESS | 2047 | _x_x_mozilla_page_load_details 07:28:33 INFO - PROCESS | 2047 | |i|pagename|runs| 07:28:33 INFO - PROCESS | 2047 | |0;ai-astar;104;118;109;118;117;117;132;172;122;115 07:28:33 INFO - PROCESS | 2047 | |1;audio-beat-detection;145;116;170;159;110;137;129;110;161;113 07:28:33 INFO - PROCESS | 2047 | |2;audio-dft;199;203;213;264;267;198;198;203;229;260 07:28:33 INFO - PROCESS | 2047 | |3;audio-fft;75;83;76;153;58;60;58;62;140;59 07:28:33 INFO - PROCESS | 2047 | |4;audio-oscillator;69;75;145;100;81;80;117;71;71;116 07:28:33 INFO - PROCESS | 2047 | |5;imaging-gaussian-blur;91;83;137;130;91;101;135;81;78;87 07:28:33 INFO - PROCESS | 2047 | |6;imaging-darkroom;143;90;96;117;106;150;149;125;149;149 07:28:33 INFO - PROCESS | 2047 | |7;imaging-desaturate;90;128;93;143;132;143;145;92;95;91 07:28:33 INFO - PROCESS | 2047 | |8;json-parse-financial;56;56;59;58;56;61;56;64;76;54 07:28:33 INFO - PROCESS | 2047 | |9;json-stringify-tinderbox;72;97;61;103;122;115;87;101;93;63 07:28:33 INFO - PROCESS | 2047 | |10;stanford-crypto-aes;90;87;88;87;86;86;87;87;87;88 07:28:33 INFO - PROCESS | 2047 | |11;stanford-crypto-ccm;140;141;154;150;131;155;146;160;164;161 07:28:33 INFO - PROCESS | 2047 | |12;stanford-crypto-pbkdf2;171;171;239;176;171;173;172;212;172;174 07:28:33 INFO - PROCESS | 2047 | |13;stanford-crypto-sha256-iterative;69;70;69;68;72;68;66;68;69;68 07:28:33 INFO - PROCESS | 2047 | __end_tp_report 07:28:33 INFO - PROCESS | 2047 | __start_cc_report 07:28:33 INFO - PROCESS | 2047 | _x_x_mozilla_cycle_collect,1107 07:28:33 INFO - PROCESS | 2047 | __end_cc_report 07:28:33 INFO - PROCESS | 2047 | __startTimestamp1471098513339__endTimestamp 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | ------- Summary: start ------- 07:28:33 INFO - PROCESS | 2047 | Number of tests: 14 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#0] ai-astar Cycles:10 Average:122.40 Median:118.00 stddev:18.92 (16.0%) stddev-sans-first:18.86 07:28:33 INFO - PROCESS | 2047 | Values: 104.0 118.0 109.0 118.0 117.0 117.0 132.0 172.0 122.0 115.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:141.00 stddev:22.88 (16.2%) stddev-sans-first:23.98 07:28:33 INFO - PROCESS | 2047 | Values: 145.0 116.0 170.0 159.0 110.0 137.0 129.0 110.0 161.0 113.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#2] audio-dft Cycles:10 Average:223.40 Median:221.00 stddev:29.34 (13.3%) stddev-sans-first:29.76 07:28:33 INFO - PROCESS | 2047 | Values: 199.0 203.0 213.0 264.0 267.0 198.0 198.0 203.0 229.0 260.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#3] audio-fft Cycles:10 Average:82.40 Median:61.00 stddev:35.05 (57.5%) stddev-sans-first:37.07 07:28:33 INFO - PROCESS | 2047 | Values: 75.0 83.0 76.0 153.0 58.0 60.0 58.0 62.0 140.0 59.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:71.00 stddev:25.90 (36.5%) stddev-sans-first:26.04 07:28:33 INFO - PROCESS | 2047 | Values: 69.0 75.0 145.0 100.0 81.0 80.0 117.0 71.0 71.0 116.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:82.00 stddev:23.43 (28.6%) stddev-sans-first:24.55 07:28:33 INFO - PROCESS | 2047 | Values: 91.0 83.0 137.0 130.0 91.0 101.0 135.0 81.0 78.0 87.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#6] imaging-darkroom Cycles:10 Average:127.40 Median:149.00 stddev:23.83 (16.0%) stddev-sans-first:24.60 07:28:33 INFO - PROCESS | 2047 | Values: 143.0 90.0 96.0 117.0 106.0 150.0 149.0 125.0 149.0 149.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#7] imaging-desaturate Cycles:10 Average:115.20 Median:90.50 stddev:24.81 (27.4%) stddev-sans-first:24.58 07:28:33 INFO - PROCESS | 2047 | Values: 90.0 128.0 93.0 143.0 132.0 143.0 145.0 92.0 95.0 91.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:58.50 stddev:6.47 (11.1%) stddev-sans-first:6.73 07:28:33 INFO - PROCESS | 2047 | Values: 56.0 56.0 59.0 58.0 56.0 61.0 56.0 64.0 76.0 54.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#9] json-stringify-tinderbox Cycles:10 Average:91.40 Median:67.50 stddev:20.76 (30.8%) stddev-sans-first:20.80 07:28:33 INFO - PROCESS | 2047 | Values: 72.0 97.0 61.0 103.0 122.0 115.0 87.0 101.0 93.0 63.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.16 (1.3%) stddev-sans-first:0.71 07:28:33 INFO - PROCESS | 2047 | Values: 90.0 87.0 88.0 87.0 86.0 86.0 87.0 87.0 87.0 88.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:154.50 stddev:10.62 (6.9%) stddev-sans-first:10.61 07:28:33 INFO - PROCESS | 2047 | Values: 140.0 141.0 154.0 150.0 131.0 155.0 146.0 160.0 164.0 161.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:173.50 stddev:23.29 (13.4%) stddev-sans-first:24.29 07:28:33 INFO - PROCESS | 2047 | Values: 171.0 171.0 239.0 176.0 171.0 173.0 172.0 212.0 172.0 174.0 07:28:33 INFO - PROCESS | 2047 | 07:28:33 INFO - PROCESS | 2047 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 07:28:33 INFO - PROCESS | 2047 | Values: 69.0 70.0 69.0 68.0 72.0 68.0 66.0 68.0 69.0 68.0 07:28:33 INFO - PROCESS | 2047 | -------- Summary: end -------- 07:28:33 INFO - PROCESS | 2047 | 07:28:34 INFO - TEST-INFO | 2047: exit 0 07:28:34 INFO - TEST-OK | kraken | took 61796ms 07:28:34 INFO - SUITE-END | took 1175s 07:28:34 INFO - Completed test suite (00:19:35) 07:28:34 INFO - javascript benchmark 07:28:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7363.493183612869, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2883.0, 3385.8645654173833, 3403.030136411122, 3412.2663627320153, 3440.105572551137, 4617.422822147231, 4759.524047595239, 5611.915821262679, 5774.451427114428, 5811.302643682759, 5672.858178545538, 5830.125481177825, 5845.678487683176, 5905.645661260327, 5991.850203744909, 5188.325517682696, 5191.402988656297, 5254.737263136847, 5339.679619222859, 5379.731013449332, 5339.919901201485, 5416.133418653017, 5432.592555558329, 5438.129899216126, 5505.807296744615, 4257.276263035292, 5163.1480805667015, 5186.377634683824, 5308.654937429054, 5331.493508116742, 4477.910441791146, 5329.573634109262, 5341.1187154119525, 5346.572274218053, 5437.456254374571, 4122.958770412288, 4632.791524381411, 5260.2372655965055, 5313.362396512443, 5372.892542149174, 5665.178549110397, 5675.602707810455, 5683.403242659544, 5762.942370576283, 5851.678157701324, 6229.0967809667345, 6263.029230469285, 6323.9051414228825, 6328.11406403104, 6345.333739957284, 6266.655333956631, 6287.371262873676, 6288.465480434169, 6312.905306420407, 6314.0844577536, 5738.282714660668, 5863.149843272701, 5961.344252132262, 5984.521238300969, 5995.430434108796, 6257.374262573797, 6354.3645635437015, 6362.077498762654, 6372.107904893226, 6382.425581697669, 6141.07883817422, 6254.749810007549, 6265.216847894013, 6294.748210071546, 6299.716512756937, 6147.0, 6203.2556093269095, 6323.019931910561, 6329.651869147149, 6329.7468101275435, 5102.36220472441, 6314.0528920661345, 6315.905261421082, 6338.334474880164, 6350.745970161234, 6270.905936410957, 6281.8743625127245, 6303.558750887486, 6308.274548426898, 6311.779087731908, 4862.9756851216225, 4905.754712264373, 4933.210686290248, 5008.574271186917, 5041.319421878, 4431.62331201845, 4447.199504089295, 4488.977555112204, 4519.276915693474, 4563.155816174019, 5545.223668686387, 5939.198208241918, 5943.31651860033, 5968.731407086691, 5997.310309314397, 6189.133521307021, 6230.968845155745, 6237.039320897759, 6241.375862413813, 6309.463695585835, 4881.4630390657, 5859.1797148399255, 5972.731227094791, 6022.5784195105925, 6030.095485677183, 5487.259220005328, 5489.917651235235, 5504.6421982571, 5508.9724551377785, 5510.669359838343, 5658.264425624642, 6234.1583886174785, 6313.96843015782, 6430.260520040255, 6438.999999999906, 6240.282367527792, 6282.057691346335, 6295.748170073146, 6306.864764342462, 6318.399752023551, 6419.711112999833, 6455.225372955088, 6458.031295305742, 6472.708728107341, 6479.870402592016, 6124.2588809726185, 6154.907676384947, 6249.937500624936, 6274.874502510015, 6300.936990630035, 6183.598066125687, 6224.688765561795, 6294.748210071729, 6302.432781049728, 6314.747410103544, 6251.53113516479, 6251.68741562911, 6265.27949285838, 6271.905921411091, 6291.307956124731, 6100.572959892765, 6159.5688301818445, 6211.751529938751, 6225.937740622536, 6248.0003199487865, 6013.6692481913915, 6054.788082417094, 6098.695065246631, 6116.418940200674, 6170.7223174958135, 6199.473044791243, 6214.322781525637, 6261.68691565429, 6286.874262514815, 6296.527760418078, 6004.909926351021, 6023.939760602513, 6168.35232300602, 6175.7838475654935, 6196.628202307876], "value": 5740.96078966981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.7015680121523, 510.65020460984204, 512.3953734593179, 516.0762235598279, 530.4377359998401, 37543.249135017286, 39905.0, 39918.800405997965, 39973.40039899397, 40009.799951000205, 40853.182936341254, 41323.58676413235, 41340.79329603355, 41610.29533080348, 41661.375079373756, 9637.03629637036, 9852.064053914866, 9869.90130098697, 9880.703578892644, 9884.406935583887, 9758.219342452623, 9861.950690246538, 9875.654352097677, 9879.456629885353, 9883.950580247089, 9854.359466634645, 9859.161971232454, 9887.950560247189, 9922.751931201741, 9927.2058235341, 9849.852252216187, 9874.308798384116, 9875.555599998017, 9893.0, 9896.0, 9559.61761529538, 9633.566489507988, 9652.420854748738, 9658.903410965871, 9679.322447428684, 39526.802365988275, 39690.60309396898, 39839.60160398388, 39855.8007209965, 39886.60113398858, 2596.4677241165514, 3144.559761633373, 3257.2508323085585, 3416.385050690875, 3454.9481757773656, 24451.633225501453, 29115.708842911725, 30386.84806575953, 30430.239244018856, 30633.693663063306, 3081.2408562983283, 3125.9687403125904, 3144.984275078633, 3154.321820808514, 3190.984045079783, 467830.0, 470318.0, 471435.0, 474178.0, 475234.0, 32550.837245814095, 32646.836765816493, 32694.836525817693, 32722.891325324534, 32882.0, 33452.3309533808, 33978.66021339804, 34043.14892127667, 34495.31009379798, 35263.471047934305, 16624.3350265988, 16744.66510669804, 16818.07500587455, 16849.831501685072, 16877.240524176443, 12900.225986440844, 13086.541971031158, 13089.672758181121, 13114.213147211198, 13114.934425328003, 15216.619584510254, 15246.771298430533, 16231.51305460838, 17720.734188987175, 18653.626927461373, 6765.695543700545, 7928.127905930343, 7999.200079991954, 8045.678172873137, 8079.959600202079, 718.6263143165525, 880.8414485392691, 940.8212439636447, 1041.2294901772634, 1161.9593314233962, 25554.872225639123, 29443.705562944095, 29829.850850746043, 30413.087607371814, 30823.537646935314, 921.6175287255847, 980.7940332530106, 1066.0245875024266, 1108.95564177432, 1171.2152857585438, 15681.529554113395, 15690.980086294354, 15796.8942174049, 15936.840631593535, 16160.111193884213, 569698.0, 635083.0, 647969.0, 657377.0, 657953.0, 56794.43205567892, 57025.429745702015, 57224.0, 57248.71375643095, 57394.0, 1184.8696643369221, 1269.0482138396203, 1313.3564553368972, 1352.3305963548107, 1356.4777560639027, 25896.22311330663, 29081.34698448323, 29169.0, 29540.704592953796, 29709.554356684235, 52619.15832945829, 56210.59473513031, 57071.71464142653, 57104.0, 57295.14057289228, 559658.0, 613636.0, 616656.0, 624754.0, 625498.0, 42619.934501637705, 42926.570734292254, 43303.566964329955, 43352.916177094565, 43690.56309436865, 46857.531424685316, 47199.29201061918, 48241.517584823705, 48242.75878620584, 48285.51714482951, 39034.0, 39205.0, 39505.03712221653, 40970.38544421776, 41012.97467563335, 38414.0, 38697.6130238694, 38774.80612596919, 39659.20681586294, 40077.39883901685, 37711.434328485644, 38207.617923820406, 39607.81176564708, 39623.0, 40883.59116408917, 28615.85692071526, 31568.842155789072, 35411.645883540834, 35506.822465887504, 35518.822405887804, 24447.75552244455, 25366.0, 25752.484950301263, 26103.955841766117, 27587.0], "value": 19545.541614326856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.36589722862584, 377.90552361909516, 385.108473882961, 389.2817751248948, 403.63067792969434, 20218.98905054747, 20437.0, 21087.0, 21251.14995400184, 21412.99999999996, 9502.47736374499, 10296.0, 12272.0, 12316.445759940802, 13693.0, 5450.700211488366, 5628.240187574666, 5630.09918413054, 5636.689982051006, 5640.266765320503, 3938.310795610771, 5554.972225138868, 5975.731092100866, 6248.4064013918605, 6310.0, 6196.907046394308, 6248.0, 6267.623942563438, 6301.0, 6388.520860935425, 5382.730863456831, 6121.326654068049, 6125.346156537732, 6222.657753823538, 6260.217472815898, 5379.515843574097, 5854.18041474194, 5872.708004239061, 6090.512758979316, 6118.235220597426, 13493.12294700851, 13577.796333055012, 13582.388792504362, 13597.252151131685, 23823.880880595658, 2033.7762846086919, 2095.308548179097, 2112.9220604233824, 2134.487722946482, 2143.1748776721074, 10060.748481287954, 10100.88890222075, 11135.554577816878, 15178.392864285415, 16004.679906401807, 1834.4129878438905, 1859.7675290588677, 1870.9064546772743, 1873.072828949665, 1968.9409317720492, 116983.0, 124641.0, 126671.36664316712, 127742.0, 129441.35279323543, 9412.482313472688, 11080.778384432266, 11518.30890146577, 11562.595309164139, 11743.823842642367, 14321.928390357982, 14508.839292856757, 14508.927455362867, 14537.636559086108, 14559.636009099857, 8296.8340633187, 8590.312774977987, 8599.818067315133, 8706.434081784664, 8758.036615972238, 8439.367047471342, 8574.914250857411, 8597.613107410181, 8707.477551346812, 8740.475571465733, 4448.510663826976, 4557.111363284194, 4565.288016993627, 4604.516525764813, 4624.5375462453485, 1760.251892945493, 1821.7449557062023, 1885.9811401885806, 1917.5493758966632, 1943.5802425979464, 863.6372723456038, 898.2364989758784, 905.9773505662412, 931.5994122527243, 983.2085171437062, 19961.101750420974, 20717.68923466149, 21413.67879481809, 21481.570368592853, 21658.675119873216, 932.5663566441638, 956.8325543029941, 979.7305740921304, 1020.4285600063988, 1058.0900425634102, 10602.734931626772, 11185.552577896793, 11192.272502287326, 11213.439328033566, 11245.718857028476, 527522.0, 602866.0, 613817.9309103426, 617170.0, 617814.0, 115718.0, 116627.0, 129463.0, 133699.0, 134655.0, 953.5518306396121, 955.8231727130503, 970.3595626886221, 974.668612671695, 1002.4987506247022, 15553.0, 17116.058616776198, 17894.015829129523, 18965.810341896406, 19146.329878454188, 37711.05722356853, 38235.0, 49246.0, 55688.0, 55908.0, 66186.00720989093, 73175.63412182905, 77225.22774772406, 77755.83366249397, 78244.60877695575, 8102.7569172924905, 8139.3081588063305, 8201.056878458814, 8273.627686753991, 8285.295749861329, 9491.572879220314, 11979.281243125091, 12429.75140497203, 12776.233425994471, 13150.736985260433, 11164.385958772345, 11477.770444590895, 11486.483108259981, 11535.36555489456, 11651.825222621497, 10896.746874109578, 11022.944885275523, 11166.441677916235, 11332.036776874058, 11414.086873050303, 11125.666230013112, 11164.9951504365, 11501.309921404743, 11668.124890633067, 11903.821442678194, 8026.357891368793, 8044.0, 8174.713885014234, 8299.543525106177, 8420.747377578682, 8263.710770123016, 10723.30298530593, 10797.13622910181, 10937.507812148313, 11038.0], "value": 9298.904480537263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.9436422543095, 1536.8539988701073, 1720.0797573298287, 1822.6445843060592, 1826.3517899046378, 7923.445358824884, 8395.83208335833, 8616.569171541414, 8977.416467929588, 8994.100589941003, 8640.567971601426, 8812.515311657857, 8836.823263534725, 8845.336599755012, 8864.335174861879, 2346.483773569816, 2371.158238825218, 2375.2874137758604, 2380.1550449590404, 2385.33210701004, 2339.4034521197073, 2365.1840115160244, 2380.9047638094457, 2382.690250267463, 2389.940251493709, 2360.5160942006933, 2371.34787933318, 2377.5601513720017, 2388.737238903719, 2392.820538459614, 2337.0651739304412, 2351.706036745407, 2354.6585745066955, 2363.3618922890723, 2366.656834758959, 2319.420144963759, 2332.055517515409, 2342.543204075206, 2345.2612427085414, 2347.225415612844, 7404.629768511553, 8857.645694172226, 8921.776955576162, 8929.0, 8931.285497160212, 5236.92144617831, 5315.893682126374, 5336.759845806948, 5386.461353864622, 5401.351837779453, 3141.780075394723, 3637.3634613942454, 3645.981770091159, 3700.9259814803554, 3733.1413774831667, 1087.3856271206744, 1096.0026375997884, 1101.515333253374, 1113.777244551093, 1119.4458742922225, 11592.478338474704, 11736.471858766376, 11818.054555635528, 11839.052875769918, 11862.466189021428, 4696.38946936896, 4712.528747125329, 4789.1015422530445, 4831.855044348676, 4885.364902562644, 8909.376343655882, 9693.369930954465, 9906.752331191778, 10007.849882251772, 10017.649382271586, 5351.063563876306, 5357.276767636397, 5357.678539287655, 5375.408705042442, 5381.112116500812, 4433.0, 4765.547273009128, 4881.633877459205, 4900.754962251945, 4915.090708218991, 3478.7912725236565, 3868.709846761504, 3960.1881614269582, 3960.20795840833, 3997.380406037069, 1283.4406196471332, 1292.4700872642172, 1297.6690943809267, 1306.6667999660026, 1310.2662508994993, 834.2741814621197, 875.5753459572103, 937.9859302110474, 941.2422999485343, 941.2987324443196, 5792.652440853562, 5895.4399332063385, 6006.369331220247, 6114.082887566811, 6177.660228687465, 433.30022014446445, 445.5588966922788, 449.94825595056335, 453.8003278557424, 455.37386094120586, 3863.8454461821775, 3982.920341593152, 4016.0961796413253, 4040.878773636796, 4151.73013754105, 10475.47622618866, 10924.2899211551, 10938.234323597431, 10940.835887461695, 10966.561337546409, 10886.510107045202, 10907.945460272647, 10918.890811091946, 10919.12646988239, 10963.945180274048, 7743.5353878767455, 8174.468659537111, 8219.095899451055, 8268.8346233075, 8337.082920878698, 5399.893021930417, 5690.402507736628, 5986.204138758442, 6057.848553786191, 6199.318075011835, 9563.474008929576, 9833.999999999714, 10073.899261007296, 10119.696409107739, 10181.541830617789, 9953.004699529989, 10293.3823970562, 10301.536430860779, 10388.792224155626, 10461.110805581306, 6614.470842332698, 7509.924900751141, 7615.923840761743, 7676.0, 7685.0, 8339.66641334364, 8411.116832732476, 8415.537145456814, 8425.87361189595, 8432.620532075949, 7335.266473352622, 7394.408447324308, 7557.244275572399, 7620.0, 7628.923710762821, 7328.853422931618, 7471.402287816853, 7486.876968454558, 7570.735024274124, 7640.885386719093, 6931.133608298963, 7048.823779405351, 7098.503104782616, 7101.893471598033, 7126.180489243803, 4336.1978034063795, 4951.405831300123, 4975.50244975514, 5007.349044624321, 5144.871378215575, 3874.8881859387266, 5037.395512538519, 5135.640505164752, 5191.76637051326, 5237.869053273546], "value": 4523.2271556697615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.1706392739603, 310.10534607656916, 312.773239401434, 317.3161836242896, 320.5752378099019, 5183.352080989876, 5554.472325129106, 5623.1003039513635, 5627.296587926509, 5678.716064196789, 4378.6934914555995, 4814.374131362927, 5184.429712731606, 5282.445343238962, 5649.802256921009, 3463.8960831175104, 4031.2945234583904, 4101.89248902796, 4162.729422587538, 4176.331786914095, 3127.6246850377875, 3720.9069773255615, 4115.839184428184, 4191.7275377100395, 4192.664586833046, 4177.16456708658, 4193.664506839461, 4199.45407097077, 4208.284591619432, 4209.137126888981, 2815.7610651313357, 4060.2691515527194, 4161.9375709364385, 4164.5210800758, 4237.6186143247105, 2967.9018763057593, 3435.57423669177, 3550.6449355064547, 3551.8756843510355, 3581.81509279342, 4406.294992801137, 4799.808007679689, 5059.3422855028975, 5421.051316019721, 5443.938432005761, 4364.6508279337895, 4397.912041759147, 4474.552544745532, 4774.092922344744, 4806.543378379083, 4838.491958344393, 5649.971750141264, 5812.82561523155, 5835.5915085944, 5852.648841069549, 3745.943810842812, 3920.8235629396745, 3951.4467974483596, 3963.564007959122, 3974.6621537169376, 5303.867403314909, 5688.829335119953, 5912.196779982104, 5971.104334349839, 6262.874742505124, 3226.9677303227136, 4000.299947509174, 4028.5568587455355, 4070.409790580349, 4077.510698716173, 3610.5847827499647, 4094.1811637672586, 4099.036726369301, 4101.5488296287385, 4129.855455059119, 4334.82959600906, 4523.072770082125, 4773.164696178155, 4802.247179779355, 4835.685680430831, 4836.226203807374, 5127.3847138343635, 5911.467967882912, 5939.881202375928, 5979.790707325223, 1356.1524047470332, 1371.3417559571462, 1381.597678356469, 1401.341369556307, 1401.7336706026026, 789.2226157235119, 806.0609390060514, 837.7654256808104, 842.7682387343407, 855.6320782063773, 4987.501249875056, 5224.399194092652, 5485.561155107582, 5506.944930550643, 5515.7242137892945, 5225.085610018232, 5875.884681514652, 6117.204763380821, 6182.505399568024, 6183.81448556544, 5250.816221432232, 5469.726513674301, 5521.0, 5523.4752698494385, 5559.610827242054, 2726.573349718752, 3140.481820499592, 3176.6664500227143, 3184.9840750796097, 3191.4042978510743, 5019.6948793314, 5983.491403230774, 6289.276733175743, 6294.9685251574365, 6334.873302534015, 5659.603827732019, 6194.314382942142, 6199.752009919643, 6209.441150296405, 6244.843878903063, 5279.073138304491, 5722.884037612792, 5945.791897283574, 6268.561200715997, 6284.402981716729, 5696.829095127153, 5802.245708057925, 5980.557484376688, 6011.609245399035, 6017.217761690952, 5913.34953155144, 5967.597614560662, 6027.60820546663, 6038.818835434944, 6041.214642096676, 4908.509149085063, 5533.446655334435, 5555.972070194431, 5941.465268125889, 6288.402601752826, 3569.6608822162893, 3711.814409279579, 3758.977893653764, 3962.663173630274, 4052.6555242804693, 6123.663198524124, 6132.785352512819, 6136.631802091889, 6143.447089761943, 6216.937830621636, 4534.795934183036, 4900.701314151824, 5858.681796595903, 5987.520998320037, 6006.819795406145, 4864.935090892715, 4930.630202734737, 5966.642001479925, 5968.150542899719, 5984.8803023940145, 4778.689385189951, 5624.128260119688, 5778.855528611818, 5829.417058294137, 5849.473547380756, 5613.354464236501, 5623.971880140573, 5668.631538949955, 5774.0, 6039.486643635164, 5847.912281315868, 5856.238688970577, 5880.529557635465, 5881.529477641693, 5884.735186916513], "value": 4215.321341635691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.4474110194047, 716.2550947015104, 746.5931067568175, 777.0985656638301, 834.5076404921095, 14833.703325933475, 15638.609034774136, 15674.999999999985, 15677.764833527506, 15703.371865125395, 14141.646458838533, 14262.643433914158, 14275.214863182548, 14319.42722291107, 14337.426502939896, 553.9058360078776, 820.9794755131139, 848.8854004709378, 849.3884403229665, 850.0309647002391, 841.0874201491389, 845.3575282785066, 846.5513277962659, 851.6806197675871, 853.9786505337386, 881.7663319220412, 892.7187935800234, 895.0691281067682, 895.5880295064278, 899.2850683706469, 873.1617647058799, 884.5886662701843, 887.3389324952951, 888.6711916590871, 888.8177923525661, 661.2957200581366, 661.5137873662902, 662.7978466567695, 664.4783844681901, 665.4077870695086, 14547.199904005276, 14644.267786610626, 14657.193854338007, 14691.926540367336, 14719.190444525548, 13161.210327380388, 13466.730665386638, 14829.48096816617, 14835.332410041574, 15021.849781502264, 11304.265222760494, 12195.878041219563, 12366.505339786398, 12418.81371779424, 12617.053720970964, 3500.3174380995715, 3845.6923446124524, 3872.6320999505283, 4089.672826173899, 4094.4267802507675, 101513.95458136268, 104054.99999999924, 117889.0, 118623.0, 118819.40590296993, 11370.204085714086, 11379.146564007733, 11438.942805286088, 11590.826137607943, 11616.303021818718, 23273.418164546023, 23429.062837486308, 23478.413039673804, 23526.7647323528, 23541.646875296883, 7386.926130738624, 7946.284834364935, 8088.514689118671, 8184.263416292562, 8322.958385208156, 4358.150160718629, 4432.534583868712, 4440.755758433253, 4497.302918047708, 4548.476925153584, 3723.6648701616987, 3956.9711874912155, 3965.583613720518, 3986.880393588197, 4006.358982562834, 681.2370145437043, 707.2255879811598, 711.7686402523663, 713.8822094354477, 716.2622498826217, 606.6511755740466, 608.9360617135226, 680.4828330468879, 703.581508128951, 714.6885465171365, 9185.678501252423, 9689.70930872075, 9804.803903921882, 9866.654667086761, 9900.405975641484, 545.9317585301837, 600.3756093662543, 636.2197198243613, 661.110805965975, 688.5145972089665, 4282.76444795533, 4621.214393553104, 4862.367892173995, 4888.0, 4897.897972956056, 136197.0, 142528.28735856462, 161481.0, 167845.0, 168528.15735921243, 144084.0, 144898.0, 149448.2527587355, 149782.0, 150399.0, 103670.0, 122095.16857247148, 123364.0, 123860.0, 124789.37605311915, 9539.427634341962, 10127.949360253446, 10138.847917281395, 10281.177505799667, 10318.329308594917, 61993.690031551356, 64573.70852583016, 65464.0, 66697.81033505972, 68025.0, 79445.0, 79928.0, 88775.0, 89759.0, 98959.50520247352, 12967.157134786208, 13010.54463093825, 13086.80369794473, 13321.0, 13335.266560339274, 12830.0, 14855.40578376896, 14898.255087245378, 14938.477153299582, 15110.524579347031, 13822.166455876722, 13866.0, 14025.079275000757, 14351.497697580535, 14413.927930360282, 14012.0, 14033.789493157816, 14279.500217492337, 14685.779713304095, 14933.775993360325, 13817.654558636115, 14124.152550846982, 14130.646733831325, 14149.43402263939, 14618.976671632883, 10758.569657213624, 10958.154709211267, 11042.723931901766, 11352.829707554558, 11581.189316747746, 10097.091261786474, 10307.278490505592, 10676.7721712001, 10968.287061340987, 11866.584669536525], "value": 8011.544296627092, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1640.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 109.0, 118.0, 117.0, 117.0, 132.0, 172.0, 122.0, 115.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 170.0, 159.0, 110.0, 137.0, 129.0, 110.0, 161.0, 113.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 203.0, 213.0, 264.0, 267.0, 198.0, 198.0, 203.0, 229.0, 260.0], "value": 223.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 76.0, 153.0, 58.0, 60.0, 58.0, 62.0, 140.0, 59.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 145.0, 100.0, 81.0, 80.0, 117.0, 71.0, 71.0, 116.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 137.0, 130.0, 91.0, 101.0, 135.0, 81.0, 78.0, 87.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 90.0, 96.0, 117.0, 106.0, 150.0, 149.0, 125.0, 149.0, 149.0], "value": 127.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 128.0, 93.0, 143.0, 132.0, 143.0, 145.0, 92.0, 95.0, 91.0], "value": 115.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 59.0, 58.0, 56.0, 61.0, 56.0, 64.0, 76.0, 54.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 97.0, 61.0, 103.0, 122.0, 115.0, 87.0, 101.0, 93.0, 63.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 87.0, 86.0, 86.0, 87.0, 87.0, 87.0, 88.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 154.0, 150.0, 131.0, 155.0, 146.0, 160.0, 164.0, 161.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 239.0, 176.0, 171.0, 173.0, 172.0, 212.0, 172.0, 174.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 68.0, 72.0, 68.0, 66.0, 68.0, 69.0, 68.0], "value": 68.7, "unit": "score"}]}]} 07:28:34 INFO - Return code: 0 07:28:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:28:34 ERROR - # TBPL SUCCESS # 07:28:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:28:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:28:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:28:34 INFO - 2016-08-13 07:28:34.685 screenresolution[2052:29628] starting screenresolution argv=screenresolution get 07:28:34 INFO - 2016-08-13 07:28:34.688 screenresolution[2052:29628] Display 0: 1600x1200x32@60 07:28:34 INFO - 2016-08-13 07:28:34.694 screenresolution[2053:29631] starting screenresolution argv=screenresolution list 07:28:34 INFO - Available Modes on Display 0 07:28:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:28:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:28:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:28:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:28:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:28:34 INFO - Intel Iris: 07:28:34 INFO - Chipset Model: Intel Iris 07:28:34 INFO - Type: GPU 07:28:34 INFO - Bus: Built-In 07:28:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:28:34 INFO - Vendor: Intel (0x8086) 07:28:34 INFO - Device ID: 0x0a2e 07:28:34 INFO - Revision ID: 0x0009 07:28:34 INFO - Displays: 07:28:34 INFO - Display: 07:28:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:28:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:28:34 INFO - Display Serial Number: 1600x1200 60 07:28:34 INFO - Main Display: Yes 07:28:34 INFO - Mirror: Off 07:28:34 INFO - Online: Yes 07:28:34 INFO - Rotation: Supported 07:28:34 INFO - Return code: 0 07:28:34 INFO - Running post-action listener: _resource_record_post_action 07:28:34 INFO - [mozharness: 2016-08-13 14:28:34.928852Z] Finished run-tests step (success) 07:28:34 INFO - Running post-run listener: _resource_record_post_run 07:28:34 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 122880; Write bytes: 707280384; Read time: 3; Write time: 2065 07:28:34 INFO - TinderboxPrint: CPU usage
54.2% 07:28:34 INFO - TinderboxPrint: I/O read bytes / time
122,880 / 3 07:28:34 INFO - TinderboxPrint: I/O write bytes / time
707,280,384 / 2,065 07:28:34 INFO - TinderboxPrint: CPU idle
2,217.9 (45.8%) 07:28:34 INFO - TinderboxPrint: CPU system
977.4 (20.2%) 07:28:34 INFO - TinderboxPrint: CPU user
1,650.4 (34.1%) 07:28:34 INFO - TinderboxPrint: Swap in / out
404,336,640 / 0 07:28:34 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 0; Write bytes: 408200704; Read time: 0; Write time: 727 07:28:35 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 20480; Write bytes: 297596928; Read time: 2; Write time: 1332 07:28:35 INFO - Running post-run listener: _upload_blobber_files 07:28:35 INFO - Blob upload gear active. 07:28:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:28:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:28:35 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:37 INFO - (blobuploader) - INFO - Done attempting. 07:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:28:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:28:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:37 INFO - (blobuploader) - INFO - Done attempting. 07:28:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:28:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:28:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:40 INFO - (blobuploader) - INFO - Done attempting. 07:28:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:40 INFO - Return code: 0 07:28:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d77142f6146c808fbf59c2b5c59d4394f615c2a2e0e9a6fe3f2aac26f5e0bdb29e085ba2ca0ce41daaefe5b173009334e49753c181cc34dcb630bfa45c03102b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7810a2832fe83ac12f68ec6052a08644b4bb6653087e264c27f53d958e6352c7abc748ff50836106cbb0d83765594d03997b1b3b88e1340630191f25a80111c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0a48d8dc9642069d2e64d7e8ca10430a8293d85d7f02ef40960aa945869e6159b219c77102d11d3860b6f2e53baee570ddb099f478aefcc935fd7666b21dc90"} 07:28:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:40 INFO - Contents: 07:28:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d77142f6146c808fbf59c2b5c59d4394f615c2a2e0e9a6fe3f2aac26f5e0bdb29e085ba2ca0ce41daaefe5b173009334e49753c181cc34dcb630bfa45c03102b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7810a2832fe83ac12f68ec6052a08644b4bb6653087e264c27f53d958e6352c7abc748ff50836106cbb0d83765594d03997b1b3b88e1340630191f25a80111c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0a48d8dc9642069d2e64d7e8ca10430a8293d85d7f02ef40960aa945869e6159b219c77102d11d3860b6f2e53baee570ddb099f478aefcc935fd7666b21dc90"} 07:28:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:40 INFO - Copying logs to upload dir... 07:28:40 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.026844 ========= master_lag: 1.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-08-13 07:28:41.519841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:41.522884) ========= 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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d77142f6146c808fbf59c2b5c59d4394f615c2a2e0e9a6fe3f2aac26f5e0bdb29e085ba2ca0ce41daaefe5b173009334e49753c181cc34dcb630bfa45c03102b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7810a2832fe83ac12f68ec6052a08644b4bb6653087e264c27f53d958e6352c7abc748ff50836106cbb0d83765594d03997b1b3b88e1340630191f25a80111c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0a48d8dc9642069d2e64d7e8ca10430a8293d85d7f02ef40960aa945869e6159b219c77102d11d3860b6f2e53baee570ddb099f478aefcc935fd7666b21dc90"} build_url:https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/I4O39b-ETn6HN_wgjFYPBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d77142f6146c808fbf59c2b5c59d4394f615c2a2e0e9a6fe3f2aac26f5e0bdb29e085ba2ca0ce41daaefe5b173009334e49753c181cc34dcb630bfa45c03102b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7810a2832fe83ac12f68ec6052a08644b4bb6653087e264c27f53d958e6352c7abc748ff50836106cbb0d83765594d03997b1b3b88e1340630191f25a80111c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0a48d8dc9642069d2e64d7e8ca10430a8293d85d7f02ef40960aa945869e6159b219c77102d11d3860b6f2e53baee570ddb099f478aefcc935fd7666b21dc90"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:41.556070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:41.556387) ========= 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.VIHy8MwqUe/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.h3yhkB2jkI/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005197 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 07:28:41.606853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 07:28:41.607159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 07:28:41.607495) ========= ========= Total master_lag: 1.49 =========